[INFO] fetching crate redpine 0.3.0...
[INFO] testing redpine-0.3.0 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1
[INFO] extracting crate redpine 0.3.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate redpine 0.3.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate redpine 0.3.0
[INFO] tweaked toml for crates.io crate redpine 0.3.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate redpine 0.3.0 on toolchain b83b707f97d809763b7861afa7638871f3339a33
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate redpine 0.3.0 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" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 88b63429feb195103a2bacfc7f1215be761f39b404f74fd4967619651b178481
[INFO] running `Command { std: "docker" "start" "-a" "88b63429feb195103a2bacfc7f1215be761f39b404f74fd4967619651b178481", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "88b63429feb195103a2bacfc7f1215be761f39b404f74fd4967619651b178481", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "88b63429feb195103a2bacfc7f1215be761f39b404f74fd4967619651b178481", kill_on_drop: false }`
[INFO] [stdout] 88b63429feb195103a2bacfc7f1215be761f39b404f74fd4967619651b178481
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 37af4ffcd7abf5526e0b38e07b829c84f91e1bcf08b1c6910df1919db5826b3f
[INFO] running `Command { std: "docker" "start" "-a" "37af4ffcd7abf5526e0b38e07b829c84f91e1bcf08b1c6910df1919db5826b3f", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling rustix v0.38.20
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling bitflags v2.4.1
[INFO] [stderr]    Compiling pin-project-lite v0.2.13
[INFO] [stderr]    Compiling linux-raw-sys v0.4.10
[INFO] [stderr]    Compiling siphasher v1.0.0
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling polling v3.2.0
[INFO] [stderr]    Compiling redpine v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.91s
[INFO] running `Command { std: "docker" "inspect" "37af4ffcd7abf5526e0b38e07b829c84f91e1bcf08b1c6910df1919db5826b3f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37af4ffcd7abf5526e0b38e07b829c84f91e1bcf08b1c6910df1919db5826b3f", kill_on_drop: false }`
[INFO] [stdout] 37af4ffcd7abf5526e0b38e07b829c84f91e1bcf08b1c6910df1919db5826b3f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 68e8cf0de038d03a1e598a4ab57b9d98f3f118cbd15497c51187a9e52ffbc2a5
[INFO] running `Command { std: "docker" "start" "-a" "68e8cf0de038d03a1e598a4ab57b9d98f3f118cbd15497c51187a9e52ffbc2a5", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling md5 v0.7.0
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling num_cpus v1.16.0
[INFO] [stderr]    Compiling core_affinity v0.8.1
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling redpine v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 7.19s
[INFO] running `Command { std: "docker" "inspect" "68e8cf0de038d03a1e598a4ab57b9d98f3f118cbd15497c51187a9e52ffbc2a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "68e8cf0de038d03a1e598a4ab57b9d98f3f118cbd15497c51187a9e52ffbc2a5", kill_on_drop: false }`
[INFO] [stdout] 68e8cf0de038d03a1e598a4ab57b9d98f3f118cbd15497c51187a9e52ffbc2a5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a7a114648bb9d1a16e1d28dc1f0618f704bcf7858d4341637e1a9e104081bb2c
[INFO] running `Command { std: "docker" "start" "-a" "a7a114648bb9d1a16e1d28dc1f0618f704bcf7858d4341637e1a9e104081bb2c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/redpine-5f41af2082f7d127)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test buffer::reliable::tests::send_fragmentation ... ok
[INFO] [stdout] test buffer::reliable::tests::resend_resync ... ok
[INFO] [stdout] test buffer::unreliable::tests::send_fragmentation ... ok
[INFO] [stdout] test endpoint::prio::tests::maxed_counters ... ok
[INFO] [stdout] test endpoint::cc::tests::basic ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::beyond_window ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::dup_rejection ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::sequential_receive ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::skips ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::bad_nonce_verification ... ok
[INFO] [stdout] test endpoint::prio::tests::simple ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::drop_detection ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::nonsequential_receive ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::ideal_nonce_verification ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::send_receive_window ... ok
[INFO] [stdout] test endpoint::prio::tests::single_channels ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::full_window_nonce_verification ... ok
[INFO] [stdout] test endpoint::tests::tx_state ... ok
[INFO] [stdout] test frame::serial::crc::tests::zero_nonzero_crc ... ok
[INFO] [stdout] test frame::serial::crc::tests::basic ... ok
[INFO] [stdout] test timer_queue::tests::test_no_trigger_if_test_returns_false ... ok
[INFO] [stdout] test timer_queue::tests::test_expired_timer_removed ... ok
[INFO] [stdout] test buffer::reliable::tests::invalid_acks ... ok
[INFO] [stdout] test timer_queue::tests::test_trigger_callback_called ... ok
[INFO] [stdout] test buffer::reliable::tests::resend ... ok
[INFO] [stdout] test timer_queue::tests::test_limit_respected ... ok
[INFO] [stdout] test frame::serial::tests::stream_data ... ok
[INFO] [stdout] test buffer::reliable::tests::ack_advancement ... ok
[INFO] [stdout] test frame::serial::crc::tests::random ... ok
[INFO] [stderr]      Running unittests src/bin/client.rs (/opt/rustwide/target/debug/deps/client-26758d1a95000d9f)
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/server.rs (/opt/rustwide/target/debug/deps/server-aee27f25e2c112a2)
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multi_client_connect_disconnect.rs (/opt/rustwide/target/debug/deps/multi_client_connect_disconnect-46a8e2af608c606d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test multi_client_connect_disconnect ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multi_client_transfer.rs (/opt/rustwide/target/debug/deps/multi_client_transfer-038b92e44caf0213)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test multi_client_transfer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 14.44s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/send_while_blocking.rs (/opt/rustwide/target/debug/deps/send_while_blocking-68101f3d4aa3c058)
[INFO] [stdout] test send_while_blocking ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/single_client_connect_disconnect.rs (/opt/rustwide/target/debug/deps/single_client_connect_disconnect-b97b39b348ab9c4e)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/single_client_transfer.rs (/opt/rustwide/target/debug/deps/single_client_transfer-feeeecec6df3a8e4)
[INFO] [stdout] test single_client_connect_disconnect ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.50s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test single_client_transfer ... ok
[INFO] [stderr]      Running tests/validate_sendable.rs (/opt/rustwide/target/debug/deps/validate_sendable-8bc968deba57da9b)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.48s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test client_send ... ok
[INFO] [stdout] test server_send ... ok
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests redpine
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a7a114648bb9d1a16e1d28dc1f0618f704bcf7858d4341637e1a9e104081bb2c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a7a114648bb9d1a16e1d28dc1f0618f704bcf7858d4341637e1a9e104081bb2c", kill_on_drop: false }`
[INFO] [stdout] a7a114648bb9d1a16e1d28dc1f0618f704bcf7858d4341637e1a9e104081bb2c