783bbc06aa9fe58e4de90e5ce13650aeb0458b9d
[rust-lightning] / fuzz / src / chanmon_consistency.rs
1 // This file is Copyright its original authors, visible in version control
2 // history.
3 //
4 // This file is licensed under the Apache License, Version 2.0 <LICENSE-APACHE
5 // or http://www.apache.org/licenses/LICENSE-2.0> or the MIT license
6 // <LICENSE-MIT or http://opensource.org/licenses/MIT>, at your option.
7 // You may not use this file except in accordance with one or both of these
8 // licenses.
9
10 //! Test that monitor update failures don't get our channel state out of sync.
11 //! One of the biggest concern with the monitor update failure handling code is that messages
12 //! resent after monitor updating is restored are delivered out-of-order, resulting in
13 //! commitment_signed messages having "invalid signatures".
14 //! To test this we stand up a network of three nodes and read bytes from the fuzz input to denote
15 //! actions such as sending payments, handling events, or changing monitor update return values on
16 //! a per-node basis. This should allow it to find any cases where the ordering of actions results
17 //! in us getting out of sync with ourselves, and, assuming at least one of our recieve- or
18 //! send-side handling is correct, other peers. We consider it a failure if any action results in a
19 //! channel being force-closed.
20
21 use bitcoin::TxMerkleNode;
22 use bitcoin::blockdata::block::BlockHeader;
23 use bitcoin::blockdata::constants::genesis_block;
24 use bitcoin::blockdata::transaction::{Transaction, TxOut};
25 use bitcoin::blockdata::script::{Builder, Script};
26 use bitcoin::blockdata::opcodes;
27 use bitcoin::blockdata::locktime::PackedLockTime;
28 use bitcoin::network::constants::Network;
29
30 use bitcoin::hashes::Hash as TraitImport;
31 use bitcoin::hashes::sha256::Hash as Sha256;
32 use bitcoin::hash_types::{BlockHash, WPubkeyHash};
33
34 use lightning::chain;
35 use lightning::chain::{BestBlock, ChannelMonitorUpdateStatus, chainmonitor, channelmonitor, Confirm, Watch};
36 use lightning::chain::channelmonitor::{ChannelMonitor, MonitorEvent};
37 use lightning::chain::transaction::OutPoint;
38 use lightning::chain::chaininterface::{BroadcasterInterface, ConfirmationTarget, FeeEstimator};
39 use lightning::chain::keysinterface::{KeyMaterial, KeysInterface, InMemorySigner, Recipient};
40 use lightning::ln::{PaymentHash, PaymentPreimage, PaymentSecret};
41 use lightning::ln::channelmanager::{self, ChainParameters, ChannelManager, PaymentSendFailure, ChannelManagerReadArgs, PaymentId};
42 use lightning::ln::channel::FEE_SPIKE_BUFFER_FEE_INCREASE_MULTIPLE;
43 use lightning::ln::msgs::{CommitmentUpdate, ChannelMessageHandler, DecodeError, UpdateAddHTLC, Init};
44 use lightning::ln::script::ShutdownScript;
45 use lightning::util::enforcing_trait_impls::{EnforcingSigner, EnforcementState};
46 use lightning::util::errors::APIError;
47 use lightning::util::events;
48 use lightning::util::logger::Logger;
49 use lightning::util::config::UserConfig;
50 use lightning::util::events::MessageSendEventsProvider;
51 use lightning::util::ser::{Readable, ReadableArgs, Writeable, Writer};
52 use lightning::routing::router::{Route, RouteHop};
53
54 use crate::utils::test_logger::{self, Output};
55 use crate::utils::test_persister::TestPersister;
56
57 use bitcoin::secp256k1::{PublicKey, SecretKey, Scalar};
58 use bitcoin::secp256k1::ecdh::SharedSecret;
59 use bitcoin::secp256k1::ecdsa::RecoverableSignature;
60 use bitcoin::secp256k1::Secp256k1;
61
62 use std::mem;
63 use std::cmp::{self, Ordering};
64 use std::collections::{HashSet, hash_map, HashMap};
65 use std::sync::{Arc,Mutex};
66 use std::sync::atomic;
67 use std::io::Cursor;
68 use bitcoin::bech32::u5;
69
70 const MAX_FEE: u32 = 10_000;
71 struct FuzzEstimator {
72         ret_val: atomic::AtomicU32,
73 }
74 impl FeeEstimator for FuzzEstimator {
75         fn get_est_sat_per_1000_weight(&self, conf_target: ConfirmationTarget) -> u32 {
76                 // We force-close channels if our counterparty sends us a feerate which is a small multiple
77                 // of our HighPriority fee estimate or smaller than our Background fee estimate. Thus, we
78                 // always return a HighPriority feerate here which is >= the maximum Normal feerate and a
79                 // Background feerate which is <= the minimum Normal feerate.
80                 match conf_target {
81                         ConfirmationTarget::HighPriority => MAX_FEE,
82                         ConfirmationTarget::Background => 253,
83                         ConfirmationTarget::Normal => cmp::min(self.ret_val.load(atomic::Ordering::Acquire), MAX_FEE),
84                 }
85         }
86 }
87
88 pub struct TestBroadcaster {}
89 impl BroadcasterInterface for TestBroadcaster {
90         fn broadcast_transaction(&self, _tx: &Transaction) { }
91 }
92
93 pub struct VecWriter(pub Vec<u8>);
94 impl Writer for VecWriter {
95         fn write_all(&mut self, buf: &[u8]) -> Result<(), ::std::io::Error> {
96                 self.0.extend_from_slice(buf);
97                 Ok(())
98         }
99 }
100
101 struct TestChainMonitor {
102         pub logger: Arc<dyn Logger>,
103         pub keys: Arc<KeyProvider>,
104         pub persister: Arc<TestPersister>,
105         pub chain_monitor: Arc<chainmonitor::ChainMonitor<EnforcingSigner, Arc<dyn chain::Filter>, Arc<TestBroadcaster>, Arc<FuzzEstimator>, Arc<dyn Logger>, Arc<TestPersister>>>,
106         // If we reload a node with an old copy of ChannelMonitors, the ChannelManager deserialization
107         // logic will automatically force-close our channels for us (as we don't have an up-to-date
108         // monitor implying we are not able to punish misbehaving counterparties). Because this test
109         // "fails" if we ever force-close a channel, we avoid doing so, always saving the latest
110         // fully-serialized monitor state here, as well as the corresponding update_id.
111         pub latest_monitors: Mutex<HashMap<OutPoint, (u64, Vec<u8>)>>,
112         pub should_update_manager: atomic::AtomicBool,
113 }
114 impl TestChainMonitor {
115         pub fn new(broadcaster: Arc<TestBroadcaster>, logger: Arc<dyn Logger>, feeest: Arc<FuzzEstimator>, persister: Arc<TestPersister>, keys: Arc<KeyProvider>) -> Self {
116                 Self {
117                         chain_monitor: Arc::new(chainmonitor::ChainMonitor::new(None, broadcaster, logger.clone(), feeest, Arc::clone(&persister))),
118                         logger,
119                         keys,
120                         persister,
121                         latest_monitors: Mutex::new(HashMap::new()),
122                         should_update_manager: atomic::AtomicBool::new(false),
123                 }
124         }
125 }
126 impl chain::Watch<EnforcingSigner> for TestChainMonitor {
127         fn watch_channel(&self, funding_txo: OutPoint, monitor: channelmonitor::ChannelMonitor<EnforcingSigner>) -> chain::ChannelMonitorUpdateStatus {
128                 let mut ser = VecWriter(Vec::new());
129                 monitor.write(&mut ser).unwrap();
130                 if let Some(_) = self.latest_monitors.lock().unwrap().insert(funding_txo, (monitor.get_latest_update_id(), ser.0)) {
131                         panic!("Already had monitor pre-watch_channel");
132                 }
133                 self.should_update_manager.store(true, atomic::Ordering::Relaxed);
134                 self.chain_monitor.watch_channel(funding_txo, monitor)
135         }
136
137         fn update_channel(&self, funding_txo: OutPoint, update: channelmonitor::ChannelMonitorUpdate) -> chain::ChannelMonitorUpdateStatus {
138                 let mut map_lock = self.latest_monitors.lock().unwrap();
139                 let mut map_entry = match map_lock.entry(funding_txo) {
140                         hash_map::Entry::Occupied(entry) => entry,
141                         hash_map::Entry::Vacant(_) => panic!("Didn't have monitor on update call"),
142                 };
143                 let deserialized_monitor = <(BlockHash, channelmonitor::ChannelMonitor<EnforcingSigner>)>::
144                         read(&mut Cursor::new(&map_entry.get().1), &*self.keys).unwrap().1;
145                 deserialized_monitor.update_monitor(&update, &&TestBroadcaster{}, &FuzzEstimator { ret_val: atomic::AtomicU32::new(253) }, &self.logger).unwrap();
146                 let mut ser = VecWriter(Vec::new());
147                 deserialized_monitor.write(&mut ser).unwrap();
148                 map_entry.insert((update.update_id, ser.0));
149                 self.should_update_manager.store(true, atomic::Ordering::Relaxed);
150                 self.chain_monitor.update_channel(funding_txo, update)
151         }
152
153         fn release_pending_monitor_events(&self) -> Vec<(OutPoint, Vec<MonitorEvent>, Option<PublicKey>)> {
154                 return self.chain_monitor.release_pending_monitor_events();
155         }
156 }
157
158 struct KeyProvider {
159         node_id: u8,
160         rand_bytes_id: atomic::AtomicU32,
161         enforcement_states: Mutex<HashMap<[u8;32], Arc<Mutex<EnforcementState>>>>,
162 }
163 impl KeysInterface for KeyProvider {
164         type Signer = EnforcingSigner;
165
166         fn get_node_secret(&self, _recipient: Recipient) -> Result<SecretKey, ()> {
167                 Ok(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, self.node_id]).unwrap())
168         }
169
170         fn ecdh(&self, recipient: Recipient, other_key: &PublicKey, tweak: Option<&Scalar>) -> Result<SharedSecret, ()> {
171                 let mut node_secret = self.get_node_secret(recipient)?;
172                 if let Some(tweak) = tweak {
173                         node_secret = node_secret.mul_tweak(tweak).unwrap();
174                 }
175                 Ok(SharedSecret::new(other_key, &node_secret))
176         }
177
178         fn get_inbound_payment_key_material(&self) -> KeyMaterial {
179                 KeyMaterial([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, self.node_id])
180         }
181
182         fn get_destination_script(&self) -> Script {
183                 let secp_ctx = Secp256k1::signing_only();
184                 let channel_monitor_claim_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, self.node_id]).unwrap();
185                 let our_channel_monitor_claim_key_hash = WPubkeyHash::hash(&PublicKey::from_secret_key(&secp_ctx, &channel_monitor_claim_key).serialize());
186                 Builder::new().push_opcode(opcodes::all::OP_PUSHBYTES_0).push_slice(&our_channel_monitor_claim_key_hash[..]).into_script()
187         }
188
189         fn get_shutdown_scriptpubkey(&self) -> ShutdownScript {
190                 let secp_ctx = Secp256k1::signing_only();
191                 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, 3, self.node_id]).unwrap();
192                 let pubkey_hash = WPubkeyHash::hash(&PublicKey::from_secret_key(&secp_ctx, &secret_key).serialize());
193                 ShutdownScript::new_p2wpkh(&pubkey_hash)
194         }
195
196         fn get_channel_signer(&self, _inbound: bool, channel_value_satoshis: u64) -> EnforcingSigner {
197                 let secp_ctx = Secp256k1::signing_only();
198                 let id = self.rand_bytes_id.fetch_add(1, atomic::Ordering::Relaxed);
199                 let keys = InMemorySigner::new(
200                         &secp_ctx,
201                         self.get_node_secret(Recipient::Node).unwrap(),
202                         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, self.node_id]).unwrap(),
203                         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, self.node_id]).unwrap(),
204                         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, 6, self.node_id]).unwrap(),
205                         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, self.node_id]).unwrap(),
206                         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, self.node_id]).unwrap(),
207                         [id as u8, 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, self.node_id],
208                         channel_value_satoshis,
209                         [0; 32],
210                 );
211                 let revoked_commitment = self.make_enforcement_state_cell(keys.commitment_seed);
212                 EnforcingSigner::new_with_revoked(keys, revoked_commitment, false)
213         }
214
215         fn get_secure_random_bytes(&self) -> [u8; 32] {
216                 let id = self.rand_bytes_id.fetch_add(1, atomic::Ordering::Relaxed);
217                 let mut res = [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, self.node_id];
218                 res[30-4..30].copy_from_slice(&id.to_le_bytes());
219                 res
220         }
221
222         fn read_chan_signer(&self, buffer: &[u8]) -> Result<Self::Signer, DecodeError> {
223                 let mut reader = std::io::Cursor::new(buffer);
224
225                 let inner: InMemorySigner = ReadableArgs::read(&mut reader, self.get_node_secret(Recipient::Node).unwrap())?;
226                 let state = self.make_enforcement_state_cell(inner.commitment_seed);
227
228                 Ok(EnforcingSigner {
229                         inner,
230                         state,
231                         disable_revocation_policy_check: false,
232                 })
233         }
234
235         fn sign_invoice(&self, _hrp_bytes: &[u8], _invoice_data: &[u5], _recipient: Recipient) -> Result<RecoverableSignature, ()> {
236                 unreachable!()
237         }
238 }
239
240 impl KeyProvider {
241         fn make_enforcement_state_cell(&self, commitment_seed: [u8; 32]) -> Arc<Mutex<EnforcementState>> {
242                 let mut revoked_commitments = self.enforcement_states.lock().unwrap();
243                 if !revoked_commitments.contains_key(&commitment_seed) {
244                         revoked_commitments.insert(commitment_seed, Arc::new(Mutex::new(EnforcementState::new())));
245                 }
246                 let cell = revoked_commitments.get(&commitment_seed).unwrap();
247                 Arc::clone(cell)
248         }
249 }
250
251 #[inline]
252 fn check_api_err(api_err: APIError) {
253         match api_err {
254                 APIError::APIMisuseError { .. } => panic!("We can't misuse the API"),
255                 APIError::FeeRateTooHigh { .. } => panic!("We can't send too much fee?"),
256                 APIError::RouteError { .. } => panic!("Our routes should work"),
257                 APIError::ChannelUnavailable { err } => {
258                         // Test the error against a list of errors we can hit, and reject
259                         // all others. If you hit this panic, the list of acceptable errors
260                         // is probably just stale and you should add new messages here.
261                         match err.as_str() {
262                                 "Peer for first hop currently disconnected/pending monitor update!" => {},
263                                 _ if err.starts_with("Cannot push more than their max accepted HTLCs ") => {},
264                                 _ if err.starts_with("Cannot send value that would put us over the max HTLC value in flight our peer will accept ") => {},
265                                 _ if err.starts_with("Cannot send value that would put our balance under counterparty-announced channel reserve value") => {},
266                                 _ if err.starts_with("Cannot send value that would put counterparty balance under holder-announced channel reserve value") => {},
267                                 _ if err.starts_with("Cannot send value that would overdraw remaining funds.") => {},
268                                 _ if err.starts_with("Cannot send value that would not leave enough to pay for fees.") => {},
269                                 _ if err.starts_with("Cannot send value that would put our exposure to dust HTLCs at") => {},
270                                 _ => panic!("{}", err),
271                         }
272                 },
273                 APIError::MonitorUpdateInProgress => {
274                         // We can (obviously) temp-fail a monitor update
275                 },
276                 APIError::IncompatibleShutdownScript { .. } => panic!("Cannot send an incompatible shutdown script"),
277         }
278 }
279 #[inline]
280 fn check_payment_err(send_err: PaymentSendFailure) {
281         match send_err {
282                 PaymentSendFailure::ParameterError(api_err) => check_api_err(api_err),
283                 PaymentSendFailure::PathParameterError(per_path_results) => {
284                         for res in per_path_results { if let Err(api_err) = res { check_api_err(api_err); } }
285                 },
286                 PaymentSendFailure::AllFailedResendSafe(per_path_results) => {
287                         for api_err in per_path_results { check_api_err(api_err); }
288                 },
289                 PaymentSendFailure::PartialFailure { results, .. } => {
290                         for res in results { if let Err(api_err) = res { check_api_err(api_err); } }
291                 },
292                 PaymentSendFailure::DuplicatePayment => panic!(),
293         }
294 }
295
296 type ChanMan = ChannelManager<Arc<TestChainMonitor>, Arc<TestBroadcaster>, Arc<KeyProvider>, Arc<FuzzEstimator>, Arc<dyn Logger>>;
297
298 #[inline]
299 fn get_payment_secret_hash(dest: &ChanMan, payment_id: &mut u8) -> Option<(PaymentSecret, PaymentHash)> {
300         let mut payment_hash;
301         for _ in 0..256 {
302                 payment_hash = PaymentHash(Sha256::hash(&[*payment_id; 1]).into_inner());
303                 if let Ok(payment_secret) = dest.create_inbound_payment_for_hash(payment_hash, None, 3600) {
304                         return Some((payment_secret, payment_hash));
305                 }
306                 *payment_id = payment_id.wrapping_add(1);
307         }
308         None
309 }
310
311 #[inline]
312 fn send_payment(source: &ChanMan, dest: &ChanMan, dest_chan_id: u64, amt: u64, payment_id: &mut u8, payment_idx: &mut u64) -> bool {
313         let (payment_secret, payment_hash) =
314                 if let Some((secret, hash)) = get_payment_secret_hash(dest, payment_id) { (secret, hash) } else { return true; };
315         let mut payment_id = [0; 32];
316         payment_id[0..8].copy_from_slice(&payment_idx.to_ne_bytes());
317         *payment_idx += 1;
318         if let Err(err) = source.send_payment(&Route {
319                 paths: vec![vec![RouteHop {
320                         pubkey: dest.get_our_node_id(),
321                         node_features: channelmanager::provided_node_features(),
322                         short_channel_id: dest_chan_id,
323                         channel_features: channelmanager::provided_channel_features(),
324                         fee_msat: amt,
325                         cltv_expiry_delta: 200,
326                 }]],
327                 payment_params: None,
328         }, payment_hash, &Some(payment_secret), PaymentId(payment_id)) {
329                 check_payment_err(err);
330                 false
331         } else { true }
332 }
333 #[inline]
334 fn send_hop_payment(source: &ChanMan, middle: &ChanMan, middle_chan_id: u64, dest: &ChanMan, dest_chan_id: u64, amt: u64, payment_id: &mut u8, payment_idx: &mut u64) -> bool {
335         let (payment_secret, payment_hash) =
336                 if let Some((secret, hash)) = get_payment_secret_hash(dest, payment_id) { (secret, hash) } else { return true; };
337         let mut payment_id = [0; 32];
338         payment_id[0..8].copy_from_slice(&payment_idx.to_ne_bytes());
339         *payment_idx += 1;
340         if let Err(err) = source.send_payment(&Route {
341                 paths: vec![vec![RouteHop {
342                         pubkey: middle.get_our_node_id(),
343                         node_features: channelmanager::provided_node_features(),
344                         short_channel_id: middle_chan_id,
345                         channel_features: channelmanager::provided_channel_features(),
346                         fee_msat: 50000,
347                         cltv_expiry_delta: 100,
348                 },RouteHop {
349                         pubkey: dest.get_our_node_id(),
350                         node_features: channelmanager::provided_node_features(),
351                         short_channel_id: dest_chan_id,
352                         channel_features: channelmanager::provided_channel_features(),
353                         fee_msat: amt,
354                         cltv_expiry_delta: 200,
355                 }]],
356                 payment_params: None,
357         }, payment_hash, &Some(payment_secret), PaymentId(payment_id)) {
358                 check_payment_err(err);
359                 false
360         } else { true }
361 }
362
363 #[inline]
364 pub fn do_test<Out: Output>(data: &[u8], underlying_out: Out) {
365         let out = SearchingOutput::new(underlying_out);
366         let broadcast = Arc::new(TestBroadcaster{});
367
368         macro_rules! make_node {
369                 ($node_id: expr, $fee_estimator: expr) => { {
370                         let logger: Arc<dyn Logger> = Arc::new(test_logger::TestLogger::new($node_id.to_string(), out.clone()));
371                         let keys_manager = Arc::new(KeyProvider { node_id: $node_id, rand_bytes_id: atomic::AtomicU32::new(0), enforcement_states: Mutex::new(HashMap::new()) });
372                         let monitor = Arc::new(TestChainMonitor::new(broadcast.clone(), logger.clone(), $fee_estimator.clone(),
373                                 Arc::new(TestPersister {
374                                         update_ret: Mutex::new(ChannelMonitorUpdateStatus::Completed)
375                                 }), Arc::clone(&keys_manager)));
376
377                         let mut config = UserConfig::default();
378                         config.channel_config.forwarding_fee_proportional_millionths = 0;
379                         config.channel_handshake_config.announced_channel = true;
380                         let network = Network::Bitcoin;
381                         let params = ChainParameters {
382                                 network,
383                                 best_block: BestBlock::from_genesis(network),
384                         };
385                         (ChannelManager::new($fee_estimator.clone(), monitor.clone(), broadcast.clone(), Arc::clone(&logger), keys_manager.clone(), config, params),
386                         monitor, keys_manager)
387                 } }
388         }
389
390         macro_rules! reload_node {
391                 ($ser: expr, $node_id: expr, $old_monitors: expr, $keys_manager: expr, $fee_estimator: expr) => { {
392                     let keys_manager = Arc::clone(& $keys_manager);
393                         let logger: Arc<dyn Logger> = Arc::new(test_logger::TestLogger::new($node_id.to_string(), out.clone()));
394                         let chain_monitor = Arc::new(TestChainMonitor::new(broadcast.clone(), logger.clone(), $fee_estimator.clone(),
395                                 Arc::new(TestPersister {
396                                         update_ret: Mutex::new(ChannelMonitorUpdateStatus::Completed)
397                                 }), Arc::clone(& $keys_manager)));
398
399                         let mut config = UserConfig::default();
400                         config.channel_config.forwarding_fee_proportional_millionths = 0;
401                         config.channel_handshake_config.announced_channel = true;
402
403                         let mut monitors = HashMap::new();
404                         let mut old_monitors = $old_monitors.latest_monitors.lock().unwrap();
405                         for (outpoint, (update_id, monitor_ser)) in old_monitors.drain() {
406                                 monitors.insert(outpoint, <(BlockHash, ChannelMonitor<EnforcingSigner>)>::read(&mut Cursor::new(&monitor_ser), &*$keys_manager).expect("Failed to read monitor").1);
407                                 chain_monitor.latest_monitors.lock().unwrap().insert(outpoint, (update_id, monitor_ser));
408                         }
409                         let mut monitor_refs = HashMap::new();
410                         for (outpoint, monitor) in monitors.iter_mut() {
411                                 monitor_refs.insert(*outpoint, monitor);
412                         }
413
414                         let read_args = ChannelManagerReadArgs {
415                                 keys_manager,
416                                 fee_estimator: $fee_estimator.clone(),
417                                 chain_monitor: chain_monitor.clone(),
418                                 tx_broadcaster: broadcast.clone(),
419                                 logger,
420                                 default_config: config,
421                                 channel_monitors: monitor_refs,
422                         };
423
424                         let res = (<(BlockHash, ChanMan)>::read(&mut Cursor::new(&$ser.0), read_args).expect("Failed to read manager").1, chain_monitor.clone());
425                         for (funding_txo, mon) in monitors.drain() {
426                                 assert_eq!(chain_monitor.chain_monitor.watch_channel(funding_txo, mon),
427                                         ChannelMonitorUpdateStatus::Completed);
428                         }
429                         res
430                 } }
431         }
432
433         let mut channel_txn = Vec::new();
434         macro_rules! make_channel {
435                 ($source: expr, $dest: expr, $chan_id: expr) => { {
436                         $source.peer_connected(&$dest.get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
437                         $dest.peer_connected(&$source.get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
438
439                         $source.create_channel($dest.get_our_node_id(), 100_000, 42, 0, None).unwrap();
440                         let open_channel = {
441                                 let events = $source.get_and_clear_pending_msg_events();
442                                 assert_eq!(events.len(), 1);
443                                 if let events::MessageSendEvent::SendOpenChannel { ref msg, .. } = events[0] {
444                                         msg.clone()
445                                 } else { panic!("Wrong event type"); }
446                         };
447
448                         $dest.handle_open_channel(&$source.get_our_node_id(), channelmanager::provided_init_features(), &open_channel);
449                         let accept_channel = {
450                                 let events = $dest.get_and_clear_pending_msg_events();
451                                 assert_eq!(events.len(), 1);
452                                 if let events::MessageSendEvent::SendAcceptChannel { ref msg, .. } = events[0] {
453                                         msg.clone()
454                                 } else { panic!("Wrong event type"); }
455                         };
456
457                         $source.handle_accept_channel(&$dest.get_our_node_id(), channelmanager::provided_init_features(), &accept_channel);
458                         let funding_output;
459                         {
460                                 let events = $source.get_and_clear_pending_events();
461                                 assert_eq!(events.len(), 1);
462                                 if let events::Event::FundingGenerationReady { ref temporary_channel_id, ref channel_value_satoshis, ref output_script, .. } = events[0] {
463                                         let tx = Transaction { version: $chan_id, lock_time: PackedLockTime::ZERO, input: Vec::new(), output: vec![TxOut {
464                                                 value: *channel_value_satoshis, script_pubkey: output_script.clone(),
465                                         }]};
466                                         funding_output = OutPoint { txid: tx.txid(), index: 0 };
467                                         $source.funding_transaction_generated(&temporary_channel_id, &$dest.get_our_node_id(), tx.clone()).unwrap();
468                                         channel_txn.push(tx);
469                                 } else { panic!("Wrong event type"); }
470                         }
471
472                         let funding_created = {
473                                 let events = $source.get_and_clear_pending_msg_events();
474                                 assert_eq!(events.len(), 1);
475                                 if let events::MessageSendEvent::SendFundingCreated { ref msg, .. } = events[0] {
476                                         msg.clone()
477                                 } else { panic!("Wrong event type"); }
478                         };
479                         $dest.handle_funding_created(&$source.get_our_node_id(), &funding_created);
480
481                         let funding_signed = {
482                                 let events = $dest.get_and_clear_pending_msg_events();
483                                 assert_eq!(events.len(), 1);
484                                 if let events::MessageSendEvent::SendFundingSigned { ref msg, .. } = events[0] {
485                                         msg.clone()
486                                 } else { panic!("Wrong event type"); }
487                         };
488                         $source.handle_funding_signed(&$dest.get_our_node_id(), &funding_signed);
489
490                         funding_output
491                 } }
492         }
493
494         macro_rules! confirm_txn {
495                 ($node: expr) => { {
496                         let chain_hash = genesis_block(Network::Bitcoin).block_hash();
497                         let mut header = BlockHeader { version: 0x20000000, prev_blockhash: chain_hash, merkle_root: TxMerkleNode::all_zeros(), time: 42, bits: 42, nonce: 42 };
498                         let txdata: Vec<_> = channel_txn.iter().enumerate().map(|(i, tx)| (i + 1, tx)).collect();
499                         $node.transactions_confirmed(&header, &txdata, 1);
500                         for _ in 2..100 {
501                                 header = BlockHeader { version: 0x20000000, prev_blockhash: header.block_hash(), merkle_root: TxMerkleNode::all_zeros(), time: 42, bits: 42, nonce: 42 };
502                         }
503                         $node.best_block_updated(&header, 99);
504                 } }
505         }
506
507         macro_rules! lock_fundings {
508                 ($nodes: expr) => { {
509                         let mut node_events = Vec::new();
510                         for node in $nodes.iter() {
511                                 node_events.push(node.get_and_clear_pending_msg_events());
512                         }
513                         for (idx, node_event) in node_events.iter().enumerate() {
514                                 for event in node_event {
515                                         if let events::MessageSendEvent::SendChannelReady { ref node_id, ref msg } = event {
516                                                 for node in $nodes.iter() {
517                                                         if node.get_our_node_id() == *node_id {
518                                                                 node.handle_channel_ready(&$nodes[idx].get_our_node_id(), msg);
519                                                         }
520                                                 }
521                                         } else { panic!("Wrong event type"); }
522                                 }
523                         }
524
525                         for node in $nodes.iter() {
526                                 let events = node.get_and_clear_pending_msg_events();
527                                 for event in events {
528                                         if let events::MessageSendEvent::SendAnnouncementSignatures { .. } = event {
529                                         } else { panic!("Wrong event type"); }
530                                 }
531                         }
532                 } }
533         }
534
535         let fee_est_a = Arc::new(FuzzEstimator { ret_val: atomic::AtomicU32::new(253) });
536         let mut last_htlc_clear_fee_a =  253;
537         let fee_est_b = Arc::new(FuzzEstimator { ret_val: atomic::AtomicU32::new(253) });
538         let mut last_htlc_clear_fee_b =  253;
539         let fee_est_c = Arc::new(FuzzEstimator { ret_val: atomic::AtomicU32::new(253) });
540         let mut last_htlc_clear_fee_c =  253;
541
542         // 3 nodes is enough to hit all the possible cases, notably unknown-source-unknown-dest
543         // forwarding.
544         let (node_a, mut monitor_a, keys_manager_a) = make_node!(0, fee_est_a);
545         let (node_b, mut monitor_b, keys_manager_b) = make_node!(1, fee_est_b);
546         let (node_c, mut monitor_c, keys_manager_c) = make_node!(2, fee_est_c);
547
548         let mut nodes = [node_a, node_b, node_c];
549
550         let chan_1_funding = make_channel!(nodes[0], nodes[1], 0);
551         let chan_2_funding = make_channel!(nodes[1], nodes[2], 1);
552
553         for node in nodes.iter() {
554                 confirm_txn!(node);
555         }
556
557         lock_fundings!(nodes);
558
559         let chan_a = nodes[0].list_usable_channels()[0].short_channel_id.unwrap();
560         let chan_b = nodes[2].list_usable_channels()[0].short_channel_id.unwrap();
561
562         let mut payment_id: u8 = 0;
563         let mut payment_idx: u64 = 0;
564
565         let mut chan_a_disconnected = false;
566         let mut chan_b_disconnected = false;
567         let mut ab_events = Vec::new();
568         let mut ba_events = Vec::new();
569         let mut bc_events = Vec::new();
570         let mut cb_events = Vec::new();
571
572         let mut node_a_ser = VecWriter(Vec::new());
573         nodes[0].write(&mut node_a_ser).unwrap();
574         let mut node_b_ser = VecWriter(Vec::new());
575         nodes[1].write(&mut node_b_ser).unwrap();
576         let mut node_c_ser = VecWriter(Vec::new());
577         nodes[2].write(&mut node_c_ser).unwrap();
578
579         macro_rules! test_return {
580                 () => { {
581                         assert_eq!(nodes[0].list_channels().len(), 1);
582                         assert_eq!(nodes[1].list_channels().len(), 2);
583                         assert_eq!(nodes[2].list_channels().len(), 1);
584                         return;
585                 } }
586         }
587
588         let mut read_pos = 0;
589         macro_rules! get_slice {
590                 ($len: expr) => {
591                         {
592                                 let slice_len = $len as usize;
593                                 if data.len() < read_pos + slice_len {
594                                         test_return!();
595                                 }
596                                 read_pos += slice_len;
597                                 &data[read_pos - slice_len..read_pos]
598                         }
599                 }
600         }
601
602         loop {
603                 // Push any events from Node B onto ba_events and bc_events
604                 macro_rules! push_excess_b_events {
605                         ($excess_events: expr, $expect_drop_node: expr) => { {
606                                 let a_id = nodes[0].get_our_node_id();
607                                 let expect_drop_node: Option<usize> = $expect_drop_node;
608                                 let expect_drop_id = if let Some(id) = expect_drop_node { Some(nodes[id].get_our_node_id()) } else { None };
609                                 for event in $excess_events {
610                                         let push_a = match event {
611                                                 events::MessageSendEvent::UpdateHTLCs { ref node_id, .. } => {
612                                                         if Some(*node_id) == expect_drop_id { panic!("peer_disconnected should drop msgs bound for the disconnected peer"); }
613                                                         *node_id == a_id
614                                                 },
615                                                 events::MessageSendEvent::SendRevokeAndACK { ref node_id, .. } => {
616                                                         if Some(*node_id) == expect_drop_id { panic!("peer_disconnected should drop msgs bound for the disconnected peer"); }
617                                                         *node_id == a_id
618                                                 },
619                                                 events::MessageSendEvent::SendChannelReestablish { ref node_id, .. } => {
620                                                         if Some(*node_id) == expect_drop_id { panic!("peer_disconnected should drop msgs bound for the disconnected peer"); }
621                                                         *node_id == a_id
622                                                 },
623                                                 events::MessageSendEvent::SendChannelReady { .. } => continue,
624                                                 events::MessageSendEvent::SendAnnouncementSignatures { .. } => continue,
625                                                 events::MessageSendEvent::SendChannelUpdate { ref node_id, ref msg } => {
626                                                         assert_eq!(msg.contents.flags & 2, 0); // The disable bit must never be set!
627                                                         if Some(*node_id) == expect_drop_id { panic!("peer_disconnected should drop msgs bound for the disconnected peer"); }
628                                                         *node_id == a_id
629                                                 },
630                                                 _ => panic!("Unhandled message event {:?}", event),
631                                         };
632                                         if push_a { ba_events.push(event); } else { bc_events.push(event); }
633                                 }
634                         } }
635                 }
636
637                 // While delivering messages, we select across three possible message selection processes
638                 // to ensure we get as much coverage as possible. See the individual enum variants for more
639                 // details.
640                 #[derive(PartialEq)]
641                 enum ProcessMessages {
642                         /// Deliver all available messages, including fetching any new messages from
643                         /// `get_and_clear_pending_msg_events()` (which may have side effects).
644                         AllMessages,
645                         /// Call `get_and_clear_pending_msg_events()` first, and then deliver up to one
646                         /// message (which may already be queued).
647                         OneMessage,
648                         /// Deliver up to one already-queued message. This avoids any potential side-effects
649                         /// of `get_and_clear_pending_msg_events()` (eg freeing the HTLC holding cell), which
650                         /// provides potentially more coverage.
651                         OnePendingMessage,
652                 }
653
654                 macro_rules! process_msg_events {
655                         ($node: expr, $corrupt_forward: expr, $limit_events: expr) => { {
656                                 let mut events = if $node == 1 {
657                                         let mut new_events = Vec::new();
658                                         mem::swap(&mut new_events, &mut ba_events);
659                                         new_events.extend_from_slice(&bc_events[..]);
660                                         bc_events.clear();
661                                         new_events
662                                 } else if $node == 0 {
663                                         let mut new_events = Vec::new();
664                                         mem::swap(&mut new_events, &mut ab_events);
665                                         new_events
666                                 } else {
667                                         let mut new_events = Vec::new();
668                                         mem::swap(&mut new_events, &mut cb_events);
669                                         new_events
670                                 };
671                                 let mut new_events = Vec::new();
672                                 if $limit_events != ProcessMessages::OnePendingMessage {
673                                         new_events = nodes[$node].get_and_clear_pending_msg_events();
674                                 }
675                                 let mut had_events = false;
676                                 let mut events_iter = events.drain(..).chain(new_events.drain(..));
677                                 let mut extra_ev = None;
678                                 for event in &mut events_iter {
679                                         had_events = true;
680                                         match event {
681                                                 events::MessageSendEvent::UpdateHTLCs { node_id, updates: CommitmentUpdate { update_add_htlcs, update_fail_htlcs, update_fulfill_htlcs, update_fail_malformed_htlcs, update_fee, commitment_signed } } => {
682                                                         for (idx, dest) in nodes.iter().enumerate() {
683                                                                 if dest.get_our_node_id() == node_id {
684                                                                         for update_add in update_add_htlcs.iter() {
685                                                                                 out.locked_write(format!("Delivering update_add_htlc to node {}.\n", idx).as_bytes());
686                                                                                 if !$corrupt_forward {
687                                                                                         dest.handle_update_add_htlc(&nodes[$node].get_our_node_id(), update_add);
688                                                                                 } else {
689                                                                                         // Corrupt the update_add_htlc message so that its HMAC
690                                                                                         // check will fail and we generate a
691                                                                                         // update_fail_malformed_htlc instead of an
692                                                                                         // update_fail_htlc as we do when we reject a payment.
693                                                                                         let mut msg_ser = update_add.encode();
694                                                                                         msg_ser[1000] ^= 0xff;
695                                                                                         let new_msg = UpdateAddHTLC::read(&mut Cursor::new(&msg_ser)).unwrap();
696                                                                                         dest.handle_update_add_htlc(&nodes[$node].get_our_node_id(), &new_msg);
697                                                                                 }
698                                                                         }
699                                                                         for update_fulfill in update_fulfill_htlcs.iter() {
700                                                                                 out.locked_write(format!("Delivering update_fulfill_htlc to node {}.\n", idx).as_bytes());
701                                                                                 dest.handle_update_fulfill_htlc(&nodes[$node].get_our_node_id(), update_fulfill);
702                                                                         }
703                                                                         for update_fail in update_fail_htlcs.iter() {
704                                                                                 out.locked_write(format!("Delivering update_fail_htlc to node {}.\n", idx).as_bytes());
705                                                                                 dest.handle_update_fail_htlc(&nodes[$node].get_our_node_id(), update_fail);
706                                                                         }
707                                                                         for update_fail_malformed in update_fail_malformed_htlcs.iter() {
708                                                                                 out.locked_write(format!("Delivering update_fail_malformed_htlc to node {}.\n", idx).as_bytes());
709                                                                                 dest.handle_update_fail_malformed_htlc(&nodes[$node].get_our_node_id(), update_fail_malformed);
710                                                                         }
711                                                                         if let Some(msg) = update_fee {
712                                                                                 out.locked_write(format!("Delivering update_fee to node {}.\n", idx).as_bytes());
713                                                                                 dest.handle_update_fee(&nodes[$node].get_our_node_id(), &msg);
714                                                                         }
715                                                                         let processed_change = !update_add_htlcs.is_empty() || !update_fulfill_htlcs.is_empty() ||
716                                                                                 !update_fail_htlcs.is_empty() || !update_fail_malformed_htlcs.is_empty();
717                                                                         if $limit_events != ProcessMessages::AllMessages && processed_change {
718                                                                                 // If we only want to process some messages, don't deliver the CS until later.
719                                                                                 extra_ev = Some(events::MessageSendEvent::UpdateHTLCs { node_id, updates: CommitmentUpdate {
720                                                                                         update_add_htlcs: Vec::new(),
721                                                                                         update_fail_htlcs: Vec::new(),
722                                                                                         update_fulfill_htlcs: Vec::new(),
723                                                                                         update_fail_malformed_htlcs: Vec::new(),
724                                                                                         update_fee: None,
725                                                                                         commitment_signed
726                                                                                 } });
727                                                                                 break;
728                                                                         }
729                                                                         out.locked_write(format!("Delivering commitment_signed to node {}.\n", idx).as_bytes());
730                                                                         dest.handle_commitment_signed(&nodes[$node].get_our_node_id(), &commitment_signed);
731                                                                         break;
732                                                                 }
733                                                         }
734                                                 },
735                                                 events::MessageSendEvent::SendRevokeAndACK { ref node_id, ref msg } => {
736                                                         for (idx, dest) in nodes.iter().enumerate() {
737                                                                 if dest.get_our_node_id() == *node_id {
738                                                                         out.locked_write(format!("Delivering revoke_and_ack to node {}.\n", idx).as_bytes());
739                                                                         dest.handle_revoke_and_ack(&nodes[$node].get_our_node_id(), msg);
740                                                                 }
741                                                         }
742                                                 },
743                                                 events::MessageSendEvent::SendChannelReestablish { ref node_id, ref msg } => {
744                                                         for (idx, dest) in nodes.iter().enumerate() {
745                                                                 if dest.get_our_node_id() == *node_id {
746                                                                         out.locked_write(format!("Delivering channel_reestablish to node {}.\n", idx).as_bytes());
747                                                                         dest.handle_channel_reestablish(&nodes[$node].get_our_node_id(), msg);
748                                                                 }
749                                                         }
750                                                 },
751                                                 events::MessageSendEvent::SendChannelReady { .. } => {
752                                                         // Can be generated as a reestablish response
753                                                 },
754                                                 events::MessageSendEvent::SendAnnouncementSignatures { .. } => {
755                                                         // Can be generated as a reestablish response
756                                                 },
757                                                 events::MessageSendEvent::SendChannelUpdate { ref msg, .. } => {
758                                                         // When we reconnect we will resend a channel_update to make sure our
759                                                         // counterparty has the latest parameters for receiving payments
760                                                         // through us. We do, however, check that the message does not include
761                                                         // the "disabled" bit, as we should never ever have a channel which is
762                                                         // disabled when we send such an update (or it may indicate channel
763                                                         // force-close which we should detect as an error).
764                                                         assert_eq!(msg.contents.flags & 2, 0);
765                                                 },
766                                                 _ => if out.may_fail.load(atomic::Ordering::Acquire) {
767                                                         return;
768                                                 } else {
769                                                         panic!("Unhandled message event {:?}", event)
770                                                 },
771                                         }
772                                         if $limit_events != ProcessMessages::AllMessages {
773                                                 break;
774                                         }
775                                 }
776                                 if $node == 1 {
777                                         push_excess_b_events!(extra_ev.into_iter().chain(events_iter), None);
778                                 } else if $node == 0 {
779                                         if let Some(ev) = extra_ev { ab_events.push(ev); }
780                                         for event in events_iter { ab_events.push(event); }
781                                 } else {
782                                         if let Some(ev) = extra_ev { cb_events.push(ev); }
783                                         for event in events_iter { cb_events.push(event); }
784                                 }
785                                 had_events
786                         } }
787                 }
788
789                 macro_rules! drain_msg_events_on_disconnect {
790                         ($counterparty_id: expr) => { {
791                                 if $counterparty_id == 0 {
792                                         for event in nodes[0].get_and_clear_pending_msg_events() {
793                                                 match event {
794                                                         events::MessageSendEvent::UpdateHTLCs { .. } => {},
795                                                         events::MessageSendEvent::SendRevokeAndACK { .. } => {},
796                                                         events::MessageSendEvent::SendChannelReestablish { .. } => {},
797                                                         events::MessageSendEvent::SendChannelReady { .. } => {},
798                                                         events::MessageSendEvent::SendAnnouncementSignatures { .. } => {},
799                                                         events::MessageSendEvent::SendChannelUpdate { ref msg, .. } => {
800                                                                 assert_eq!(msg.contents.flags & 2, 0); // The disable bit must never be set!
801                                                         },
802                                                         _ => if out.may_fail.load(atomic::Ordering::Acquire) {
803                                                                 return;
804                                                         } else {
805                                                                 panic!("Unhandled message event")
806                                                         },
807                                                 }
808                                         }
809                                         push_excess_b_events!(nodes[1].get_and_clear_pending_msg_events().drain(..), Some(0));
810                                         ab_events.clear();
811                                         ba_events.clear();
812                                 } else {
813                                         for event in nodes[2].get_and_clear_pending_msg_events() {
814                                                 match event {
815                                                         events::MessageSendEvent::UpdateHTLCs { .. } => {},
816                                                         events::MessageSendEvent::SendRevokeAndACK { .. } => {},
817                                                         events::MessageSendEvent::SendChannelReestablish { .. } => {},
818                                                         events::MessageSendEvent::SendChannelReady { .. } => {},
819                                                         events::MessageSendEvent::SendAnnouncementSignatures { .. } => {},
820                                                         events::MessageSendEvent::SendChannelUpdate { ref msg, .. } => {
821                                                                 assert_eq!(msg.contents.flags & 2, 0); // The disable bit must never be set!
822                                                         },
823                                                         _ => if out.may_fail.load(atomic::Ordering::Acquire) {
824                                                                 return;
825                                                         } else {
826                                                                 panic!("Unhandled message event")
827                                                         },
828                                                 }
829                                         }
830                                         push_excess_b_events!(nodes[1].get_and_clear_pending_msg_events().drain(..), Some(2));
831                                         bc_events.clear();
832                                         cb_events.clear();
833                                 }
834                         } }
835                 }
836
837                 macro_rules! process_events {
838                         ($node: expr, $fail: expr) => { {
839                                 // In case we get 256 payments we may have a hash collision, resulting in the
840                                 // second claim/fail call not finding the duplicate-hash HTLC, so we have to
841                                 // deduplicate the calls here.
842                                 let mut claim_set = HashSet::new();
843                                 let mut events = nodes[$node].get_and_clear_pending_events();
844                                 // Sort events so that PendingHTLCsForwardable get processed last. This avoids a
845                                 // case where we first process a PendingHTLCsForwardable, then claim/fail on a
846                                 // PaymentReceived, claiming/failing two HTLCs, but leaving a just-generated
847                                 // PaymentReceived event for the second HTLC in our pending_events (and breaking
848                                 // our claim_set deduplication).
849                                 events.sort_by(|a, b| {
850                                         if let events::Event::PaymentReceived { .. } = a {
851                                                 if let events::Event::PendingHTLCsForwardable { .. } = b {
852                                                         Ordering::Less
853                                                 } else { Ordering::Equal }
854                                         } else if let events::Event::PendingHTLCsForwardable { .. } = a {
855                                                 if let events::Event::PaymentReceived { .. } = b {
856                                                         Ordering::Greater
857                                                 } else { Ordering::Equal }
858                                         } else { Ordering::Equal }
859                                 });
860                                 let had_events = !events.is_empty();
861                                 for event in events.drain(..) {
862                                         match event {
863                                                 events::Event::PaymentReceived { payment_hash, .. } => {
864                                                         if claim_set.insert(payment_hash.0) {
865                                                                 if $fail {
866                                                                         nodes[$node].fail_htlc_backwards(&payment_hash);
867                                                                 } else {
868                                                                         nodes[$node].claim_funds(PaymentPreimage(payment_hash.0));
869                                                                 }
870                                                         }
871                                                 },
872                                                 events::Event::PaymentSent { .. } => {},
873                                                 events::Event::PaymentClaimed { .. } => {},
874                                                 events::Event::PaymentPathSuccessful { .. } => {},
875                                                 events::Event::PaymentPathFailed { .. } => {},
876                                                 events::Event::ProbeSuccessful { .. } | events::Event::ProbeFailed { .. } => {
877                                                         // Even though we don't explicitly send probes, because probes are
878                                                         // detected based on hashing the payment hash+preimage, its rather
879                                                         // trivial for the fuzzer to build payments that accidentally end up
880                                                         // looking like probes.
881                                                 },
882                                                 events::Event::PaymentForwarded { .. } if $node == 1 => {},
883                                                 events::Event::ChannelReady { .. } => {},
884                                                 events::Event::PendingHTLCsForwardable { .. } => {
885                                                         nodes[$node].process_pending_htlc_forwards();
886                                                 },
887                                                 events::Event::HTLCHandlingFailed { .. } => {},
888                                                 _ => if out.may_fail.load(atomic::Ordering::Acquire) {
889                                                         return;
890                                                 } else {
891                                                         panic!("Unhandled event")
892                                                 },
893                                         }
894                                 }
895                                 had_events
896                         } }
897                 }
898
899                 let v = get_slice!(1)[0];
900                 out.locked_write(format!("READ A BYTE! HANDLING INPUT {:x}...........\n", v).as_bytes());
901                 match v {
902                         // In general, we keep related message groups close together in binary form, allowing
903                         // bit-twiddling mutations to have similar effects. This is probably overkill, but no
904                         // harm in doing so.
905
906                         0x00 => *monitor_a.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::InProgress,
907                         0x01 => *monitor_b.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::InProgress,
908                         0x02 => *monitor_c.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::InProgress,
909                         0x04 => *monitor_a.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed,
910                         0x05 => *monitor_b.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed,
911                         0x06 => *monitor_c.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed,
912
913                         0x08 => {
914                                 if let Some((id, _)) = monitor_a.latest_monitors.lock().unwrap().get(&chan_1_funding) {
915                                         monitor_a.chain_monitor.force_channel_monitor_updated(chan_1_funding, *id);
916                                         nodes[0].process_monitor_events();
917                                 }
918                         },
919                         0x09 => {
920                                 if let Some((id, _)) = monitor_b.latest_monitors.lock().unwrap().get(&chan_1_funding) {
921                                         monitor_b.chain_monitor.force_channel_monitor_updated(chan_1_funding, *id);
922                                         nodes[1].process_monitor_events();
923                                 }
924                         },
925                         0x0a => {
926                                 if let Some((id, _)) = monitor_b.latest_monitors.lock().unwrap().get(&chan_2_funding) {
927                                         monitor_b.chain_monitor.force_channel_monitor_updated(chan_2_funding, *id);
928                                         nodes[1].process_monitor_events();
929                                 }
930                         },
931                         0x0b => {
932                                 if let Some((id, _)) = monitor_c.latest_monitors.lock().unwrap().get(&chan_2_funding) {
933                                         monitor_c.chain_monitor.force_channel_monitor_updated(chan_2_funding, *id);
934                                         nodes[2].process_monitor_events();
935                                 }
936                         },
937
938                         0x0c => {
939                                 if !chan_a_disconnected {
940                                         nodes[0].peer_disconnected(&nodes[1].get_our_node_id(), false);
941                                         nodes[1].peer_disconnected(&nodes[0].get_our_node_id(), false);
942                                         chan_a_disconnected = true;
943                                         drain_msg_events_on_disconnect!(0);
944                                 }
945                         },
946                         0x0d => {
947                                 if !chan_b_disconnected {
948                                         nodes[1].peer_disconnected(&nodes[2].get_our_node_id(), false);
949                                         nodes[2].peer_disconnected(&nodes[1].get_our_node_id(), false);
950                                         chan_b_disconnected = true;
951                                         drain_msg_events_on_disconnect!(2);
952                                 }
953                         },
954                         0x0e => {
955                                 if chan_a_disconnected {
956                                         nodes[0].peer_connected(&nodes[1].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
957                                         nodes[1].peer_connected(&nodes[0].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
958                                         chan_a_disconnected = false;
959                                 }
960                         },
961                         0x0f => {
962                                 if chan_b_disconnected {
963                                         nodes[1].peer_connected(&nodes[2].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
964                                         nodes[2].peer_connected(&nodes[1].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
965                                         chan_b_disconnected = false;
966                                 }
967                         },
968
969                         0x10 => { process_msg_events!(0, true, ProcessMessages::AllMessages); },
970                         0x11 => { process_msg_events!(0, false, ProcessMessages::AllMessages); },
971                         0x12 => { process_msg_events!(0, true, ProcessMessages::OneMessage); },
972                         0x13 => { process_msg_events!(0, false, ProcessMessages::OneMessage); },
973                         0x14 => { process_msg_events!(0, true, ProcessMessages::OnePendingMessage); },
974                         0x15 => { process_msg_events!(0, false, ProcessMessages::OnePendingMessage); },
975
976                         0x16 => { process_events!(0, true); },
977                         0x17 => { process_events!(0, false); },
978
979                         0x18 => { process_msg_events!(1, true, ProcessMessages::AllMessages); },
980                         0x19 => { process_msg_events!(1, false, ProcessMessages::AllMessages); },
981                         0x1a => { process_msg_events!(1, true, ProcessMessages::OneMessage); },
982                         0x1b => { process_msg_events!(1, false, ProcessMessages::OneMessage); },
983                         0x1c => { process_msg_events!(1, true, ProcessMessages::OnePendingMessage); },
984                         0x1d => { process_msg_events!(1, false, ProcessMessages::OnePendingMessage); },
985
986                         0x1e => { process_events!(1, true); },
987                         0x1f => { process_events!(1, false); },
988
989                         0x20 => { process_msg_events!(2, true, ProcessMessages::AllMessages); },
990                         0x21 => { process_msg_events!(2, false, ProcessMessages::AllMessages); },
991                         0x22 => { process_msg_events!(2, true, ProcessMessages::OneMessage); },
992                         0x23 => { process_msg_events!(2, false, ProcessMessages::OneMessage); },
993                         0x24 => { process_msg_events!(2, true, ProcessMessages::OnePendingMessage); },
994                         0x25 => { process_msg_events!(2, false, ProcessMessages::OnePendingMessage); },
995
996                         0x26 => { process_events!(2, true); },
997                         0x27 => { process_events!(2, false); },
998
999                         0x2c => {
1000                                 if !chan_a_disconnected {
1001                                         nodes[1].peer_disconnected(&nodes[0].get_our_node_id(), false);
1002                                         chan_a_disconnected = true;
1003                                         drain_msg_events_on_disconnect!(0);
1004                                 }
1005                                 if monitor_a.should_update_manager.load(atomic::Ordering::Relaxed) {
1006                                         node_a_ser.0.clear();
1007                                         nodes[0].write(&mut node_a_ser).unwrap();
1008                                 }
1009                                 let (new_node_a, new_monitor_a) = reload_node!(node_a_ser, 0, monitor_a, keys_manager_a, fee_est_a);
1010                                 nodes[0] = new_node_a;
1011                                 monitor_a = new_monitor_a;
1012                         },
1013                         0x2d => {
1014                                 if !chan_a_disconnected {
1015                                         nodes[0].peer_disconnected(&nodes[1].get_our_node_id(), false);
1016                                         chan_a_disconnected = true;
1017                                         nodes[0].get_and_clear_pending_msg_events();
1018                                         ab_events.clear();
1019                                         ba_events.clear();
1020                                 }
1021                                 if !chan_b_disconnected {
1022                                         nodes[2].peer_disconnected(&nodes[1].get_our_node_id(), false);
1023                                         chan_b_disconnected = true;
1024                                         nodes[2].get_and_clear_pending_msg_events();
1025                                         bc_events.clear();
1026                                         cb_events.clear();
1027                                 }
1028                                 let (new_node_b, new_monitor_b) = reload_node!(node_b_ser, 1, monitor_b, keys_manager_b, fee_est_b);
1029                                 nodes[1] = new_node_b;
1030                                 monitor_b = new_monitor_b;
1031                         },
1032                         0x2e => {
1033                                 if !chan_b_disconnected {
1034                                         nodes[1].peer_disconnected(&nodes[2].get_our_node_id(), false);
1035                                         chan_b_disconnected = true;
1036                                         drain_msg_events_on_disconnect!(2);
1037                                 }
1038                                 if monitor_c.should_update_manager.load(atomic::Ordering::Relaxed) {
1039                                         node_c_ser.0.clear();
1040                                         nodes[2].write(&mut node_c_ser).unwrap();
1041                                 }
1042                                 let (new_node_c, new_monitor_c) = reload_node!(node_c_ser, 2, monitor_c, keys_manager_c, fee_est_c);
1043                                 nodes[2] = new_node_c;
1044                                 monitor_c = new_monitor_c;
1045                         },
1046
1047                         // 1/10th the channel size:
1048                         0x30 => { send_payment(&nodes[0], &nodes[1], chan_a, 10_000_000, &mut payment_id, &mut payment_idx); },
1049                         0x31 => { send_payment(&nodes[1], &nodes[0], chan_a, 10_000_000, &mut payment_id, &mut payment_idx); },
1050                         0x32 => { send_payment(&nodes[1], &nodes[2], chan_b, 10_000_000, &mut payment_id, &mut payment_idx); },
1051                         0x33 => { send_payment(&nodes[2], &nodes[1], chan_b, 10_000_000, &mut payment_id, &mut payment_idx); },
1052                         0x34 => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 10_000_000, &mut payment_id, &mut payment_idx); },
1053                         0x35 => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 10_000_000, &mut payment_id, &mut payment_idx); },
1054
1055                         0x38 => { send_payment(&nodes[0], &nodes[1], chan_a, 1_000_000, &mut payment_id, &mut payment_idx); },
1056                         0x39 => { send_payment(&nodes[1], &nodes[0], chan_a, 1_000_000, &mut payment_id, &mut payment_idx); },
1057                         0x3a => { send_payment(&nodes[1], &nodes[2], chan_b, 1_000_000, &mut payment_id, &mut payment_idx); },
1058                         0x3b => { send_payment(&nodes[2], &nodes[1], chan_b, 1_000_000, &mut payment_id, &mut payment_idx); },
1059                         0x3c => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 1_000_000, &mut payment_id, &mut payment_idx); },
1060                         0x3d => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 1_000_000, &mut payment_id, &mut payment_idx); },
1061
1062                         0x40 => { send_payment(&nodes[0], &nodes[1], chan_a, 100_000, &mut payment_id, &mut payment_idx); },
1063                         0x41 => { send_payment(&nodes[1], &nodes[0], chan_a, 100_000, &mut payment_id, &mut payment_idx); },
1064                         0x42 => { send_payment(&nodes[1], &nodes[2], chan_b, 100_000, &mut payment_id, &mut payment_idx); },
1065                         0x43 => { send_payment(&nodes[2], &nodes[1], chan_b, 100_000, &mut payment_id, &mut payment_idx); },
1066                         0x44 => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 100_000, &mut payment_id, &mut payment_idx); },
1067                         0x45 => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 100_000, &mut payment_id, &mut payment_idx); },
1068
1069                         0x48 => { send_payment(&nodes[0], &nodes[1], chan_a, 10_000, &mut payment_id, &mut payment_idx); },
1070                         0x49 => { send_payment(&nodes[1], &nodes[0], chan_a, 10_000, &mut payment_id, &mut payment_idx); },
1071                         0x4a => { send_payment(&nodes[1], &nodes[2], chan_b, 10_000, &mut payment_id, &mut payment_idx); },
1072                         0x4b => { send_payment(&nodes[2], &nodes[1], chan_b, 10_000, &mut payment_id, &mut payment_idx); },
1073                         0x4c => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 10_000, &mut payment_id, &mut payment_idx); },
1074                         0x4d => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 10_000, &mut payment_id, &mut payment_idx); },
1075
1076                         0x50 => { send_payment(&nodes[0], &nodes[1], chan_a, 1_000, &mut payment_id, &mut payment_idx); },
1077                         0x51 => { send_payment(&nodes[1], &nodes[0], chan_a, 1_000, &mut payment_id, &mut payment_idx); },
1078                         0x52 => { send_payment(&nodes[1], &nodes[2], chan_b, 1_000, &mut payment_id, &mut payment_idx); },
1079                         0x53 => { send_payment(&nodes[2], &nodes[1], chan_b, 1_000, &mut payment_id, &mut payment_idx); },
1080                         0x54 => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 1_000, &mut payment_id, &mut payment_idx); },
1081                         0x55 => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 1_000, &mut payment_id, &mut payment_idx); },
1082
1083                         0x58 => { send_payment(&nodes[0], &nodes[1], chan_a, 100, &mut payment_id, &mut payment_idx); },
1084                         0x59 => { send_payment(&nodes[1], &nodes[0], chan_a, 100, &mut payment_id, &mut payment_idx); },
1085                         0x5a => { send_payment(&nodes[1], &nodes[2], chan_b, 100, &mut payment_id, &mut payment_idx); },
1086                         0x5b => { send_payment(&nodes[2], &nodes[1], chan_b, 100, &mut payment_id, &mut payment_idx); },
1087                         0x5c => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 100, &mut payment_id, &mut payment_idx); },
1088                         0x5d => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 100, &mut payment_id, &mut payment_idx); },
1089
1090                         0x60 => { send_payment(&nodes[0], &nodes[1], chan_a, 10, &mut payment_id, &mut payment_idx); },
1091                         0x61 => { send_payment(&nodes[1], &nodes[0], chan_a, 10, &mut payment_id, &mut payment_idx); },
1092                         0x62 => { send_payment(&nodes[1], &nodes[2], chan_b, 10, &mut payment_id, &mut payment_idx); },
1093                         0x63 => { send_payment(&nodes[2], &nodes[1], chan_b, 10, &mut payment_id, &mut payment_idx); },
1094                         0x64 => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 10, &mut payment_id, &mut payment_idx); },
1095                         0x65 => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 10, &mut payment_id, &mut payment_idx); },
1096
1097                         0x68 => { send_payment(&nodes[0], &nodes[1], chan_a, 1, &mut payment_id, &mut payment_idx); },
1098                         0x69 => { send_payment(&nodes[1], &nodes[0], chan_a, 1, &mut payment_id, &mut payment_idx); },
1099                         0x6a => { send_payment(&nodes[1], &nodes[2], chan_b, 1, &mut payment_id, &mut payment_idx); },
1100                         0x6b => { send_payment(&nodes[2], &nodes[1], chan_b, 1, &mut payment_id, &mut payment_idx); },
1101                         0x6c => { send_hop_payment(&nodes[0], &nodes[1], chan_a, &nodes[2], chan_b, 1, &mut payment_id, &mut payment_idx); },
1102                         0x6d => { send_hop_payment(&nodes[2], &nodes[1], chan_b, &nodes[0], chan_a, 1, &mut payment_id, &mut payment_idx); },
1103
1104                         0x80 => {
1105                                 let max_feerate = last_htlc_clear_fee_a * FEE_SPIKE_BUFFER_FEE_INCREASE_MULTIPLE as u32;
1106                                 if fee_est_a.ret_val.fetch_add(250, atomic::Ordering::AcqRel) + 250 > max_feerate {
1107                                         fee_est_a.ret_val.store(max_feerate, atomic::Ordering::Release);
1108                                 }
1109                                 nodes[0].maybe_update_chan_fees();
1110                         },
1111                         0x81 => { fee_est_a.ret_val.store(253, atomic::Ordering::Release); nodes[0].maybe_update_chan_fees(); },
1112
1113                         0x84 => {
1114                                 let max_feerate = last_htlc_clear_fee_b * FEE_SPIKE_BUFFER_FEE_INCREASE_MULTIPLE as u32;
1115                                 if fee_est_b.ret_val.fetch_add(250, atomic::Ordering::AcqRel) + 250 > max_feerate {
1116                                         fee_est_b.ret_val.store(max_feerate, atomic::Ordering::Release);
1117                                 }
1118                                 nodes[1].maybe_update_chan_fees();
1119                         },
1120                         0x85 => { fee_est_b.ret_val.store(253, atomic::Ordering::Release); nodes[1].maybe_update_chan_fees(); },
1121
1122                         0x88 => {
1123                                 let max_feerate = last_htlc_clear_fee_c * FEE_SPIKE_BUFFER_FEE_INCREASE_MULTIPLE as u32;
1124                                 if fee_est_c.ret_val.fetch_add(250, atomic::Ordering::AcqRel) + 250 > max_feerate {
1125                                         fee_est_c.ret_val.store(max_feerate, atomic::Ordering::Release);
1126                                 }
1127                                 nodes[2].maybe_update_chan_fees();
1128                         },
1129                         0x89 => { fee_est_c.ret_val.store(253, atomic::Ordering::Release); nodes[2].maybe_update_chan_fees(); },
1130
1131                         0xff => {
1132                                 // Test that no channel is in a stuck state where neither party can send funds even
1133                                 // after we resolve all pending events.
1134                                 // First make sure there are no pending monitor updates, resetting the error state
1135                                 // and calling force_channel_monitor_updated for each monitor.
1136                                 *monitor_a.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed;
1137                                 *monitor_b.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed;
1138                                 *monitor_c.persister.update_ret.lock().unwrap() = ChannelMonitorUpdateStatus::Completed;
1139
1140                                 if let Some((id, _)) = monitor_a.latest_monitors.lock().unwrap().get(&chan_1_funding) {
1141                                         monitor_a.chain_monitor.force_channel_monitor_updated(chan_1_funding, *id);
1142                                         nodes[0].process_monitor_events();
1143                                 }
1144                                 if let Some((id, _)) = monitor_b.latest_monitors.lock().unwrap().get(&chan_1_funding) {
1145                                         monitor_b.chain_monitor.force_channel_monitor_updated(chan_1_funding, *id);
1146                                         nodes[1].process_monitor_events();
1147                                 }
1148                                 if let Some((id, _)) = monitor_b.latest_monitors.lock().unwrap().get(&chan_2_funding) {
1149                                         monitor_b.chain_monitor.force_channel_monitor_updated(chan_2_funding, *id);
1150                                         nodes[1].process_monitor_events();
1151                                 }
1152                                 if let Some((id, _)) = monitor_c.latest_monitors.lock().unwrap().get(&chan_2_funding) {
1153                                         monitor_c.chain_monitor.force_channel_monitor_updated(chan_2_funding, *id);
1154                                         nodes[2].process_monitor_events();
1155                                 }
1156
1157                                 // Next, make sure peers are all connected to each other
1158                                 if chan_a_disconnected {
1159                                         nodes[0].peer_connected(&nodes[1].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
1160                                         nodes[1].peer_connected(&nodes[0].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
1161                                         chan_a_disconnected = false;
1162                                 }
1163                                 if chan_b_disconnected {
1164                                         nodes[1].peer_connected(&nodes[2].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
1165                                         nodes[2].peer_connected(&nodes[1].get_our_node_id(), &Init { features: channelmanager::provided_init_features(), remote_network_address: None }).unwrap();
1166                                         chan_b_disconnected = false;
1167                                 }
1168
1169                                 for i in 0..std::usize::MAX {
1170                                         if i == 100 { panic!("It may take may iterations to settle the state, but it should not take forever"); }
1171                                         // Then, make sure any current forwards make their way to their destination
1172                                         if process_msg_events!(0, false, ProcessMessages::AllMessages) { continue; }
1173                                         if process_msg_events!(1, false, ProcessMessages::AllMessages) { continue; }
1174                                         if process_msg_events!(2, false, ProcessMessages::AllMessages) { continue; }
1175                                         // ...making sure any pending PendingHTLCsForwardable events are handled and
1176                                         // payments claimed.
1177                                         if process_events!(0, false) { continue; }
1178                                         if process_events!(1, false) { continue; }
1179                                         if process_events!(2, false) { continue; }
1180                                         break;
1181                                 }
1182
1183                                 // Finally, make sure that at least one end of each channel can make a substantial payment
1184                                 assert!(
1185                                         send_payment(&nodes[0], &nodes[1], chan_a, 10_000_000, &mut payment_id, &mut payment_idx) ||
1186                                         send_payment(&nodes[1], &nodes[0], chan_a, 10_000_000, &mut payment_id, &mut payment_idx));
1187                                 assert!(
1188                                         send_payment(&nodes[1], &nodes[2], chan_b, 10_000_000, &mut payment_id, &mut payment_idx) ||
1189                                         send_payment(&nodes[2], &nodes[1], chan_b, 10_000_000, &mut payment_id, &mut payment_idx));
1190
1191                                 last_htlc_clear_fee_a = fee_est_a.ret_val.load(atomic::Ordering::Acquire);
1192                                 last_htlc_clear_fee_b = fee_est_b.ret_val.load(atomic::Ordering::Acquire);
1193                                 last_htlc_clear_fee_c = fee_est_c.ret_val.load(atomic::Ordering::Acquire);
1194                         },
1195                         _ => test_return!(),
1196                 }
1197
1198                 node_a_ser.0.clear();
1199                 nodes[0].write(&mut node_a_ser).unwrap();
1200                 monitor_a.should_update_manager.store(false, atomic::Ordering::Relaxed);
1201                 node_b_ser.0.clear();
1202                 nodes[1].write(&mut node_b_ser).unwrap();
1203                 monitor_b.should_update_manager.store(false, atomic::Ordering::Relaxed);
1204                 node_c_ser.0.clear();
1205                 nodes[2].write(&mut node_c_ser).unwrap();
1206                 monitor_c.should_update_manager.store(false, atomic::Ordering::Relaxed);
1207         }
1208 }
1209
1210 /// We actually have different behavior based on if a certain log string has been seen, so we have
1211 /// to do a bit more tracking.
1212 #[derive(Clone)]
1213 struct SearchingOutput<O: Output> {
1214         output: O,
1215         may_fail: Arc<atomic::AtomicBool>,
1216 }
1217 impl<O: Output> Output for SearchingOutput<O> {
1218         fn locked_write(&self, data: &[u8]) {
1219                 // We hit a design limitation of LN state machine (see CONCURRENT_INBOUND_HTLC_FEE_BUFFER)
1220                 if std::str::from_utf8(data).unwrap().contains("Outbound update_fee HTLC buffer overflow - counterparty should force-close this channel") {
1221                         self.may_fail.store(true, atomic::Ordering::Release);
1222                 }
1223                 self.output.locked_write(data)
1224         }
1225 }
1226 impl<O: Output> SearchingOutput<O> {
1227         pub fn new(output: O) -> Self {
1228                 Self { output, may_fail: Arc::new(atomic::AtomicBool::new(false)) }
1229         }
1230 }
1231
1232 pub fn chanmon_consistency_test<Out: Output>(data: &[u8], out: Out) {
1233         do_test(data, out);
1234 }
1235
1236 #[no_mangle]
1237 pub extern "C" fn chanmon_consistency_run(data: *const u8, datalen: usize) {
1238         do_test(unsafe { std::slice::from_raw_parts(data, datalen) }, test_logger::DevNull{});
1239 }