[INFO] fetching crate vectormatrix 0.1.2...
[INFO] testing vectormatrix-0.1.2 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate vectormatrix 0.1.2 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate vectormatrix 0.1.2
[INFO] finished tweaking crates.io crate vectormatrix 0.1.2
[INFO] tweaked toml for crates.io crate vectormatrix 0.1.2 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate vectormatrix 0.1.2 on toolchain caccb4d0368bd918ef6668af8e13834d07040417
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate vectormatrix 0.1.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 57377d5bc09cd5d4ba0dd86447f43be0376a0c34d37965c6829988f280472875
[INFO] running `Command { std: "docker" "start" "-a" "57377d5bc09cd5d4ba0dd86447f43be0376a0c34d37965c6829988f280472875", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "57377d5bc09cd5d4ba0dd86447f43be0376a0c34d37965c6829988f280472875", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "57377d5bc09cd5d4ba0dd86447f43be0376a0c34d37965c6829988f280472875", kill_on_drop: false }`
[INFO] [stdout] 57377d5bc09cd5d4ba0dd86447f43be0376a0c34d37965c6829988f280472875
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1a0fe600e047743eebccde50603e434910e9e53d99fa52827103c6e9c93a2ed7
[INFO] running `Command { std: "docker" "start" "-a" "1a0fe600e047743eebccde50603e434910e9e53d99fa52827103c6e9c93a2ed7", kill_on_drop: false }`
[INFO] [stderr]    Compiling vectormatrix v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.46s
[INFO] running `Command { std: "docker" "inspect" "1a0fe600e047743eebccde50603e434910e9e53d99fa52827103c6e9c93a2ed7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a0fe600e047743eebccde50603e434910e9e53d99fa52827103c6e9c93a2ed7", kill_on_drop: false }`
[INFO] [stdout] 1a0fe600e047743eebccde50603e434910e9e53d99fa52827103c6e9c93a2ed7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a417978fe3f8d99426b0465a09d6e057897a6bd0ae7fe0fbe93c27ad9b280984
[INFO] running `Command { std: "docker" "start" "-a" "a417978fe3f8d99426b0465a09d6e057897a6bd0ae7fe0fbe93c27ad9b280984", kill_on_drop: false }`
[INFO] [stderr]    Compiling vectormatrix v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.82s
[INFO] running `Command { std: "docker" "inspect" "a417978fe3f8d99426b0465a09d6e057897a6bd0ae7fe0fbe93c27ad9b280984", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a417978fe3f8d99426b0465a09d6e057897a6bd0ae7fe0fbe93c27ad9b280984", kill_on_drop: false }`
[INFO] [stdout] a417978fe3f8d99426b0465a09d6e057897a6bd0ae7fe0fbe93c27ad9b280984
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7db7cb80a6a57f0ae8ce30efa894ce481aa3be29c10ee02ef054a6990a664f39
[INFO] running `Command { std: "docker" "start" "-a" "7db7cb80a6a57f0ae8ce30efa894ce481aa3be29c10ee02ef054a6990a664f39", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/vectormatrix-69e70171e4070519)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test matrix::m3x3::tests::inverse ... ok
[INFO] [stdout] test matrix::tests::map ... ok
[INFO] [stdout] test matrix::m3x3::tests::test_determinant ... ok
[INFO] [stdout] test matrix::tests::test_elementwise ... ok
[INFO] [stdout] test matrix::tests::test_from_array ... ok
[INFO] [stdout] test matrix::m4x4::tests::inverse ... ok
[INFO] [stdout] test matrix::tests::test_debug ... ok
[INFO] [stdout] test matrix::m2x2::tests::inverse ... ok
[INFO] [stdout] test matrix::m2x2::tests::determinant ... ok
[INFO] [stdout] test matrix::tests::rows_cols ... ok
[INFO] [stdout] test matrix::tests::test ... ok
[INFO] [stdout] test vector::tests::elementwise ... ok
[INFO] [stdout] test matrix::m4x4::tests::determinant ... ok
[INFO] [stdout] test vector::tests::eq_approx ... ok
[INFO] [stdout] test vector::tests::map ... ok
[INFO] [stdout] test vector::tests::scalar_assign ... ok
[INFO] [stdout] test vector::tests::test_clamp ... ok
[INFO] [stdout] test vector::tests::test_convert ... ok
[INFO] [stdout] test vector::tests::test_cross ... ok
[INFO] [stdout] test vector::tests::test_mix ... ok
[INFO] [stdout] test vector::tests::test_dot ... ok
[INFO] [stdout] test vector::tests::euclid_distance ... ok
[INFO] [stdout] test vector::tests::normalize ... ok
[INFO] [stdout] test vector::tests::scalar ... ok
[INFO] [stdout] test vector::tests::elementwise_assign ... ok
[INFO] [stdout] test vector::tests::length ... ok
[INFO] [stdout] test matrix::tests::test_mul ... ok
[INFO] [stdout] test vector::tests::min_max ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests vectormatrix
[INFO] [stdout] 
[INFO] [stdout] running 69 tests
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::ONE (line 512) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::elementwise_sub (line 397) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::elementwise_add (line 341) ... ok
[INFO] [stdout] test src/matrix.rs - matrix (line 21) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::eq_approx (line 1031) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix (line 83) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::element_at (line 1126) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::new_from_array (line 200) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::columns_mut (line 1093) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::div_scalar (line 832) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::map (line 957) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::columns (line 1069) ... ok
[INFO] [stdout] test src/vector.rs - vector (line 19) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::sub_scalar (line 774) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::new_rows (line 164) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::add_scalar (line 745) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::map_in_place (line 993) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::element_at_mut (line 1155) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<MaybeUninit<T>,R,C>::assume_init (line 300) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::ZERO (line 489) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::new_columns (line 133) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::mul_scalar (line 803) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::rows (line 1185) ... ok
[INFO] [stdout] test src/vector.rs - vector::NormalizedVector<T,N>::as_vector (line 182) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector (line 52) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::ONE (line 121) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,R,C>::transpose (line 243) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,M,N>::mul_matrix (line 1245) ... ok
[INFO] [stdout] test src/vector.rs - vector::NormalizedVector (line 143) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::clamp (line 1138) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::div_scalar (line 664) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,3>::cross (line 923) ... ok
[INFO] [stdout] test src/vector.rs - vector::NormalizedVector<T,N>::into_vector (line 163) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::elementwise_mul (line 435) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::dot (line 1110) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::eq_approx (line 1033) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::from_row (line 1240) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::from_col (line 1257) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::euclid_distance_to (line 834) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::elementwise_div (line 470) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::into_inner (line 92) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::max (line 1061) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::add_assign_scalar (line 690) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::ZERO (line 109) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::elementwise_sub (line 404) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::length (line 805) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::mul_scalar (line 630) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::add_scalar (line 578) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::add_elementwise_assign (line 501) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::min (line 1082) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::mul_assign_scalar (line 733) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::normalize (line 871) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::mix (line 1179) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::map_in_place (line 1001) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::x_mut (line 242) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::new (line 78) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::x (line 227) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::sub_scalar (line 604) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::map (line 966) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::w_mut (line 349) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::z_mut (line 313) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::to_row (line 1224) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::w (line 334) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::to_col (line 1274) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::elementwise_add (line 369) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::y_mut (line 277) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::z (line 298) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::y (line 262) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::length_squared (line 782) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 69 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7db7cb80a6a57f0ae8ce30efa894ce481aa3be29c10ee02ef054a6990a664f39", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7db7cb80a6a57f0ae8ce30efa894ce481aa3be29c10ee02ef054a6990a664f39", kill_on_drop: false }`
[INFO] [stdout] 7db7cb80a6a57f0ae8ce30efa894ce481aa3be29c10ee02ef054a6990a664f39