[INFO] updating cached repository https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune", kill_on_drop: false }`
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 81bbf41723dbf2e18bc9ba0007da76df5e404fe7
[INFO] testing HiraokaTakuya/ray_tracing_in_one_weekend against master#62efba8a050c64249dab942951bb28f710208bc8 for pr-90799
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHiraokaTakuya%2Fray_tracing_in_one_weekend" "/workspace/builds/worker-8/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-8/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend on toolchain 62efba8a050c64249dab942951bb28f710208bc8
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend
[INFO] finished tweaking git repo https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend
[INFO] tweaked toml for git repo https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] crate git repo https://github.com/HiraokaTakuya/ray_tracing_in_one_weekend already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "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-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1986da19b9753b3f8a51535be5f494d4395338358a85845187bb0a835ba16b05
[INFO] running `Command { std: "docker" "start" "-a" "1986da19b9753b3f8a51535be5f494d4395338358a85845187bb0a835ba16b05", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1986da19b9753b3f8a51535be5f494d4395338358a85845187bb0a835ba16b05", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1986da19b9753b3f8a51535be5f494d4395338358a85845187bb0a835ba16b05", kill_on_drop: false }`
[INFO] [stdout] 1986da19b9753b3f8a51535be5f494d4395338358a85845187bb0a835ba16b05
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 063fc0d2a9458936ef9e3d017de45050a91e70bd4f2a14be313908f7c5a2fa6e
[INFO] running `Command { std: "docker" "start" "-a" "063fc0d2a9458936ef9e3d017de45050a91e70bd4f2a14be313908f7c5a2fa6e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.94
[INFO] [stderr]    Compiling getrandom v0.2.2
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling rand_core v0.6.2
[INFO] [stderr]    Compiling rand_chacha v0.3.0
[INFO] [stderr]    Compiling rand v0.8.3
[INFO] [stderr]    Compiling ray_tracing_in_one_weekend v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.60s
[INFO] running `Command { std: "docker" "inspect" "063fc0d2a9458936ef9e3d017de45050a91e70bd4f2a14be313908f7c5a2fa6e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "063fc0d2a9458936ef9e3d017de45050a91e70bd4f2a14be313908f7c5a2fa6e", kill_on_drop: false }`
[INFO] [stdout] 063fc0d2a9458936ef9e3d017de45050a91e70bd4f2a14be313908f7c5a2fa6e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8a34332606efe274e17502d4b0261a34c95791c6a6e50d25b90fcebbd7b12bcf
[INFO] running `Command { std: "docker" "start" "-a" "8a34332606efe274e17502d4b0261a34c95791c6a6e50d25b90fcebbd7b12bcf", kill_on_drop: false }`
[INFO] [stderr]    Compiling ray_tracing_in_one_weekend v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.05s
[INFO] running `Command { std: "docker" "inspect" "8a34332606efe274e17502d4b0261a34c95791c6a6e50d25b90fcebbd7b12bcf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a34332606efe274e17502d4b0261a34c95791c6a6e50d25b90fcebbd7b12bcf", kill_on_drop: false }`
[INFO] [stdout] 8a34332606efe274e17502d4b0261a34c95791c6a6e50d25b90fcebbd7b12bcf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 97d0a69312c8a773508c8ee051c14291cfe7de83cc5ae735f9c9e7887ae0e270
[INFO] running `Command { std: "docker" "start" "-a" "97d0a69312c8a773508c8ee051c14291cfe7de83cc5ae735f9c9e7887ae0e270", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.35s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ray_tracing_in_one_weekend-46c1a804e4860e7a)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test vec3::test_add ... ok
[INFO] [stdout] test vec3::test_add_assign ... ok
[INFO] [stdout] test vec3::test_div ... ok
[INFO] [stdout] test vec3::test_div_assign ... ok
[INFO] [stdout] test vec3::test_index ... ok
[INFO] [stdout] test vec3::test_index_mut ... ok
[INFO] [stdout] test vec3::test_length ... ok
[INFO] [stdout] test vec3::test_mul_assign ... ok
[INFO] [stdout] test vec3::test_mul ... ok
[INFO] [stdout] test vec3::test_neg ... ok
[INFO] [stdout] test vec3::test_sub ... ok
[INFO] [stdout] test vec3::test_sub_assign ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ray_tracing_in_one_weekend-4fc41c61b538048b)
[INFO] [stdout] 
[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]    Doc-tests ray_tracing_in_one_weekend
[INFO] [stdout] 
[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] running `Command { std: "docker" "inspect" "97d0a69312c8a773508c8ee051c14291cfe7de83cc5ae735f9c9e7887ae0e270", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "97d0a69312c8a773508c8ee051c14291cfe7de83cc5ae735f9c9e7887ae0e270", kill_on_drop: false }`
[INFO] [stdout] 97d0a69312c8a773508c8ee051c14291cfe7de83cc5ae735f9c9e7887ae0e270