git.bitcoin.ninja Git - rust-lightning/blob - fuzz/src/full_stack.rs

   1 //! Test that no series of bytes received over the wire/connections created/payments sent can
   2 //! result in a crash. We do this by standing up a node and then reading bytes from input to denote
   3 //! actions such as creating new inbound/outbound connections, bytes to be read from a connection,
   4 //! or payments to send/ways to handle events generated.
   5 //! This test has been very useful, though due to its complexity good starting inputs are critical.
   6
   7 use bitcoin::blockdata::block::BlockHeader;
   8 use bitcoin::blockdata::transaction::{Transaction, TxOut};
   9 use bitcoin::blockdata::script::{Builder, Script};
  10 use bitcoin::blockdata::opcodes;
  11 use bitcoin::consensus::encode::deserialize;
  12 use bitcoin::network::constants::Network;
  13 use bitcoin::util::hash::BitcoinHash;
  14
  15 use bitcoin_hashes::Hash as TraitImport;
  16 use bitcoin_hashes::HashEngine as TraitImportEngine;
  17 use bitcoin_hashes::sha256::Hash as Sha256;
  18 use bitcoin_hashes::hash160::Hash as Hash160;
  19 use bitcoin_hashes::sha256d::Hash as Sha256dHash;
  20
  21 use lightning::chain::chaininterface::{BroadcasterInterface,ConfirmationTarget,ChainListener,FeeEstimator,ChainWatchInterfaceUtil};
  22 use lightning::chain::transaction::OutPoint;
  23 use lightning::chain::keysinterface::{InMemoryChannelKeys, KeysInterface};
  24 use lightning::ln::channelmonitor;
  25 use lightning::ln::channelmanager::{ChannelManager, PaymentHash, PaymentPreimage};
  26 use lightning::ln::peer_handler::{MessageHandler,PeerManager,SocketDescriptor};
  27 use lightning::ln::router::Router;
  28 use lightning::util::events::{EventsProvider,Event};
  29 use lightning::util::enforcing_trait_impls::EnforcingChannelKeys;
  30 use lightning::util::logger::Logger;
  31 use lightning::util::config::UserConfig;
  32
  33 use utils::test_logger;
  34
  35 use secp256k1::key::{PublicKey,SecretKey};
  36 use secp256k1::Secp256k1;
  37
  38 use std::cell::RefCell;
  39 use std::collections::{HashMap, hash_map};
  40 use std::cmp;
  41 use std::hash::Hash;
  42 use std::sync::{Arc,Mutex};
  43 use std::sync::atomic::{AtomicU64,AtomicUsize,Ordering};
  44
  45 #[inline]
  46 pub fn slice_to_be16(v: &[u8]) -> u16 {
  47         ((v[0] as u16) << 8*1) |
  48         ((v[1] as u16) << 8*0)
  49 }
  50
  51 #[inline]
  52 pub fn slice_to_be24(v: &[u8]) -> u32 {
  53         ((v[0] as u32) << 8*2) |
  54         ((v[1] as u32) << 8*1) |
  55         ((v[2] as u32) << 8*0)
  56 }
  57
  58 #[inline]
  59 pub fn slice_to_be32(v: &[u8]) -> u32 {
  60         ((v[0] as u32) << 8*3) |
  61         ((v[1] as u32) << 8*2) |
  62         ((v[2] as u32) << 8*1) |
  63         ((v[3] as u32) << 8*0)
  64 }
  65
  66 #[inline]
  67 pub fn be64_to_array(u: u64) -> [u8; 8] {
  68         let mut v = [0; 8];
  69         v[0] = ((u >> 8*7) & 0xff) as u8;
  70         v[1] = ((u >> 8*6) & 0xff) as u8;
  71         v[2] = ((u >> 8*5) & 0xff) as u8;
  72         v[3] = ((u >> 8*4) & 0xff) as u8;
  73         v[4] = ((u >> 8*3) & 0xff) as u8;
  74         v[5] = ((u >> 8*2) & 0xff) as u8;
  75         v[6] = ((u >> 8*1) & 0xff) as u8;
  76         v[7] = ((u >> 8*0) & 0xff) as u8;
  77         v
  78 }
  79
  80 struct InputData {
  81         data: Vec<u8>,
  82         read_pos: AtomicUsize,
  83 }
  84 impl InputData {
  85         fn get_slice(&self, len: usize) -> Option<&[u8]> {
  86                 let old_pos = self.read_pos.fetch_add(len, Ordering::AcqRel);
  87                 if self.data.len() < old_pos + len {
  88                         return None;
  89                 }
  90                 Some(&self.data[old_pos..old_pos + len])
  91         }
  92 }
  93
  94 struct FuzzEstimator {
  95         input: Arc<InputData>,
  96 }
  97 impl FeeEstimator for FuzzEstimator {
  98         fn get_est_sat_per_1000_weight(&self, _: ConfirmationTarget) -> u64 {
  99 println!("fee_get");
 100                 //TODO: We should actually be testing at least much more than 64k...
 101                 match self.input.get_slice(2) {
 102                         Some(slice) => cmp::max(slice_to_be16(slice) as u64, 253),
 103                         None => 0
 104                 }
 105         }
 106 }
 107
 108 pub struct TestBroadcaster {
 109         pub txn_broadcasted: Mutex<Vec<Transaction>>,
 110 }
 111 impl BroadcasterInterface for TestBroadcaster {
 112         fn broadcast_transaction(&self, tx: &Transaction) {
 113                 self.txn_broadcasted.lock().unwrap().push(tx.clone());
 114         }
 115 }
 116
 117 #[derive(Clone)]
 118 struct Peer<'a> {
 119         id: u8,
 120         peers_connected: &'a RefCell<[bool; 256]>,
 121 }
 122 impl<'a> SocketDescriptor for Peer<'a> {
 123         fn send_data(&mut self, data: &[u8], _resume_read: bool) -> usize {
 124                 data.len()
 125         }
 126         fn disconnect_socket(&mut self) {
 127                 assert!(self.peers_connected.borrow()[self.id as usize]);
 128                 self.peers_connected.borrow_mut()[self.id as usize] = false;
 129         }
 130 }
 131 impl<'a> PartialEq for Peer<'a> {
 132         fn eq(&self, other: &Self) -> bool {
 133                 self.id == other.id
 134         }
 135 }
 136 impl<'a> Eq for Peer<'a> {}
 137 impl<'a> Hash for Peer<'a> {
 138         fn hash<H : std::hash::Hasher>(&self, h: &mut H) {
 139                 self.id.hash(h)
 140         }
 141 }
 142
 143 struct MoneyLossDetector<'a> {
 144         manager: Arc<ChannelManager<EnforcingChannelKeys, Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>>>,
 145         monitor: Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>,
 146         broadcaster: Arc<TestBroadcaster>,
 147         handler: PeerManager<Peer<'a>, Arc<ChannelManager<EnforcingChannelKeys, Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>>>>,
 148
 149         peers: &'a RefCell<[bool; 256]>,
 150         funding_txn: Vec<Transaction>,
 151         txids_confirmed: HashMap<Sha256dHash, usize>,
 152         header_hashes: Vec<Sha256dHash>,
 153         height: usize,
 154         max_height: usize,
 155         blocks_connected: u32,
 156 }
 157 impl<'a> MoneyLossDetector<'a> {
 158         pub fn new(peers: &'a RefCell<[bool; 256]>, manager: Arc<ChannelManager<EnforcingChannelKeys, Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>>>, monitor: Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>, broadcaster: Arc<TestBroadcaster>, handler: PeerManager<Peer<'a>, Arc<ChannelManager<EnforcingChannelKeys, Arc<channelmonitor::SimpleManyChannelMonitor<OutPoint>>>>>) -> Self {
 159                 MoneyLossDetector {
 160                         manager,
 161                         monitor,
 162                         broadcaster,
 163                         handler,
 164
 165                         peers,
 166                         funding_txn: Vec::new(),
 167                         txids_confirmed: HashMap::new(),
 168                         header_hashes: vec![Default::default()],
 169                         height: 0,
 170                         max_height: 0,
 171                         blocks_connected: 0,
 172                 }
 173         }
 174
 175         fn connect_block(&mut self, all_txn: &[Transaction]) {
 176                 let mut txn = Vec::with_capacity(all_txn.len());
 177                 let mut txn_idxs = Vec::with_capacity(all_txn.len());
 178                 for (idx, tx) in all_txn.iter().enumerate() {
 179                         let txid = tx.txid();
 180                         match self.txids_confirmed.entry(txid) {
 181                                 hash_map::Entry::Vacant(e) => {
 182                                         e.insert(self.height);
 183                                         txn.push(tx);
 184                                         txn_idxs.push(idx as u32 + 1);
 185                                 },
 186                                 _ => {},
 187                         }
 188                 }
 189
 190                 let header = BlockHeader { version: 0x20000000, prev_blockhash: self.header_hashes[self.height], merkle_root: Default::default(), time: self.blocks_connected, bits: 42, nonce: 42 };
 191                 self.height += 1;
 192                 self.blocks_connected += 1;
 193                 self.manager.block_connected(&header, self.height as u32, &txn[..], &txn_idxs[..]);
 194                 (*self.monitor).block_connected(&header, self.height as u32, &txn[..], &txn_idxs[..]);
 195                 if self.header_hashes.len() > self.height {
 196                         self.header_hashes[self.height] = header.bitcoin_hash();
 197                 } else {
 198                         assert_eq!(self.header_hashes.len(), self.height);
 199                         self.header_hashes.push(header.bitcoin_hash());
 200                 }
 201                 self.max_height = cmp::max(self.height, self.max_height);
 202         }
 203
 204         fn disconnect_block(&mut self) {
 205                 if self.height > 0 && (self.max_height < 6 || self.height >= self.max_height - 6) {
 206                         let header = BlockHeader { version: 0x20000000, prev_blockhash: self.header_hashes[self.height], merkle_root: Default::default(), time: 42, bits: 42, nonce: 42 };
 207                         self.manager.block_disconnected(&header, self.height as u32);
 208                         self.monitor.block_disconnected(&header, self.height as u32);
 209                         self.height -= 1;
 210                         let removal_height = self.height;
 211                         self.txids_confirmed.retain(|_, height| {
 212                                 removal_height != *height
 213                         });
 214                 }
 215         }
 216 }
 217
 218 impl<'a> Drop for MoneyLossDetector<'a> {
 219         fn drop(&mut self) {
 220                 if !::std::thread::panicking() {
 221                         // Disconnect all peers
 222                         for (idx, peer) in self.peers.borrow().iter().enumerate() {
 223                                 if *peer {
 224                                         self.handler.disconnect_event(&Peer{id: idx as u8, peers_connected: &self.peers});
 225                                 }
 226                         }
 227
 228                         // Force all channels onto the chain (and time out claim txn)
 229                         self.manager.force_close_all_channels();
 230                         for _ in 0..6*24*14 {
 231                                 self.connect_block(&[]);
 232                         }
 233                 }
 234
 235                 // Test that all broadcasted transactions either spend one of our funding transactions or
 236                 // some other broadcasted transaction:
 237
 238                 let mut txn_map = HashMap::new();
 239                 let mut funding_txn_map = HashMap::new();
 240                 for tx in self.funding_txn.drain(..) {
 241                         funding_txn_map.insert(tx.bitcoin_hash(), tx);
 242                 }
 243                 let mut txn_broadcasted = self.broadcaster.txn_broadcasted.lock().unwrap();
 244                 for tx in txn_broadcasted.drain(..) {
 245                         txn_map.insert(tx.bitcoin_hash(), tx);
 246                 }
 247                 /*for (_, tx) in txn_map.iter() {
 248                         for inp in tx.input.iter() {
 249                                 let prev_tx = match funding_txn_map.get(&inp.prev_hash) {
 250                                         Some(ptx) => ptx,
 251                                         None => {
 252                                                 txn_map.get(&inp.prev_hash).unwrap()
 253                                         }
 254                                 };
 255                                 assert!(prev_tx.output.len() > inp.prev_index as usize);
 256                         }
 257                 }*/
 258
 259                 //XXX: Find all non-conflicting sets of txn broadcasted and ensure that in each case we
 260                 //always get back at least the amount we expect minus tx fees (which we should be able to
 261                 //calculate now!
 262         }
 263 }
 264
 265 struct KeyProvider {
 266         node_secret: SecretKey,
 267         counter: AtomicU64,
 268 }
 269 impl KeysInterface for KeyProvider {
 270         type ChanKeySigner = EnforcingChannelKeys;
 271
 272         fn get_node_secret(&self) -> SecretKey {
 273                 self.node_secret.clone()
 274         }
 275
 276         fn get_destination_script(&self) -> Script {
 277                 let secp_ctx = Secp256k1::signing_only();
 278                 let channel_monitor_claim_key = SecretKey::from_slice(&hex::decode("0fffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff").unwrap()[..]).unwrap();
 279                 let our_channel_monitor_claim_key_hash = <Hash160 as bitcoin_hashes::Hash>::hash(&PublicKey::from_secret_key(&secp_ctx, &channel_monitor_claim_key).serialize());
 280                 Builder::new().push_opcode(opcodes::all::OP_PUSHBYTES_0).push_slice(&our_channel_monitor_claim_key_hash[..]).into_script()
 281         }
 282
 283         fn get_shutdown_pubkey(&self) -> PublicKey {
 284                 let secp_ctx = Secp256k1::signing_only();
 285                 PublicKey::from_secret_key(&secp_ctx, &SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]).unwrap())
 286         }
 287
 288         fn get_channel_keys(&self, inbound: bool, channel_value_satoshis: u64) -> EnforcingChannelKeys {
 289                 let ctr = self.counter.fetch_add(1, Ordering::Relaxed) as u8;
 290                 EnforcingChannelKeys::new(if inbound {
 291                         InMemoryChannelKeys {
 292                                 funding_key:               SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1, ctr]).unwrap(),
 293                                 revocation_base_key:       SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 2, ctr]).unwrap(),
 294                                 payment_base_key:          SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, ctr]).unwrap(),
 295                                 delayed_payment_base_key:  SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 4, ctr]).unwrap(),
 296                                 htlc_base_key:             SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 5, ctr]).unwrap(),
 297                                 commitment_seed: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 6, ctr],
 298                                 remote_channel_pubkeys: None,
 299                                 channel_value_satoshis: channel_value_satoshis,
 300                         }
 301                 } else {
 302                         InMemoryChannelKeys {
 303                                 funding_key:               SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 7, ctr]).unwrap(),
 304                                 revocation_base_key:       SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 8, ctr]).unwrap(),
 305                                 payment_base_key:          SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 9, ctr]).unwrap(),
 306                                 delayed_payment_base_key:  SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 10, ctr]).unwrap(),
 307                                 htlc_base_key:             SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 11, ctr]).unwrap(),
 308                                 commitment_seed: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 12, ctr],
 309                                 remote_channel_pubkeys: None,
 310                                 channel_value_satoshis: channel_value_satoshis,
 311                         }
 312                 })
 313         }
 314
 315         fn get_onion_rand(&self) -> (SecretKey, [u8; 32]) {
 316                 let ctr = self.counter.fetch_add(1, Ordering::Relaxed) as u8;
 317                 (SecretKey::from_slice(&[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 13, ctr]).unwrap(),
 318                 [0; 32])
 319         }
 320
 321         fn get_channel_id(&self) -> [u8; 32] {
 322                 let ctr = self.counter.fetch_add(1, Ordering::Relaxed);
 323                 [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,
 324                 (ctr >> 8*7) as u8, (ctr >> 8*6) as u8, (ctr >> 8*5) as u8, (ctr >> 8*4) as u8, (ctr >> 8*3) as u8, (ctr >> 8*2) as u8, (ctr >> 8*1) as u8, 14, (ctr >> 8*0) as u8]
 325         }
 326 }
 327
 328 #[inline]
 329 pub fn do_test(data: &[u8], logger: &Arc<dyn Logger>) {
 330         let input = Arc::new(InputData {
 331                 data: data.to_vec(),
 332                 read_pos: AtomicUsize::new(0),
 333         });
 334         let fee_est = Arc::new(FuzzEstimator {
 335                 input: input.clone(),
 336         });
 337
 338         macro_rules! get_slice {
 339                 ($len: expr) => {
 340                         match input.get_slice($len as usize) {
 341                                 Some(slice) => slice,
 342                                 None => return,
 343                         }
 344                 }
 345         }
 346
 347         macro_rules! get_pubkey {
 348                 () => {
 349                         match PublicKey::from_slice(get_slice!(33)) {
 350                                 Ok(key) => key,
 351                                 Err(_) => return,
 352                         }
 353                 }
 354         }
 355
 356         let our_network_key = match SecretKey::from_slice(get_slice!(32)) {
 357                 Ok(key) => key,
 358                 Err(_) => return,
 359         };
 360
 361         let watch = Arc::new(ChainWatchInterfaceUtil::new(Network::Bitcoin, Arc::clone(&logger)));
 362         let broadcast = Arc::new(TestBroadcaster{ txn_broadcasted: Mutex::new(Vec::new()) });
 363         let monitor = Arc::new(channelmonitor::SimpleManyChannelMonitor::new(watch.clone(), broadcast.clone(), Arc::clone(&logger), fee_est.clone()));
 364
 365         let keys_manager = Arc::new(KeyProvider { node_secret: our_network_key.clone(), counter: AtomicU64::new(0) });
 366         let mut config = UserConfig::default();
 367         config.channel_options.fee_proportional_millionths =  slice_to_be32(get_slice!(4));
 368         config.channel_options.announced_channel = get_slice!(1)[0] != 0;
 369         config.peer_channel_config_limits.min_dust_limit_satoshis = 0;
 370         let channelmanager = Arc::new(ChannelManager::new(Network::Bitcoin, fee_est.clone(), monitor.clone(), broadcast.clone(), Arc::clone(&logger), keys_manager.clone(), config, 0).unwrap());
 371         let router = Arc::new(Router::new(PublicKey::from_secret_key(&Secp256k1::signing_only(), &keys_manager.get_node_secret()), watch.clone(), Arc::clone(&logger)));
 372
 373         let peers = RefCell::new([false; 256]);
 374         let mut loss_detector = MoneyLossDetector::new(&peers, channelmanager.clone(), monitor.clone(), broadcast.clone(), PeerManager::new(MessageHandler {
 375                 chan_handler: channelmanager.clone(),
 376                 route_handler: router.clone(),
 377         }, our_network_key, &[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 15, 0], Arc::clone(&logger)));
 378
 379         let mut should_forward = false;
 380         let mut payments_received: Vec<(PaymentHash, Option<[u8; 32]>, u64)> = Vec::new();
 381         let mut payments_sent = 0;
 382         let mut pending_funding_generation: Vec<([u8; 32], u64, Script)> = Vec::new();
 383         let mut pending_funding_signatures = HashMap::new();
 384         let mut pending_funding_relay = Vec::new();
 385
 386         loop {
 387 let a = get_slice!(1)[0];
 388 println!("action: {}", a);
 389                 match a {
 390                         0 => {
 391                                 let mut new_id = 0;
 392                                 for i in 1..256 {
 393                                         if !peers.borrow()[i-1] {
 394                                                 new_id = i;
 395                                                 break;
 396                                         }
 397                                 }
 398                                 if new_id == 0 { return; }
 399                                 loss_detector.handler.new_outbound_connection(get_pubkey!(), Peer{id: (new_id - 1) as u8, peers_connected: &peers}).unwrap();
 400                                 peers.borrow_mut()[new_id - 1] = true;
 401                         },
 402                         1 => {
 403                                 let mut new_id = 0;
 404                                 for i in 1..256 {
 405                                         if !peers.borrow()[i-1] {
 406                                                 new_id = i;
 407                                                 break;
 408                                         }
 409                                 }
 410                                 if new_id == 0 { return; }
 411                                 loss_detector.handler.new_inbound_connection(Peer{id: (new_id - 1) as u8, peers_connected: &peers}).unwrap();
 412                                 peers.borrow_mut()[new_id - 1] = true;
 413                         },
 414                         2 => {
 415                                 let peer_id = get_slice!(1)[0];
 416                                 if !peers.borrow()[peer_id as usize] { return; }
 417                                 loss_detector.handler.disconnect_event(&Peer{id: peer_id, peers_connected: &peers});
 418                                 peers.borrow_mut()[peer_id as usize] = false;
 419                         },
 420                         3 => {
 421                                 let peer_id = get_slice!(1)[0];
 422                                 if !peers.borrow()[peer_id as usize] { return; }
 423                                 match loss_detector.handler.read_event(&mut Peer{id: peer_id, peers_connected: &peers}, get_slice!(get_slice!(1)[0])) {
 424                                         Ok(res) => assert!(!res),
 425                                         Err(_) => { peers.borrow_mut()[peer_id as usize] = false; }
 426                                 }
 427                         },
 428                         4 => {
 429                                 let value = slice_to_be24(get_slice!(3)) as u64;
 430                                 let route = match router.get_route(&get_pubkey!(), None, &Vec::new(), value, 42) {
 431                                         Ok(route) => route,
 432                                         Err(_) => return,
 433                                 };
 434                                 let mut payment_hash = PaymentHash([0; 32]);
 435                                 payment_hash.0[0..8].copy_from_slice(&be64_to_array(payments_sent));
 436                                 let mut sha = Sha256::engine();
 437                                 sha.input(&payment_hash.0[..]);
 438                                 payment_hash.0 = Sha256::from_engine(sha).into_inner();
 439                                 payments_sent += 1;
 440                                 match channelmanager.send_payment(route, payment_hash, None) {
 441                                         Ok(_) => {},
 442                                         Err(_) => return,
 443                                 }
 444                         },
 445                         5 => {
 446                                 let peer_id = get_slice!(1)[0];
 447                                 if !peers.borrow()[peer_id as usize] { return; }
 448                                 let their_key = get_pubkey!();
 449                                 let chan_value = slice_to_be24(get_slice!(3)) as u64;
 450                                 let push_msat_value = slice_to_be24(get_slice!(3)) as u64;
 451                                 if channelmanager.create_channel(their_key, chan_value, push_msat_value, 0).is_err() { return; }
 452                         },
 453                         6 => {
 454                                 let mut channels = channelmanager.list_channels();
 455                                 let channel_id = get_slice!(1)[0] as usize;
 456                                 if channel_id >= channels.len() { return; }
 457                                 channels.sort_by(|a, b| { a.channel_id.cmp(&b.channel_id) });
 458                                 if channelmanager.close_channel(&channels[channel_id].channel_id).is_err() { return; }
 459                         },
 460                         7 => {
 461                                 if should_forward {
 462                                         channelmanager.process_pending_htlc_forwards();
 463                                         should_forward = false;
 464                                 }
 465                         },
 466                         8 => {
 467                                 for (payment, payment_secret, amt) in payments_received.drain(..) {
 468                                         // SHA256 is defined as XOR of all input bytes placed in the first byte, and 0s
 469                                         // for the remaining bytes. Thus, if not all remaining bytes are 0s we cannot
 470                                         // fulfill this HTLC, but if they are, we can just take the first byte and
 471                                         // place that anywhere in our preimage.
 472                                         if &payment.0[1..] != &[0; 31] {
 473                                                 channelmanager.fail_htlc_backwards(&payment, &payment_secret);
 474                                         } else {
 475                                                 let mut payment_preimage = PaymentPreimage([0; 32]);
 476                                                 payment_preimage.0[0] = payment.0[0];
 477                                                 channelmanager.claim_funds(payment_preimage, &payment_secret, amt);
 478                                         }
 479                                 }
 480                         },
 481                         9 => {
 482                                 for (payment, payment_secret, _) in payments_received.drain(..) {
 483                                         channelmanager.fail_htlc_backwards(&payment, &payment_secret);
 484                                 }
 485                         },
 486                         10 => {
 487                                 'outer_loop: for funding_generation in pending_funding_generation.drain(..) {
 488                                         let mut tx = Transaction { version: 0, lock_time: 0, input: Vec::new(), output: vec![TxOut {
 489                                                         value: funding_generation.1, script_pubkey: funding_generation.2,
 490                                                 }] };
 491                                         let funding_output = 'search_loop: loop {
 492                                                 let funding_txid = tx.txid();
 493                                                 if let None = loss_detector.txids_confirmed.get(&funding_txid) {
 494                                                         let outpoint = OutPoint::new(funding_txid, 0);
 495                                                         for chan in channelmanager.list_channels() {
 496                                                                 if chan.channel_id == outpoint.to_channel_id() {
 497                                                                         tx.version += 1;
 498                                                                         continue 'search_loop;
 499                                                                 }
 500                                                         }
 501                                                         break outpoint;
 502                                                 }
 503                                                 tx.version += 1;
 504                                                 if tx.version > 0xff {
 505                                                         continue 'outer_loop;
 506                                                 }
 507                                         };
 508                                         channelmanager.funding_transaction_generated(&funding_generation.0, funding_output.clone());
 509                                         pending_funding_signatures.insert(funding_output, tx);
 510                                 }
 511                         },
 512                         11 => {
 513                                 if !pending_funding_relay.is_empty() {
 514                                         loss_detector.connect_block(&pending_funding_relay[..]);
 515                                         for _ in 2..100 {
 516                                                 loss_detector.connect_block(&[]);
 517                                         }
 518                                 }
 519                                 for tx in pending_funding_relay.drain(..) {
 520                                         loss_detector.funding_txn.push(tx);
 521                                 }
 522                         },
 523                         12 => {
 524                                 let txlen = slice_to_be16(get_slice!(2));
 525                                 if txlen == 0 {
 526                                         loss_detector.connect_block(&[]);
 527                                 } else {
 528                                         let txres: Result<Transaction, _> = deserialize(get_slice!(txlen));
 529                                         if let Ok(tx) = txres {
 530                                                 let mut output_val = 0;
 531                                                 for out in tx.output.iter() {
 532                                                         if out.value > 21_000_000_0000_0000 { return; }
 533                                                         output_val += out.value;
 534                                                         if output_val > 21_000_000_0000_0000 { return; }
 535                                                 }
 536                                                 loss_detector.connect_block(&[tx]);
 537                                         } else {
 538                                                 return;
 539                                         }
 540                                 }
 541                         },
 542                         13 => {
 543                                 loss_detector.disconnect_block();
 544                         },
 545                         14 => {
 546                                 let mut channels = channelmanager.list_channels();
 547                                 let channel_id = get_slice!(1)[0] as usize;
 548                                 if channel_id >= channels.len() { return; }
 549                                 channels.sort_by(|a, b| { a.channel_id.cmp(&b.channel_id) });
 550                                 channelmanager.force_close_channel(&channels[channel_id].channel_id);
 551                         },
 552                         _ => return,
 553                 }
 554 println!("PROCESSING EVENTS");
 555                 loss_detector.handler.process_events();
 556                 for event in loss_detector.manager.get_and_clear_pending_events() {
 557                         match event {
 558                                 Event::FundingGenerationReady { temporary_channel_id, channel_value_satoshis, output_script, .. } => {
 559 println!("fgr");
 560                                         pending_funding_generation.push((temporary_channel_id, channel_value_satoshis, output_script));
 561                                 },
 562                                 Event::FundingBroadcastSafe { funding_txo, .. } => {
 563 println!("fbs");
 564                                         pending_funding_relay.push(pending_funding_signatures.remove(&funding_txo).unwrap());
 565                                 },
 566                                 Event::PaymentReceived { payment_hash, payment_secret, amt } => {
 567                                         //TODO: enhance by fetching random amounts from fuzz input?
 568                                         payments_received.push((payment_hash, payment_secret, amt));
 569                                 },
 570                                 Event::PaymentSent {..} => {},
 571                                 Event::PaymentFailed {..} => {},
 572                                 Event::PendingHTLCsForwardable {..} => {
 573 println!("PENDING HTLCS FORWARDABLE");
 574                                         should_forward = true;
 575                                 },
 576                                 Event::SpendableOutputs {..} => {},
 577                         }
 578                 }
 579         }
 580 }
 581
 582 #[no_mangle]
 583 pub extern "C" fn full_stack_run(data: *const u8, datalen: usize) {
 584         let logger: Arc<dyn Logger> = Arc::new(test_logger::TestLogger::new("".to_owned()));
 585         do_test(unsafe { std::slice::from_raw_parts(data, datalen) }, &logger);
 586 }
 587
 588 #[cfg(test)]
 589 mod tests {
 590         use utils::test_logger;
 591         use lightning::util::logger::{Logger, Record};
 592         use std::collections::HashMap;
 593         use std::sync::{Arc, Mutex};
 594
 595         struct TrackingLogger {
 596                 /// (module, message) -> count
 597                 pub lines: Mutex<HashMap<(String, String), usize>>,
 598         }
 599         impl Logger for TrackingLogger {
 600                 fn log(&self, record: &Record) {
 601                         *self.lines.lock().unwrap().entry((record.module_path.to_string(), format!("{}", record.args))).or_insert(0) += 1;
 602                         println!("{:<5} [{} : {}, {}] {}", record.level.to_string(), record.module_path, record.file, record.line, record.args);
 603                 }
 604         }
 605
 606         #[test]
 607         fn test_no_existing_test_breakage() {
 608                 // To avoid accidentally causing all existing fuzz test cases to be useless by making minor
 609                 // changes (such as requesting feerate info in a new place), we run a pretty full
 610                 // step-through with two peers and HTLC forwarding here. Obviously this is pretty finicky,
 611                 // so this should be updated pretty liberally, but at least we'll know when changes occur.
 612                 // If nothing else, this test serves as a pretty great initial full_stack_target seed.
 613
 614                 // What each byte represents is broken down below, and then everything is concatenated into
 615                 // one large test at the end (you want %s/ -.*//g %s/\n\| \|\t\|\///g).
 616
 617                 // Following BOLT 8, lightning message on the wire are: 2-byte encrypted message length +
 618                 // 16-byte MAC of the encrypted message length + encrypted Lightning message + 16-byte MAC
 619                 // of the Lightning message
 620                 // I.e 2nd inbound read, len 18 : 0006 (encrypted message length) + 03000000000000000000000000000000 (MAC of the encrypted message length)
 621                 // Len 22 : 0010 00000000 (encrypted lightning message) + 03000000000000000000000000000000 (MAC of the Lightning message)
 622
 623                 // Writing new code generating transactions and see a new failure ? Don't forget to add input for the FuzzEstimator !
 624
 625                 // 0000000000000000000000000000000000000000000000000000000000000000 - our network key
 626                 // 00000000 - fee_proportional_millionths
 627                 // 01 - announce_channels_publicly
 628                 //
 629                 // 00 - new outbound connection with id 0
 630                 // 030000000000000000000000000000000000000000000000000000000000000000 - peer's pubkey
 631                 // 030032 - inbound read from peer id 0 of len 50
 632                 // 00 030000000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - noise act two (0||pubkey||mac)
 633                 //
 634                 // 030012 - inbound read from peer id 0 of len 18
 635                 // 0006 03000000000000000000000000000000 - message header indicating message length 6
 636                 // 030016 - inbound read from peer id 0 of len 22
 637                 // 0010 00000000 03000000000000000000000000000000 - init message with no features (type 16) and mac
 638                 //
 639                 // 030012 - inbound read from peer id 0 of len 18
 640                 // 0141 03000000000000000000000000000000 - message header indicating message length 321
 641                 // 0300fe - inbound read from peer id 0 of len 254
 642                 // 0020 7500000000000000000000000000000000000000000000000000000000000000 ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679 000000000000c350 0000000000000000 0000000000000222 ffffffffffffffff 0000000000000222 0000000000000000 000000fd 0006 01e3 030000000000000000000000000000000000000000000000000000000000000001 030000000000000000000000000000000000000000000000000000000000000002 030000000000000000000000000000000000000000000000000000000000000003 030000000000000000000000000000000000000000000000000000000000000004 - beginning of open_channel message
 643                 // 030053 - inbound read from peer id 0 of len 83
 644                 // 030000000000000000000000000000000000000000000000000000000000000005 030000000000000000000000000000000000000000000000000000000000000000 01 03000000000000000000000000000000 - rest of open_channel and mac
 645                 //
 646                 // 00fd00fd00fd - Three feerate requests (all returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 647                 // - client should now respond with accept_channel (CHECK 1: type 33 to peer 03000000)
 648                 //
 649                 // 030012 - inbound read from peer id 0 of len 18
 650                 // 0084 03000000000000000000000000000000 - message header indicating message length 132
 651                 // 030094 - inbound read from peer id 0 of len 148
 652                 // 0022 ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679 3d00000000000000000000000000000000000000000000000000000000000000 0000 5c000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001 03000000000000000000000000000000 - funding_created and mac
 653                 // - client should now respond with funding_signed (CHECK 2: type 35 to peer 03000000)
 654                 //
 655                 // 0c005e - connect a block with one transaction of len 94
 656                 // 020000000100000000000000000000000000000000000000000000000000000000000000000000000000ffffffff0150c3000000000000220020ae0000000000000000000000000000000000000000000000000000000000000000000000 - the funding transaction
 657                 // 0c0000 - connect a block with no transactions
 658                 // 0c0000 - connect a block with no transactions
 659                 // 0c0000 - connect a block with no transactions
 660                 // 0c0000 - connect a block with no transactions
 661                 // 0c0000 - connect a block with no transactions
 662                 // 0c0000 - connect a block with no transactions
 663                 // 0c0000 - connect a block with no transactions
 664                 // 0c0000 - connect a block with no transactions
 665                 // 0c0000 - connect a block with no transactions
 666                 // 0c0000 - connect a block with no transactions
 667                 // 0c0000 - connect a block with no transactions
 668                 // 0c0000 - connect a block with no transactions
 669                 // - by now client should have sent a funding_locked (CHECK 3: SendFundingLocked to 03000000 for chan 3d000000)
 670                 //
 671                 // 030012 - inbound read from peer id 0 of len 18
 672                 // 0043 03000000000000000000000000000000 - message header indicating message length 67
 673                 // 030053 - inbound read from peer id 0 of len 83
 674                 // 0024 3d00000000000000000000000000000000000000000000000000000000000000 030100000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - funding_locked and mac
 675                 //
 676                 // 01 - new inbound connection with id 1
 677                 // 030132 - inbound read from peer id 1 of len 50
 678                 // 0003000000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000 - inbound noise act 1
 679                 // 030142 - inbound read from peer id 1 of len 66
 680                 // 000302000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003000000000000000000000000000000 - inbound noise act 3
 681                 //
 682                 // 030112 - inbound read from peer id 1 of len 18
 683                 // 0006 01000000000000000000000000000000 - message header indicating message length 6
 684                 // 030116 - inbound read from peer id 1 of len 22
 685                 // 0010 00000000 01000000000000000000000000000000 - init message with no features (type 16)
 686                 //
 687                 // 05 01 030200000000000000000000000000000000000000000000000000000000000000 00c350 0003e8 - create outbound channel to peer 1 for 50k sat
 688                 // 00fd00fd00fd - Three feerate requests (all returning min feerate) (gonna be ingested by FuzzEstimator)
 689                 //
 690                 // 030112 - inbound read from peer id 1 of len 18
 691                 // 0110 01000000000000000000000000000000 - message header indicating message length 272
 692                 // 0301ff - inbound read from peer id 1 of len 255
 693                 // 0021 0000000000000000000000000000000000000000000000000000000000000e02 000000000000001a 00000000004c4b40 00000000000003e8 00000000000003e8 00000002 03f0 0005 030000000000000000000000000000000000000000000000000000000000000100 030000000000000000000000000000000000000000000000000000000000000200 030000000000000000000000000000000000000000000000000000000000000300 030000000000000000000000000000000000000000000000000000000000000400 030000000000000000000000000000000000000000000000000000000000000500 03000000000000000000000000000000 - beginning of accept_channel
 694                 // 030121 - inbound read from peer id 1 of len 33
 695                 // 0000000000000000000000000000000000 01000000000000000000000000000000 - rest of accept_channel and mac
 696                 //
 697                 // 0a - create the funding transaction (client should send funding_created now)
 698                 //
 699                 // 030112 - inbound read from peer id 1 of len 18
 700                 // 0062 01000000000000000000000000000000 - message header indicating message length 98
 701                 // 030172 - inbound read from peer id 1 of len 114
 702                 // 0023 3900000000000000000000000000000000000000000000000000000000000000 f0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100 01000000000000000000000000000000 - funding_signed message and mac
 703                 //
 704                 // 0b - broadcast funding transaction
 705                 // - by now client should have sent a funding_locked (CHECK 4: SendFundingLocked to 03020000 for chan 3f000000)
 706                 //
 707                 // 030112 - inbound read from peer id 1 of len 18
 708                 // 0043 01000000000000000000000000000000 - message header indicating message length 67
 709                 // 030153 - inbound read from peer id 1 of len 83
 710                 // 0024 3900000000000000000000000000000000000000000000000000000000000000 030100000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - funding_locked and mac
 711                 //
 712                 // 030012 - inbound read from peer id 0 of len 18
 713                 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
 714                 // 0300ff - inbound read from peer id 0 of len 255
 715                 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000000 0000000000003e80 ff00000000000000000000000000000000000000000000000000000000000000 00000121 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e000001000000000000000003e8000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
 716                 // 0300ff - inbound read from peer id 0 of len 255
 717                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 718                 // 0300ff - inbound read from peer id 0 of len 255
 719                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 720                 // 0300ff - inbound read from peer id 0 of len 255
 721                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 722                 // 0300ff - inbound read from peer id 0 of len 255
 723                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 724                 // 0300c1 - inbound read from peer id 0 of len 193
 725                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ef00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
 726                 //
 727                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 728                 //
 729                 // 030012 - inbound read from peer id 0 of len 18
 730                 // 0064 03000000000000000000000000000000 - message header indicating message length 100
 731                 // 030074 - inbound read from peer id 0 of len 116
 732                 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 4d000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001 0000 03000000000000000000000000000000 - commitment_signed and mac
 733                 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6: types 133 and 132 to peer 03000000)
 734                 //
 735                 // 030012 - inbound read from peer id 0 of len 18
 736                 // 0063 03000000000000000000000000000000 - message header indicating message length 99
 737                 // 030073 - inbound read from peer id 0 of len 115
 738                 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000000000000000000000000000000000000000000000000000000 030200000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
 739                 //
 740                 // 07 - process the now-pending HTLC forward
 741                 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7: SendHTLCs event for node 03020000 with 1 HTLCs for channel 3f000000)
 742                 //
 743                 // - we respond with commitment_signed then revoke_and_ack (a weird, but valid, order)
 744                 // 030112 - inbound read from peer id 1 of len 18
 745                 // 0064 01000000000000000000000000000000 - message header indicating message length 100
 746                 // 030174 - inbound read from peer id 1 of len 116
 747                 // 0084 3900000000000000000000000000000000000000000000000000000000000000 f1000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100 0000 01000000000000000000000000000000 - commitment_signed and mac
 748                 //
 749                 // 030112 - inbound read from peer id 1 of len 18
 750                 // 0063 01000000000000000000000000000000 - message header indicating message length 99
 751                 // 030173 - inbound read from peer id 1 of len 115
 752                 // 0085 3900000000000000000000000000000000000000000000000000000000000000 0000000000000000000000000000000000000000000000000000000000000000 030200000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
 753                 //
 754                 // 030112 - inbound read from peer id 1 of len 18
 755                 // 004a 01000000000000000000000000000000 - message header indicating message length 74
 756                 // 03015a - inbound read from peer id 1 of len 90
 757                 // 0082 3900000000000000000000000000000000000000000000000000000000000000 0000000000000000 ff00888888888888888888888888888888888888888888888888888888888888 01000000000000000000000000000000 - update_fulfill_htlc and mac
 758                 // - client should immediately claim the pending HTLC from peer 0 (CHECK 8: SendFulfillHTLCs for node 03000000 with preimage ff00888888 for channel 3d000000)
 759                 //
 760                 // 030112 - inbound read from peer id 1 of len 18
 761                 // 0064 01000000000000000000000000000000 - message header indicating message length 100
 762                 // 030174 - inbound read from peer id 1 of len 116
 763                 // 0084 3900000000000000000000000000000000000000000000000000000000000000 fd000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100 0000 01000000000000000000000000000000 - commitment_signed and mac
 764                 //
 765                 // 030112 - inbound read from peer id 1 of len 18
 766                 // 0063 01000000000000000000000000000000 - message header indicating message length 99
 767                 // 030173 - inbound read from peer id 1 of len 115
 768                 // 0085 3900000000000000000000000000000000000000000000000000000000000000 0100000000000000000000000000000000000000000000000000000000000000 030300000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
 769                 //
 770                 // - before responding to the commitment_signed generated above, send a new HTLC
 771                 // 030012 - inbound read from peer id 0 of len 18
 772                 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
 773                 // 0300ff - inbound read from peer id 0 of len 255
 774                 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000001 0000000000003e80 ff00000000000000000000000000000000000000000000000000000000000000 00000121 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e000001000000000000000003e8000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
 775                 // 0300ff - inbound read from peer id 0 of len 255
 776                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 777                 // 0300ff - inbound read from peer id 0 of len 255
 778                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 779                 // 0300ff - inbound read from peer id 0 of len 255
 780                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 781                 // 0300ff - inbound read from peer id 0 of len 255
 782                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 783                 // 0300c1 - inbound read from peer id 0 of len 193
 784                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ef00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
 785                 //
 786                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 787                 //
 788                 // - now respond to the update_fulfill_htlc+commitment_signed messages the client sent to peer 0
 789                 // 030012 - inbound read from peer id 0 of len 18
 790                 // 0063 03000000000000000000000000000000 - message header indicating message length 99
 791                 // 030073 - inbound read from peer id 0 of len 115
 792                 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0100000000000000000000000000000000000000000000000000000000000000 030300000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
 793                 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6 duplicates)
 794                 //
 795                 // 030012 - inbound read from peer id 0 of len 18
 796                 // 0064 03000000000000000000000000000000 - message header indicating message length 100
 797                 // 030074 - inbound read from peer id 0 of len 116
 798                 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 be000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001 0000 03000000000000000000000000000000 - commitment_signed and mac
 799                 //
 800                 // 030012 - inbound read from peer id 0 of len 18
 801                 // 0063 03000000000000000000000000000000 - message header indicating message length 99
 802                 // 030073 - inbound read from peer id 0 of len 115
 803                 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0200000000000000000000000000000000000000000000000000000000000000 030400000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
 804                 //
 805                 // 07 - process the now-pending HTLC forward
 806                 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7 duplicate)
 807                 // - we respond with revoke_and_ack, then commitment_signed, then update_fail_htlc
 808                 //
 809                 // 030112 - inbound read from peer id 1 of len 18
 810                 // 0064 01000000000000000000000000000000 - message header indicating message length 100
 811                 // 030174 - inbound read from peer id 1 of len 116
 812                 // 0084 3900000000000000000000000000000000000000000000000000000000000000 fc000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100 0000 01000000000000000000000000000000 - commitment_signed and mac
 813                 //
 814                 // 030112 - inbound read from peer id 1 of len 18
 815                 // 0063 01000000000000000000000000000000 - message header indicating message length 99
 816                 // 030173 - inbound read from peer id 1 of len 115
 817                 // 0085 3900000000000000000000000000000000000000000000000000000000000000 0200000000000000000000000000000000000000000000000000000000000000 030400000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
 818                 //
 819                 // 030112 - inbound read from peer id 1 of len 18
 820                 // 002c 01000000000000000000000000000000 - message header indicating message length 44
 821                 // 03013c - inbound read from peer id 1 of len 60
 822                 // 0083 3900000000000000000000000000000000000000000000000000000000000000 0000000000000001 0000 01000000000000000000000000000000 - update_fail_htlc and mac
 823                 //
 824                 // 030112 - inbound read from peer id 1 of len 18
 825                 // 0064 01000000000000000000000000000000 - message header indicating message length 100
 826                 // 030174 - inbound read from peer id 1 of len 116
 827                 // 0084 3900000000000000000000000000000000000000000000000000000000000000 fb000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100 0000 01000000000000000000000000000000 - commitment_signed and mac
 828                 //
 829                 // 030112 - inbound read from peer id 1 of len 18
 830                 // 0063 01000000000000000000000000000000 - message header indicating message length 99
 831                 // 030173 - inbound read from peer id 1 of len 115
 832                 // 0085 3900000000000000000000000000000000000000000000000000000000000000 0300000000000000000000000000000000000000000000000000000000000000 030500000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
 833                 //
 834                 // 07 - process the now-pending HTLC forward
 835                 // - client now sends id 0 update_fail_htlc and commitment_signed (CHECK 9)
 836                 // - now respond to the update_fail_htlc+commitment_signed messages the client sent to peer 0
 837                 //
 838                 // 030012 - inbound read from peer id 0 of len 18
 839                 // 0063 03000000000000000000000000000000 - message header indicating message length 99
 840                 // 030073 - inbound read from peer id 0 of len 115
 841                 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0300000000000000000000000000000000000000000000000000000000000000 030500000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
 842                 //
 843                 // 030012 - inbound read from peer id 0 of len 18
 844                 // 0064 03000000000000000000000000000000 - message header indicating message length 100
 845                 // 030074 - inbound read from peer id 0 of len 116
 846                 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 4f000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001 0000 03000000000000000000000000000000 - commitment_signed and mac
 847                 // - client should now respond with revoke_and_ack (CHECK 5 duplicate)
 848                 //
 849                 // 030012 - inbound read from peer id 0 of len 18
 850                 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
 851                 // 0300ff - inbound read from peer id 0 of len 255
 852                 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000002 00000000000b0838 ff00000000000000000000000000000000000000000000000000000000000000 00000121 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e0000010000000000000003e800000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
 853                 // 0300ff - inbound read from peer id 0 of len 255
 854                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 855                 // 0300ff - inbound read from peer id 0 of len 255
 856                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 857                 // 0300ff - inbound read from peer id 0 of len 255
 858                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 859                 // 0300ff - inbound read from peer id 0 of len 255
 860                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
 861                 // 0300c1 - inbound read from peer id 0 of len 193
 862                 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ef00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
 863                 //
 864                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 865                 //
 866                 // 030012 - inbound read from peer id 0 of len 18
 867                 // 00a4 03000000000000000000000000000000 - message header indicating message length 164
 868                 // 0300b4 - inbound read from peer id 0 of len 180
 869                 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 07000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001 0001 c8000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000007f00000000000000 03000000000000000000000000000000 - commitment_signed and mac
 870                 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6 duplicates)
 871                 //
 872                 // 030012 - inbound read from peer id 0 of len 18
 873                 // 0063 03000000000000000000000000000000 - message header indicating message length 99
 874                 // 030073 - inbound read from peer id 0 of len 115
 875                 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0400000000000000000000000000000000000000000000000000000000000000 030600000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
 876                 //
 877                 // 07 - process the now-pending HTLC forward
 878                 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7 duplicate)
 879                 //
 880                 // 0c007d - connect a block with one transaction of len 125
 881                 // 0200000001390000000000000000000000000000000000000000000000000000000000000000000000000000008002000100000000000022002090000000000000000000000000000000000000000000000000000000000000006cc10000000000001600145c0000000000000000000000000000000000000005000020 - the commitment transaction for channel 3f00000000000000000000000000000000000000000000000000000000000000
 882                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 883                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 884                 // 0c005e - connect a block with one transaction of len 94
 885                 // 0200000001fd00000000000000000000000000000000000000000000000000000000000000000000000000000000014f00000000000000220020f60000000000000000000000000000000000000000000000000000000000000000000000 - the funding transaction
 886                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 887                 // 0c0000 - connect a block with no transactions
 888                 // 00fd - A feerate request (returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
 889                 // 0c0000 - connect a block with no transactions
 890                 // 0c0000 - connect a block with no transactions
 891                 // 0c0000 - connect a block with no transactions
 892                 // 0c0000 - connect a block with no transactions
 893                 //
 894                 // 07 - process the now-pending HTLC forward
 895                 // - client now fails the HTLC backwards as it was unable to extract the payment preimage (CHECK 9 duplicate and CHECK 10)
 896
 897                 let logger = Arc::new(TrackingLogger { lines: Mutex::new(HashMap::new()) });
 898                 super::do_test(&::hex::decode("00000000000000000000000000000000000000000000000000000000000000000000000001000300000000000000000000000000000000000000000000000000000000000000000300320003000000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000030012000603000000000000000000000000000000030016001000000000030000000000000000000000000000000300120141030000000000000000000000000000000300fe00207500000000000000000000000000000000000000000000000000000000000000ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679000000000000c35000000000000000000000000000000222ffffffffffffffff00000000000002220000000000000000000000fd000601e3030000000000000000000000000000000000000000000000000000000000000001030000000000000000000000000000000000000000000000000000000000000002030000000000000000000000000000000000000000000000000000000000000003030000000000000000000000000000000000000000000000000000000000000004030053030000000000000000000000000000000000000000000000000000000000000005030000000000000000000000000000000000000000000000000000000000000000010300000000000000000000000000000000fd00fd00fd0300120084030000000000000000000000000000000300940022ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb1819096793d0000000000000000000000000000000000000000000000000000000000000000005c000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001030000000000000000000000000000000c005e020000000100000000000000000000000000000000000000000000000000000000000000000000000000ffffffff0150c3000000000000220020ae00000000000000000000000000000000000000000000000000000000000000000000000c00000c00000c00000c00000c00000c00000c00000c00000c00000c00000c00000c000003001200430300000000000000000000000000000003005300243d000000000000000000000000000000000000000000000000000000000000000301000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000001030132000300000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003014200030200000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000300000000000000000000000000000003011200060100000000000000000000000000000003011600100000000001000000000000000000000000000000050103020000000000000000000000000000000000000000000000000000000000000000c3500003e800fd00fd00fd0301120110010000000000000000000000000000000301ff00210000000000000000000000000000000000000000000000000000000000000e02000000000000001a00000000004c4b4000000000000003e800000000000003e80000000203f00005030000000000000000000000000000000000000000000000000000000000000100030000000000000000000000000000000000000000000000000000000000000200030000000000000000000000000000000000000000000000000000000000000300030000000000000000000000000000000000000000000000000000000000000400030000000000000000000000000000000000000000000000000000000000000500030000000000000000000000000000000301210000000000000000000000000000000000010000000000000000000000000000000a03011200620100000000000000000000000000000003017200233900000000000000000000000000000000000000000000000000000000000000f0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100010000000000000000000000000000000b030112004301000000000000000000000000000000030153002439000000000000000000000000000000000000000000000000000000000000000301000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003e80ff0000000000000000000000000000000000000000000000000000000000000000000121000300000000000000000000000000000000000000000000000000000000000005550000000e000001000000000000000003e8000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffef000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000000fd03001200640300000000000000000000000000000003007400843d000000000000000000000000000000000000000000000000000000000000004d00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000030200000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000703011200640100000000000000000000000000000003017400843900000000000000000000000000000000000000000000000000000000000000f100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000010000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003020000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000030112004a0100000000000000000000000000000003015a008239000000000000000000000000000000000000000000000000000000000000000000000000000000ff008888888888888888888888888888888888888888888888888888888888880100000000000000000000000000000003011200640100000000000000000000000000000003017400843900000000000000000000000000000000000000000000000000000000000000fd0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001000000010000000000000000000000000000000301120063010000000000000000000000000000000301730085390000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000000000000000000000000000000000000303000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d0000000000000000000000000000000000000000000000000000000000000000000000000000010000000000003e80ff0000000000000000000000000000000000000000000000000000000000000000000121000300000000000000000000000000000000000000000000000000000000000005550000000e000001000000000000000003e8000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffef000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000000fd03001200630300000000000000000000000000000003007300853d0000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000000000000000000000000000000000000303000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200640300000000000000000000000000000003007400843d00000000000000000000000000000000000000000000000000000000000000be00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000200000000000000000000000000000000000000000000000000000000000000030400000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000703011200640100000000000000000000000000000003017400843900000000000000000000000000000000000000000000000000000000000000fc00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000010000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853900000000000000000000000000000000000000000000000000000000000000020000000000000000000000000000000000000000000000000000000000000003040000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000030112002c0100000000000000000000000000000003013c00833900000000000000000000000000000000000000000000000000000000000000000000000000000100000100000000000000000000000000000003011200640100000000000000000000000000000003017400843900000000000000000000000000000000000000000000000000000000000000fb000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100000001000000000000000000000000000000030112006301000000000000000000000000000000030173008539000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000000000000000000000000000000000000030500000000000000000000000000000000000000000000000000000000000000010000000000000000000000000000000703001200630300000000000000000000000000000003007300853d0000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000000000000000000000000000000000000305000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200640300000000000000000000000000000003007400843d000000000000000000000000000000000000000000000000000000000000004f00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000100000300000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d00000000000000000000000000000000000000000000000000000000000000000000000000000200000000000b0838ff0000000000000000000000000000000000000000000000000000000000000000000121000300000000000000000000000000000000000000000000000000000000000005550000000e0000010000000000000003e800000000010000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffef000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000000fd03001200a4030000000000000000000000000000000300b400843d00000000000000000000000000000000000000000000000000000000000000070000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000010001c8000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000007f000000000000000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d00000000000000000000000000000000000000000000000000000000000000040000000000000000000000000000000000000000000000000000000000000003060000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000070c007d0200000001390000000000000000000000000000000000000000000000000000000000000000000000000000008002000100000000000022002090000000000000000000000000000000000000000000000000000000000000006cc10000000000001600145c000000000000000000000000000000000000000500002000fd00fd0c005e0200000001fd00000000000000000000000000000000000000000000000000000000000000000000000000000000014f00000000000000220020f6000000000000000000000000000000000000000000000000000000000000000000000000fd0c000000fd0c00000c00000c00000c000007").unwrap(), &(Arc::clone(&logger) as Arc<dyn Logger>));
 899
 900                 let log_entries = logger.lines.lock().unwrap();
 901                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendAcceptChannel event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 for channel ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679".to_string())), Some(&1)); // 1
 902                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingSigned event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 2
 903                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingLocked event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 3
 904                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingLocked event in peer_handler for node 030200000000000000000000000000000000000000000000000000000000000000 for channel 3900000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 4
 905                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendRevokeAndACK event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&4)); // 5
 906                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 with 0 adds, 0 fulfills, 0 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&3)); // 6
 907                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030200000000000000000000000000000000000000000000000000000000000000 with 1 adds, 0 fulfills, 0 fails for channel 3900000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&3)); // 7
 908                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 with 0 adds, 1 fulfills, 0 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 8
 909                 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000000 with 0 adds, 0 fulfills, 1 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&2)); // 9
 910                 assert_eq!(log_entries.get(&("lightning::ln::channelmonitor".to_string(), "Input spending remote commitment tx (00000000000000000000000000000000000000000000000000000000000000fd:0) in 0000000000000000000000000000000000000000000000000000000000000044 resolves outbound HTLC with payment hash ff00000000000000000000000000000000000000000000000000000000000000 with timeout".to_string())), Some(&1)); // 10
 911         }
 912 }