[INFO] fetching crate canrun_basic 0.1.0...
[INFO] testing canrun_basic-0.1.0 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate canrun_basic 0.1.0 into /workspace/builds/worker-9/source
[INFO] validating manifest of crates.io crate canrun_basic 0.1.0 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate canrun_basic 0.1.0
[INFO] finished tweaking crates.io crate canrun_basic 0.1.0
[INFO] tweaked toml for crates.io crate canrun_basic 0.1.0 written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2f065483420d1db85bceed60fd72d9bf3e993c0df3ad1efac02e2c7d300f2b8b
[INFO] running `Command { std: "docker" "start" "-a" "2f065483420d1db85bceed60fd72d9bf3e993c0df3ad1efac02e2c7d300f2b8b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2f065483420d1db85bceed60fd72d9bf3e993c0df3ad1efac02e2c7d300f2b8b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f065483420d1db85bceed60fd72d9bf3e993c0df3ad1efac02e2c7d300f2b8b", kill_on_drop: false }`
[INFO] [stdout] 2f065483420d1db85bceed60fd72d9bf3e993c0df3ad1efac02e2c7d300f2b8b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] afe177225a9e9ab08ede62f712d03d98567a0a0113eeed4c17db57bea2caf8f8
[INFO] running `Command { std: "docker" "start" "-a" "afe177225a9e9ab08ede62f712d03d98567a0a0113eeed4c17db57bea2caf8f8", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling typenum v1.13.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling im-rc v15.0.0
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling bitmaps v2.1.0
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand_xoshiro v0.4.0
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling sized-chunks v0.6.5
[INFO] [stderr]    Compiling canrun_codegen v0.1.0
[INFO] [stderr]    Compiling canrun v0.1.0
[INFO] [stderr]    Compiling canrun_basic v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.91s
[INFO] running `Command { std: "docker" "inspect" "afe177225a9e9ab08ede62f712d03d98567a0a0113eeed4c17db57bea2caf8f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "afe177225a9e9ab08ede62f712d03d98567a0a0113eeed4c17db57bea2caf8f8", kill_on_drop: false }`
[INFO] [stdout] afe177225a9e9ab08ede62f712d03d98567a0a0113eeed4c17db57bea2caf8f8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 857115fc24df9c9565b53b1c5828edcc320b9a9a979d75dc1803d8b3868ae347
[INFO] running `Command { std: "docker" "start" "-a" "857115fc24df9c9565b53b1c5828edcc320b9a9a979d75dc1803d8b3868ae347", kill_on_drop: false }`
[INFO] [stderr]    Compiling canrun_basic v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.02s
[INFO] running `Command { std: "docker" "inspect" "857115fc24df9c9565b53b1c5828edcc320b9a9a979d75dc1803d8b3868ae347", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "857115fc24df9c9565b53b1c5828edcc320b9a9a979d75dc1803d8b3868ae347", kill_on_drop: false }`
[INFO] [stdout] 857115fc24df9c9565b53b1c5828edcc320b9a9a979d75dc1803d8b3868ae347
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bc1819489b677b559cddb32f5e153767c340ba75e135390bca791f702ee51368
[INFO] running `Command { std: "docker" "start" "-a" "bc1819489b677b559cddb32f5e153767c340ba75e135390bca791f702ee51368", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/canrun_basic-9c4ef4bdd030067e)
[INFO] [stdout] running 22 tests
[INFO] [stdout] test cmp::lt::tests::fails ... ok
[INFO] [stdout] test cmp::gte::tests::fails ... ok
[INFO] [stdout] test cmp::lt::tests::succeeds ... ok
[INFO] [stdout] test cmp::gt::tests::fails ... ok
[INFO] [stdout] test cmp::gt::tests::succeeds ... ok
[INFO] [stdout] test cmp::lte::tests::fails ... ok
[INFO] [stdout] test cmp::max::tests::succeeds_gte ... ok
[INFO] [stdout] test ops::div::tests::fails ... ok
[INFO] [stdout] test ops::add::tests::succeeds ... ok
[INFO] [stdout] test cmp::min::tests::succeeds_lt ... ok
[INFO] [stdout] test cmp::min::tests::fails ... ok
[INFO] [stdout] test cmp::max::tests::fails ... ok
[INFO] [stdout] test ops::div::tests::succeeds ... ok
[INFO] [stdout] test cmp::max::tests::succeeds_gt ... ok
[INFO] [stdout] test ops::add::tests::fails ... ok
[INFO] [stdout] test cmp::min::tests::succeeds_lte ... ok
[INFO] [stdout] test ops::mul::tests::fails ... ok
[INFO] [stdout] test ops::sub::tests::succeeds ... ok
[INFO] [stdout] test ops::sub::tests::fails ... ok
[INFO] [stdout] test ops::mul::tests::succeeds ... ok
[INFO] [stdout] test cmp::lte::tests::succeeds ... ok
[INFO] [stderr]    Doc-tests canrun_basic
[INFO] [stdout] test cmp::gte::tests::succeeds ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test src/ops/mul.rs - ops::mul::mul (line 10) ... ok
[INFO] [stdout] test src/cmp/min.rs - cmp::min::min (line 10) ... ok
[INFO] [stdout] test src/cmp/lte.rs - cmp::lte::lte (line 10) ... ok
[INFO] [stdout] test src/cmp/gte.rs - cmp::gte::gte (line 10) ... ok
[INFO] [stdout] test src/ops/sub.rs - ops::sub::sub (line 10) ... ok
[INFO] [stdout] test src/ops/div.rs - ops::div::div (line 10) ... ok
[INFO] [stdout] test src/ops/add.rs - ops::add::add (line 10) ... ok
[INFO] [stdout] test src/cmp/lt.rs - cmp::lt::lt (line 10) ... ok
[INFO] [stdout] test src/cmp/max.rs - cmp::max::max (line 10) ... ok
[INFO] [stdout] test src/cmp/gt.rs - cmp::gt::gt (line 10) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.55s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "bc1819489b677b559cddb32f5e153767c340ba75e135390bca791f702ee51368", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bc1819489b677b559cddb32f5e153767c340ba75e135390bca791f702ee51368", kill_on_drop: false }`
[INFO] [stdout] bc1819489b677b559cddb32f5e153767c340ba75e135390bca791f702ee51368