[INFO] cloning repository https://github.com/wjchenqing/RayTracer
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/wjchenqing/RayTracer" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwjchenqing%2FRayTracer", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwjchenqing%2FRayTracer'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 638400584e6dde3b125e929136f007a854fc5cc0
[INFO] testing wjchenqing/RayTracer against master#404c8471aba60c2d837fa728e7c729a0f52d5830 for pr-87041-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwjchenqing%2FRayTracer" "/workspace/builds/worker-28/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-28/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/wjchenqing/RayTracer on toolchain 404c8471aba60c2d837fa728e7c729a0f52d5830
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] removed /workspace/builds/worker-28/source/rust-toolchain
[INFO] started tweaking git repo https://github.com/wjchenqing/RayTracer
[INFO] finished tweaking git repo https://github.com/wjchenqing/RayTracer
[INFO] tweaked toml for git repo https://github.com/wjchenqing/RayTracer written to /workspace/builds/worker-28/source/Cargo.toml
[INFO] crate git repo https://github.com/wjchenqing/RayTracer already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "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-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 255e7588d92f457d0b2dc6107cb8c233b4f151051d412cf7a9d73ae9cafe3fbb
[INFO] running `Command { std: "docker" "start" "-a" "255e7588d92f457d0b2dc6107cb8c233b4f151051d412cf7a9d73ae9cafe3fbb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "255e7588d92f457d0b2dc6107cb8c233b4f151051d412cf7a9d73ae9cafe3fbb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "255e7588d92f457d0b2dc6107cb8c233b4f151051d412cf7a9d73ae9cafe3fbb", kill_on_drop: false }`
[INFO] [stdout] 255e7588d92f457d0b2dc6107cb8c233b4f151051d412cf7a9d73ae9cafe3fbb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5ce1fe33673850db03ab922f0a0f633f14e03786dcd9cda9d97a054706caa20e
[INFO] running `Command { std: "docker" "start" "-a" "5ce1fe33673850db03ab922f0a0f633f14e03786dcd9cda9d97a054706caa20e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.74
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling rayon-core v1.7.1
[INFO] [stderr]    Compiling adler32 v1.2.0
[INFO] [stderr]    Compiling rand_core v0.4.2
[INFO] [stderr]    Compiling bytemuck v1.3.1
[INFO] [stderr]    Compiling memoffset v0.5.5
[INFO] [stderr]    Compiling num-traits v0.2.12
[INFO] [stderr]    Compiling num-integer v0.1.43
[INFO] [stderr]    Compiling rayon v1.3.1
[INFO] [stderr]    Compiling num-rational v0.3.0
[INFO] [stderr]    Compiling num-iter v0.1.41
[INFO] [stderr]    Compiling crossbeam-utils v0.7.2
[INFO] [stderr]    Compiling crc32fast v1.2.0
[INFO] [stderr]    Compiling miniz_oxide v0.3.7
[INFO] [stderr]    Compiling deflate v0.8.6
[INFO] [stderr]    Compiling rand_core v0.3.1
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling crossbeam-queue v0.2.3
[INFO] [stderr]    Compiling tiff v0.5.0
[INFO] [stderr]    Compiling png v0.16.7
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling terminal_size v0.1.13
[INFO] [stderr]    Compiling termios v0.3.2
[INFO] [stderr]    Compiling rand v0.5.6
[INFO] [stderr]    Compiling console v0.11.3
[INFO] [stderr]    Compiling threadpool v1.8.1
[INFO] [stderr]    Compiling indicatif v0.15.0
[INFO] [stderr]    Compiling jpeg-decoder v0.1.20
[INFO] [stderr]    Compiling image v0.23.8
[INFO] [stderr]    Compiling raytracer v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.74s
[INFO] running `Command { std: "docker" "inspect" "5ce1fe33673850db03ab922f0a0f633f14e03786dcd9cda9d97a054706caa20e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5ce1fe33673850db03ab922f0a0f633f14e03786dcd9cda9d97a054706caa20e", kill_on_drop: false }`
[INFO] [stdout] 5ce1fe33673850db03ab922f0a0f633f14e03786dcd9cda9d97a054706caa20e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c90af3a2b44555f7b961168c0efc80d89aa75b31db33a25562e54d070f089f8c
[INFO] running `Command { std: "docker" "start" "-a" "c90af3a2b44555f7b961168c0efc80d89aa75b31db33a25562e54d070f089f8c", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling raytracer v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.86s
[INFO] running `Command { std: "docker" "inspect" "c90af3a2b44555f7b961168c0efc80d89aa75b31db33a25562e54d070f089f8c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c90af3a2b44555f7b961168c0efc80d89aa75b31db33a25562e54d070f089f8c", kill_on_drop: false }`
[INFO] [stdout] c90af3a2b44555f7b961168c0efc80d89aa75b31db33a25562e54d070f089f8c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+404c8471aba60c2d837fa728e7c729a0f52d5830" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3308e358bd1c49ca846ae5273a8a361744ea3d1df1f8b1a020aa726b61d9980c
[INFO] running `Command { std: "docker" "start" "-a" "3308e358bd1c49ca846ae5273a8a361744ea3d1df1f8b1a020aa726b61d9980c", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.20s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/raytracer-2320dd7a3c3a7c83)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test vec3::tests::test_add ... ok
[INFO] [stdout] test vec3::tests::test_add_assign ... ok
[INFO] [stdout] test vec3::tests::test_add_assign_f64 ... ok
[INFO] [stdout] test vec3::tests::test_add_f64 ... ok
[INFO] [stdout] test vec3::tests::test_cross ... ok
[INFO] [stdout] test vec3::tests::test_div ... ok
[INFO] [stdout] test vec3::tests::test_elemul ... ok
[INFO] [stdout] test vec3::tests::test_length ... ok
[INFO] [stdout] test vec3::tests::test_mul_assign ... ok
[INFO] [stdout] test vec3::tests::test_mul ... ok
[INFO] [stdout] test vec3::tests::test_mul_f64 ... ok
[INFO] [stdout] test vec3::tests::test_neg ... ok
[INFO] [stdout] test vec3::tests::test_new ... ok
[INFO] [stdout] test vec3::tests::test_squared_length ... ok
[INFO] [stdout] test vec3::tests::test_sub ... ok
[INFO] [stdout] test vec3::tests::test_sub_assign ... ok
[INFO] [stdout] test vec3::tests::test_sub_assign_f64 ... ok
[INFO] [stdout] test vec3::tests::test_sub_f64 ... ok
[INFO] [stdout] test vec3::tests::test_unit ... ok
[INFO] [stdout] test vec3::tests::test_unit_panic - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3308e358bd1c49ca846ae5273a8a361744ea3d1df1f8b1a020aa726b61d9980c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3308e358bd1c49ca846ae5273a8a361744ea3d1df1f8b1a020aa726b61d9980c", kill_on_drop: false }`
[INFO] [stdout] 3308e358bd1c49ca846ae5273a8a361744ea3d1df1f8b1a020aa726b61d9980c