[INFO] fetching crate embedded-nano-mesh 2.1.9...
[INFO] testing embedded-nano-mesh-2.1.9 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate embedded-nano-mesh 2.1.9 into /workspace/builds/worker-0-tc1/source
[INFO] removed /workspace/builds/worker-0-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate embedded-nano-mesh 2.1.9
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate embedded-nano-mesh 2.1.9
[INFO] tweaked toml for crates.io crate embedded-nano-mesh 2.1.9 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate embedded-nano-mesh 2.1.9 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate embedded-nano-mesh 2.1.9 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded proto-lab v0.1.5
[INFO] [stderr]   Downloaded embedded-nano-mesh v2.1.7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d14875177a69cd2b45ba5ac3a429918a8b7d1fd8b249e533d0020726f27a67a6
[INFO] running `Command { std: "docker" "start" "-a" "d14875177a69cd2b45ba5ac3a429918a8b7d1fd8b249e533d0020726f27a67a6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d14875177a69cd2b45ba5ac3a429918a8b7d1fd8b249e533d0020726f27a67a6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d14875177a69cd2b45ba5ac3a429918a8b7d1fd8b249e533d0020726f27a67a6", kill_on_drop: false }`
[INFO] [stdout] d14875177a69cd2b45ba5ac3a429918a8b7d1fd8b249e533d0020726f27a67a6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 642f1b8d2b13f335728b974c5955049920935184c7c11d03545083d2be1b039e
[INFO] running `Command { std: "docker" "start" "-a" "642f1b8d2b13f335728b974c5955049920935184c7c11d03545083d2be1b039e", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling heapless v0.8.0
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling embedded-io v0.6.1
[INFO] [stderr]    Compiling hash32 v0.3.1
[INFO] [stderr]    Compiling embedded-nano-mesh v2.1.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.39s
[INFO] running `Command { std: "docker" "inspect" "642f1b8d2b13f335728b974c5955049920935184c7c11d03545083d2be1b039e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "642f1b8d2b13f335728b974c5955049920935184c7c11d03545083d2be1b039e", kill_on_drop: false }`
[INFO] [stdout] 642f1b8d2b13f335728b974c5955049920935184c7c11d03545083d2be1b039e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8135076f14fd63380e1ee5a59bc5ef9a943ca7596a9cc65bd77a48f767a1462b
[INFO] running `Command { std: "docker" "start" "-a" "8135076f14fd63380e1ee5a59bc5ef9a943ca7596a9cc65bd77a48f767a1462b", kill_on_drop: false }`
[INFO] [stderr]    Compiling embedded-nano-mesh v2.1.7
[INFO] [stderr]    Compiling proto-lab v0.1.5
[INFO] [stderr]    Compiling embedded-nano-mesh v2.1.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.24s
[INFO] running `Command { std: "docker" "inspect" "8135076f14fd63380e1ee5a59bc5ef9a943ca7596a9cc65bd77a48f767a1462b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8135076f14fd63380e1ee5a59bc5ef9a943ca7596a9cc65bd77a48f767a1462b", kill_on_drop: false }`
[INFO] [stdout] 8135076f14fd63380e1ee5a59bc5ef9a943ca7596a9cc65bd77a48f767a1462b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9845295eea161d4d50e2f3ab47ee51471e099b7f5aa4554bb7a82a58de57f334
[INFO] running `Command { std: "docker" "start" "-a" "9845295eea161d4d50e2f3ab47ee51471e099b7f5aa4554bb7a82a58de57f334", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/embedded_nano_mesh-581591876e90107a)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::flag_toggle_to_true ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::set_flag_from_false_to_false ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::flag_toggle_to_false ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::set_flag_from_true_to_true ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::set_second_flag ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::set_flag_from_false_to_true ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::set_flag_from_true_to_false ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::test_if_flag_set_false ... ok
[INFO] [stdout] test mesh_lib::node::packet::bitpos::tests::test_if_flag_set_true ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_1_to_1_ignore_duplication.rs (/opt/rustwide/target/debug/deps/test_1_to_1_ignore_duplication-564b7e672ea969ba)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_1_to_1_ignore_duplication ... ok
[INFO] [stderr]      Running tests/test_1_to_1_simple.rs (/opt/rustwide/target/debug/deps/test_1_to_1_simple-29a28d6e69da05d6)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_1_to_1_simple ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_1_to_1_with_255_other_devices.rs (/opt/rustwide/target/debug/deps/test_1_to_1_with_255_other_devices-009c913773cec545)
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_1_to_1_with_255_other_devices ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.30s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_2_to_1_ignore_duplication.rs (/opt/rustwide/target/debug/deps/test_2_to_1_ignore_duplication-a7c6f4ba0d760b4e)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_2_to_1_ignore_duplication ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_2_to_1_simple.rs (/opt/rustwide/target/debug/deps/test_2_to_1_simple-0f10ef23aed51abc)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_2_to_1_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_packet_travel_2_hops.rs (/opt/rustwide/target/debug/deps/test_packet_travel_2_hops-772fa93177e19643)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_packet_travel_2_hops ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_packet_travel_2_hops_lifetime_ended.rs (/opt/rustwide/target/debug/deps/test_packet_travel_2_hops_lifetime_ended-1663e5a32dcc9c7f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_packet_travel_2_hops_lifetime_ended ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_ping_pong_simple.rs (/opt/rustwide/target/debug/deps/test_ping_pong_simple-f72a90e90619dae0)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/test_ping_pong_travel_2_hops.rs (/opt/rustwide/target/debug/deps/test_ping_pong_travel_2_hops-39f911ef9ad4d2de)
[INFO] [stdout] test tests::test_send_ping_pong_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_ping_pong_travel_2_hops ... ok
[INFO] [stderr]      Running tests/test_ping_pong_travel_2_hops_lifetime_ended.rs (/opt/rustwide/target/debug/deps/test_ping_pong_travel_2_hops_lifetime_ended-f5aa337bd952e435)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_ping_pong_travel_2_hops_lifetime_ended ... ok
[INFO] [stderr]      Running tests/test_to_self_ignore_duplication.rs (/opt/rustwide/target/debug/deps/test_to_self_ignore_duplication-43748afbca964198)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.60s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_to_self_ignore_duplication ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_to_self_simple.rs (/opt/rustwide/target/debug/deps/test_to_self_simple-46c9659c36260333)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_to_self_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_transaction_simple.rs (/opt/rustwide/target/debug/deps/test_transaction_simple-15fc2c23dabcfd4b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_transaction_simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_transaction_travel_2_hops.rs (/opt/rustwide/target/debug/deps/test_transaction_travel_2_hops-7a1f7f470b74adb5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_transaction_travel_2_hops ... ok
[INFO] [stderr]      Running tests/test_transaction_travel_2_hops_lifetime_ended.rs (/opt/rustwide/target/debug/deps/test_transaction_travel_2_hops_lifetime_ended-b730b90f14b07235)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.83s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_send_transaction_travel_2_hops_lifetime_ended ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.20s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9845295eea161d4d50e2f3ab47ee51471e099b7f5aa4554bb7a82a58de57f334", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9845295eea161d4d50e2f3ab47ee51471e099b7f5aa4554bb7a82a58de57f334", kill_on_drop: false }`
[INFO] [stdout] 9845295eea161d4d50e2f3ab47ee51471e099b7f5aa4554bb7a82a58de57f334