[INFO] cloning repository https://github.com/strohs/raytracer
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/strohs/raytracer" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstrohs%2Fraytracer", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstrohs%2Fraytracer'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 609a82ad280f60c40300efa7ffb13ab8c78c50f1
[INFO] testing strohs/raytracer against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstrohs%2Fraytracer" "/workspace/builds/worker-52/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-52/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/strohs/raytracer on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/strohs/raytracer
[INFO] finished tweaking git repo https://github.com/strohs/raytracer
[INFO] tweaked toml for git repo https://github.com/strohs/raytracer written to /workspace/builds/worker-52/source/Cargo.toml
[INFO] crate git repo https://github.com/strohs/raytracer already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded image v0.23.4
[INFO] [stderr]   Downloaded png v0.16.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5770aad85d5a4a50320652b6c0c1a352bd3d28abd1fcb3c09dad01bf9a3665b9
[INFO] running `Command { std: "docker" "start" "-a" "5770aad85d5a4a50320652b6c0c1a352bd3d28abd1fcb3c09dad01bf9a3665b9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5770aad85d5a4a50320652b6c0c1a352bd3d28abd1fcb3c09dad01bf9a3665b9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5770aad85d5a4a50320652b6c0c1a352bd3d28abd1fcb3c09dad01bf9a3665b9", kill_on_drop: false }`
[INFO] [stdout] 5770aad85d5a4a50320652b6c0c1a352bd3d28abd1fcb3c09dad01bf9a3665b9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b6d33bcc9a25b849b6a3a6260da5cc0b182178b91592196787fe33383fe4d3a8
[INFO] running `Command { std: "docker" "start" "-a" "b6d33bcc9a25b849b6a3a6260da5cc0b182178b91592196787fe33383fe4d3a8", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling autocfg v1.0.0
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling libc v0.2.70
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling byteorder v1.3.4
[INFO] [stderr]    Compiling adler32 v1.0.4
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling rayon-core v1.7.0
[INFO] [stderr]    Compiling crc32fast v1.2.0
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling either v1.5.3
[INFO] [stderr]    Compiling lzw v0.10.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.6
[INFO] [stderr]    Compiling color_quant v1.0.1
[INFO] [stderr]    Compiling scoped_threadpool v0.1.9
[INFO] [stderr]    Compiling bytemuck v1.2.0
[INFO] [stderr]    Compiling miniz_oxide v0.3.6
[INFO] [stderr]    Compiling inflate v0.4.5
[INFO] [stderr]    Compiling gif v0.10.3
[INFO] [stderr]    Compiling crossbeam-utils v0.7.2
[INFO] [stderr]    Compiling memoffset v0.5.4
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling num-traits v0.2.11
[INFO] [stderr]    Compiling num-integer v0.1.42
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.40
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling deflate v0.8.4
[INFO] [stderr]    Compiling tiff v0.4.0
[INFO] [stderr]    Compiling threadpool v1.8.1
[INFO] [stderr]    Compiling crossbeam-queue v0.2.2
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling png v0.16.3
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling rayon v1.3.0
[INFO] [stderr]    Compiling jpeg-decoder v0.1.19
[INFO] [stderr]    Compiling image v0.23.4
[INFO] [stderr]    Compiling raytracer v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 11s
[INFO] running `Command { std: "docker" "inspect" "b6d33bcc9a25b849b6a3a6260da5cc0b182178b91592196787fe33383fe4d3a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b6d33bcc9a25b849b6a3a6260da5cc0b182178b91592196787fe33383fe4d3a8", kill_on_drop: false }`
[INFO] [stdout] b6d33bcc9a25b849b6a3a6260da5cc0b182178b91592196787fe33383fe4d3a8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 88db921dfae58c05f50fd486da1d6d0febf295c8ae44bc530e7e920a43aae08d
[INFO] running `Command { std: "docker" "start" "-a" "88db921dfae58c05f50fd486da1d6d0febf295c8ae44bc530e7e920a43aae08d", 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 42.76s
[INFO] running `Command { std: "docker" "inspect" "88db921dfae58c05f50fd486da1d6d0febf295c8ae44bc530e7e920a43aae08d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "88db921dfae58c05f50fd486da1d6d0febf295c8ae44bc530e7e920a43aae08d", kill_on_drop: false }`
[INFO] [stdout] 88db921dfae58c05f50fd486da1d6d0febf295c8ae44bc530e7e920a43aae08d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-52/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" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bfaffc4fdff8a1973562ce29628a6ce5b79753920f05f9f02beeb08e5f6fdb0e
[INFO] running `Command { std: "docker" "start" "-a" "bfaffc4fdff8a1973562ce29628a6ce5b79753920f05f9f02beeb08e5f6fdb0e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/raytracer-5f13939621df2109)
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test common::ray::tests::ray_at ... ok
[INFO] [stdout] test common::ray::tests::ray_default ... ok
[INFO] [stdout] test common::ray::tests::ray_direction ... ok
[INFO] [stdout] test common::ray::tests::ray_origin ... ok
[INFO] [stdout] test common::vec3::tests::add_assign_two_vec3s ... ok
[INFO] [stdout] test common::vec3::tests::add_two_vec3s ... ok
[INFO] [stdout] test common::vec3::tests::cross_product ... ok
[INFO] [stdout] test common::vec3::tests::default_vec3_is_0_0 ... ok
[INFO] [stdout] test common::vec3::tests::divide_assign_vec3_by_a_scalar_f64 ... ok
[INFO] [stdout] test common::vec3::tests::divide_vec3_by_a_scalar_f64 ... ok
[INFO] [stdout] test common::vec3::tests::dot_product ... ok
[INFO] [stdout] test common::vec3::tests::index_vec3 ... ok
[INFO] [stdout] test common::vec3::tests::multiply_assign_vec3_by_a_scalar_f64 ... ok
[INFO] [stdout] test common::vec3::tests::multiply_scalar_f64_by_vec3 ... ok
[INFO] [stdout] test common::vec3::tests::multiply_vec3_by_another_vec3 ... ok
[INFO] [stdout] test common::vec3::tests::multiply_vec3_by_scalar_f64 ... ok
[INFO] [stdout] test common::vec3::tests::negate_vec3 ... ok
[INFO] [stdout] test common::vec3::tests::subtract_two_vec3s ... ok
[INFO] [stdout] test common::vec3::tests::vec3_length ... ok
[INFO] [stdout] test common::vec3::tests::vec3_length_squared ... ok
[INFO] [stdout] test hittable::bvh_node::tests::box_compare_sphere1_x_axis_lt_sphere2 ... ok
[INFO] [stdout] test hittable::bvh_node::tests::box_compare_sphere1_xaxis_gt_sphere2 ... ok
[INFO] [stdout] test hittable::bvh_node::tests::box_compare_sphere1_y_axis_lt_sphere2 ... ok
[INFO] [stdout] test hittable::bvh_node::tests::box_compare_sphere1_z_axis_lt_sphere2 ... ok
[INFO] [stdout] test hittable::hittable_list::tests::should_return_a_surrounding_bounding_box_with_min0_max3 ... ok
[INFO] [stdout] test hittable::bvh_node::tests::box_compare_sphere1_xaxis_to_sphere2_should_be_eq ... ok
[INFO] [stdout] test hittable::primitive::sphere::tests::has_a_bounding_box_of_min_0_and_max_2 ... ok
[INFO] [stdout] test hittable::primitive::sphere::tests::should_print_debug ... ok
[INFO] [stdout] test hittable::rotate::tests::rotate_about_y_90_degrees ... ok
[INFO] [stdout] test texture::image_texture::tests::has_default_impl ... ok
[INFO] [stdout] test texture::perlin::tests::create_a_default_perlin ... ok
[INFO] [stdout] test util::command::tests::samples_per_pixel_defaults_to_500 ... ok
[INFO] [stdout] test util::command::tests::invalid_cornell_box_scene_number ... ok
[INFO] [stdout] test util::command::tests::samples_per_pixel_set_to_10000 ... ok
[INFO] [stdout] test util::command::tests::scene_defaults_to_final_scene ... ok
[INFO] [stdout] test util::command::tests::valid_cornell_box_scene_number ... ok
[INFO] [stdout] test texture::perlin::tests::generate_a_new_perlin ... ok
[INFO] [stdout] test common::vec3::tests::out_of_bounds_index_vec3_panics - should panic ... ok
[INFO] [stdout] test texture::image_texture::tests::load_an_image ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.52s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/raytracer-22b430257b5a1067)
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests raytracer
[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 6 tests
[INFO] [stdout] test src/common/vec3.rs - common::vec3::Vec3::mul (line 263) ... ok
[INFO] [stdout] test src/common/vec3.rs - common::vec3::f64::mul (line 287) ... ok
[INFO] [stdout] test src/common/vec3.rs - common::vec3::Vec3::sub (line 202) ... ok
[INFO] [stdout] test src/common/vec3.rs - common::vec3::Vec3::add (line 177) ... ok
[INFO] [stdout] test src/common/vec3.rs - common::vec3::Vec3::mul (line 238) ... ok
[INFO] [stdout] test src/common/vec3.rs - common::vec3::Vec3::neg (line 153) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.41s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "bfaffc4fdff8a1973562ce29628a6ce5b79753920f05f9f02beeb08e5f6fdb0e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bfaffc4fdff8a1973562ce29628a6ce5b79753920f05f9f02beeb08e5f6fdb0e", kill_on_drop: false }`
[INFO] [stdout] bfaffc4fdff8a1973562ce29628a6ce5b79753920f05f9f02beeb08e5f6fdb0e