[INFO] fetching crate versust 1.0.1...
[INFO] testing versust-1.0.1 against try#db823df02fd0c2cf67b43025ac3fef3f2d743245 for pr-150681
[INFO] extracting crate versust 1.0.1 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate versust 1.0.1
[INFO] finished tweaking crates.io crate versust 1.0.1
[INFO] tweaked toml for crates.io crate versust 1.0.1 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate versust 1.0.1 on toolchain db823df02fd0c2cf67b43025ac3fef3f2d743245
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate versust 1.0.1 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" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ae895023d5ba4617f7614e73bdc292bd1ef7a01d636fca57ec70595b5eb1397c
[INFO] running `Command { std: "docker" "start" "-a" "ae895023d5ba4617f7614e73bdc292bd1ef7a01d636fca57ec70595b5eb1397c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ae895023d5ba4617f7614e73bdc292bd1ef7a01d636fca57ec70595b5eb1397c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ae895023d5ba4617f7614e73bdc292bd1ef7a01d636fca57ec70595b5eb1397c", kill_on_drop: false }`
[INFO] [stdout] ae895023d5ba4617f7614e73bdc292bd1ef7a01d636fca57ec70595b5eb1397c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6a334f4d2cd2c139b538fbb36b2c7229dfd9198330d01b0dc59c19b38e33c4d2
[INFO] running `Command { std: "docker" "start" "-a" "6a334f4d2cd2c139b538fbb36b2c7229dfd9198330d01b0dc59c19b38e33c4d2", kill_on_drop: false }`
[INFO] [stderr]    Compiling versust v1.0.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] running `Command { std: "docker" "inspect" "6a334f4d2cd2c139b538fbb36b2c7229dfd9198330d01b0dc59c19b38e33c4d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6a334f4d2cd2c139b538fbb36b2c7229dfd9198330d01b0dc59c19b38e33c4d2", kill_on_drop: false }`
[INFO] [stdout] 6a334f4d2cd2c139b538fbb36b2c7229dfd9198330d01b0dc59c19b38e33c4d2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4f14620c3f6764578b9e2043e67688c2740a739f3237d50b10e80d994d8506c1
[INFO] running `Command { std: "docker" "start" "-a" "4f14620c3f6764578b9e2043e67688c2740a739f3237d50b10e80d994d8506c1", kill_on_drop: false }`
[INFO] [stderr]    Compiling versust v1.0.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.20s
[INFO] running `Command { std: "docker" "inspect" "4f14620c3f6764578b9e2043e67688c2740a739f3237d50b10e80d994d8506c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4f14620c3f6764578b9e2043e67688c2740a739f3237d50b10e80d994d8506c1", kill_on_drop: false }`
[INFO] [stdout] 4f14620c3f6764578b9e2043e67688c2740a739f3237d50b10e80d994d8506c1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8d6148e4ae01f0402ffc4d9abdf75e65689d8210c0f64210987e45b6fc596851
[INFO] running `Command { std: "docker" "start" "-a" "8d6148e4ae01f0402ffc4d9abdf75e65689d8210c0f64210987e45b6fc596851", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/versust-c55aa2501660c966)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test concurrency::race::tests::race_fails_on_empty_jobs ... ok
[INFO] [stdout] test concurrency::rush::tests::rush_fails_on_empty_jobs ... ok
[INFO] [stdout] test concurrency::race::tests::race_runs_correctly ... ok
[INFO] [stdout] test tests::test_concurrency ... ok
[INFO] [stdout] test concurrency::rush::tests::rush_runs_correctly ... ok
[INFO] [stdout] test concurrency::race::tests::race_fails_when_all_jobs_panic ... ok
[INFO] [stdout] test concurrency::rush::tests::rush_fails_when_all_jobs_panic ... ok
[INFO] [stdout] test concurrency::branch::tests::branch_runs_correctly ... ok
[INFO] [stdout] test concurrency::sync::tests::sync_runs_correctly ... ok
[INFO] [stdout] test concurrency::race::tests::race_run_jobs_atomically ... ok
[INFO] [stdout] test concurrency::race::tests::race_terminates_other_jobs ... ok
[INFO] [stdout] test concurrency::rush::tests::rush_runs_remaining_jobs ... ok
[INFO] [stdout] test concurrency::branch::tests::branch_returns_immediately ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.31s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests versust
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test src/concurrency/rush.rs - concurrency::rush::rush (line 17) ... ok
[INFO] [stdout] test src/concurrency/rush.rs - concurrency::rush::rush (line 97) ... ok
[INFO] [stdout] test src/concurrency/branch.rs - concurrency::branch::branch (line 37) ... ok
[INFO] [stdout] test src/concurrency/sync.rs - concurrency::sync::sync (line 15) ... ok
[INFO] [stdout] test src/concurrency/branch.rs - concurrency::branch::branch (line 15) ... ok
[INFO] [stdout] test src/concurrency/branch.rs - concurrency::branch::branch (line 84) ... ok
[INFO] [stdout] test src/concurrency/sync.rs - concurrency::sync::sync (line 37) ... ok
[INFO] [stdout] test src/concurrency/sync.rs - concurrency::sync::sync (line 82) ... ok
[INFO] [stdout] test src/concurrency/race.rs - concurrency::race::race (line 28) ... ok
[INFO] [stdout] test src/concurrency/race.rs - concurrency::race::race (line 197) ... ok
[INFO] [stdout] test src/concurrency/race.rs - concurrency::race::race (line 69) ... ok
[INFO] [stdout] test src/concurrency/rush.rs - concurrency::rush::rush (line 38) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.49s; merged doctests compilation took 1.28s
[INFO] running `Command { std: "docker" "inspect" "8d6148e4ae01f0402ffc4d9abdf75e65689d8210c0f64210987e45b6fc596851", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d6148e4ae01f0402ffc4d9abdf75e65689d8210c0f64210987e45b6fc596851", kill_on_drop: false }`
[INFO] [stdout] 8d6148e4ae01f0402ffc4d9abdf75e65689d8210c0f64210987e45b6fc596851