Add custom message handler to peer manager
[rust-lightning] / lightning-net-tokio / src / lib.rs
1 // This file is Copyright its original authors, visible in version control
2 // history.
3 //
4 // This file is licensed under the Apache License, Version 2.0 <LICENSE-APACHE
5 // or http://www.apache.org/licenses/LICENSE-2.0> or the MIT license
6 // <LICENSE-MIT or http://opensource.org/licenses/MIT>, at your option.
7 // You may not use this file except in accordance with one or both of these
8 // licenses.
9
10 //! A socket handling library for those running in Tokio environments who wish to use
11 //! rust-lightning with native TcpStreams.
12 //!
13 //! Designed to be as simple as possible, the high-level usage is almost as simple as "hand over a
14 //! TcpStream and a reference to a PeerManager and the rest is handled", except for the
15 //! [Event](../lightning/util/events/enum.Event.html) handling mechanism; see example below.
16 //!
17 //! The PeerHandler, due to the fire-and-forget nature of this logic, must be an Arc, and must use
18 //! the SocketDescriptor provided here as the PeerHandler's SocketDescriptor.
19 //!
20 //! Three methods are exposed to register a new connection for handling in tokio::spawn calls; see
21 //! their individual docs for details.
22 //!
23 //! # Example
24 //! ```
25 //! use std::net::TcpStream;
26 //! use bitcoin::secp256k1::key::PublicKey;
27 //! use lightning::util::events::{Event, EventHandler, EventsProvider};
28 //! use std::net::SocketAddr;
29 //! use std::sync::Arc;
30 //!
31 //! // Define concrete types for our high-level objects:
32 //! type TxBroadcaster = dyn lightning::chain::chaininterface::BroadcasterInterface + Send + Sync;
33 //! type FeeEstimator = dyn lightning::chain::chaininterface::FeeEstimator + Send + Sync;
34 //! type Logger = dyn lightning::util::logger::Logger + Send + Sync;
35 //! type ChainAccess = dyn lightning::chain::Access + Send + Sync;
36 //! type ChainFilter = dyn lightning::chain::Filter + Send + Sync;
37 //! type DataPersister = dyn lightning::chain::channelmonitor::Persist<lightning::chain::keysinterface::InMemorySigner> + Send + Sync;
38 //! type ChainMonitor = lightning::chain::chainmonitor::ChainMonitor<lightning::chain::keysinterface::InMemorySigner, Arc<ChainFilter>, Arc<TxBroadcaster>, Arc<FeeEstimator>, Arc<Logger>, Arc<DataPersister>>;
39 //! type ChannelManager = Arc<lightning::ln::channelmanager::SimpleArcChannelManager<ChainMonitor, TxBroadcaster, FeeEstimator, Logger>>;
40 //! type PeerManager = Arc<lightning::ln::peer_handler::SimpleArcPeerManager<lightning_net_tokio::SocketDescriptor, ChainMonitor, TxBroadcaster, FeeEstimator, ChainAccess, Logger>>;
41 //!
42 //! // Connect to node with pubkey their_node_id at addr:
43 //! async fn connect_to_node(peer_manager: PeerManager, chain_monitor: Arc<ChainMonitor>, channel_manager: ChannelManager, their_node_id: PublicKey, addr: SocketAddr) {
44 //!     lightning_net_tokio::connect_outbound(peer_manager, their_node_id, addr).await;
45 //!     loop {
46 //!             channel_manager.await_persistable_update();
47 //!             channel_manager.process_pending_events(&|event| {
48 //!                     // Handle the event!
49 //!             });
50 //!             chain_monitor.process_pending_events(&|event| {
51 //!                     // Handle the event!
52 //!             });
53 //!     }
54 //! }
55 //!
56 //! // Begin reading from a newly accepted socket and talk to the peer:
57 //! async fn accept_socket(peer_manager: PeerManager, chain_monitor: Arc<ChainMonitor>, channel_manager: ChannelManager, socket: TcpStream) {
58 //!     lightning_net_tokio::setup_inbound(peer_manager, socket);
59 //!     loop {
60 //!             channel_manager.await_persistable_update();
61 //!             channel_manager.process_pending_events(&|event| {
62 //!                     // Handle the event!
63 //!             });
64 //!             chain_monitor.process_pending_events(&|event| {
65 //!                     // Handle the event!
66 //!             });
67 //!     }
68 //! }
69 //! ```
70
71 #![deny(broken_intra_doc_links)]
72 #![deny(missing_docs)]
73
74 use bitcoin::secp256k1::key::PublicKey;
75
76 use tokio::net::TcpStream;
77 use tokio::{io, time};
78 use tokio::sync::mpsc;
79 use tokio::io::{AsyncReadExt, AsyncWrite, AsyncWriteExt};
80
81 use lightning::ln::peer_handler;
82 use lightning::ln::peer_handler::SocketDescriptor as LnSocketTrait;
83 use lightning::ln::peer_handler::CustomMessageHandler;
84 use lightning::ln::msgs::{ChannelMessageHandler, RoutingMessageHandler};
85 use lightning::util::logger::Logger;
86
87 use std::task;
88 use std::net::SocketAddr;
89 use std::net::TcpStream as StdTcpStream;
90 use std::sync::{Arc, Mutex};
91 use std::sync::atomic::{AtomicU64, Ordering};
92 use std::time::Duration;
93 use std::hash::Hash;
94
95 static ID_COUNTER: AtomicU64 = AtomicU64::new(0);
96
97 /// Connection contains all our internal state for a connection - we hold a reference to the
98 /// Connection object (in an Arc<Mutex<>>) in each SocketDescriptor we create as well as in the
99 /// read future (which is returned by schedule_read).
100 struct Connection {
101         writer: Option<io::WriteHalf<TcpStream>>,
102         // Because our PeerManager is templated by user-provided types, and we can't (as far as I can
103         // tell) have a const RawWakerVTable built out of templated functions, we need some indirection
104         // between being woken up with write-ready and calling PeerManager::write_buffer_space_avail.
105         // This provides that indirection, with a Sender which gets handed to the PeerManager Arc on
106         // the schedule_read stack.
107         //
108         // An alternative (likely more effecient) approach would involve creating a RawWakerVTable at
109         // runtime with functions templated by the Arc<PeerManager> type, calling
110         // write_buffer_space_avail directly from tokio's write wake, however doing so would require
111         // more unsafe voodo than I really feel like writing.
112         write_avail: mpsc::Sender<()>,
113         // When we are told by rust-lightning to pause read (because we have writes backing up), we do
114         // so by setting read_paused. At that point, the read task will stop reading bytes from the
115         // socket. To wake it up (without otherwise changing its state, we can push a value into this
116         // Sender.
117         read_waker: mpsc::Sender<()>,
118         read_paused: bool,
119         rl_requested_disconnect: bool,
120         id: u64,
121 }
122 impl Connection {
123         async fn schedule_read<CMH, RMH, L, UMH>(peer_manager: Arc<peer_handler::PeerManager<SocketDescriptor, Arc<CMH>, Arc<RMH>, Arc<L>, Arc<UMH>>>, us: Arc<Mutex<Self>>, mut reader: io::ReadHalf<TcpStream>, mut read_wake_receiver: mpsc::Receiver<()>, mut write_avail_receiver: mpsc::Receiver<()>) where
124                         CMH: ChannelMessageHandler + 'static,
125                         RMH: RoutingMessageHandler + 'static,
126                         L: Logger + 'static + ?Sized,
127                         UMH: CustomMessageHandler + 'static {
128                 // 8KB is nice and big but also should never cause any issues with stack overflowing.
129                 let mut buf = [0; 8192];
130
131                 let mut our_descriptor = SocketDescriptor::new(us.clone());
132                 // An enum describing why we did/are disconnecting:
133                 enum Disconnect {
134                         // Rust-Lightning told us to disconnect, either by returning an Err or by calling
135                         // SocketDescriptor::disconnect_socket.
136                         // In this case, we do not call peer_manager.socket_disconnected() as Rust-Lightning
137                         // already knows we're disconnected.
138                         CloseConnection,
139                         // The connection was disconnected for some other reason, ie because the socket was
140                         // closed.
141                         // In this case, we do need to call peer_manager.socket_disconnected() to inform
142                         // Rust-Lightning that the socket is gone.
143                         PeerDisconnected
144                 }
145                 let disconnect_type = loop {
146                         let read_paused = {
147                                 let us_lock = us.lock().unwrap();
148                                 if us_lock.rl_requested_disconnect {
149                                         break Disconnect::CloseConnection;
150                                 }
151                                 us_lock.read_paused
152                         };
153                         tokio::select! {
154                                 v = write_avail_receiver.recv() => {
155                                         assert!(v.is_some()); // We can't have dropped the sending end, its in the us Arc!
156                                         if let Err(_) = peer_manager.write_buffer_space_avail(&mut our_descriptor) {
157                                                 break Disconnect::CloseConnection;
158                                         }
159                                 },
160                                 _ = read_wake_receiver.recv() => {},
161                                 read = reader.read(&mut buf), if !read_paused => match read {
162                                         Ok(0) => break Disconnect::PeerDisconnected,
163                                         Ok(len) => {
164                                                 let read_res = peer_manager.read_event(&mut our_descriptor, &buf[0..len]);
165                                                 let mut us_lock = us.lock().unwrap();
166                                                 match read_res {
167                                                         Ok(pause_read) => {
168                                                                 if pause_read {
169                                                                         us_lock.read_paused = true;
170                                                                 }
171                                                         },
172                                                         Err(_) => break Disconnect::CloseConnection,
173                                                 }
174                                         },
175                                         Err(_) => break Disconnect::PeerDisconnected,
176                                 },
177                         }
178                         peer_manager.process_events();
179                 };
180                 let writer_option = us.lock().unwrap().writer.take();
181                 if let Some(mut writer) = writer_option {
182                         // If the socket is already closed, shutdown() will fail, so just ignore it.
183                         let _ = writer.shutdown().await;
184                 }
185                 if let Disconnect::PeerDisconnected = disconnect_type {
186                         peer_manager.socket_disconnected(&our_descriptor);
187                         peer_manager.process_events();
188                 }
189         }
190
191         fn new(stream: StdTcpStream) -> (io::ReadHalf<TcpStream>, mpsc::Receiver<()>, mpsc::Receiver<()>, Arc<Mutex<Self>>) {
192                 // We only ever need a channel of depth 1 here: if we returned a non-full write to the
193                 // PeerManager, we will eventually get notified that there is room in the socket to write
194                 // new bytes, which will generate an event. That event will be popped off the queue before
195                 // we call write_buffer_space_avail, ensuring that we have room to push a new () if, during
196                 // the write_buffer_space_avail() call, send_data() returns a non-full write.
197                 let (write_avail, write_receiver) = mpsc::channel(1);
198                 // Similarly here - our only goal is to make sure the reader wakes up at some point after
199                 // we shove a value into the channel which comes after we've reset the read_paused bool to
200                 // false.
201                 let (read_waker, read_receiver) = mpsc::channel(1);
202                 stream.set_nonblocking(true).unwrap();
203                 let (reader, writer) = io::split(TcpStream::from_std(stream).unwrap());
204
205                 (reader, write_receiver, read_receiver,
206                 Arc::new(Mutex::new(Self {
207                         writer: Some(writer), write_avail, read_waker, read_paused: false,
208                         rl_requested_disconnect: false,
209                         id: ID_COUNTER.fetch_add(1, Ordering::AcqRel)
210                 })))
211         }
212 }
213
214 /// Process incoming messages and feed outgoing messages on the provided socket generated by
215 /// accepting an incoming connection.
216 ///
217 /// The returned future will complete when the peer is disconnected and associated handling
218 /// futures are freed, though, because all processing futures are spawned with tokio::spawn, you do
219 /// not need to poll the provided future in order to make progress.
220 pub fn setup_inbound<CMH, RMH, L, UMH>(peer_manager: Arc<peer_handler::PeerManager<SocketDescriptor, Arc<CMH>, Arc<RMH>, Arc<L>, Arc<UMH>>>, stream: StdTcpStream) -> impl std::future::Future<Output=()> where
221                 CMH: ChannelMessageHandler + 'static + Send + Sync,
222                 RMH: RoutingMessageHandler + 'static + Send + Sync,
223                 L: Logger + 'static + ?Sized + Send + Sync,
224                 UMH: CustomMessageHandler + 'static + Send + Sync {
225         let (reader, write_receiver, read_receiver, us) = Connection::new(stream);
226         #[cfg(debug_assertions)]
227         let last_us = Arc::clone(&us);
228
229         let handle_opt = if let Ok(_) = peer_manager.new_inbound_connection(SocketDescriptor::new(us.clone())) {
230                 Some(tokio::spawn(Connection::schedule_read(peer_manager, us, reader, read_receiver, write_receiver)))
231         } else {
232                 // Note that we will skip socket_disconnected here, in accordance with the PeerManager
233                 // requirements.
234                 None
235         };
236
237         async move {
238                 if let Some(handle) = handle_opt {
239                         if let Err(e) = handle.await {
240                                 assert!(e.is_cancelled());
241                         } else {
242                                 // This is certainly not guaranteed to always be true - the read loop may exit
243                                 // while there are still pending write wakers that need to be woken up after the
244                                 // socket shutdown(). Still, as a check during testing, to make sure tokio doesn't
245                                 // keep too many wakers around, this makes sense. The race should be rare (we do
246                                 // some work after shutdown()) and an error would be a major memory leak.
247                                 #[cfg(debug_assertions)]
248                                 assert!(Arc::try_unwrap(last_us).is_ok());
249                         }
250                 }
251         }
252 }
253
254 /// Process incoming messages and feed outgoing messages on the provided socket generated by
255 /// making an outbound connection which is expected to be accepted by a peer with the given
256 /// public key. The relevant processing is set to run free (via tokio::spawn).
257 ///
258 /// The returned future will complete when the peer is disconnected and associated handling
259 /// futures are freed, though, because all processing futures are spawned with tokio::spawn, you do
260 /// not need to poll the provided future in order to make progress.
261 pub fn setup_outbound<CMH, RMH, L, UMH>(peer_manager: Arc<peer_handler::PeerManager<SocketDescriptor, Arc<CMH>, Arc<RMH>, Arc<L>, Arc<UMH>>>, their_node_id: PublicKey, stream: StdTcpStream) -> impl std::future::Future<Output=()> where
262                 CMH: ChannelMessageHandler + 'static + Send + Sync,
263                 RMH: RoutingMessageHandler + 'static + Send + Sync,
264                 L: Logger + 'static + ?Sized + Send + Sync,
265                 UMH: CustomMessageHandler + 'static + Send + Sync {
266         let (reader, mut write_receiver, read_receiver, us) = Connection::new(stream);
267         #[cfg(debug_assertions)]
268         let last_us = Arc::clone(&us);
269
270         let handle_opt = if let Ok(initial_send) = peer_manager.new_outbound_connection(their_node_id, SocketDescriptor::new(us.clone())) {
271                 Some(tokio::spawn(async move {
272                         // We should essentially always have enough room in a TCP socket buffer to send the
273                         // initial 10s of bytes. However, tokio running in single-threaded mode will always
274                         // fail writes and wake us back up later to write. Thus, we handle a single
275                         // std::task::Poll::Pending but still expect to write the full set of bytes at once
276                         // and use a relatively tight timeout.
277                         if let Ok(Ok(())) = tokio::time::timeout(Duration::from_millis(100), async {
278                                 loop {
279                                         match SocketDescriptor::new(us.clone()).send_data(&initial_send, true) {
280                                                 v if v == initial_send.len() => break Ok(()),
281                                                 0 => {
282                                                         write_receiver.recv().await;
283                                                         // In theory we could check for if we've been instructed to disconnect
284                                                         // the peer here, but its OK to just skip it - we'll check for it in
285                                                         // schedule_read prior to any relevant calls into RL.
286                                                 },
287                                                 _ => {
288                                                         eprintln!("Failed to write first full message to socket!");
289                                                         peer_manager.socket_disconnected(&SocketDescriptor::new(Arc::clone(&us)));
290                                                         break Err(());
291                                                 }
292                                         }
293                                 }
294                         }).await {
295                                 Connection::schedule_read(peer_manager, us, reader, read_receiver, write_receiver).await;
296                         }
297                 }))
298         } else {
299                 // Note that we will skip socket_disconnected here, in accordance with the PeerManager
300                 // requirements.
301                 None
302         };
303
304         async move {
305                 if let Some(handle) = handle_opt {
306                         if let Err(e) = handle.await {
307                                 assert!(e.is_cancelled());
308                         } else {
309                                 // This is certainly not guaranteed to always be true - the read loop may exit
310                                 // while there are still pending write wakers that need to be woken up after the
311                                 // socket shutdown(). Still, as a check during testing, to make sure tokio doesn't
312                                 // keep too many wakers around, this makes sense. The race should be rare (we do
313                                 // some work after shutdown()) and an error would be a major memory leak.
314                                 #[cfg(debug_assertions)]
315                                 assert!(Arc::try_unwrap(last_us).is_ok());
316                         }
317                 }
318         }
319 }
320
321 /// Process incoming messages and feed outgoing messages on a new connection made to the given
322 /// socket address which is expected to be accepted by a peer with the given public key (by
323 /// scheduling futures with tokio::spawn).
324 ///
325 /// Shorthand for TcpStream::connect(addr) with a timeout followed by setup_outbound().
326 ///
327 /// Returns a future (as the fn is async) which needs to be polled to complete the connection and
328 /// connection setup. That future then returns a future which will complete when the peer is
329 /// disconnected and associated handling futures are freed, though, because all processing in said
330 /// futures are spawned with tokio::spawn, you do not need to poll the second future in order to
331 /// make progress.
332 pub async fn connect_outbound<CMH, RMH, L, UMH>(peer_manager: Arc<peer_handler::PeerManager<SocketDescriptor, Arc<CMH>, Arc<RMH>, Arc<L>, Arc<UMH>>>, their_node_id: PublicKey, addr: SocketAddr) -> Option<impl std::future::Future<Output=()>> where
333                 CMH: ChannelMessageHandler + 'static + Send + Sync,
334                 RMH: RoutingMessageHandler + 'static + Send + Sync,
335                 L: Logger + 'static + ?Sized + Send + Sync,
336                 UMH: CustomMessageHandler + 'static + Send + Sync {
337         if let Ok(Ok(stream)) = time::timeout(Duration::from_secs(10), async { TcpStream::connect(&addr).await.map(|s| s.into_std().unwrap()) }).await {
338                 Some(setup_outbound(peer_manager, their_node_id, stream))
339         } else { None }
340 }
341
342 const SOCK_WAKER_VTABLE: task::RawWakerVTable =
343         task::RawWakerVTable::new(clone_socket_waker, wake_socket_waker, wake_socket_waker_by_ref, drop_socket_waker);
344
345 fn clone_socket_waker(orig_ptr: *const ()) -> task::RawWaker {
346         write_avail_to_waker(orig_ptr as *const mpsc::Sender<()>)
347 }
348 // When waking, an error should be fine. Most likely we got two send_datas in a row, both of which
349 // failed to fully write, but we only need to call write_buffer_space_avail() once. Otherwise, the
350 // sending thread may have already gone away due to a socket close, in which case there's nothing
351 // to wake up anyway.
352 fn wake_socket_waker(orig_ptr: *const ()) {
353         let sender = unsafe { &mut *(orig_ptr as *mut mpsc::Sender<()>) };
354         let _ = sender.try_send(());
355         drop_socket_waker(orig_ptr);
356 }
357 fn wake_socket_waker_by_ref(orig_ptr: *const ()) {
358         let sender_ptr = orig_ptr as *const mpsc::Sender<()>;
359         let sender = unsafe { (*sender_ptr).clone() };
360         let _ = sender.try_send(());
361 }
362 fn drop_socket_waker(orig_ptr: *const ()) {
363         let _orig_box = unsafe { Box::from_raw(orig_ptr as *mut mpsc::Sender<()>) };
364         // _orig_box is now dropped
365 }
366 fn write_avail_to_waker(sender: *const mpsc::Sender<()>) -> task::RawWaker {
367         let new_box = Box::leak(Box::new(unsafe { (*sender).clone() }));
368         let new_ptr = new_box as *const mpsc::Sender<()>;
369         task::RawWaker::new(new_ptr as *const (), &SOCK_WAKER_VTABLE)
370 }
371
372 /// The SocketDescriptor used to refer to sockets by a PeerHandler. This is pub only as it is a
373 /// type in the template of PeerHandler.
374 pub struct SocketDescriptor {
375         conn: Arc<Mutex<Connection>>,
376         id: u64,
377 }
378 impl SocketDescriptor {
379         fn new(conn: Arc<Mutex<Connection>>) -> Self {
380                 let id = conn.lock().unwrap().id;
381                 Self { conn, id }
382         }
383 }
384 impl peer_handler::SocketDescriptor for SocketDescriptor {
385         fn send_data(&mut self, data: &[u8], resume_read: bool) -> usize {
386                 // To send data, we take a lock on our Connection to access the WriteHalf of the TcpStream,
387                 // writing to it if there's room in the kernel buffer, or otherwise create a new Waker with
388                 // a SocketDescriptor in it which can wake up the write_avail Sender, waking up the
389                 // processing future which will call write_buffer_space_avail and we'll end up back here.
390                 let mut us = self.conn.lock().unwrap();
391                 if us.writer.is_none() {
392                         // The writer gets take()n when it is time to shut down, so just fast-return 0 here.
393                         return 0;
394                 }
395
396                 if resume_read && us.read_paused {
397                         // The schedule_read future may go to lock up but end up getting woken up by there
398                         // being more room in the write buffer, dropping the other end of this Sender
399                         // before we get here, so we ignore any failures to wake it up.
400                         us.read_paused = false;
401                         let _ = us.read_waker.try_send(());
402                 }
403                 if data.is_empty() { return 0; }
404                 let waker = unsafe { task::Waker::from_raw(write_avail_to_waker(&us.write_avail)) };
405                 let mut ctx = task::Context::from_waker(&waker);
406                 let mut written_len = 0;
407                 loop {
408                         match std::pin::Pin::new(us.writer.as_mut().unwrap()).poll_write(&mut ctx, &data[written_len..]) {
409                                 task::Poll::Ready(Ok(res)) => {
410                                         // The tokio docs *seem* to indicate this can't happen, and I certainly don't
411                                         // know how to handle it if it does (cause it should be a Poll::Pending
412                                         // instead):
413                                         assert_ne!(res, 0);
414                                         written_len += res;
415                                         if written_len == data.len() { return written_len; }
416                                 },
417                                 task::Poll::Ready(Err(e)) => {
418                                         // The tokio docs *seem* to indicate this can't happen, and I certainly don't
419                                         // know how to handle it if it does (cause it should be a Poll::Pending
420                                         // instead):
421                                         assert_ne!(e.kind(), io::ErrorKind::WouldBlock);
422                                         // Probably we've already been closed, just return what we have and let the
423                                         // read thread handle closing logic.
424                                         return written_len;
425                                 },
426                                 task::Poll::Pending => {
427                                         // We're queued up for a write event now, but we need to make sure we also
428                                         // pause read given we're now waiting on the remote end to ACK (and in
429                                         // accordance with the send_data() docs).
430                                         us.read_paused = true;
431                                         return written_len;
432                                 },
433                         }
434                 }
435         }
436
437         fn disconnect_socket(&mut self) {
438                 let mut us = self.conn.lock().unwrap();
439                 us.rl_requested_disconnect = true;
440                 // Wake up the sending thread, assuming it is still alive
441                 let _ = us.write_avail.try_send(());
442         }
443 }
444 impl Clone for SocketDescriptor {
445         fn clone(&self) -> Self {
446                 Self {
447                         conn: Arc::clone(&self.conn),
448                         id: self.id,
449                 }
450         }
451 }
452 impl Eq for SocketDescriptor {}
453 impl PartialEq for SocketDescriptor {
454         fn eq(&self, o: &Self) -> bool {
455                 self.id == o.id
456         }
457 }
458 impl Hash for SocketDescriptor {
459         fn hash<H: std::hash::Hasher>(&self, state: &mut H) {
460                 self.id.hash(state);
461         }
462 }
463
464 #[cfg(test)]
465 mod tests {
466         use lightning::ln::features::*;
467         use lightning::ln::msgs::*;
468         use lightning::ln::peer_handler::{MessageHandler, PeerManager};
469         use lightning::util::events::*;
470         use bitcoin::secp256k1::{Secp256k1, SecretKey, PublicKey};
471
472         use tokio::sync::mpsc;
473
474         use std::mem;
475         use std::sync::atomic::{AtomicBool, Ordering};
476         use std::sync::{Arc, Mutex};
477         use std::time::Duration;
478
479         pub struct TestLogger();
480         impl lightning::util::logger::Logger for TestLogger {
481                 fn log(&self, record: &lightning::util::logger::Record) {
482                         println!("{:<5} [{} : {}, {}] {}", record.level.to_string(), record.module_path, record.file, record.line, record.args);
483                 }
484         }
485
486         struct MsgHandler{
487                 expected_pubkey: PublicKey,
488                 pubkey_connected: mpsc::Sender<()>,
489                 pubkey_disconnected: mpsc::Sender<()>,
490                 disconnected_flag: AtomicBool,
491                 msg_events: Mutex<Vec<MessageSendEvent>>,
492         }
493         impl RoutingMessageHandler for MsgHandler {
494                 fn handle_node_announcement(&self, _msg: &NodeAnnouncement) -> Result<bool, LightningError> { Ok(false) }
495                 fn handle_channel_announcement(&self, _msg: &ChannelAnnouncement) -> Result<bool, LightningError> { Ok(false) }
496                 fn handle_channel_update(&self, _msg: &ChannelUpdate) -> Result<bool, LightningError> { Ok(false) }
497                 fn handle_htlc_fail_channel_update(&self, _update: &HTLCFailChannelUpdate) { }
498                 fn get_next_channel_announcements(&self, _starting_point: u64, _batch_amount: u8) -> Vec<(ChannelAnnouncement, Option<ChannelUpdate>, Option<ChannelUpdate>)> { Vec::new() }
499                 fn get_next_node_announcements(&self, _starting_point: Option<&PublicKey>, _batch_amount: u8) -> Vec<NodeAnnouncement> { Vec::new() }
500                 fn sync_routing_table(&self, _their_node_id: &PublicKey, _init_msg: &Init) { }
501                 fn handle_reply_channel_range(&self, _their_node_id: &PublicKey, _msg: ReplyChannelRange) -> Result<(), LightningError> { Ok(()) }
502                 fn handle_reply_short_channel_ids_end(&self, _their_node_id: &PublicKey, _msg: ReplyShortChannelIdsEnd) -> Result<(), LightningError> { Ok(()) }
503                 fn handle_query_channel_range(&self, _their_node_id: &PublicKey, _msg: QueryChannelRange) -> Result<(), LightningError> { Ok(()) }
504                 fn handle_query_short_channel_ids(&self, _their_node_id: &PublicKey, _msg: QueryShortChannelIds) -> Result<(), LightningError> { Ok(()) }
505         }
506         impl ChannelMessageHandler for MsgHandler {
507                 fn handle_open_channel(&self, _their_node_id: &PublicKey, _their_features: InitFeatures, _msg: &OpenChannel) {}
508                 fn handle_accept_channel(&self, _their_node_id: &PublicKey, _their_features: InitFeatures, _msg: &AcceptChannel) {}
509                 fn handle_funding_created(&self, _their_node_id: &PublicKey, _msg: &FundingCreated) {}
510                 fn handle_funding_signed(&self, _their_node_id: &PublicKey, _msg: &FundingSigned) {}
511                 fn handle_funding_locked(&self, _their_node_id: &PublicKey, _msg: &FundingLocked) {}
512                 fn handle_shutdown(&self, _their_node_id: &PublicKey, _their_features: &InitFeatures, _msg: &Shutdown) {}
513                 fn handle_closing_signed(&self, _their_node_id: &PublicKey, _msg: &ClosingSigned) {}
514                 fn handle_update_add_htlc(&self, _their_node_id: &PublicKey, _msg: &UpdateAddHTLC) {}
515                 fn handle_update_fulfill_htlc(&self, _their_node_id: &PublicKey, _msg: &UpdateFulfillHTLC) {}
516                 fn handle_update_fail_htlc(&self, _their_node_id: &PublicKey, _msg: &UpdateFailHTLC) {}
517                 fn handle_update_fail_malformed_htlc(&self, _their_node_id: &PublicKey, _msg: &UpdateFailMalformedHTLC) {}
518                 fn handle_commitment_signed(&self, _their_node_id: &PublicKey, _msg: &CommitmentSigned) {}
519                 fn handle_revoke_and_ack(&self, _their_node_id: &PublicKey, _msg: &RevokeAndACK) {}
520                 fn handle_update_fee(&self, _their_node_id: &PublicKey, _msg: &UpdateFee) {}
521                 fn handle_announcement_signatures(&self, _their_node_id: &PublicKey, _msg: &AnnouncementSignatures) {}
522                 fn handle_channel_update(&self, _their_node_id: &PublicKey, _msg: &ChannelUpdate) {}
523                 fn peer_disconnected(&self, their_node_id: &PublicKey, _no_connection_possible: bool) {
524                         if *their_node_id == self.expected_pubkey {
525                                 self.disconnected_flag.store(true, Ordering::SeqCst);
526                                 self.pubkey_disconnected.clone().try_send(()).unwrap();
527                         }
528                 }
529                 fn peer_connected(&self, their_node_id: &PublicKey, _msg: &Init) {
530                         if *their_node_id == self.expected_pubkey {
531                                 self.pubkey_connected.clone().try_send(()).unwrap();
532                         }
533                 }
534                 fn handle_channel_reestablish(&self, _their_node_id: &PublicKey, _msg: &ChannelReestablish) {}
535                 fn handle_error(&self, _their_node_id: &PublicKey, _msg: &ErrorMessage) {}
536         }
537         impl MessageSendEventsProvider for MsgHandler {
538                 fn get_and_clear_pending_msg_events(&self) -> Vec<MessageSendEvent> {
539                         let mut ret = Vec::new();
540                         mem::swap(&mut *self.msg_events.lock().unwrap(), &mut ret);
541                         ret
542                 }
543         }
544
545         async fn do_basic_connection_test() {
546                 let secp_ctx = Secp256k1::new();
547                 let a_key = SecretKey::from_slice(&[1; 32]).unwrap();
548                 let b_key = SecretKey::from_slice(&[1; 32]).unwrap();
549                 let a_pub = PublicKey::from_secret_key(&secp_ctx, &a_key);
550                 let b_pub = PublicKey::from_secret_key(&secp_ctx, &b_key);
551
552                 let (a_connected_sender, mut a_connected) = mpsc::channel(1);
553                 let (a_disconnected_sender, mut a_disconnected) = mpsc::channel(1);
554                 let a_handler = Arc::new(MsgHandler {
555                         expected_pubkey: b_pub,
556                         pubkey_connected: a_connected_sender,
557                         pubkey_disconnected: a_disconnected_sender,
558                         disconnected_flag: AtomicBool::new(false),
559                         msg_events: Mutex::new(Vec::new()),
560                 });
561                 let a_manager = Arc::new(PeerManager::new(MessageHandler {
562                         chan_handler: Arc::clone(&a_handler),
563                         route_handler: Arc::clone(&a_handler),
564                 }, a_key.clone(), &[1; 32], Arc::new(TestLogger()), Arc::new(lightning::ln::peer_handler::IgnoringMessageHandler{})));
565
566                 let (b_connected_sender, mut b_connected) = mpsc::channel(1);
567                 let (b_disconnected_sender, mut b_disconnected) = mpsc::channel(1);
568                 let b_handler = Arc::new(MsgHandler {
569                         expected_pubkey: a_pub,
570                         pubkey_connected: b_connected_sender,
571                         pubkey_disconnected: b_disconnected_sender,
572                         disconnected_flag: AtomicBool::new(false),
573                         msg_events: Mutex::new(Vec::new()),
574                 });
575                 let b_manager = Arc::new(PeerManager::new(MessageHandler {
576                         chan_handler: Arc::clone(&b_handler),
577                         route_handler: Arc::clone(&b_handler),
578                 }, b_key.clone(), &[2; 32], Arc::new(TestLogger()), Arc::new(lightning::ln::peer_handler::IgnoringMessageHandler{})));
579
580                 // We bind on localhost, hoping the environment is properly configured with a local
581                 // address. This may not always be the case in containers and the like, so if this test is
582                 // failing for you check that you have a loopback interface and it is configured with
583                 // 127.0.0.1.
584                 let (conn_a, conn_b) = if let Ok(listener) = std::net::TcpListener::bind("127.0.0.1:9735") {
585                         (std::net::TcpStream::connect("127.0.0.1:9735").unwrap(), listener.accept().unwrap().0)
586                 } else if let Ok(listener) = std::net::TcpListener::bind("127.0.0.1:9999") {
587                         (std::net::TcpStream::connect("127.0.0.1:9999").unwrap(), listener.accept().unwrap().0)
588                 } else if let Ok(listener) = std::net::TcpListener::bind("127.0.0.1:46926") {
589                         (std::net::TcpStream::connect("127.0.0.1:46926").unwrap(), listener.accept().unwrap().0)
590                 } else { panic!("Failed to bind to v4 localhost on common ports"); };
591
592                 let fut_a = super::setup_outbound(Arc::clone(&a_manager), b_pub, conn_a);
593                 let fut_b = super::setup_inbound(b_manager, conn_b);
594
595                 tokio::time::timeout(Duration::from_secs(10), a_connected.recv()).await.unwrap();
596                 tokio::time::timeout(Duration::from_secs(1), b_connected.recv()).await.unwrap();
597
598                 a_handler.msg_events.lock().unwrap().push(MessageSendEvent::HandleError {
599                         node_id: b_pub, action: ErrorAction::DisconnectPeer { msg: None }
600                 });
601                 assert!(!a_handler.disconnected_flag.load(Ordering::SeqCst));
602                 assert!(!b_handler.disconnected_flag.load(Ordering::SeqCst));
603
604                 a_manager.process_events();
605                 tokio::time::timeout(Duration::from_secs(10), a_disconnected.recv()).await.unwrap();
606                 tokio::time::timeout(Duration::from_secs(1), b_disconnected.recv()).await.unwrap();
607                 assert!(a_handler.disconnected_flag.load(Ordering::SeqCst));
608                 assert!(b_handler.disconnected_flag.load(Ordering::SeqCst));
609
610                 fut_a.await;
611                 fut_b.await;
612         }
613
614         #[tokio::test(flavor = "multi_thread")]
615         async fn basic_threaded_connection_test() {
616                 do_basic_connection_test().await;
617         }
618         #[tokio::test]
619         async fn basic_unthreaded_connection_test() {
620                 do_basic_connection_test().await;
621         }
622 }