[INFO] fetching crate lightning 0.0.14...
[INFO] testing lightning-0.0.14 against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530
[INFO] extracting crate lightning 0.0.14 into /workspace/builds/worker-4/source
[INFO] validating manifest of crates.io crate lightning 0.0.14 on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate lightning 0.0.14
[INFO] finished tweaking crates.io crate lightning 0.0.14
[INFO] tweaked toml for crates.io crate lightning 0.0.14 written to /workspace/builds/worker-4/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 21124e0b16d89d39f82f437673444e323193cf1f1900d13166783b0fd2b3474a
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "21124e0b16d89d39f82f437673444e323193cf1f1900d13166783b0fd2b3474a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "21124e0b16d89d39f82f437673444e323193cf1f1900d13166783b0fd2b3474a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21124e0b16d89d39f82f437673444e323193cf1f1900d13166783b0fd2b3474a", kill_on_drop: false }`
[INFO] [stdout] 21124e0b16d89d39f82f437673444e323193cf1f1900d13166783b0fd2b3474a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 32f78179b6629384bcfe2977a7f0accdf878ba2fe4649537c7bb655d750a4f94
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "32f78179b6629384bcfe2977a7f0accdf878ba2fe4649537c7bb655d750a4f94", kill_on_drop: false }`
[INFO] [stderr]    Compiling bitcoin_hashes v0.9.4
[INFO] [stderr]    Compiling bech32 v0.7.3
[INFO] [stderr]    Compiling secp256k1-sys v0.4.0
[INFO] [stderr]    Compiling bitcoinconsensus v0.19.0-3
[INFO] [stderr]    Compiling secp256k1 v0.20.2
[INFO] [stderr]    Compiling bitcoin v0.26.0
[INFO] [stderr]    Compiling lightning v0.0.14 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 25.15s
[INFO] running `Command { std: "docker" "inspect" "32f78179b6629384bcfe2977a7f0accdf878ba2fe4649537c7bb655d750a4f94", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "32f78179b6629384bcfe2977a7f0accdf878ba2fe4649537c7bb655d750a4f94", kill_on_drop: false }`
[INFO] [stdout] 32f78179b6629384bcfe2977a7f0accdf878ba2fe4649537c7bb655d750a4f94
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d719ae06199b282d0a7e4953e04023e52efefbd8607fd2b631348e5612833bec
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "d719ae06199b282d0a7e4953e04023e52efefbd8607fd2b631348e5612833bec", kill_on_drop: false }`
[INFO] [stderr]    Compiling winapi-build v0.1.1
[INFO] [stderr]    Compiling winapi v0.2.8
[INFO] [stderr]    Compiling regex-syntax v0.3.9
[INFO] [stderr]    Compiling utf8-ranges v0.1.3
[INFO] [stderr]    Compiling hex v0.3.2
[INFO] [stderr]    Compiling memchr v0.1.11
[INFO] [stderr]    Compiling aho-corasick v0.5.3
[INFO] [stderr]    Compiling kernel32-sys v0.2.2
[INFO] [stderr]    Compiling thread-id v2.0.0
[INFO] [stderr]    Compiling thread_local v0.2.7
[INFO] [stderr]    Compiling regex v0.1.80
[INFO] [stderr]    Compiling lightning v0.0.14 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 55.54s
[INFO] running `Command { std: "docker" "inspect" "d719ae06199b282d0a7e4953e04023e52efefbd8607fd2b631348e5612833bec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d719ae06199b282d0a7e4953e04023e52efefbd8607fd2b631348e5612833bec", kill_on_drop: false }`
[INFO] [stdout] d719ae06199b282d0a7e4953e04023e52efefbd8607fd2b631348e5612833bec
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 89b67200517f4cb078ba9f2a7dead275369665ebe8feb3677002c5e6d49ef25f
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "89b67200517f4cb078ba9f2a7dead275369665ebe8feb3677002c5e6d49ef25f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/lightning-cb56ad48ee48b7d0)
[INFO] [stdout] 
[INFO] [stdout] running 307 tests
[INFO] [stdout] test chain::keysinterface::dyn_sign ... ok
[INFO] [stdout] test ln::channel::tests::test_max_funding_satoshis ... ok
[INFO] [stdout] test ln::channel::tests::test_per_commitment_secret_gen ... ok
[INFO] [stdout] test chain::transaction::tests::test_channel_id_calculation ... ok
[INFO] [stdout] test ln::chan_utils::tests::test_per_commitment_storage ... ok
[INFO] [stdout] test ln::features::tests::convert_to_context_with_relevant_flags ... ok
[INFO] [stdout] test ln::features::tests::invoice_features_encoding ... ok
[INFO] [stdout] test ln::channelmanager::tests::test_wait_timeout ... ok
[INFO] [stdout] test ln::features::tests::sanity_test_known_features ... ok
[INFO] [stdout] test ln::features::tests::sanity_test_unknown_bits ... ok
[INFO] [stdout] test ln::features::tests::set_feature_bits ... ok
[INFO] [stdout] test chain::channelmonitor::tests::test_claim_txn_weight_computation ... ok
[INFO] [stdout] test ln::channel::tests::test_key_derivation ... ok
[INFO] [stdout] test ln::channel::tests::channel_update ... ok
[INFO] [stdout] test ln::channel::tests::test_timeout_vs_success_htlc_dust_limit ... ok
[INFO] [stdout] test ln::channel::tests::test_open_channel_msg_fee ... ok
[INFO] [stdout] test ln::channel::tests::test_holder_vs_counterparty_dust_limit ... ok
[INFO] [stdout] test ln::channel::tests::channel_reestablish_no_updates ... ok
[INFO] [stdout] test ln::channel::tests::outbound_commitment_test ... ok
[INFO] [stdout] test chain::channelmonitor::tests::test_prune_preimages ... ok
[INFO] [stdout] test ln::functional_tests::bolt2_open_channel_sane_dust_limit ... ok
[INFO] [stdout] test ln::functional_tests::bolt2_open_channel_sending_node_checks_part2 ... ok
[INFO] [stdout] test ln::functional_tests::bolt2_open_channel_sending_node_checks_part1 ... ok
[INFO] [stdout] test ln::functional_tests::htlc_fail_async_shutdown ... ok
[INFO] [stdout] test ln::functional_tests::fail_backward_pending_htlc_upon_channel_failure ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_no_rebroadcast ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_cs ... ok
[INFO] [stdout] test ln::functional_tests::pre_funding_lock_shutdown_test ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::monitor_failed_no_reestablish_response ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_simple_monitor_permanent_update_fail ... ok
[INFO] [stdout] test chain::chainmonitor::tests::connect_block_checks_dependent_transactions ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::first_message_on_recv_ordering ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_and_persister_update_fail ... ok
[INFO] [stdout] test ln::functional_tests::test_1_conf_open ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::monitor_update_claim_fail_no_response ... ok
[INFO] [stdout] test ln::functional_tests::revoked_output_claim ... ok
[INFO] [stdout] test ln::functional_tests::claim_htlc_outputs_shared_tx ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::claim_while_disconnected_monitor_update_fail ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_reestablish ... ok
[INFO] [stdout] test ln::functional_tests::test_announce_disable_channels ... ok
[INFO] [stdout] test ln::functional_tests::test_basic_channel_reserve ... ok
[INFO] [stdout] test ln::functional_tests::claim_htlc_outputs_single_tx ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::during_funding_monitor_fail has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::raa_no_response_awaiting_raa_state has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_a has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_b has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_c has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_claim has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_raa has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_on_pending_forwards has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_raa_while_paused has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_path_paused_mpp has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_simple_monitor_temporary_update_fail has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_async_inbound_update_fee ... ok
[INFO] [stdout] test ln::functional_tests::channel_monitor_network_test has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_raa_while_paused ... ok
[INFO] [stdout] test ln::functional_tests::test_bump_penalty_txn_on_remote_commitment ... ok
[INFO] [stdout] test ln::functional_tests::channel_reserve_in_flight_removes has been running for over 60 seconds
[INFO] [stdout] test ln::chanmon_update_fail_tests::raa_no_response_awaiting_raa_state ... ok
[INFO] [stdout] test ln::functional_tests::duplicate_htlc_test has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::fake_network_test has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::holding_cell_htlc_counting has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::htlc_claim_single_commitment_only_a has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_chan_reserve_violation_inbound_htlc_outbound_channel ... ok
[INFO] [stdout] test ln::functional_tests::htlc_claim_single_commitment_only_b has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_chan_reserve_dust_inbound_htlcs_outbound_chan ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::during_funding_monitor_fail ... ok
[INFO] [stdout] test ln::functional_tests::test_chan_reserve_violation_outbound_htlc_inbound_chan ... ok
[INFO] [stdout] test ln::functional_tests::channel_reserve_in_flight_removes ... ok
[INFO] [stdout] test ln::functional_tests::test_claim_on_remote_sizeable_push_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_bump_penalty_txn_on_revoked_commitment ... ok
[INFO] [stdout] test ln::functional_tests::test_claim_on_remote_revoked_sizeable_push_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_claim_sizeable_push_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_bump_txn_sanitize_tracking_maps ... ok
[INFO] [stdout] test ln::functional_tests::test_bump_penalty_txn_on_revoked_htlcs ... ok
[INFO] [stdout] test ln::functional_tests::test_counterparty_raa_skip_no_crash ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_on_pending_forwards ... ok
[INFO] [stdout] test ln::functional_tests::test_concurrent_monitor_claim ... ok
[INFO] [stdout] test ln::functional_tests::test_chan_reserve_violation_inbound_htlc_inbound_chan ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_claim ... ok
[INFO] [stdout] test ln::functional_tests::test_bad_secret_hash ... ok
[INFO] [stdout] test ln::functional_tests::test_check_htlc_underpaying ... ok
[INFO] [stdout] test ln::functional_tests::test_duplicate_chan_id ... ok
[INFO] [stdout] test ln::functional_tests::htlc_claim_single_commitment_only_a ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_path_paused_mpp ... ok
[INFO] [stdout] test ln::functional_tests::test_dynamic_spendable_outputs_local_htlc_success_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_holding_cell_htlc_upon_free ... ok
[INFO] [stdout] test ln::functional_tests::test_dynamic_spendable_outputs_local_htlc_timeout_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_chan_reserve_dust_inbound_htlcs_inbound_chan ... ok
[INFO] [stdout] test ln::functional_tests::test_duplicate_htlc_different_direction_onchain ... ok
[INFO] [stdout] test ln::functional_tests::test_fee_spike_violation_fails_htlc ... ok
[INFO] [stdout] test ln::functional_tests::test_data_loss_protect ... ok
[INFO] [stdout] test ln::functional_tests::test_drop_messages_peer_disconnect_dual_htlc ... ok
[INFO] [stdout] test ln::functional_tests::test_free_and_fail_holding_cell_htlcs ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_simple_monitor_temporary_update_fail ... ok
[INFO] [stdout] test ln::functional_tests::test_channel_reserve_holding_cell_htlcs has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_htlc_ignore_latest_remote_commitment ... ok
[INFO] [stdout] test ln::functional_tests::test_insane_channel_opens ... ok
[INFO] [stdout] test ln::functional_tests::test_funding_peer_disconnect ... ok
[INFO] [stdout] test ln::functional_tests::test_commitment_revoked_fail_backward_exhaustive_a has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_commitment_revoked_fail_backward_exhaustive_b has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_inbound_outbound_capacity_is_not_zero ... ok
[INFO] [stdout] test ln::functional_tests::test_error_chans_closed ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_holding_cell_htlc_upon_free_multihop ... ok
[INFO] [stdout] test ln::functional_tests::test_force_close_fail_back ... ok
[INFO] [stdout] test ln::functional_tests::test_invalid_funding_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_invalid_channel_announcement ... ok
[INFO] [stdout] test ln::functional_tests::test_drop_messages_peer_disconnect_a has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_htlc_no_detection ... ok
[INFO] [stdout] test ln::functional_tests::test_drop_messages_peer_disconnect_b has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::htlc_claim_single_commitment_only_b ... ok
[INFO] [stdout] test ln::functional_tests::test_duplicate_payment_hash_one_failure_one_success has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::duplicate_htlc_test ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_latest_remote_announce_a has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_latest_remote_announce_b has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_override_0msat_htlc_minimum ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_previous_remote_announce has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_failure_delay_dust_htlc_local_commitment ... ok
[INFO] [stdout] test ln::functional_tests::test_override_channel_config ... ok
[INFO] [stdout] test ln::functional_tests::test_pre_lockin_no_chan_closed_update ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_b ... ok
[INFO] [stdout] test ln::functional_tests::test_multi_flight_update_fee ... ok
[INFO] [stdout] test ln::functional_tests::test_duplicate_payment_hash_one_failure_one_success ... ok
[INFO] [stdout] test ln::functional_tests::test_manager_serialize_deserialize_events ... ok
[INFO] [stdout] test ln::functional_tests::test_key_derivation_params ... ok
[INFO] [stdout] test ln::functional_tests::test_htlc_timeout ... ok
[INFO] [stdout] test ln::functional_tests::test_holding_cell_htlc_add_timeouts has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_no_txn_manager_serialize_deserialize ... ok
[INFO] [stdout] test ln::functional_tests::test_htlc_on_chain_success has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_htlc_on_chain_timeout has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_secret_timeout ... ok
[INFO] [stdout] test ln::functional_tests::test_shutdown_script_segwit_but_not_anysegwit ... ok
[INFO] [stdout] test ln::functional_tests::test_preimage_storage ... ok
[INFO] [stdout] test ln::functional_tests::test_shutdown_script_any_segwit_allowed ... ok
[INFO] [stdout] test ln::functional_tests::test_shutdown_script_any_segwit_not_allowed ... ok
[INFO] [stdout] test ln::functional_tests::test_drop_messages_peer_disconnect_b ... ok
[INFO] [stdout] test ln::functional_tests::test_holding_cell_htlc_add_timeouts ... ok
[INFO] [stdout] test ln::functional_tests::test_justice_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_manager_serialize_deserialize_inconsistent_monitor has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_static_spendable_outputs_justice_tx_revoked_commitment_tx ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_c ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_check_amount_received_more_than_min ... ok
[INFO] [stdout] test ln::functional_tests::test_onchain_htlc_settlement_after_close has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_simple_manager_serialize_deserialize ... ok
[INFO] [stdout] test ln::functional_tests::test_static_spendable_outputs_justice_tx_revoked_htlc_timeout_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_static_output_closing_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_static_spendable_outputs_preimage_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_onchain_to_onchain_claim has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_check_cltv_expiry ... ok
[INFO] [stdout] test ln::functional_tests::test_htlc_on_chain_success ... ok
[INFO] [stdout] test ln::functional_tests::test_static_spendable_outputs_justice_tx_revoked_htlc_success_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_manager_serialize_deserialize_inconsistent_monitor ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_check_max_htlc_limit ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_update_fail_raa ... ok
[INFO] [stdout] test ln::functional_tests::test_drop_messages_peer_disconnect_a ... ok
[INFO] [stdout] test ln::functional_tests::test_static_spendable_outputs_timeout_tx ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_zero_value_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_value_below_minimum_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_check_max_in_flight_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_sanity_on_in_flight_opens has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_sender_can_afford_amount_sent ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_cltv_expiry_too_high ... ok
[INFO] [stdout] test ln::functional_tests::test_simple_commitment_revoked_fail_backward ... ok
[INFO] [stdout] test ln::functional_tests::test_shutdown_rebroadcast has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_receiver_check_repeated_id_ignore ... ok
[INFO] [stdout] test ln::functional_tests::test_onchain_to_onchain_claim ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_exceed_max_htlc_value_in_flight ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_zero_value_msat ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fee ... ok
[INFO] [stdout] test ln::chanmon_update_fail_tests::test_monitor_temporary_update_fail_a ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fee_that_funder_cannot_afford ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fee_vanilla ... ok
[INFO] [stdout] test ln::functional_tests::test_upfront_shutdown_script_unsupport_segwit ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_announcement_signatures ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_accept_channel ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_channel_reestablish_no_secret ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_missing_badonion_bit_for_malformed_htlc_message ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_channel_reestablish_with_secret ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_closing_signed ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_update_fail_htlc_before_commitment ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_error ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_final_onion_hop_data ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_final_onion_hop_data_with_secret ... ok
[INFO] [stdout] test ln::functional_tests::test_user_configurable_csv_delay ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_funding_created ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_commitment_signed ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_gossip_timestamp_filter ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_init ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_legacy_onion_hop_data ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_funding_locked ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_nonfinal_onion_hop_data ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_channel_announcement ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_ping ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_pong ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_funding_signed ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_query_channel_range ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_reply_channel_range ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_query_short_channel_ids ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_reply_short_channel_ids_end ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_update_fulfill_htlc_before_commitment ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_after_malformed_htlc_message_must_forward_update_fail_htlc ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_update_fail_htlc ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_update_fail_malformed_htlc ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fee_unordered_raa ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_update_fulfill_htlc ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_update_fee ... ok
[INFO] [stdout] test ln::msgs::tests::query_channel_range_end_blocknum ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_revoke_and_ack ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_update_add_htlc ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_update_fail_malformed_htlc_before_commitment ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_open_channel ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::max_message_len_decryption ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::max_msg_len_limit_value ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::max_message_len_encryption ... ok
[INFO] [stdout] test ln::onion_utils::tests::test_failure_packet_onion ... ok
[INFO] [stdout] test ln::onion_utils::tests::onion_vectors ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_channel_update ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::noise_initiator_test_vectors ... ok
[INFO] [stdout] test ln::onion_utils::tests::variable_length_onion_vectors ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_shutdown ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::noise_responder_test_vectors ... ok
[INFO] [stdout] test ln::functional_tests::test_update_err_monitor_lockdown ... ok
[INFO] [stdout] test ln::peer_channel_encryptor::tests::message_encryption_decryption_test_vectors ... ok
[INFO] [stdout] test ln::msgs::tests::encoding_node_announcement ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_incorrect_htlc_id ... ok
[INFO] [stdout] test ln::functional_tests::test_simple_mpp has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_simple_peer_disconnect has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_simple_mpp ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fulfill_htlc_bolt2_wrong_preimage ... ok
[INFO] [stdout] test ln::wire::tests::is_even_message_type ... ok
[INFO] [stdout] test ln::wire::tests::is_odd_message_type ... ok
[INFO] [stdout] test ln::wire::tests::read_clightning_init_msg ... ok
[INFO] [stdout] test ln::wire::tests::read_empty_buffer ... ok
[INFO] [stdout] test ln::wire::tests::read_empty_payload ... ok
[INFO] [stdout] test ln::wire::tests::read_incomplete_type ... ok
[INFO] [stdout] test ln::wire::tests::read_invalid_message ... ok
[INFO] [stdout] test ln::wire::tests::read_known_message ... ok
[INFO] [stdout] test ln::wire::tests::read_lnd_chan_announcement ... ok
[INFO] [stdout] test ln::wire::tests::read_lnd_init_msg ... ok
[INFO] [stdout] test ln::wire::tests::read_lnd_node_announcement ... ok
[INFO] [stdout] test ln::wire::tests::read_message_encoded_with_write ... ok
[INFO] [stdout] test ln::wire::tests::read_unknown_message ... ok
[INFO] [stdout] test ln::wire::tests::write_message_with_type ... ok
[INFO] [stdout] test ln::functional_tests::test_update_fee_with_fundee_update_add_htlc ... ok
[INFO] [stdout] test routing::network_graph::tests::getting_next_channel_announcements ... ok
[INFO] [stdout] test routing::network_graph::tests::calling_sync_routing_table ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_channel_announcements ... ok
[INFO] [stdout] test routing::network_graph::tests::getting_next_node_announcements ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_channel_update ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_htlc_fail_channel_update ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_node_announcements ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_query_short_channel_ids ... ok
[INFO] [stdout] test ln::peer_handler::tests::test_timer_tick_occurred ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_reply_channel_range ... ok
[INFO] [stdout] test ln::functional_tests::test_sweep_outbound_htlc_failure_update ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_reply_short_channel_ids ... ok
[INFO] [stdout] test routing::network_graph::tests::request_full_sync_finite_times ... ok
[INFO] [stdout] test routing::network_graph::tests::network_graph_serialization ... ok
[INFO] [stdout] test routing::router::tests::available_amount_while_routing_test ... ok
[INFO] [stdout] test routing::router::tests::available_liquidity_last_hop_test ... ok
[INFO] [stdout] test routing::router::tests::disable_node_test ... ok
[INFO] [stdout] test routing::router::tests::disable_channels_test ... ok
[INFO] [stdout] test routing::router::tests::drop_lowest_channel_mpp_route_test ... ok
[INFO] [stdout] test routing::router::tests::generate_routes ... ok
[INFO] [stdout] test routing::router::tests::generate_routes_mpp ... ok
[INFO] [stdout] test routing::router::tests::exact_fee_liquidity_limit ... ok
[INFO] [stdout] test ln::reorg_tests::test_set_outpoints_partial_claiming ... ok
[INFO] [stdout] test routing::router::tests::htlc_minimum_test ... ok
[INFO] [stdout] test routing::router::tests::htlc_max_reduction_below_min ... ok
[INFO] [stdout] test routing::router::tests::fees_on_mpp_route_test ... ok
[INFO] [stdout] test routing::router::tests::ignore_fee_first_hop_test ... ok
[INFO] [stdout] test routing::router::tests::htlc_minimum_overpay_test ... ok
[INFO] [stdout] test routing::router::tests::long_mpp_route_test ... ok
[INFO] [stdout] test ln::peer_handler::tests::test_disconnect_peer ... ok
[INFO] [stdout] test routing::router::tests::last_hops_test ... ok
[INFO] [stdout] test routing::router::tests::invalid_first_hop_test ... ok
[INFO] [stdout] test ln::functional_tests::updates_shutdown_wait ... ok
[INFO] [stdout] test routing::router::tests::min_criteria_consistency ... ok
[INFO] [stdout] test routing::router::tests::our_chans_test ... ok
[INFO] [stdout] test util::byte_utils::tests::test_all ... ok
[INFO] [stdout] test util::chacha20::test::test_chacha20_256_tls_vectors ... ok
[INFO] [stdout] test util::chacha20::test::test_chacha20_256_tls_vectors_96_nonce ... ok
[INFO] [stdout] test util::logger::tests::test_level_show ... ok
[INFO] [stdout] test util::logger::tests::test_logging_macros ... ok
[INFO] [stdout] test routing::router::tests::simple_route_test ... ok
[INFO] [stdout] test util::message_signing::test::test_recover_pk ... ok
[INFO] [stdout] test util::message_signing::test::test_sign ... ok
[INFO] [stdout] test routing::router::tests::unannounced_path_test ... ok
[INFO] [stdout] test util::poly1305::test::donna_self_test ... ok
[INFO] [stdout] test util::poly1305::test::test_nacl_vector ... ok
[INFO] [stdout] test util::poly1305::test::test_tls_vectors ... ok
[INFO] [stdout] test util::scid_utils::tests::test_block_from_scid ... ok
[INFO] [stdout] test util::scid_utils::tests::test_scid_from_parts ... ok
[INFO] [stdout] test util::ser_macros::tests::bolt_tlv_bogus_n1_stream ... ok
[INFO] [stdout] test util::ser_macros::tests::bolt_tlv_bogus_stream ... ok
[INFO] [stdout] test util::ser_macros::tests::bolt_tlv_valid_n1_stream ... ok
[INFO] [stdout] test util::ser_macros::tests::simple_test_tlv_write ... ok
[INFO] [stdout] test util::ser_macros::tests::tlv_req_type_missing_or_extra ... ok
[INFO] [stdout] test util::ser_macros::tests::tlv_simple_good_cases ... ok
[INFO] [stdout] test util::ser_macros::tests::tlv_types_out_of_order ... ok
[INFO] [stdout] test util::ser_macros::tests::tlv_v_short_read ... ok
[INFO] [stdout] test util::transaction_utils::tests::bip69_txout_test_1 ... ok
[INFO] [stdout] test util::transaction_utils::tests::bip69_txout_test_2 ... ok
[INFO] [stdout] test util::transaction_utils::tests::sort_output_by_bip_test ... ok
[INFO] [stdout] test util::transaction_utils::tests::sort_output_by_script_pubkey ... ok
[INFO] [stdout] test util::transaction_utils::tests::sort_output_by_value ... ok
[INFO] [stdout] test util::transaction_utils::tests::sort_output_tie_breaker_test ... ok
[INFO] [stdout] test util::transaction_utils::tests::test_tx_change_edge ... ok
[INFO] [stdout] test util::transaction_utils::tests::test_tx_extra_outputs ... ok
[INFO] [stdout] test util::transaction_utils::tests::test_tx_value_overrun ... ok
[INFO] [stdout] test util::zbase32::tests::test_decode ... ok
[INFO] [stdout] test util::zbase32::tests::test_decode_wrong ... ok
[INFO] [stdout] test util::zbase32::tests::test_encode ... ok
[INFO] [stdout] test util::message_signing::test::test_verify ... ok
[INFO] [stdout] test routing::router::tests::mpp_cheaper_route_test ... ok
[INFO] [stdout] test routing::router::tests::our_chans_last_hop_connect_test ... ok
[INFO] [stdout] test util::message_signing::test::test_verify_ground_truth_ish ... ok
[INFO] [stdout] test routing::router::tests::simple_mpp_route_test ... ok
[INFO] [stdout] test ln::reorg_tests::test_onchain_htlc_timeout_delay_remote_commitment ... ok
[INFO] [stdout] test ln::reorg_tests::test_onchain_htlc_claim_reorg_remote_commitment ... ok
[INFO] [stdout] test ln::functional_tests::channel_monitor_network_test ... ok
[INFO] [stdout] test ln::functional_tests::test_upfront_shutdown_script ... ok
[INFO] [stdout] test ln::reorg_tests::test_onchain_htlc_timeout_delay_local_commitment ... ok
[INFO] [stdout] test ln::peer_handler::tests::test_do_attempt_write_data ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_exceed_max_htlc_num_and_htlc_id_increment has been running for over 60 seconds
[INFO] [stdout] test ln::reorg_tests::test_onchain_htlc_claim_reorg_local_commitment ... ok
[INFO] [stdout] test ln::functional_tests::test_simple_peer_disconnect ... ok
[INFO] [stdout] test ln::functional_tests::test_shutdown_rebroadcast ... ok
[INFO] [stdout] test ln::functional_tests::test_sanity_on_in_flight_opens ... ok
[INFO] [stdout] test ln::functional_tests::test_onchain_htlc_settlement_after_close ... ok
[INFO] [stdout] test ln::functional_tests::holding_cell_htlc_counting ... ok
[INFO] [stdout] test ln::onion_route_tests::test_onion_failure has been running for over 60 seconds
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan has been running for over 60 seconds
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan_via_funding_unconfirmed has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_channel_reserve_holding_cell_htlcs ... ok
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan_via_listen has been running for over 60 seconds
[INFO] [stdout] test routing::network_graph::tests::handling_query_channel_range has been running for over 60 seconds
[INFO] [stdout] test ln::functional_tests::test_commitment_revoked_fail_backward_exhaustive_b ... ok
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan_via_listen ... ok
[INFO] [stdout] test ln::functional_tests::test_htlc_on_chain_timeout ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_latest_remote_announce_b ... ok
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_previous_remote_announce ... ok
[INFO] [stdout] test ln::functional_tests::test_commitment_revoked_fail_backward_exhaustive_a ... ok
[INFO] [stdout] test ln::functional_tests::test_fail_backwards_latest_remote_announce_a ... ok
[INFO] [stdout] test ln::functional_tests::test_update_add_htlc_bolt2_sender_exceed_max_htlc_num_and_htlc_id_increment ... ok
[INFO] [stdout] test ln::reorg_tests::test_unconf_chan_via_funding_unconfirmed ... ok
[INFO] [stdout] test ln::functional_tests::fake_network_test ... ok
[INFO] [stdout] test routing::network_graph::tests::handling_query_channel_range ... ok
[INFO] [stdout] test ln::onion_route_tests::test_onion_failure ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 307 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 342.20s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests lightning
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/chain/transaction.rs - chain::transaction::TransactionData (line 22) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.27s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "89b67200517f4cb078ba9f2a7dead275369665ebe8feb3677002c5e6d49ef25f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "89b67200517f4cb078ba9f2a7dead275369665ebe8feb3677002c5e6d49ef25f", kill_on_drop: false }`
[INFO] [stdout] 89b67200517f4cb078ba9f2a7dead275369665ebe8feb3677002c5e6d49ef25f