1 // This file is Copyright its original authors, visible in version control
4 // This file is licensed under the Apache License, Version 2.0 <LICENSE-APACHE
5 // or http://www.apache.org/licenses/LICENSE-2.0> or the MIT license
6 // <LICENSE-MIT or http://opensource.org/licenses/MIT>, at your option.
7 // You may not use this file except in accordance with one or both of these
10 //! Test that no series of bytes received over the wire/connections created/payments sent can
11 //! result in a crash. We do this by standing up a node and then reading bytes from input to denote
12 //! actions such as creating new inbound/outbound connections, bytes to be read from a connection,
13 //! or payments to send/ways to handle events generated.
14 //! This test has been very useful, though due to its complexity good starting inputs are critical.
16 use bitcoin::blockdata::block::BlockHeader;
17 use bitcoin::blockdata::transaction::{Transaction, TxOut};
18 use bitcoin::blockdata::script::{Builder, Script};
19 use bitcoin::blockdata::opcodes;
20 use bitcoin::consensus::encode::deserialize;
21 use bitcoin::network::constants::Network;
22 use bitcoin::blockdata::constants::genesis_block;
24 use bitcoin::hashes::Hash as TraitImport;
25 use bitcoin::hashes::HashEngine as TraitImportEngine;
26 use bitcoin::hashes::sha256::Hash as Sha256;
27 use bitcoin::hash_types::{Txid, BlockHash, WPubkeyHash};
30 use lightning::chain::{BestBlock, Confirm, Listen};
31 use lightning::chain::chaininterface::{BroadcasterInterface, ConfirmationTarget, FeeEstimator};
32 use lightning::chain::chainmonitor;
33 use lightning::chain::transaction::OutPoint;
34 use lightning::chain::keysinterface::{InMemorySigner, KeysInterface};
35 use lightning::ln::{PaymentHash, PaymentPreimage, PaymentSecret};
36 use lightning::ln::channelmanager::{ChainParameters, ChannelManager};
37 use lightning::ln::peer_handler::{MessageHandler,PeerManager,SocketDescriptor,IgnoringMessageHandler};
38 use lightning::ln::msgs::DecodeError;
39 use lightning::ln::script::ShutdownScript;
40 use lightning::routing::network_graph::{NetGraphMsgHandler, NetworkGraph};
41 use lightning::routing::router::get_route;
42 use lightning::routing::scorer::Scorer;
43 use lightning::util::config::UserConfig;
44 use lightning::util::errors::APIError;
45 use lightning::util::events::Event;
46 use lightning::util::enforcing_trait_impls::{EnforcingSigner, EnforcementState};
47 use lightning::util::logger::Logger;
48 use lightning::util::ser::Readable;
50 use utils::test_logger;
51 use utils::test_persister::TestPersister;
53 use bitcoin::secp256k1::key::{PublicKey,SecretKey};
54 use bitcoin::secp256k1::recovery::RecoverableSignature;
55 use bitcoin::secp256k1::Secp256k1;
57 use std::cell::RefCell;
58 use std::collections::{HashMap, hash_map};
60 use std::sync::{Arc, Mutex};
61 use std::sync::atomic::{AtomicU64,AtomicUsize,Ordering};
64 pub fn slice_to_be16(v: &[u8]) -> u16 {
65 ((v[0] as u16) << 8*1) |
66 ((v[1] as u16) << 8*0)
70 pub fn slice_to_be24(v: &[u8]) -> u32 {
71 ((v[0] as u32) << 8*2) |
72 ((v[1] as u32) << 8*1) |
73 ((v[2] as u32) << 8*0)
77 pub fn slice_to_be32(v: &[u8]) -> u32 {
78 ((v[0] as u32) << 8*3) |
79 ((v[1] as u32) << 8*2) |
80 ((v[2] as u32) << 8*1) |
81 ((v[3] as u32) << 8*0)
85 pub fn be64_to_array(u: u64) -> [u8; 8] {
87 v[0] = ((u >> 8*7) & 0xff) as u8;
88 v[1] = ((u >> 8*6) & 0xff) as u8;
89 v[2] = ((u >> 8*5) & 0xff) as u8;
90 v[3] = ((u >> 8*4) & 0xff) as u8;
91 v[4] = ((u >> 8*3) & 0xff) as u8;
92 v[5] = ((u >> 8*2) & 0xff) as u8;
93 v[6] = ((u >> 8*1) & 0xff) as u8;
94 v[7] = ((u >> 8*0) & 0xff) as u8;
100 read_pos: AtomicUsize,
103 fn get_slice(&self, len: usize) -> Option<&[u8]> {
104 let old_pos = self.read_pos.fetch_add(len, Ordering::AcqRel);
105 if self.data.len() < old_pos + len {
108 Some(&self.data[old_pos..old_pos + len])
112 struct FuzzEstimator {
113 input: Arc<InputData>,
115 impl FeeEstimator for FuzzEstimator {
116 fn get_est_sat_per_1000_weight(&self, _: ConfirmationTarget) -> u32 {
117 //TODO: We should actually be testing at least much more than 64k...
118 match self.input.get_slice(2) {
119 Some(slice) => cmp::max(slice_to_be16(slice) as u32, 253),
125 struct TestBroadcaster {
126 txn_broadcasted: Mutex<Vec<Transaction>>,
128 impl BroadcasterInterface for TestBroadcaster {
129 fn broadcast_transaction(&self, tx: &Transaction) {
130 self.txn_broadcasted.lock().unwrap().push(tx.clone());
137 peers_connected: &'a RefCell<[bool; 256]>,
139 impl<'a> SocketDescriptor for Peer<'a> {
140 fn send_data(&mut self, data: &[u8], _resume_read: bool) -> usize {
143 fn disconnect_socket(&mut self) {
144 assert!(self.peers_connected.borrow()[self.id as usize]);
145 self.peers_connected.borrow_mut()[self.id as usize] = false;
148 impl<'a> PartialEq for Peer<'a> {
149 fn eq(&self, other: &Self) -> bool {
153 impl<'a> Eq for Peer<'a> {}
154 impl<'a> std::hash::Hash for Peer<'a> {
155 fn hash<H : std::hash::Hasher>(&self, h: &mut H) {
160 type ChannelMan = ChannelManager<
162 Arc<chainmonitor::ChainMonitor<EnforcingSigner, Arc<dyn chain::Filter>, Arc<TestBroadcaster>, Arc<FuzzEstimator>, Arc<dyn Logger>, Arc<TestPersister>>>,
163 Arc<TestBroadcaster>, Arc<KeyProvider>, Arc<FuzzEstimator>, Arc<dyn Logger>>;
164 type PeerMan<'a> = PeerManager<Peer<'a>, Arc<ChannelMan>, Arc<NetGraphMsgHandler<Arc<dyn chain::Access>, Arc<dyn Logger>>>, Arc<dyn Logger>, IgnoringMessageHandler>;
166 struct MoneyLossDetector<'a> {
167 manager: Arc<ChannelMan>,
168 monitor: Arc<chainmonitor::ChainMonitor<EnforcingSigner, Arc<dyn chain::Filter>, Arc<TestBroadcaster>, Arc<FuzzEstimator>, Arc<dyn Logger>, Arc<TestPersister>>>,
169 handler: PeerMan<'a>,
171 peers: &'a RefCell<[bool; 256]>,
172 funding_txn: Vec<Transaction>,
173 txids_confirmed: HashMap<Txid, usize>,
174 header_hashes: Vec<(BlockHash, u32)>,
177 blocks_connected: u32,
179 impl<'a> MoneyLossDetector<'a> {
180 pub fn new(peers: &'a RefCell<[bool; 256]>,
181 manager: Arc<ChannelMan>,
182 monitor: Arc<chainmonitor::ChainMonitor<EnforcingSigner, Arc<dyn chain::Filter>, Arc<TestBroadcaster>, Arc<FuzzEstimator>, Arc<dyn Logger>, Arc<TestPersister>>>,
183 handler: PeerMan<'a>) -> Self {
190 funding_txn: Vec::new(),
191 txids_confirmed: HashMap::new(),
192 header_hashes: vec![(genesis_block(Network::Bitcoin).block_hash(), 0)],
199 fn connect_block(&mut self, all_txn: &[Transaction]) {
200 let mut txdata = Vec::with_capacity(all_txn.len());
201 for (idx, tx) in all_txn.iter().enumerate() {
202 let txid = tx.txid();
203 match self.txids_confirmed.entry(txid) {
204 hash_map::Entry::Vacant(e) => {
205 e.insert(self.height);
206 txdata.push((idx + 1, tx));
212 self.blocks_connected += 1;
213 let header = BlockHeader { version: 0x20000000, prev_blockhash: self.header_hashes[self.height].0, merkle_root: Default::default(), time: self.blocks_connected, bits: 42, nonce: 42 };
215 self.manager.transactions_confirmed(&header, &txdata, self.height as u32);
216 self.manager.best_block_updated(&header, self.height as u32);
217 (*self.monitor).transactions_confirmed(&header, &txdata, self.height as u32);
218 (*self.monitor).best_block_updated(&header, self.height as u32);
219 if self.header_hashes.len() > self.height {
220 self.header_hashes[self.height] = (header.block_hash(), self.blocks_connected);
222 assert_eq!(self.header_hashes.len(), self.height);
223 self.header_hashes.push((header.block_hash(), self.blocks_connected));
225 self.max_height = cmp::max(self.height, self.max_height);
228 fn disconnect_block(&mut self) {
229 if self.height > 0 && (self.max_height < 6 || self.height >= self.max_height - 6) {
230 let header = BlockHeader { version: 0x20000000, prev_blockhash: self.header_hashes[self.height - 1].0, merkle_root: Default::default(), time: self.header_hashes[self.height].1, bits: 42, nonce: 42 };
231 self.manager.block_disconnected(&header, self.height as u32);
232 self.monitor.block_disconnected(&header, self.height as u32);
234 let removal_height = self.height;
235 self.txids_confirmed.retain(|_, height| {
236 removal_height != *height
242 impl<'a> Drop for MoneyLossDetector<'a> {
244 if !::std::thread::panicking() {
245 // Disconnect all peers
246 for (idx, peer) in self.peers.borrow().iter().enumerate() {
248 self.handler.socket_disconnected(&Peer{id: idx as u8, peers_connected: &self.peers});
252 // Force all channels onto the chain (and time out claim txn)
253 self.manager.force_close_all_channels();
259 node_secret: SecretKey,
262 impl KeysInterface for KeyProvider {
263 type Signer = EnforcingSigner;
265 fn get_node_secret(&self) -> SecretKey {
266 self.node_secret.clone()
269 fn get_destination_script(&self) -> Script {
270 let secp_ctx = Secp256k1::signing_only();
271 let channel_monitor_claim_key = SecretKey::from_slice(&hex::decode("0fffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff").unwrap()[..]).unwrap();
272 let our_channel_monitor_claim_key_hash = WPubkeyHash::hash(&PublicKey::from_secret_key(&secp_ctx, &channel_monitor_claim_key).serialize());
273 Builder::new().push_opcode(opcodes::all::OP_PUSHBYTES_0).push_slice(&our_channel_monitor_claim_key_hash[..]).into_script()
276 fn get_shutdown_scriptpubkey(&self) -> ShutdownScript {
277 let secp_ctx = Secp256k1::signing_only();
278 let secret_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, 0, 1]).unwrap();
279 let pubkey_hash = WPubkeyHash::hash(&PublicKey::from_secret_key(&secp_ctx, &secret_key).serialize());
280 ShutdownScript::new_p2wpkh(&pubkey_hash)
283 fn get_channel_signer(&self, inbound: bool, channel_value_satoshis: u64) -> EnforcingSigner {
284 let ctr = self.counter.fetch_add(1, Ordering::Relaxed) as u8;
285 let secp_ctx = Secp256k1::signing_only();
286 EnforcingSigner::new(if inbound {
289 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(),
290 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(),
291 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(),
292 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(),
293 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(),
294 [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],
295 channel_value_satoshis,
301 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(),
302 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(),
303 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(),
304 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(),
305 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(),
306 [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],
307 channel_value_satoshis,
313 fn get_secure_random_bytes(&self) -> [u8; 32] {
314 let ctr = self.counter.fetch_add(1, Ordering::Relaxed);
315 [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,
316 (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]
319 fn read_chan_signer(&self, mut data: &[u8]) -> Result<EnforcingSigner, DecodeError> {
320 let inner: InMemorySigner = Readable::read(&mut data)?;
321 let state = Arc::new(Mutex::new(EnforcementState::new()));
323 Ok(EnforcingSigner::new_with_revoked(
330 fn sign_invoice(&self, _invoice_preimage: Vec<u8>) -> Result<RecoverableSignature, ()> {
336 pub fn do_test(data: &[u8], logger: &Arc<dyn Logger>) {
337 let input = Arc::new(InputData {
339 read_pos: AtomicUsize::new(0),
341 let fee_est = Arc::new(FuzzEstimator {
342 input: input.clone(),
345 macro_rules! get_slice {
347 match input.get_slice($len as usize) {
348 Some(slice) => slice,
354 macro_rules! get_pubkey {
356 match PublicKey::from_slice(get_slice!(33)) {
363 let our_network_key = match SecretKey::from_slice(get_slice!(32)) {
368 let broadcast = Arc::new(TestBroadcaster{ txn_broadcasted: Mutex::new(Vec::new()) });
369 let monitor = Arc::new(chainmonitor::ChainMonitor::new(None, broadcast.clone(), Arc::clone(&logger), fee_est.clone(), Arc::new(TestPersister{})));
371 let keys_manager = Arc::new(KeyProvider { node_secret: our_network_key.clone(), counter: AtomicU64::new(0) });
372 let mut config = UserConfig::default();
373 config.channel_options.forwarding_fee_proportional_millionths = slice_to_be32(get_slice!(4));
374 config.channel_options.announced_channel = get_slice!(1)[0] != 0;
375 let network = Network::Bitcoin;
376 let params = ChainParameters {
378 best_block: BestBlock::from_genesis(network),
380 let channelmanager = Arc::new(ChannelManager::new(fee_est.clone(), monitor.clone(), broadcast.clone(), Arc::clone(&logger), keys_manager.clone(), config, params));
381 let our_id = PublicKey::from_secret_key(&Secp256k1::signing_only(), &keys_manager.get_node_secret());
382 let network_graph = NetworkGraph::new(genesis_block(network).block_hash());
383 let net_graph_msg_handler = Arc::new(NetGraphMsgHandler::new(network_graph, None, Arc::clone(&logger)));
384 let scorer = Scorer::new(0);
386 let peers = RefCell::new([false; 256]);
387 let mut loss_detector = MoneyLossDetector::new(&peers, channelmanager.clone(), monitor.clone(), PeerManager::new(MessageHandler {
388 chan_handler: channelmanager.clone(),
389 route_handler: net_graph_msg_handler.clone(),
390 }, 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), IgnoringMessageHandler{}));
392 let mut should_forward = false;
393 let mut payments_received: Vec<PaymentHash> = Vec::new();
394 let mut payments_sent = 0;
395 let mut pending_funding_generation: Vec<([u8; 32], u64, Script)> = Vec::new();
396 let mut pending_funding_signatures = HashMap::new();
399 match get_slice!(1)[0] {
403 if !peers.borrow()[i-1] {
408 if new_id == 0 { return; }
409 loss_detector.handler.new_outbound_connection(get_pubkey!(), Peer{id: (new_id - 1) as u8, peers_connected: &peers}).unwrap();
410 peers.borrow_mut()[new_id - 1] = true;
415 if !peers.borrow()[i-1] {
420 if new_id == 0 { return; }
421 loss_detector.handler.new_inbound_connection(Peer{id: (new_id - 1) as u8, peers_connected: &peers}).unwrap();
422 peers.borrow_mut()[new_id - 1] = true;
425 let peer_id = get_slice!(1)[0];
426 if !peers.borrow()[peer_id as usize] { return; }
427 loss_detector.handler.socket_disconnected(&Peer{id: peer_id, peers_connected: &peers});
428 peers.borrow_mut()[peer_id as usize] = false;
431 let peer_id = get_slice!(1)[0];
432 if !peers.borrow()[peer_id as usize] { return; }
433 match loss_detector.handler.read_event(&mut Peer{id: peer_id, peers_connected: &peers}, get_slice!(get_slice!(1)[0])) {
434 Ok(res) => assert!(!res),
435 Err(_) => { peers.borrow_mut()[peer_id as usize] = false; }
439 let value = slice_to_be24(get_slice!(3)) as u64;
440 let route = match get_route(&our_id, &net_graph_msg_handler.network_graph, &get_pubkey!(), None, None, &Vec::new(), value, 42, Arc::clone(&logger), &scorer) {
444 let mut payment_hash = PaymentHash([0; 32]);
445 payment_hash.0[0..8].copy_from_slice(&be64_to_array(payments_sent));
446 let mut sha = Sha256::engine();
447 sha.input(&payment_hash.0[..]);
448 payment_hash.0 = Sha256::from_engine(sha).into_inner();
450 match channelmanager.send_payment(&route, payment_hash, &None) {
456 let value = slice_to_be24(get_slice!(3)) as u64;
457 let mut route = match get_route(&our_id, &net_graph_msg_handler.network_graph, &get_pubkey!(), None, None, &Vec::new(), value, 42, Arc::clone(&logger), &scorer) {
461 route.paths.push(route.paths[0].clone());
462 let mut payment_hash = PaymentHash([0; 32]);
463 payment_hash.0[0..8].copy_from_slice(&be64_to_array(payments_sent));
464 let mut sha = Sha256::engine();
465 sha.input(&payment_hash.0[..]);
466 payment_hash.0 = Sha256::from_engine(sha).into_inner();
468 let mut payment_secret = PaymentSecret([0; 32]);
469 payment_secret.0[0..8].copy_from_slice(&be64_to_array(payments_sent));
471 match channelmanager.send_payment(&route, payment_hash, &Some(payment_secret)) {
477 let peer_id = get_slice!(1)[0];
478 if !peers.borrow()[peer_id as usize] { return; }
479 let their_key = get_pubkey!();
480 let chan_value = slice_to_be24(get_slice!(3)) as u64;
481 let push_msat_value = slice_to_be24(get_slice!(3)) as u64;
482 if channelmanager.create_channel(their_key, chan_value, push_msat_value, 0, None).is_err() { return; }
485 let mut channels = channelmanager.list_channels();
486 let channel_id = get_slice!(1)[0] as usize;
487 if channel_id >= channels.len() { return; }
488 channels.sort_by(|a, b| { a.channel_id.cmp(&b.channel_id) });
489 if channelmanager.close_channel(&channels[channel_id].channel_id).is_err() { return; }
493 channelmanager.process_pending_htlc_forwards();
494 should_forward = false;
498 for payment in payments_received.drain(..) {
499 // SHA256 is defined as XOR of all input bytes placed in the first byte, and 0s
500 // for the remaining bytes. Thus, if not all remaining bytes are 0s we cannot
501 // fulfill this HTLC, but if they are, we can just take the first byte and
502 // place that anywhere in our preimage.
503 if &payment.0[1..] != &[0; 31] {
504 channelmanager.fail_htlc_backwards(&payment);
506 let mut payment_preimage = PaymentPreimage([0; 32]);
507 payment_preimage.0[0] = payment.0[0];
508 channelmanager.claim_funds(payment_preimage);
513 let payment_preimage = PaymentPreimage(keys_manager.get_secure_random_bytes());
514 let mut sha = Sha256::engine();
515 sha.input(&payment_preimage.0[..]);
516 let payment_hash = PaymentHash(Sha256::from_engine(sha).into_inner());
517 // Note that this may fail - our hashes may collide and we'll end up trying to
518 // double-register the same payment_hash.
519 let _ = channelmanager.create_inbound_payment_for_hash(payment_hash, None, 1, 0);
522 for payment in payments_received.drain(..) {
523 channelmanager.fail_htlc_backwards(&payment);
527 'outer_loop: for funding_generation in pending_funding_generation.drain(..) {
528 let mut tx = Transaction { version: 0, lock_time: 0, input: Vec::new(), output: vec![TxOut {
529 value: funding_generation.1, script_pubkey: funding_generation.2,
531 let funding_output = 'search_loop: loop {
532 let funding_txid = tx.txid();
533 if let None = loss_detector.txids_confirmed.get(&funding_txid) {
534 let outpoint = OutPoint { txid: funding_txid, index: 0 };
535 for chan in channelmanager.list_channels() {
536 if chan.channel_id == outpoint.to_channel_id() {
538 continue 'search_loop;
544 if tx.version > 0xff {
545 continue 'outer_loop;
548 if let Err(e) = channelmanager.funding_transaction_generated(&funding_generation.0, tx.clone()) {
549 // It's possible the channel has been closed in the mean time, but any other
550 // failure may be a bug.
551 if let APIError::ChannelUnavailable { err } = e {
552 assert_eq!(err, "No such channel");
555 pending_funding_signatures.insert(funding_output, tx);
559 let mut txn = broadcast.txn_broadcasted.lock().unwrap().split_off(0);
561 loss_detector.connect_block(&txn[..]);
563 loss_detector.connect_block(&[]);
566 for tx in txn.drain(..) {
567 loss_detector.funding_txn.push(tx);
571 let txlen = slice_to_be16(get_slice!(2));
573 loss_detector.connect_block(&[]);
575 let txres: Result<Transaction, _> = deserialize(get_slice!(txlen));
576 if let Ok(tx) = txres {
577 let mut output_val = 0;
578 for out in tx.output.iter() {
579 if out.value > 21_000_000_0000_0000 { return; }
580 output_val += out.value;
581 if output_val > 21_000_000_0000_0000 { return; }
583 loss_detector.connect_block(&[tx]);
590 loss_detector.disconnect_block();
593 let mut channels = channelmanager.list_channels();
594 let channel_id = get_slice!(1)[0] as usize;
595 if channel_id >= channels.len() { return; }
596 channels.sort_by(|a, b| { a.channel_id.cmp(&b.channel_id) });
597 channelmanager.force_close_channel(&channels[channel_id].channel_id).unwrap();
602 loss_detector.handler.process_events();
603 for event in loss_detector.manager.get_and_clear_pending_events() {
605 Event::FundingGenerationReady { temporary_channel_id, channel_value_satoshis, output_script, .. } => {
606 pending_funding_generation.push((temporary_channel_id, channel_value_satoshis, output_script));
608 Event::PaymentReceived { payment_hash, .. } => {
609 //TODO: enhance by fetching random amounts from fuzz input?
610 payments_received.push(payment_hash);
612 Event::PendingHTLCsForwardable {..} => {
613 should_forward = true;
621 pub fn full_stack_test<Out: test_logger::Output>(data: &[u8], out: Out) {
622 let logger: Arc<dyn Logger> = Arc::new(test_logger::TestLogger::new("".to_owned(), out));
623 do_test(data, &logger);
627 pub extern "C" fn full_stack_run(data: *const u8, datalen: usize) {
628 let logger: Arc<dyn Logger> = Arc::new(test_logger::TestLogger::new("".to_owned(), test_logger::DevNull {}));
629 do_test(unsafe { std::slice::from_raw_parts(data, datalen) }, &logger);
634 use lightning::util::logger::{Logger, Record};
635 use std::collections::HashMap;
636 use std::sync::{Arc, Mutex};
638 struct TrackingLogger {
639 /// (module, message) -> count
640 pub lines: Mutex<HashMap<(String, String), usize>>,
642 impl Logger for TrackingLogger {
643 fn log(&self, record: &Record) {
644 *self.lines.lock().unwrap().entry((record.module_path.to_string(), format!("{}", record.args))).or_insert(0) += 1;
645 println!("{:<5} [{} : {}, {}] {}", record.level.to_string(), record.module_path, record.file, record.line, record.args);
650 fn test_no_existing_test_breakage() {
651 // To avoid accidentally causing all existing fuzz test cases to be useless by making minor
652 // changes (such as requesting feerate info in a new place), we run a pretty full
653 // step-through with two peers and HTLC forwarding here. Obviously this is pretty finicky,
654 // so this should be updated pretty liberally, but at least we'll know when changes occur.
655 // If nothing else, this test serves as a pretty great initial full_stack_target seed.
657 // What each byte represents is broken down below, and then everything is concatenated into
658 // one large test at the end (you want %s/ -.*//g %s/\n\| \|\t\|\///g).
660 // Following BOLT 8, lightning message on the wire are: 2-byte encrypted message length +
661 // 16-byte MAC of the encrypted message length + encrypted Lightning message + 16-byte MAC
662 // of the Lightning message
663 // I.e 2nd inbound read, len 18 : 0006 (encrypted message length) + 03000000000000000000000000000000 (MAC of the encrypted message length)
664 // Len 22 : 0010 00000000 (encrypted lightning message) + 03000000000000000000000000000000 (MAC of the Lightning message)
666 // Writing new code generating transactions and see a new failure ? Don't forget to add input for the FuzzEstimator !
668 // 0100000000000000000000000000000000000000000000000000000000000000 - our network key
669 // 00000000 - fee_proportional_millionths
670 // 01 - announce_channels_publicly
672 // 00 - new outbound connection with id 0
673 // 030000000000000000000000000000000000000000000000000000000000000002 - peer's pubkey
674 // 030032 - inbound read from peer id 0 of len 50
675 // 00 030000000000000000000000000000000000000000000000000000000000000002 03000000000000000000000000000000 - noise act two (0||pubkey||mac)
677 // 030012 - inbound read from peer id 0 of len 18
678 // 000a 03000000000000000000000000000000 - message header indicating message length 10
679 // 03001a - inbound read from peer id 0 of len 26
680 // 0010 00022000 00022000 03000000000000000000000000000000 - init message (type 16) with static_remotekey (0x2000) and mac
682 // 030012 - inbound read from peer id 0 of len 18
683 // 0141 03000000000000000000000000000000 - message header indicating message length 321
684 // 0300fe - inbound read from peer id 0 of len 254
685 // 0020 7500000000000000000000000000000000000000000000000000000000000000 ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679 000000000000c350 0000000000000000 0000000000000162 ffffffffffffffff 0000000000000222 0000000000000000 000000fd 0006 01e3 030000000000000000000000000000000000000000000000000000000000000001 030000000000000000000000000000000000000000000000000000000000000002 030000000000000000000000000000000000000000000000000000000000000003 030000000000000000000000000000000000000000000000000000000000000004 - beginning of open_channel message
686 // 030053 - inbound read from peer id 0 of len 83
687 // 030000000000000000000000000000000000000000000000000000000000000005 020900000000000000000000000000000000000000000000000000000000000000 01 03000000000000000000000000000000 - rest of open_channel and mac
689 // 00fd00fd00fd - Three feerate requests (all returning min feerate, which our open_channel also uses) (gonna be ingested by FuzzEstimator)
690 // - client should now respond with accept_channel (CHECK 1: type 33 to peer 03000000)
692 // 030012 - inbound read from peer id 0 of len 18
693 // 0084 03000000000000000000000000000000 - message header indicating message length 132
694 // 030094 - inbound read from peer id 0 of len 148
695 // 0022 ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679 3d00000000000000000000000000000000000000000000000000000000000000 0000 00000000000000000000000000000000000000000000000000000000000000210100000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - funding_created and mac
696 // - client should now respond with funding_signed (CHECK 2: type 35 to peer 03000000)
698 // 0c005e - connect a block with one transaction of len 94
699 // 020000000100000000000000000000000000000000000000000000000000000000000000000000000000ffffffff0150c3000000000000220020ae0000000000000000000000000000000000000000000000000000000000000000000000 - the funding transaction
700 // 0c0000 - connect a block with no transactions
701 // 0c0000 - connect a block with no transactions
702 // 0c0000 - connect a block with no transactions
703 // 0c0000 - connect a block with no transactions
704 // 0c0000 - connect a block with no transactions
705 // 0c0000 - connect a block with no transactions
706 // 0c0000 - connect a block with no transactions
707 // 0c0000 - connect a block with no transactions
708 // 0c0000 - connect a block with no transactions
709 // 0c0000 - connect a block with no transactions
710 // 0c0000 - connect a block with no transactions
711 // 0c0000 - connect a block with no transactions
712 // - by now client should have sent a funding_locked (CHECK 3: SendFundingLocked to 03000000 for chan 3d000000)
714 // 030012 - inbound read from peer id 0 of len 18
715 // 0043 03000000000000000000000000000000 - message header indicating message length 67
716 // 030053 - inbound read from peer id 0 of len 83
717 // 0024 3d00000000000000000000000000000000000000000000000000000000000000 020800000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - funding_locked and mac
719 // 01 - new inbound connection with id 1
720 // 030132 - inbound read from peer id 1 of len 50
721 // 0003000000000000000000000000000000000000000000000000000000000000000703000000000000000000000000000000 - inbound noise act 1
722 // 030142 - inbound read from peer id 1 of len 66
723 // 000302000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003000000000000000000000000000000 - inbound noise act 3
725 // 030112 - inbound read from peer id 1 of len 18
726 // 000a 01000000000000000000000000000000 - message header indicating message length 10
727 // 03011a - inbound read from peer id 1 of len 26
728 // 0010 00022000 00022000 01000000000000000000000000000000 - init message (type 16) with static_remotekey (0x2000) and mac
730 // 05 01 030200000000000000000000000000000000000000000000000000000000000000 00c350 0003e8 - create outbound channel to peer 1 for 50k sat
731 // 00fd - One feerate requests (all returning min feerate) (gonna be ingested by FuzzEstimator)
733 // 030112 - inbound read from peer id 1 of len 18
734 // 0110 01000000000000000000000000000000 - message header indicating message length 272
735 // 0301ff - inbound read from peer id 1 of len 255
736 // 0021 0000000000000000000000000000000000000000000000000000000000000e05 0000000000000162 00000000004c4b40 00000000000003e8 00000000000003e8 00000002 03f0 0005 030000000000000000000000000000000000000000000000000000000000000100 030000000000000000000000000000000000000000000000000000000000000200 030000000000000000000000000000000000000000000000000000000000000300 030000000000000000000000000000000000000000000000000000000000000400 030000000000000000000000000000000000000000000000000000000000000500 02660000000000000000000000000000 - beginning of accept_channel
737 // 030121 - inbound read from peer id 1 of len 33
738 // 0000000000000000000000000000000000 01000000000000000000000000000000 - rest of accept_channel and mac
740 // 0a - create the funding transaction (client should send funding_created now)
742 // 030112 - inbound read from peer id 1 of len 18
743 // 0062 01000000000000000000000000000000 - message header indicating message length 98
744 // 030172 - inbound read from peer id 1 of len 114
745 // 0023 3a00000000000000000000000000000000000000000000000000000000000000 000000000000000000000000000000000000000000000000000000000000007c0001000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - funding_signed message and mac
747 // 0b - broadcast funding transaction
748 // - by now client should have sent a funding_locked (CHECK 4: SendFundingLocked to 03020000 for chan 3f000000)
750 // 030112 - inbound read from peer id 1 of len 18
751 // 0043 01000000000000000000000000000000 - message header indicating message length 67
752 // 030153 - inbound read from peer id 1 of len 83
753 // 0024 3a00000000000000000000000000000000000000000000000000000000000000 026700000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - funding_locked and mac
755 // 030012 - inbound read from peer id 0 of len 18
756 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
757 // 0300ff - inbound read from peer id 0 of len 255
758 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000000 0000000000003e80 ff00000000000000000000000000000000000000000000000000000000000000 000003f0 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e000001000000000000000003e8000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
759 // 0300ff - inbound read from peer id 0 of len 255
760 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
761 // 0300ff - inbound read from peer id 0 of len 255
762 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
763 // 0300ff - inbound read from peer id 0 of len 255
764 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
765 // 0300ff - inbound read from peer id 0 of len 255
766 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
767 // 0300c1 - inbound read from peer id 0 of len 193
768 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff 4e00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
770 // 030012 - inbound read from peer id 0 of len 18
771 // 0064 03000000000000000000000000000000 - message header indicating message length 100
772 // 030074 - inbound read from peer id 0 of len 116
773 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000300100000000000000000000000000000000000000000000000000000000000000 0000 03000000000000000000000000000000 - commitment_signed and mac
774 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6: types 133 and 132 to peer 03000000)
776 // 030012 - inbound read from peer id 0 of len 18
777 // 0063 03000000000000000000000000000000 - message header indicating message length 99
778 // 030073 - inbound read from peer id 0 of len 115
779 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0900000000000000000000000000000000000000000000000000000000000000 020b00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
781 // 07 - process the now-pending HTLC forward
782 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7: SendHTLCs event for node 03020000 with 1 HTLCs for channel 3f000000)
784 // - we respond with commitment_signed then revoke_and_ack (a weird, but valid, order)
785 // 030112 - inbound read from peer id 1 of len 18
786 // 0064 01000000000000000000000000000000 - message header indicating message length 100
787 // 030174 - inbound read from peer id 1 of len 116
788 // 0084 3a00000000000000000000000000000000000000000000000000000000000000 000000000000000000000000000000000000000000000000000000000000006a0001000000000000000000000000000000000000000000000000000000000000 0000 01000000000000000000000000000000 - commitment_signed and mac
790 // 030112 - inbound read from peer id 1 of len 18
791 // 0063 01000000000000000000000000000000 - message header indicating message length 99
792 // 030173 - inbound read from peer id 1 of len 115
793 // 0085 3a00000000000000000000000000000000000000000000000000000000000000 6600000000000000000000000000000000000000000000000000000000000000 026400000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
795 // 030112 - inbound read from peer id 1 of len 18
796 // 004a 01000000000000000000000000000000 - message header indicating message length 74
797 // 03015a - inbound read from peer id 1 of len 90
798 // 0082 3a00000000000000000000000000000000000000000000000000000000000000 0000000000000000 ff00888888888888888888888888888888888888888888888888888888888888 01000000000000000000000000000000 - update_fulfill_htlc and mac
799 // - client should immediately claim the pending HTLC from peer 0 (CHECK 8: SendFulfillHTLCs for node 03000000 with preimage ff00888888 for channel 3d000000)
801 // 030112 - inbound read from peer id 1 of len 18
802 // 0064 01000000000000000000000000000000 - message header indicating message length 100
803 // 030174 - inbound read from peer id 1 of len 116
804 // 0084 3a00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000100001000000000000000000000000000000000000000000000000000000000000 0000 01000000000000000000000000000000 - commitment_signed and mac
806 // 030112 - inbound read from peer id 1 of len 18
807 // 0063 01000000000000000000000000000000 - message header indicating message length 99
808 // 030173 - inbound read from peer id 1 of len 115
809 // 0085 3a00000000000000000000000000000000000000000000000000000000000000 6700000000000000000000000000000000000000000000000000000000000000 026500000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
811 // - before responding to the commitment_signed generated above, send a new HTLC
812 // 030012 - inbound read from peer id 0 of len 18
813 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
814 // 0300ff - inbound read from peer id 0 of len 255
815 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000001 0000000000003e80 ff00000000000000000000000000000000000000000000000000000000000000 000003f0 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e000001000000000000000003e8000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
816 // 0300ff - inbound read from peer id 0 of len 255
817 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
818 // 0300ff - inbound read from peer id 0 of len 255
819 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
820 // 0300ff - inbound read from peer id 0 of len 255
821 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
822 // 0300ff - inbound read from peer id 0 of len 255
823 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
824 // 0300c1 - inbound read from peer id 0 of len 193
825 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff 4e00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
827 // - now respond to the update_fulfill_htlc+commitment_signed messages the client sent to peer 0
828 // 030012 - inbound read from peer id 0 of len 18
829 // 0063 03000000000000000000000000000000 - message header indicating message length 99
830 // 030073 - inbound read from peer id 0 of len 115
831 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0800000000000000000000000000000000000000000000000000000000000000 020a00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
832 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6 duplicates)
834 // 030012 - inbound read from peer id 0 of len 18
835 // 0064 03000000000000000000000000000000 - message header indicating message length 100
836 // 030074 - inbound read from peer id 0 of len 116
837 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000c30100000000000000000000000000000000000000000000000000000000000000 0000 03000000000000000000000000000000 - commitment_signed and mac
839 // 030012 - inbound read from peer id 0 of len 18
840 // 0063 03000000000000000000000000000000 - message header indicating message length 99
841 // 030073 - inbound read from peer id 0 of len 115
842 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0b00000000000000000000000000000000000000000000000000000000000000 020d00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
844 // 07 - process the now-pending HTLC forward
845 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7 duplicate)
846 // - we respond with revoke_and_ack, then commitment_signed, then update_fail_htlc
848 // 030112 - inbound read from peer id 1 of len 18
849 // 0064 01000000000000000000000000000000 - message header indicating message length 100
850 // 030174 - inbound read from peer id 1 of len 116
851 // 0084 3a00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000390001000000000000000000000000000000000000000000000000000000000000 0000 01000000000000000000000000000000 - commitment_signed and mac
853 // 030112 - inbound read from peer id 1 of len 18
854 // 0063 01000000000000000000000000000000 - message header indicating message length 99
855 // 030173 - inbound read from peer id 1 of len 115
856 // 0085 3a00000000000000000000000000000000000000000000000000000000000000 6400000000000000000000000000000000000000000000000000000000000000 027000000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
858 // 030112 - inbound read from peer id 1 of len 18
859 // 002c 01000000000000000000000000000000 - message header indicating message length 44
860 // 03013c - inbound read from peer id 1 of len 60
861 // 0083 3a00000000000000000000000000000000000000000000000000000000000000 0000000000000001 0000 01000000000000000000000000000000 - update_fail_htlc and mac
863 // 030112 - inbound read from peer id 1 of len 18
864 // 0064 01000000000000000000000000000000 - message header indicating message length 100
865 // 030174 - inbound read from peer id 1 of len 116
866 // 0084 3a00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000390001000000000000000000000000000000000000000000000000000000000000 0000 01000000000000000000000000000000 - commitment_signed and mac
868 // 030112 - inbound read from peer id 1 of len 18
869 // 0063 01000000000000000000000000000000 - message header indicating message length 99
870 // 030173 - inbound read from peer id 1 of len 115
871 // 0085 3a00000000000000000000000000000000000000000000000000000000000000 6500000000000000000000000000000000000000000000000000000000000000 027100000000000000000000000000000000000000000000000000000000000000 01000000000000000000000000000000 - revoke_and_ack and mac
873 // 07 - process the now-pending HTLC forward
874 // - client now sends id 0 update_fail_htlc and commitment_signed (CHECK 9)
875 // - now respond to the update_fail_htlc+commitment_signed messages the client sent to peer 0
877 // 030012 - inbound read from peer id 0 of len 18
878 // 0063 03000000000000000000000000000000 - message header indicating message length 99
879 // 030073 - inbound read from peer id 0 of len 115
880 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0a00000000000000000000000000000000000000000000000000000000000000 020c00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
882 // 030012 - inbound read from peer id 0 of len 18
883 // 0064 03000000000000000000000000000000 - message header indicating message length 100
884 // 030074 - inbound read from peer id 0 of len 116
885 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000320100000000000000000000000000000000000000000000000000000000000000 0000 03000000000000000000000000000000 - commitment_signed and mac
886 // - client should now respond with revoke_and_ack (CHECK 5 duplicate)
888 // 030012 - inbound read from peer id 0 of len 18
889 // 05ac 03000000000000000000000000000000 - message header indicating message length 1452
890 // 0300ff - inbound read from peer id 0 of len 255
891 // 0080 3d00000000000000000000000000000000000000000000000000000000000000 0000000000000002 00000000000b0838 ff00000000000000000000000000000000000000000000000000000000000000 000003f0 00 030000000000000000000000000000000000000000000000000000000000000555 0000000e000001000000000000000927c0000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000 ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff - beginning of update_add_htlc from 0 to 1 via client
892 // 0300ff - inbound read from peer id 0 of len 255
893 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
894 // 0300ff - inbound read from peer id 0 of len 255
895 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
896 // 0300ff - inbound read from peer id 0 of len 255
897 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
898 // 0300ff - inbound read from peer id 0 of len 255
899 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff
900 // 0300c1 - inbound read from peer id 0 of len 193
901 // ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff 4b00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - end of update_add_htlc from 0 to 1 via client and mac
903 // 030012 - inbound read from peer id 0 of len 18
904 // 00a4 03000000000000000000000000000000 - message header indicating message length 164
905 // 0300b4 - inbound read from peer id 0 of len 180
906 // 0084 3d00000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000750100000000000000000000000000000000000000000000000000000000000000 0001 00000000000000000000000000000000000000000000000000000000000000670500000000000000000000000000000000000000000000000000000000000006 03000000000000000000000000000000 - commitment_signed and mac
907 // - client should now respond with revoke_and_ack and commitment_signed (CHECK 5/6 duplicates)
909 // 030012 - inbound read from peer id 0 of len 18
910 // 0063 03000000000000000000000000000000 - message header indicating message length 99
911 // 030073 - inbound read from peer id 0 of len 115
912 // 0085 3d00000000000000000000000000000000000000000000000000000000000000 0d00000000000000000000000000000000000000000000000000000000000000 020f00000000000000000000000000000000000000000000000000000000000000 03000000000000000000000000000000 - revoke_and_ack and mac
914 // 07 - process the now-pending HTLC forward
915 // - client now sends id 1 update_add_htlc and commitment_signed (CHECK 7 duplicate)
917 // 0c007d - connect a block with one transaction of len 125
918 // 02000000013a000000000000000000000000000000000000000000000000000000000000000000000000000000800258020000000000002200204b0000000000000000000000000000000000000000000000000000000000000014c0000000000000160014280000000000000000000000000000000000000005000020 - the commitment transaction for channel 3f00000000000000000000000000000000000000000000000000000000000000
920 // 0c005e - connect a block with one transaction of len 94
921 // 0200000001730000000000000000000000000000000000000000000000000000000000000000000000000000000001a701000000000000220020b20000000000000000000000000000000000000000000000000000000000000000000000 - the HTLC timeout transaction
922 // 0c0000 - connect a block with no transactions
923 // 0c0000 - connect a block with no transactions
924 // 0c0000 - connect a block with no transactions
925 // 0c0000 - connect a block with no transactions
926 // 0c0000 - connect a block with no transactions
928 // 07 - process the now-pending HTLC forward
929 // - client now fails the HTLC backwards as it was unable to extract the payment preimage (CHECK 9 duplicate and CHECK 10)
931 let logger = Arc::new(TrackingLogger { lines: Mutex::new(HashMap::new()) });
932 super::do_test(&::hex::decode("01000000000000000000000000000000000000000000000000000000000000000000000001000300000000000000000000000000000000000000000000000000000000000000020300320003000000000000000000000000000000000000000000000000000000000000000203000000000000000000000000000000030012000a0300000000000000000000000000000003001a00100002200000022000030000000000000000000000000000000300120141030000000000000000000000000000000300fe00207500000000000000000000000000000000000000000000000000000000000000ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679000000000000c35000000000000000000000000000000162ffffffffffffffff00000000000002220000000000000000000000fd000601e3030000000000000000000000000000000000000000000000000000000000000001030000000000000000000000000000000000000000000000000000000000000002030000000000000000000000000000000000000000000000000000000000000003030000000000000000000000000000000000000000000000000000000000000004030053030000000000000000000000000000000000000000000000000000000000000005020900000000000000000000000000000000000000000000000000000000000000010300000000000000000000000000000000fd00fd00fd0300120084030000000000000000000000000000000300940022ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb1819096793d00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000210100000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000c005e020000000100000000000000000000000000000000000000000000000000000000000000000000000000ffffffff0150c3000000000000220020ae00000000000000000000000000000000000000000000000000000000000000000000000c00000c00000c00000c00000c00000c00000c00000c00000c00000c00000c00000c000003001200430300000000000000000000000000000003005300243d0000000000000000000000000000000000000000000000000000000000000002080000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000010301320003000000000000000000000000000000000000000000000000000000000000000703000000000000000000000000000000030142000302000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003000000000000000000000000000000030112000a0100000000000000000000000000000003011a0010000220000002200001000000000000000000000000000000050103020000000000000000000000000000000000000000000000000000000000000000c3500003e800fd0301120110010000000000000000000000000000000301ff00210000000000000000000000000000000000000000000000000000000000000e05000000000000016200000000004c4b4000000000000003e800000000000003e80000000203f00005030000000000000000000000000000000000000000000000000000000000000100030000000000000000000000000000000000000000000000000000000000000200030000000000000000000000000000000000000000000000000000000000000300030000000000000000000000000000000000000000000000000000000000000400030000000000000000000000000000000000000000000000000000000000000500026600000000000000000000000000000301210000000000000000000000000000000000010000000000000000000000000000000a03011200620100000000000000000000000000000003017200233a00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000007c0001000000000000000000000000000000000000000000000000000000000000010000000000000000000000000000000b03011200430100000000000000000000000000000003015300243a000000000000000000000000000000000000000000000000000000000000000267000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003e80ff00000000000000000000000000000000000000000000000000000000000000000003f0000300000000000000000000000000000000000000000000000000000000000005550000000e000001000000000000000003e8000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff4e000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200640300000000000000000000000000000003007400843d000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000030010000000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000900000000000000000000000000000000000000000000000000000000000000020b00000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000703011200640100000000000000000000000000000003017400843a00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000006a000100000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853a00000000000000000000000000000000000000000000000000000000000000660000000000000000000000000000000000000000000000000000000000000002640000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000030112004a0100000000000000000000000000000003015a00823a000000000000000000000000000000000000000000000000000000000000000000000000000000ff008888888888888888888888888888888888888888888888888888888888880100000000000000000000000000000003011200640100000000000000000000000000000003017400843a000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000010000100000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853a0000000000000000000000000000000000000000000000000000000000000067000000000000000000000000000000000000000000000000000000000000000265000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d0000000000000000000000000000000000000000000000000000000000000000000000000000010000000000003e80ff00000000000000000000000000000000000000000000000000000000000000000003f0000300000000000000000000000000000000000000000000000000000000000005550000000e000001000000000000000003e8000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff4e000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000800000000000000000000000000000000000000000000000000000000000000020a000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200640300000000000000000000000000000003007400843d0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000c3010000000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000b00000000000000000000000000000000000000000000000000000000000000020d00000000000000000000000000000000000000000000000000000000000000030000000000000000000000000000000703011200640100000000000000000000000000000003017400843a000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000039000100000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853a00000000000000000000000000000000000000000000000000000000000000640000000000000000000000000000000000000000000000000000000000000002700000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000030112002c0100000000000000000000000000000003013c00833a00000000000000000000000000000000000000000000000000000000000000000000000000000100000100000000000000000000000000000003011200640100000000000000000000000000000003017400843a000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000039000100000000000000000000000000000000000000000000000000000000000000000100000000000000000000000000000003011200630100000000000000000000000000000003017300853a000000000000000000000000000000000000000000000000000000000000006500000000000000000000000000000000000000000000000000000000000000027100000000000000000000000000000000000000000000000000000000000000010000000000000000000000000000000703001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000020c000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200640300000000000000000000000000000003007400843d000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000032010000000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001205ac030000000000000000000000000000000300ff00803d00000000000000000000000000000000000000000000000000000000000000000000000000000200000000000b0838ff00000000000000000000000000000000000000000000000000000000000000000003f0000300000000000000000000000000000000000000000000000000000000000005550000000e000001000000000000000927c0000000a00000000000000000000000000a00000000000000000000000000000000000000000000000000000000000000ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0300c1ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff4b000000000000000000000000000000000000000000000000000000000000000300000000000000000000000000000003001200a4030000000000000000000000000000000300b400843d00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000007501000000000000000000000000000000000000000000000000000000000000000001000000000000000000000000000000000000000000000000000000000000006705000000000000000000000000000000000000000000000000000000000000060300000000000000000000000000000003001200630300000000000000000000000000000003007300853d000000000000000000000000000000000000000000000000000000000000000d00000000000000000000000000000000000000000000000000000000000000020f0000000000000000000000000000000000000000000000000000000000000003000000000000000000000000000000070c007d02000000013a000000000000000000000000000000000000000000000000000000000000000000000000000000800258020000000000002200204b0000000000000000000000000000000000000000000000000000000000000014c00000000000001600142800000000000000000000000000000000000000050000200c005e0200000001730000000000000000000000000000000000000000000000000000000000000000000000000000000001a701000000000000220020b200000000000000000000000000000000000000000000000000000000000000000000000c00000c00000c00000c00000c000007").unwrap(), &(Arc::clone(&logger) as Arc<dyn Logger>));
934 let log_entries = logger.lines.lock().unwrap();
935 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendAcceptChannel event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 for channel ff4f00f805273c1b203bb5ebf8436bfde57b3be8c2f5e95d9491dbb181909679".to_string())), Some(&1)); // 1
936 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingSigned event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 2
937 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingLocked event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 3
938 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendFundingLocked event in peer_handler for node 030200000000000000000000000000000000000000000000000000000000000000 for channel 3a00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 4
939 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling SendRevokeAndACK event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&4)); // 5
940 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 with 0 adds, 0 fulfills, 0 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&3)); // 6
941 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 3a00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&3)); // 7
942 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 with 0 adds, 1 fulfills, 0 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&1)); // 8
943 assert_eq!(log_entries.get(&("lightning::ln::peer_handler".to_string(), "Handling UpdateHTLCs event in peer_handler for node 030000000000000000000000000000000000000000000000000000000000000002 with 0 adds, 0 fulfills, 1 fails for channel 3d00000000000000000000000000000000000000000000000000000000000000".to_string())), Some(&2)); // 9
944 assert_eq!(log_entries.get(&("lightning::chain::channelmonitor".to_string(), "Input spending counterparty commitment tx (0000000000000000000000000000000000000000000000000000000000000073:0) in 0000000000000000000000000000000000000000000000000000000000000067 resolves outbound HTLC with payment hash ff00000000000000000000000000000000000000000000000000000000000000 with timeout".to_string())), Some(&1)); // 10