[INFO] fetching crate matriarch 0.1.0...
[INFO] testing matriarch-0.1.0 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate matriarch 0.1.0 into /workspace/builds/worker-12/source
[INFO] validating manifest of crates.io crate matriarch 0.1.0 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate matriarch 0.1.0
[INFO] finished tweaking crates.io crate matriarch 0.1.0
[INFO] tweaked toml for crates.io crate matriarch 0.1.0 written to /workspace/builds/worker-12/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 21304269eaebdf19241826e62368558ef05d7b53bc2619506e06801ac072cf62
[INFO] running `Command { std: "docker" "start" "-a" "21304269eaebdf19241826e62368558ef05d7b53bc2619506e06801ac072cf62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "21304269eaebdf19241826e62368558ef05d7b53bc2619506e06801ac072cf62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21304269eaebdf19241826e62368558ef05d7b53bc2619506e06801ac072cf62", kill_on_drop: false }`
[INFO] [stdout] 21304269eaebdf19241826e62368558ef05d7b53bc2619506e06801ac072cf62
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 81d7440d1fb5e894ad7595cc3cd7ddb3e49b4ac4539ca2aff594ce1e2c952a5c
[INFO] running `Command { std: "docker" "start" "-a" "81d7440d1fb5e894ad7595cc3cd7ddb3e49b4ac4539ca2aff594ce1e2c952a5c", kill_on_drop: false }`
[INFO] [stderr]    Compiling matriarch v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.36s
[INFO] running `Command { std: "docker" "inspect" "81d7440d1fb5e894ad7595cc3cd7ddb3e49b4ac4539ca2aff594ce1e2c952a5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "81d7440d1fb5e894ad7595cc3cd7ddb3e49b4ac4539ca2aff594ce1e2c952a5c", kill_on_drop: false }`
[INFO] [stdout] 81d7440d1fb5e894ad7595cc3cd7ddb3e49b4ac4539ca2aff594ce1e2c952a5c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f8a532795f8df2d3ab11cc2d54506e4638ad57b55487a6fa5a57fc40494d3581
[INFO] running `Command { std: "docker" "start" "-a" "f8a532795f8df2d3ab11cc2d54506e4638ad57b55487a6fa5a57fc40494d3581", kill_on_drop: false }`
[INFO] [stderr]    Compiling matriarch v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.19s
[INFO] running `Command { std: "docker" "inspect" "f8a532795f8df2d3ab11cc2d54506e4638ad57b55487a6fa5a57fc40494d3581", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f8a532795f8df2d3ab11cc2d54506e4638ad57b55487a6fa5a57fc40494d3581", kill_on_drop: false }`
[INFO] [stdout] f8a532795f8df2d3ab11cc2d54506e4638ad57b55487a6fa5a57fc40494d3581
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d6c73d8b652983518f92d13ac89c5fa6cc2a18b6495e125aafe30872fabd5b32
[INFO] running `Command { std: "docker" "start" "-a" "d6c73d8b652983518f92d13ac89c5fa6cc2a18b6495e125aafe30872fabd5b32", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stdout] running 77 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/matriarch-f05faf90a483a400)
[INFO] [stdout] test mat2::tests::create_new_mat2_identity ... ok
[INFO] [stdout] test mat2::tests::get_determinant_of_mat2 ... ok
[INFO] [stdout] test mat2::tests::mat2_multiplication ... ok
[INFO] [stdout] test mat2::tests::get_determinant_equal_to_zero ... ok
[INFO] [stdout] test mat2::tests::mat2_to_vec2_array ... ok
[INFO] [stdout] test mat2::tests::mat2_to_col_array ... ok
[INFO] [stdout] test mat2::tests::multiply_by_identity ... ok
[INFO] [stdout] test mat3::tests::create_new_mat3 ... ok
[INFO] [stdout] test mat2::tests::multiply_mat2_by_vec2 ... ok
[INFO] [stdout] test mat3::tests::create_new_mat3_from_array ... ok
[INFO] [stdout] test mat3::tests::create_new_mat3_from_col_array ... ok
[INFO] [stdout] test mat3::tests::create_new_mat3_identity ... ok
[INFO] [stdout] test mat3::tests::get_determinant_equal_to_zero ... ok
[INFO] [stdout] test mat3::tests::get_determinant_of_mat3 ... ok
[INFO] [stdout] test mat3::tests::mat3_multiplication ... ok
[INFO] [stdout] test mat3::tests::mat3_scalar_multiplication ... ok
[INFO] [stdout] test mat3::tests::mat3_to_array ... ok
[INFO] [stdout] test mat3::tests::mat3_to_col_array ... ok
[INFO] [stdout] test mat3::tests::mat3_to_vec3_array ... ok
[INFO] [stdout] test mat3::tests::multiply_by_identity ... ok
[INFO] [stdout] test mat3::tests::multiply_mat3_by_vec3 ... ok
[INFO] [stdout] test mat2::tests::create_new_mat2 ... ok
[INFO] [stdout] test mat2::tests::mat2_scalar_multiplication ... ok
[INFO] [stdout] test mat2::tests::mat2_to_array ... ok
[INFO] [stdout] test mat2::tests::create_new_mat2_from_array ... ok
[INFO] [stdout] test mat4::tests::create_new_mat4_from_array ... ok
[INFO] [stdout] test mat4::tests::create_new_mat4 ... ok
[INFO] [stdout] test mat2::tests::create_new_mat2_from_values ... ok
[INFO] [stdout] test mat2::tests::create_new_mat2_from_col_array ... ok
[INFO] [stdout] test mat4::tests::get_determinant_of_mat4 ... ok
[INFO] [stdout] test mat4::tests::mat4_to_array ... ok
[INFO] [stdout] test mat4::tests::mat4_to_col_array ... ok
[INFO] [stdout] test mat4::tests::mat4_to_vec4_array ... ok
[INFO] [stdout] test mat4::tests::create_new_mat4_identity ... ok
[INFO] [stdout] test mat4::tests::multiply_by_identity ... ok
[INFO] [stdout] test mat4::tests::multiply_mat4_by_vec4 ... ok
[INFO] [stdout] test vec2::tests::create_new_vec2 ... ok
[INFO] [stdout] test vec2::tests::create_new_vec2_from_array ... ok
[INFO] [stdout] test vec2::tests::create_new_vec2_from_values ... ok
[INFO] [stdout] test vec2::tests::get_a_negative_vec2 ... ok
[INFO] [stdout] test vec2::tests::get_cross_product ... ok
[INFO] [stdout] test vec2::tests::get_dot_product ... ok
[INFO] [stdout] test vec2::tests::get_vec2_as_array ... ok
[INFO] [stdout] test vec2::tests::get_vec2_length ... ok
[INFO] [stdout] test vec2::tests::multiply_a_vec2_by_a_scalar ... ok
[INFO] [stdout] test vec2::tests::subtract_2_vec2s ... ok
[INFO] [stdout] test mat4::tests::mat4_multiplication ... ok
[INFO] [stdout] test mat4::tests::get_determinant_equal_to_zero ... ok
[INFO] [stdout] test vec3::tests::create_new_vec3_from_array ... ok
[INFO] [stdout] test mat4::tests::mat4_scalar_multiplication ... ok
[INFO] [stdout] test vec3::tests::create_new_vec3_from_values ... ok
[INFO] [stderr]    Doc-tests matriarch
[INFO] [stdout] test vec3::tests::create_new_vec3 ... ok
[INFO] [stdout] test vec2::tests::subtract_assign_2_vec2s ... ok
[INFO] [stdout] test mat4::tests::create_new_mat4_from_col_array ... ok
[INFO] [stdout] test vec2::tests::add_assign_2_vec2s ... ok
[INFO] [stdout] test vec3::tests::add_2_vec3s_together ... ok
[INFO] [stdout] test vec3::tests::subtract_assign_2_vec3s ... ok
[INFO] [stdout] test vec4::tests::get_a_negative_vec4 ... ok
[INFO] [stdout] test vec4::tests::get_vec4_as_array ... ok
[INFO] [stdout] test vec4::tests::multiply_a_vec4_by_a_scalar ... ok
[INFO] [stdout] test vec4::tests::get_vec4_length ... ok
[INFO] [stdout] test vec4::tests::subtract_assign_2_vec4s ... ok
[INFO] [stdout] test vec4::tests::subtract_2_vec4s ... ok
[INFO] [stdout] test vec4::tests::get_dot_product ... ok
[INFO] [stdout] test vec3::tests::get_vec3_length ... ok
[INFO] [stdout] test vec3::tests::get_vec3_as_array ... ok
[INFO] [stdout] test vec3::tests::get_dot_product ... ok
[INFO] [stdout] test vec3::tests::get_cross_product ... ok
[INFO] [stdout] test vec3::tests::get_a_negative_vec3 ... ok
[INFO] [stdout] test vec4::tests::add_assign_2_vec4s ... ok
[INFO] [stdout] test vec3::tests::multiply_a_vec3_by_a_scalar ... ok
[INFO] [stdout] test vec4::tests::create_new_vec4_from_values ... ok
[INFO] [stdout] test vec3::tests::subtract_2_vec3s ... ok
[INFO] [stdout] test vec2::tests::add_2_vec2s_together ... ok
[INFO] [stdout] test vec3::tests::add_assign_2_vec3s ... ok
[INFO] [stdout] test vec4::tests::create_new_vec4 ... ok
[INFO] [stdout] test vec4::tests::create_new_vec4_from_array ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 77 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::to_array (line 55) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::add (line 97) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::to_array (line 56) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::new (line 17) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::sub (line 195) ... ok
[INFO] [stdout] test src/mat2.rs - mat2::f32::mul (line 141) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::new_from_values (line 29) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::add_assign (line 122) ... ok
[INFO] [stdout] test src/mat3.rs - mat3::Mat3::mul (line 112) ... ok
[INFO] [stdout] test src/mat4.rs - mat4::Mat4::mul (line 156) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::cross_product (line 71) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::sub_assign (line 205) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::sub_assign (line 214) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::mul (line 159) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::sub (line 185) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::f32::mul (line 142) ... ok
[INFO] [stdout] test src/mat2.rs - mat2::Mat2::mul (line 107) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::cross_product (line 72) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::new_from_array (line 43) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::new_from_array (line 43) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::new_from_values (line 28) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::new (line 18) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::Vec3::add_assign (line 117) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::neg (line 179) ... ok
[INFO] [stdout] test src/vec3.rs - vec3::f32::mul (line 138) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::mul (line 162) ... ok
[INFO] [stdout] test src/vec2.rs - vec2::Vec2::add (line 103) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.52s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "d6c73d8b652983518f92d13ac89c5fa6cc2a18b6495e125aafe30872fabd5b32", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d6c73d8b652983518f92d13ac89c5fa6cc2a18b6495e125aafe30872fabd5b32", kill_on_drop: false }`
[INFO] [stdout] d6c73d8b652983518f92d13ac89c5fa6cc2a18b6495e125aafe30872fabd5b32