[INFO] fetching crate redpine 0.3.0...
[INFO] testing redpine-0.3.0 against 1.99.0-beta.1+cargoflags=--release for beta-release-1.99-2
[INFO] extracting crate redpine 0.3.0 into /workspace/builds/worker-6-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-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate redpine 0.3.0 on toolchain 1.99.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.1" "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" "+1.99.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:8683fc1fc2eb5c9ac98e0d076ab094b2ffac7f99da555d2b6a2e27f346de2ec7" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b
[INFO] running `Command { std: "docker" "start" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling rustix v0.38.20
[INFO] [stderr]    Compiling linux-raw-sys v0.4.10
[INFO] [stderr]    Compiling bitflags v2.4.1
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling pin-project-lite v0.2.13
[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 `release` profile [optimized] target(s) in 9.23s
[INFO] running `Command { std: "docker" "inspect" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", 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] [stdout] warning: value assigned to `read_idx` is never read
[INFO] [stdout]    --> tests/common/util.rs:100:17
[INFO] [stdout]     |
[INFO] [stdout] 100 |                 read_idx += 1;
[INFO] [stdout]     |                 ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = help: maybe it is overwritten before being read?
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `read_idx` is never read
[INFO] [stdout]    --> tests/common/util.rs:100:17
[INFO] [stdout]     |
[INFO] [stdout] 100 |                 read_idx += 1;
[INFO] [stdout]     |                 ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = help: maybe it is overwritten before being read?
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `read_idx` is never read
[INFO] [stdout]    --> tests/common/util.rs:100:17
[INFO] [stdout]     |
[INFO] [stdout] 100 |                 read_idx += 1;
[INFO] [stdout]     |                 ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = help: maybe it is overwritten before being read?
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `read_idx` is never read
[INFO] [stdout]    --> tests/common/util.rs:100:17
[INFO] [stdout]     |
[INFO] [stdout] 100 |                 read_idx += 1;
[INFO] [stdout]     |                 ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = help: maybe it is overwritten before being read?
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `read_idx` is never read
[INFO] [stdout]    --> tests/common/util.rs:100:17
[INFO] [stdout]     |
[INFO] [stdout] 100 |                 read_idx += 1;
[INFO] [stdout]     |                 ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = help: maybe it is overwritten before being read?
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 9.03s
[INFO] running `Command { std: "docker" "inspect" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: value assigned to `read_idx` is never read
[INFO] [stderr]    --> tests/common/util.rs:100:17
[INFO] [stderr]     |
[INFO] [stderr] 100 |                 read_idx += 1;
[INFO] [stderr]     |                 ^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = help: maybe it is overwritten before being read?
[INFO] [stderr]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `redpine` (test "multi_client_transfer") generated 1 warning
[INFO] [stderr] warning: `redpine` (test "send_while_blocking") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `redpine` (test "single_client_connect_disconnect") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `redpine` (test "single_client_transfer") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `redpine` (test "multi_client_connect_disconnect") generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/redpine-ef7c1b901fa2b114)
[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::reliable::tests::resend ... ok
[INFO] [stdout] test buffer::unreliable::tests::send_fragmentation ... ok
[INFO] [stdout] test endpoint::prio::tests::maxed_counters ... ok
[INFO] [stdout] test endpoint::prio::tests::single_channels ... 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_tx::tests::bad_nonce_verification ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::nonsequential_receive ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::skips ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::full_window_nonce_verification ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::ideal_nonce_verification ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::drop_detection ... ok
[INFO] [stdout] test endpoint::tests::tx_state ... ok
[INFO] [stdout] test endpoint::segment_rx::tests::beyond_window ... ok
[INFO] [stdout] test frame::serial::crc::tests::zero_nonzero_crc ... ok
[INFO] [stdout] test timer_queue::tests::test_expired_timer_removed ... ok
[INFO] [stdout] test timer_queue::tests::test_limit_respected ... ok
[INFO] [stdout] test timer_queue::tests::test_no_trigger_if_test_returns_false ... ok
[INFO] [stdout] test frame::serial::tests::stream_data ... ok
[INFO] [stdout] test timer_queue::tests::test_trigger_callback_called ... ok
[INFO] [stdout] test endpoint::segment_tx::tests::send_receive_window ... ok
[INFO] [stdout] test frame::serial::crc::tests::basic ... ok
[INFO] [stdout] test frame::serial::crc::tests::random ... ok
[INFO] [stdout] test buffer::reliable::tests::ack_advancement ... ok
[INFO] [stdout] test endpoint::prio::tests::simple ... ok
[INFO] [stdout] test endpoint::cc::tests::basic ... ok
[INFO] [stdout] test buffer::reliable::tests::invalid_acks ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/client.rs (/opt/rustwide/target/release/deps/client-b85bbc1db60f8a7d)
[INFO] [stderr]      Running unittests src/bin/server.rs (/opt/rustwide/target/release/deps/server-7179ad118fb0e0d7)
[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/release/deps/multi_client_connect_disconnect-872061d11ddf055f)
[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.09s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multi_client_transfer.rs (/opt/rustwide/target/release/deps/multi_client_transfer-8bc56fc7526543f1)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test multi_client_transfer ... ok
[INFO] [stderr]      Running tests/send_while_blocking.rs (/opt/rustwide/target/release/deps/send_while_blocking-caa5573205560dfd)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 12.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[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.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/single_client_connect_disconnect.rs (/opt/rustwide/target/release/deps/single_client_connect_disconnect-d657a9397919d97f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test single_client_connect_disconnect ... ok
[INFO] [stderr]      Running tests/single_client_transfer.rs (/opt/rustwide/target/release/deps/single_client_transfer-b79a2814b90b4e6a)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.51s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/validate_sendable.rs (/opt/rustwide/target/release/deps/validate_sendable-eaf59644edb0a130)
[INFO] [stdout] test single_client_transfer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test client_send ... ok
[INFO] [stdout] test server_send ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests redpine
[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" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b", kill_on_drop: false }`
[INFO] [stdout] dd62874d159f5d5fa4551b295424679e97943a23e32f754139f1eaf0e25daf6b