[INFO] cloning repository https://github.com/stesel/math_3d_rust
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/stesel/math_3d_rust" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstesel%2Fmath_3d_rust", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstesel%2Fmath_3d_rust'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] cc71c1dc20a16d7838bc117295f7c448676a2897
[INFO] testing stesel/math_3d_rust against try#d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2 for pr-86479
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fstesel%2Fmath_3d_rust" "/workspace/builds/worker-31/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-31/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/stesel/math_3d_rust on toolchain d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/stesel/math_3d_rust
[INFO] finished tweaking git repo https://github.com/stesel/math_3d_rust
[INFO] tweaked toml for git repo https://github.com/stesel/math_3d_rust written to /workspace/builds/worker-31/source/Cargo.toml
[INFO] crate git repo https://github.com/stesel/math_3d_rust already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded more-asserts v0.2.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cb7f2dc3b7c4bc9a334adaa27d1817820a59874cc99ae067a1ed2b76c5d9c2d4
[INFO] running `Command { std: "docker" "start" "-a" "cb7f2dc3b7c4bc9a334adaa27d1817820a59874cc99ae067a1ed2b76c5d9c2d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cb7f2dc3b7c4bc9a334adaa27d1817820a59874cc99ae067a1ed2b76c5d9c2d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb7f2dc3b7c4bc9a334adaa27d1817820a59874cc99ae067a1ed2b76c5d9c2d4", kill_on_drop: false }`
[INFO] [stdout] cb7f2dc3b7c4bc9a334adaa27d1817820a59874cc99ae067a1ed2b76c5d9c2d4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] db7e760eea86fc6489c362e9464ebbfa1aae8b249cee0e93c659d525f1ba2b45
[INFO] running `Command { std: "docker" "start" "-a" "db7e760eea86fc6489c362e9464ebbfa1aae8b249cee0e93c659d525f1ba2b45", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling math_3d_rust v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.96s
[INFO] running `Command { std: "docker" "inspect" "db7e760eea86fc6489c362e9464ebbfa1aae8b249cee0e93c659d525f1ba2b45", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "db7e760eea86fc6489c362e9464ebbfa1aae8b249cee0e93c659d525f1ba2b45", kill_on_drop: false }`
[INFO] [stdout] db7e760eea86fc6489c362e9464ebbfa1aae8b249cee0e93c659d525f1ba2b45
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d789b499f653db4d5289b4e85c6ff4a44e15a82871248e45e0817448f999dd31
[INFO] running `Command { std: "docker" "start" "-a" "d789b499f653db4d5289b4e85c6ff4a44e15a82871248e45e0817448f999dd31", kill_on_drop: false }`
[INFO] [stderr]    Compiling more-asserts v0.2.1
[INFO] [stderr]    Compiling math_3d_rust v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.55s
[INFO] running `Command { std: "docker" "inspect" "d789b499f653db4d5289b4e85c6ff4a44e15a82871248e45e0817448f999dd31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d789b499f653db4d5289b4e85c6ff4a44e15a82871248e45e0817448f999dd31", kill_on_drop: false }`
[INFO] [stdout] d789b499f653db4d5289b4e85c6ff4a44e15a82871248e45e0817448f999dd31
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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" "+d2e9fff28e244f1ea4927194f1f9b77f93e2ffe2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bc493747146b41c8012f1a05f5a9e74ebaa5e5b03aa294bd7a3961962fccf743
[INFO] running `Command { std: "docker" "start" "-a" "bc493747146b41c8012f1a05f5a9e74ebaa5e5b03aa294bd7a3961962fccf743", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.32s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/math_3d_rust-6f2ca6b0144a999e)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/matrix.rs (/opt/rustwide/target/debug/deps/matrix-42298c0afe158cdb)
[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 13 tests
[INFO] [stdout] test matrix::should_calcualte_cofactor_for_3x3_matrix ... ok
[INFO] [stdout] test matrix::should_calculate_minor_for_3x3_matrix ... ok
[INFO] [stdout] test matrix::should_calculate_inverse_of_the_identity_matrix ... ok
[INFO] [stdout] test matrix::should_create_identity_vector ... ok
[INFO] [stdout] test matrix::should_create_submatrix_from_3x3 ... ok
[INFO] [stdout] test matrix::should_create_submatrix_from_4x4 ... ok
[INFO] [stdout] test matrix::should_create_vector ... ok
[INFO] [stdout] test matrix::should_multiply_identity_matrix_by_vector ... ok
[INFO] [stdout] test matrix::should_calculate_inverse_of_the_matrix ... ok
[INFO] [stdout] test matrix::should_multiply_matrix_by_identity_matrix ... ok
[INFO] [stdout] test matrix::should_multiply_matrix_by_vector ... ok
[INFO] [stdout] test matrix::should_multiply_two_4x4_matrices ... ok
[INFO] [stdout] test matrix::should_multiply_matrix_with_inverse ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/scalar.rs (/opt/rustwide/target/debug/deps/scalar-8122e6f6d17e079d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test scalar::should_round_float_number_to_digits_after_comma ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/vector.rs (/opt/rustwide/target/debug/deps/vector-6ea3c3b28f38ef84)
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stderr]    Doc-tests math_3d_rust
[INFO] [stdout] test vector_4::should_add_two_vectors ... ok
[INFO] [stdout] test vector_4::should_calculate_cross_product_1 ... ok
[INFO] [stdout] test vector_4::should_calculate_cross_product_2 ... ok
[INFO] [stdout] test vector_4::should_calculate_vector_magnitude_1 ... ok
[INFO] [stdout] test vector_4::should_calculate_vector_magnitude_2 ... ok
[INFO] [stdout] test vector_4::should_calculate_vector_magnitude_3 ... ok
[INFO] [stdout] test vector_4::should_calculate_vector_magnitude_4 ... ok
[INFO] [stdout] test vector_4::should_calculate_vector_magnitude_5 ... ok
[INFO] [stdout] test vector_4::should_create_vector ... ok
[INFO] [stdout] test vector_4::should_divide_vector_by_scalar ... ok
[INFO] [stdout] test vector_4::should_have_0_dot_value ... ok
[INFO] [stdout] test vector_4::should_have_negative_dot_value ... ok
[INFO] [stdout] test vector_4::should_have_positive_dot_value ... ok
[INFO] [stdout] test vector_4::should_magnitude_of_normalized_vector_1 ... ok
[INFO] [stdout] test vector_4::should_multiply_vector_by_scalar ... ok
[INFO] [stdout] test vector_4::should_multiply_vector_by_vector ... ok
[INFO] [stdout] test vector_4::should_negate_vector ... ok
[INFO] [stdout] test vector_4::should_normalize_vector ... ok
[INFO] [stdout] test vector_4::should_subtract_two_vectors ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[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" "bc493747146b41c8012f1a05f5a9e74ebaa5e5b03aa294bd7a3961962fccf743", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bc493747146b41c8012f1a05f5a9e74ebaa5e5b03aa294bd7a3961962fccf743", kill_on_drop: false }`
[INFO] [stdout] bc493747146b41c8012f1a05f5a9e74ebaa5e5b03aa294bd7a3961962fccf743