[INFO] fetching crate docker-bisect 0.1.0... [INFO] testing docker-bisect-0.1.0 against beta-2022-04-10 for beta-1.61-1 [INFO] extracting crate docker-bisect 0.1.0 into /workspace/builds/worker-20/source [INFO] validating manifest of crates.io crate docker-bisect 0.1.0 on toolchain beta-2022-04-10 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate docker-bisect 0.1.0 [INFO] finished tweaking crates.io crate docker-bisect 0.1.0 [INFO] tweaked toml for crates.io crate docker-bisect 0.1.0 written to /workspace/builds/worker-20/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 6cc9eda362c66e9322871c1d3ef1933ed89da2e8f906779f5e3b8977d36fa58d [INFO] running `Command { std: "docker" "start" "-a" "6cc9eda362c66e9322871c1d3ef1933ed89da2e8f906779f5e3b8977d36fa58d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "6cc9eda362c66e9322871c1d3ef1933ed89da2e8f906779f5e3b8977d36fa58d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6cc9eda362c66e9322871c1d3ef1933ed89da2e8f906779f5e3b8977d36fa58d", kill_on_drop: false }` [INFO] [stdout] 6cc9eda362c66e9322871c1d3ef1933ed89da2e8f906779f5e3b8977d36fa58d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0a5bb400d960b30fea0b81194d8ccc672ee4b9aa2971e4116524714f041dda27 [INFO] running `Command { std: "docker" "start" "-a" "0a5bb400d960b30fea0b81194d8ccc672ee4b9aa2971e4116524714f041dda27", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling libc v0.2.123 [INFO] [stderr] Compiling winapi-build v0.1.1 [INFO] [stderr] Compiling rand_core v0.4.2 [INFO] [stderr] Compiling log v0.4.16 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling winapi v0.2.8 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling unicode-bidi v0.3.7 [INFO] [stderr] Compiling version_check v0.1.5 [INFO] [stderr] Compiling unicode-width v0.1.9 [INFO] [stderr] Compiling httparse v1.7.0 [INFO] [stderr] Compiling percent-encoding v1.0.1 [INFO] [stderr] Compiling parking_lot_core v0.9.2 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling backtrace v0.2.3 [INFO] [stderr] Compiling nix v0.11.1 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling rustc-demangle v0.1.21 [INFO] [stderr] Compiling smallvec v1.8.0 [INFO] [stderr] Compiling language-tags v0.2.2 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling traitobject v0.0.1 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling typeable v0.1.2 [INFO] [stderr] Compiling rustc-serialize v0.3.24 [INFO] [stderr] Compiling void v1.0.2 [INFO] [stderr] Compiling safemem v0.3.3 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling autocfg v0.1.8 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling lock_api v0.4.7 [INFO] [stderr] Compiling dbghelp-sys v0.2.0 [INFO] [stderr] Compiling kernel32-sys v0.2.2 [INFO] [stderr] Compiling backtrace-sys v0.1.23 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling unicase v1.4.2 [INFO] [stderr] Compiling rand_chacha v0.1.1 [INFO] [stderr] Compiling rand_pcg v0.1.2 [INFO] [stderr] Compiling rand v0.6.5 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling base64 v0.9.3 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling log v0.3.9 [INFO] [stderr] Compiling hpack v0.2.0 [INFO] [stderr] Compiling mime v0.2.6 [INFO] [stderr] Compiling idna v0.1.5 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling xattr v0.2.2 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling terminal_size v0.1.17 [INFO] [stderr] Compiling unix_socket v0.5.0 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling solicit v0.4.4 [INFO] [stderr] Compiling colored v1.9.3 [INFO] [stderr] Compiling clap v2.34.0 [INFO] [stderr] Compiling url v1.7.2 [INFO] [stderr] Compiling tar v0.4.38 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling console v0.15.0 [INFO] [stderr] Compiling cookie v0.2.5 [INFO] [stderr] Compiling number_prefix v0.2.8 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling hyper v0.9.18 [INFO] [stderr] Compiling indicatif v0.10.3 [INFO] [stderr] Compiling error-chain v0.5.0 [INFO] [stderr] Compiling dockworker v0.0.8 [INFO] [stderr] Compiling docker-bisect v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 39.47s [INFO] running `Command { std: "docker" "inspect" "0a5bb400d960b30fea0b81194d8ccc672ee4b9aa2971e4116524714f041dda27", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0a5bb400d960b30fea0b81194d8ccc672ee4b9aa2971e4116524714f041dda27", kill_on_drop: false }` [INFO] [stdout] 0a5bb400d960b30fea0b81194d8ccc672ee4b9aa2971e4116524714f041dda27 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] fe633ec5cfdb0492994adf1fc82213854514ebdc79b86c3020fd3b1cff33915a [INFO] running `Command { std: "docker" "start" "-a" "fe633ec5cfdb0492994adf1fc82213854514ebdc79b86c3020fd3b1cff33915a", kill_on_drop: false }` [INFO] [stderr] Compiling docker-bisect v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 4.02s [INFO] [stderr] Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/docker_bisect-a2c0dfe01028db16) [INFO] [stderr] Executable unittests src/bin/docker-bisect.rs (/opt/rustwide/target/debug/deps/docker_bisect-9be1ef261b16f01a) [INFO] running `Command { std: "docker" "inspect" "fe633ec5cfdb0492994adf1fc82213854514ebdc79b86c3020fd3b1cff33915a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fe633ec5cfdb0492994adf1fc82213854514ebdc79b86c3020fd3b1cff33915a", kill_on_drop: false }` [INFO] [stdout] fe633ec5cfdb0492994adf1fc82213854514ebdc79b86c3020fd3b1cff33915a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 1fe066dce194ae1ce260ee4265628c907ee1a687d2f529cf5cff686538976bf8 [INFO] running `Command { std: "docker" "start" "-a" "1fe066dce194ae1ce260ee4265628c907ee1a687d2f529cf5cff686538976bf8", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.14s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/docker_bisect-a2c0dfe01028db16) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test tests::if_output_always_same_return_earliest_command ... ok [INFO] [stdout] test tests::if_one_difference_show_command_that_made_difference ... ok [INFO] [stdout] test tests::if_two_differences_show_two_commands_that_made_difference ... ok [INFO] [stdout] test tests::three_transitions ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s [INFO] [stdout] [INFO] [stderr] Running unittests src/bin/docker-bisect.rs (/opt/rustwide/target/debug/deps/docker_bisect-9be1ef261b16f01a) [INFO] [stdout] [INFO] [stderr] Doc-tests docker-bisect [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 1 test [INFO] [stdout] test src/lib.rs - truncate (line 25) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.33s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "1fe066dce194ae1ce260ee4265628c907ee1a687d2f529cf5cff686538976bf8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1fe066dce194ae1ce260ee4265628c907ee1a687d2f529cf5cff686538976bf8", kill_on_drop: false }` [INFO] [stdout] 1fe066dce194ae1ce260ee4265628c907ee1a687d2f529cf5cff686538976bf8