[INFO] cloning repository https://github.com/mpycroft/raytracer [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/mpycroft/raytracer" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmpycroft%2Fraytracer", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmpycroft%2Fraytracer'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 861da9a36c5f6925e837f52b842d45908f6c8457 [INFO] testing mpycroft/raytracer against master#62efba8a050c64249dab942951bb28f710208bc8 for pr-90799 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmpycroft%2Fraytracer" "/workspace/builds/worker-110/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-110/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/mpycroft/raytracer 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/mpycroft/raytracer [INFO] finished tweaking git repo https://github.com/mpycroft/raytracer [INFO] tweaked toml for git repo https://github.com/mpycroft/raytracer written to /workspace/builds/worker-110/source/Cargo.toml [INFO] crate git repo https://github.com/mpycroft/raytracer 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-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 081b3395b49ebdeb5cab5a28d121c26bb86767f9c86896670b207d832b0b865a [INFO] running `Command { std: "docker" "start" "-a" "081b3395b49ebdeb5cab5a28d121c26bb86767f9c86896670b207d832b0b865a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "081b3395b49ebdeb5cab5a28d121c26bb86767f9c86896670b207d832b0b865a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "081b3395b49ebdeb5cab5a28d121c26bb86767f9c86896670b207d832b0b865a", kill_on_drop: false }` [INFO] [stdout] 081b3395b49ebdeb5cab5a28d121c26bb86767f9c86896670b207d832b0b865a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 0f126e77f30b55b0a9c20429c209fdc86a4b800b2fa63c857c3a13fb8585869c [INFO] running `Command { std: "docker" "start" "-a" "0f126e77f30b55b0a9c20429c209fdc86a4b800b2fa63c857c3a13fb8585869c", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling proc-macro2 v1.0.30 [INFO] [stderr] Compiling syn v1.0.80 [INFO] [stderr] Compiling anyhow v1.0.44 [INFO] [stderr] Compiling paste v1.0.5 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling approx v0.5.0 [INFO] [stderr] Compiling derive-new v0.5.9 [INFO] [stderr] Compiling raytracer v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4m 57s [INFO] running `Command { std: "docker" "inspect" "0f126e77f30b55b0a9c20429c209fdc86a4b800b2fa63c857c3a13fb8585869c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0f126e77f30b55b0a9c20429c209fdc86a4b800b2fa63c857c3a13fb8585869c", kill_on_drop: false }` [INFO] [stdout] 0f126e77f30b55b0a9c20429c209fdc86a4b800b2fa63c857c3a13fb8585869c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 2de86598068221b41ee24deb506fd5ac03a2bb6126a3fccadffe689e586c5029 [INFO] running `Command { std: "docker" "start" "-a" "2de86598068221b41ee24deb506fd5ac03a2bb6126a3fccadffe689e586c5029", kill_on_drop: false }` [INFO] [stderr] Compiling raytracer v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.96s [INFO] running `Command { std: "docker" "inspect" "2de86598068221b41ee24deb506fd5ac03a2bb6126a3fccadffe689e586c5029", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2de86598068221b41ee24deb506fd5ac03a2bb6126a3fccadffe689e586c5029", kill_on_drop: false }` [INFO] [stdout] 2de86598068221b41ee24deb506fd5ac03a2bb6126a3fccadffe689e586c5029 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 52512512b15270ae5795081aaf3f5417a4b57e5676dca795f1aeb486e4f9de33 [INFO] running `Command { std: "docker" "start" "-a" "52512512b15270ae5795081aaf3f5417a4b57e5676dca795f1aeb486e4f9de33", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 12.58s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/raytracer-ded9b9e1271ebc33) [INFO] [stdout] [INFO] [stdout] running 79 tests [INFO] [stdout] test canvas::tests::new ... ok [INFO] [stdout] test canvas::tests::to_ppm ... ok [INFO] [stdout] test colour::tests::add ... ok [INFO] [stdout] test colour::tests::add_assign ... ok [INFO] [stdout] test colour::tests::black ... ok [INFO] [stdout] test colour::tests::green ... ok [INFO] [stdout] test colour::tests::mul_assign ... ok [INFO] [stdout] test colour::tests::blue ... ok [INFO] [stdout] test colour::tests::mul ... ok [INFO] [stdout] test colour::tests::to_rgb ... ok [INFO] [stdout] test canvas::tests::write_pixel ... ok [INFO] [stdout] test colour::tests::sub ... ok [INFO] [stdout] test colour::tests::white ... ok [INFO] [stdout] test colour::tests::approx ... ok [INFO] [stdout] test intersect::tests::hit ... ok [INFO] [stdout] test colour::tests::new ... ok [INFO] [stdout] test colour::tests::red ... ok [INFO] [stdout] test material::tests::approx ... ok [INFO] [stdout] test material::tests::default ... ok [INFO] [stdout] test intersect::tests::intersection_new ... ok [INFO] [stdout] test material::tests::lighting ... ok [INFO] [stdout] test colour::tests::sub_assign ... ok [INFO] [stdout] test intersect::tests::intersection_list_new ... ok [INFO] [stdout] test material::tests::new ... ok [INFO] [stdout] test math::matrix::tests::cofactor ... ok [INFO] [stdout] test math::matrix::tests::chaining_transforms ... ok [INFO] [stdout] test math::matrix::tests::identity ... ok [INFO] [stdout] test math::matrix::tests::determinant ... ok [INFO] [stdout] test math::matrix::tests::approx ... ok [INFO] [stdout] test math::matrix::tests::minor ... ok [INFO] [stdout] test math::matrix::tests::new ... ok [INFO] [stdout] test math::matrix::tests::mul_assign ... ok [INFO] [stdout] test math::matrix::tests::rotate_x ... ok [INFO] [stdout] test math::matrix::tests::rotate_z ... ok [INFO] [stdout] test math::matrix::tests::mul ... ok [INFO] [stdout] test math::matrix::tests::rotate_y ... ok [INFO] [stdout] test math::matrix::tests::shear ... ok [INFO] [stdout] test math::matrix::tests::scale ... ok [INFO] [stdout] test math::matrix::tests::sub_matrix ... ok [INFO] [stdout] test math::matrix::tests::translate ... ok [INFO] [stdout] test math::matrix::tests::invert ... ok [INFO] [stdout] test math::point::tests::approx ... ok [INFO] [stdout] test math::point::tests::new ... ok [INFO] [stdout] test math::point::tests::add_assign ... ok [INFO] [stdout] test math::point::tests::origin ... ok [INFO] [stdout] test math::ray::tests::approx ... ok [INFO] [stdout] test math::matrix::tests::transpose ... ok [INFO] [stdout] test math::point::tests::sub_assign ... ok [INFO] [stdout] test math::ray::tests::new ... ok [INFO] [stdout] test math::point::tests::sub ... ok [INFO] [stdout] test math::ray::tests::position ... ok [INFO] [stdout] test math::point::tests::add ... ok [INFO] [stdout] test math::ray::tests::transform ... ok [INFO] [stdout] test math::vector::tests::cross ... ok [INFO] [stdout] test math::vector::tests::add ... ok [INFO] [stdout] test math::vector::tests::add_assign ... ok [INFO] [stdout] test math::vector::tests::mul_assign ... ok [INFO] [stdout] test math::vector::tests::neg ... ok [INFO] [stdout] test math::vector::tests::new ... ok [INFO] [stdout] test math::vector::tests::normalise ... ok [INFO] [stdout] test math::vector::tests::sub ... ok [INFO] [stdout] test math::vector::tests::sub_assign ... ok [INFO] [stdout] test math::vector::tests::mul ... ok [INFO] [stdout] test math::vector::tests::div ... ok [INFO] [stdout] test math::vector::tests::x_axis ... ok [INFO] [stdout] test math::vector::tests::y_axis ... ok [INFO] [stdout] test math::vector::tests::z_axis ... ok [INFO] [stdout] test point_light::tests::new ... ok [INFO] [stdout] test sphere::tests::intersect ... ok [INFO] [stdout] test point_light::tests::approx ... ok [INFO] [stdout] test sphere::tests::new ... ok [INFO] [stdout] test sphere::tests::normal_at ... ok [INFO] [stdout] test math::vector::tests::approx ... ok [INFO] [stdout] test math::vector::tests::div_assign ... ok [INFO] [stdout] test math::vector::tests::reflect ... ok [INFO] [stdout] test sphere::tests::approx ... ok [INFO] [stdout] test sphere::tests::default ... ok [INFO] [stdout] test math::vector::tests::magnitude ... ok [INFO] [stdout] test math::vector::tests::dot ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/raytracer-e05f7ec4bb0754e2) [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 raytracer [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" "52512512b15270ae5795081aaf3f5417a4b57e5676dca795f1aeb486e4f9de33", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "52512512b15270ae5795081aaf3f5417a4b57e5676dca795f1aeb486e4f9de33", kill_on_drop: false }` [INFO] [stdout] 52512512b15270ae5795081aaf3f5417a4b57e5676dca795f1aeb486e4f9de33