[INFO] fetching crate threadfin 0.1.2...
[INFO] testing threadfin-0.1.2 against try#ecd7b559f89c73ac8f1d318f7501006f37b944b2 for pr-112849
[INFO] extracting crate threadfin 0.1.2 into /workspace/builds/worker-5-tc2/source
[INFO] validating manifest of crates.io crate threadfin 0.1.2 on toolchain ecd7b559f89c73ac8f1d318f7501006f37b944b2
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate threadfin 0.1.2
[INFO] finished tweaking crates.io crate threadfin 0.1.2
[INFO] tweaked toml for crates.io crate threadfin 0.1.2 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "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-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3d923f74d11b7cbdf563ae700f69d5171b1dce1211a3a38c495a9bcb9ffe49ba
[INFO] running `Command { std: "docker" "start" "-a" "3d923f74d11b7cbdf563ae700f69d5171b1dce1211a3a38c495a9bcb9ffe49ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3d923f74d11b7cbdf563ae700f69d5171b1dce1211a3a38c495a9bcb9ffe49ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3d923f74d11b7cbdf563ae700f69d5171b1dce1211a3a38c495a9bcb9ffe49ba", kill_on_drop: false }`
[INFO] [stdout] 3d923f74d11b7cbdf563ae700f69d5171b1dce1211a3a38c495a9bcb9ffe49ba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 544aad4909b26dcd1226d861e2200862c810433b2661dd493d4c2d23f05f19b1
[INFO] running `Command { std: "docker" "start" "-a" "544aad4909b26dcd1226d861e2200862c810433b2661dd493d4c2d23f05f19b1", kill_on_drop: false }`
[INFO] [stderr]    Compiling crossbeam-utils v0.8.16
[INFO] [stderr]    Compiling threadfin v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling once_cell v1.14.0
[INFO] [stderr]    Compiling crossbeam-channel v0.5.8
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.59s
[INFO] running `Command { std: "docker" "inspect" "544aad4909b26dcd1226d861e2200862c810433b2661dd493d4c2d23f05f19b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "544aad4909b26dcd1226d861e2200862c810433b2661dd493d4c2d23f05f19b1", kill_on_drop: false }`
[INFO] [stdout] 544aad4909b26dcd1226d861e2200862c810433b2661dd493d4c2d23f05f19b1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6a967df442e307d390da213bd77f8aa03b28d68879171f4e4a097de895c0a6d9
[INFO] running `Command { std: "docker" "start" "-a" "6a967df442e307d390da213bd77f8aa03b28d68879171f4e4a097de895c0a6d9", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-timer v3.0.2
[INFO] [stderr]    Compiling threadfin v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.80s
[INFO] running `Command { std: "docker" "inspect" "6a967df442e307d390da213bd77f8aa03b28d68879171f4e4a097de895c0a6d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6a967df442e307d390da213bd77f8aa03b28d68879171f4e4a097de895c0a6d9", kill_on_drop: false }`
[INFO] [stdout] 6a967df442e307d390da213bd77f8aa03b28d68879171f4e4a097de895c0a6d9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+ecd7b559f89c73ac8f1d318f7501006f37b944b2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3daa7fc05b79c684825f049718e34ec163d2a215c32a1211158ab98cb9b00e13
[INFO] running `Command { std: "docker" "start" "-a" "3daa7fc05b79c684825f049718e34ec163d2a215c32a1211158ab98cb9b00e13", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/threadfin-5adca3aac2619106)
[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/tests.rs (/opt/rustwide/target/debug/deps/tests-89e7ae8b684109e0)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test execute ... ok
[INFO] [stdout] test execute_future ... ok
[INFO] [stdout] test configure_common_after_init_returns_error ... ok
[INFO] [stdout] test name ... ok
[INFO] [stdout] test join ... ok
[INFO] [stdout] test join_timeout_expiring ... ok
[INFO] [stdout] test invalid_size_panics - should panic ... ok
[INFO] [stdout] test invalid_size_zero_panics - should panic ... ok
[INFO] [stdout] test name_with_null_bytes_panics - should panic ... ok
[INFO] [stdout] test try_execute_over_core_count ... ok
[INFO] [stdout] test try_execute_over_limit ... ok
[INFO] [stdout] test panic_count ... ok
[INFO] [stdout] test panic_propagates_to_task - should panic ... ok
[INFO] [stdout] test task_join_timeout ... ok
[INFO] [stdout] test thread_count ... ok
[INFO] [stdout] test try_execute_under_core_count ... ok
[INFO] [stdout] test idle_shutdown ... ok
[INFO] [stderr]    Doc-tests threadfin
[INFO] [stdout] test futures_that_yield_are_run_concurrently ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.40s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test src/pool.rs - pool::Builder::name (line 173) ... ok
[INFO] [stdout] test src/pool.rs - pool::Builder (line 135) ... ok
[INFO] [stdout] test src/pool.rs - pool::Builder::size (line 216) ... ok
[INFO] [stdout] test src/pool.rs - pool::Builder::size (line 207) ... ok
[INFO] [stdout] test src/pool.rs - pool::Builder::size (line 202) ... ok
[INFO] [stdout] test src/common.rs - common::configure_common (line 32) ... ok
[INFO] [stdout] test src/lib.rs - (line 17) ... ok
[INFO] [stdout] test src/common.rs - common::common (line 10) ... ok
[INFO] [stdout] test src/pool.rs - pool::PerCore (line 100) ... ok
[INFO] [stdout] test src/pool.rs - pool::Builder::stack_size (line 253) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::completed_tasks (line 514) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::running_tasks (line 480) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::execute_future (line 614) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::panicked_tasks (line 537) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::execute (line 572) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::queued_tasks (line 437) ... ok
[INFO] [stdout] test src/pool.rs - pool::ThreadPool::try_execute (line 649) ... ok
[INFO] [stdout] test src/task.rs - task::Task (line 44) ... ok
[INFO] [stdout] test src/task.rs - task::Task (line 32) ... ok
[INFO] [stdout] test src/task.rs - task::Task (line 63) ... ok
[INFO] [stdout] test src/task.rs - task::Task (line 84) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.69s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3daa7fc05b79c684825f049718e34ec163d2a215c32a1211158ab98cb9b00e13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3daa7fc05b79c684825f049718e34ec163d2a215c32a1211158ab98cb9b00e13", kill_on_drop: false }`
[INFO] [stdout] 3daa7fc05b79c684825f049718e34ec163d2a215c32a1211158ab98cb9b00e13