[INFO] cloning repository https://github.com/outamaa/vekotin
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/outamaa/vekotin" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Foutamaa%2Fvekotin", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Foutamaa%2Fvekotin'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 2d1a42c7811bdbd05bb8071ea735f3a8870eb5fb
[INFO] testing outamaa/vekotin against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Foutamaa%2Fvekotin" "/workspace/builds/worker-21/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-21/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/outamaa/vekotin 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/outamaa/vekotin
[INFO] finished tweaking git repo https://github.com/outamaa/vekotin
[INFO] tweaked toml for git repo https://github.com/outamaa/vekotin written to /workspace/builds/worker-21/source/Cargo.toml
[INFO] crate git repo https://github.com/outamaa/vekotin 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]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded num-bigint v0.4.0
[INFO] [stderr]   Downloaded emscripten_main_loop v0.1.1
[INFO] [stderr]   Downloaded sdl2 v0.34.3
[INFO] [stderr]   Downloaded sdl2-sys v0.34.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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] 79746c0b1038ce5832be908ef64e220fd3bbb7c86970d4ff5bd5796cb4c38138
[INFO] running `Command { std: "docker" "start" "-a" "79746c0b1038ce5832be908ef64e220fd3bbb7c86970d4ff5bd5796cb4c38138", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "79746c0b1038ce5832be908ef64e220fd3bbb7c86970d4ff5bd5796cb4c38138", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "79746c0b1038ce5832be908ef64e220fd3bbb7c86970d4ff5bd5796cb4c38138", kill_on_drop: false }`
[INFO] [stdout] 79746c0b1038ce5832be908ef64e220fd3bbb7c86970d4ff5bd5796cb4c38138
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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] e0c4de5353b5298d571683853d0ce50895044076dd96330afcc89d6e0ab0e74f
[INFO] running `Command { std: "docker" "start" "-a" "e0c4de5353b5298d571683853d0ce50895044076dd96330afcc89d6e0ab0e74f", kill_on_drop: false }`
[INFO] [stderr]    Compiling version-compare v0.0.10
[INFO] [stderr]    Compiling anyhow v1.0.38
[INFO] [stderr]    Compiling libc v0.2.88
[INFO] [stderr]    Compiling fiddling v0.1.0 (/opt/rustwide/workdir/fiddling)
[INFO] [stderr]    Compiling sdl2 v0.34.3
[INFO] [stderr]    Compiling emscripten_main_loop v0.1.1
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling num-bigint v0.4.0
[INFO] [stderr]    Compiling num-rational v0.4.0
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling sdl2-sys v0.34.3
[INFO] [stderr]    Compiling digest v0.1.0 (/opt/rustwide/workdir/digest)
[INFO] [stderr]    Compiling compression v0.1.0 (/opt/rustwide/workdir/compression)
[INFO] [stderr]    Compiling num-complex v0.4.0
[INFO] [stderr]    Compiling num v0.4.0
[INFO] [stderr]    Compiling math v0.1.0 (/opt/rustwide/workdir/math)
[INFO] [stderr]    Compiling loader v0.1.0 (/opt/rustwide/workdir/loader)
[INFO] [stderr]    Compiling geometry v0.1.0 (/opt/rustwide/workdir/geometry)
[INFO] [stderr]    Compiling gfx v0.1.0 (/opt/rustwide/workdir/gfx)
[INFO] [stderr]    Compiling png v0.1.0 (/opt/rustwide/workdir/bin/png)
[INFO] [stderr]    Compiling obj v0.1.0 (/opt/rustwide/workdir/bin/obj)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.00s
[INFO] running `Command { std: "docker" "inspect" "e0c4de5353b5298d571683853d0ce50895044076dd96330afcc89d6e0ab0e74f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e0c4de5353b5298d571683853d0ce50895044076dd96330afcc89d6e0ab0e74f", kill_on_drop: false }`
[INFO] [stdout] e0c4de5353b5298d571683853d0ce50895044076dd96330afcc89d6e0ab0e74f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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] 6b72ea6367f44d1b22ca53e6c5da5e31d9e56c21861b253ab0f22f78025126ed
[INFO] running `Command { std: "docker" "start" "-a" "6b72ea6367f44d1b22ca53e6c5da5e31d9e56c21861b253ab0f22f78025126ed", kill_on_drop: false }`
[INFO] [stderr]    Compiling fiddling v0.1.0 (/opt/rustwide/workdir/fiddling)
[INFO] [stderr]    Compiling compression v0.1.0 (/opt/rustwide/workdir/compression)
[INFO] [stderr]    Compiling digest v0.1.0 (/opt/rustwide/workdir/digest)
[INFO] [stderr]    Compiling math v0.1.0 (/opt/rustwide/workdir/math)
[INFO] [stderr]    Compiling loader v0.1.0 (/opt/rustwide/workdir/loader)
[INFO] [stderr]    Compiling geometry v0.1.0 (/opt/rustwide/workdir/geometry)
[INFO] [stderr]    Compiling png v0.1.0 (/opt/rustwide/workdir/bin/png)
[INFO] [stderr]    Compiling gfx v0.1.0 (/opt/rustwide/workdir/gfx)
[INFO] [stderr]    Compiling obj v0.1.0 (/opt/rustwide/workdir/bin/obj)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.05s
[INFO] running `Command { std: "docker" "inspect" "6b72ea6367f44d1b22ca53e6c5da5e31d9e56c21861b253ab0f22f78025126ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6b72ea6367f44d1b22ca53e6c5da5e31d9e56c21861b253ab0f22f78025126ed", kill_on_drop: false }`
[INFO] [stdout] 6b72ea6367f44d1b22ca53e6c5da5e31d9e56c21861b253ab0f22f78025126ed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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] 716bdb74b6a8bb77fe4b6064c76b999db5af202ffa00ffad69ce1f1e430cfc46
[INFO] running `Command { std: "docker" "start" "-a" "716bdb74b6a8bb77fe4b6064c76b999db5af202ffa00ffad69ce1f1e430cfc46", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/compression-0cdf008d1eb122bc)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test deflate::huffman::tests::test_read_length ... ok
[INFO] [stdout] test deflate::huffman::tests::test_read_deflate_symbol ... ok
[INFO] [stdout] test deflate::huffman::tests::test_read_deflate_symbol_static_alphabet ... ok
[INFO] [stdout] test deflate::huffman::tests::test_read_distance ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/digest-c40cfb3dfb5cbc18)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/fiddling-a7a8ad3d50a2c0b4)
[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 1 test
[INFO] [stdout] test tests::test_multiple_reads ... 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 unittests (/opt/rustwide/target/debug/deps/geometry-e1f761895e5ea96f)
[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]      Running unittests (/opt/rustwide/target/debug/deps/gfx-67977d0cc9c438d9)
[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]      Running unittests (/opt/rustwide/target/debug/deps/loader-a499ac8ab85edcd3)
[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]      Running unittests (/opt/rustwide/target/debug/deps/math-236721c71794db51)
[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]      Running unittests (/opt/rustwide/target/debug/deps/obj-5be7ddca08f8ce4a)
[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]      Running unittests (/opt/rustwide/target/debug/deps/png-0d202f263fcef5bd)
[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 compression
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/deflate/huffman.rs - deflate::huffman::HuffmanAlphabet<S>::lookup (line 81) ... ok
[INFO] [stdout] test src/deflate/huffman.rs - deflate::huffman::HuffmanAlphabet<S>::read_next (line 114) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.31s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests digest
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/lib.rs - Adler32 (line 150) ... ok
[INFO] [stdout] test src/lib.rs - Crc32 (line 46) ... ok
[INFO] [stdout] test src/lib.rs - DigestReader (line 81) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.49s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests fiddling
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/lib.rs - n_bits_by_index (line 67) ... ok
[INFO] [stdout] test src/lib.rs - last_n_bits (line 39) ... ok
[INFO] [stdout] test src/lib.rs - reverse_bits (line 6) ... ok
[INFO] [stdout] test src/lib.rs - first_n_bits (line 23) ... ok
[INFO] [stdout] test src/lib.rs - BitStream (line 148) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.91s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests geometry
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/triangle.rs - triangle::Triangle::contains (line 112) ... ok
[INFO] [stdout] test src/triangle.rs - triangle::Triangle::signed_area_doubled (line 45) ... ok
[INFO] [stdout] test src/triangle.rs - triangle::Triangle::normal (line 25) ... ok
[INFO] [stdout] test src/triangle.rs - triangle::Triangle::barycentric_coordinates (line 73) ... ok
[INFO] [stdout] test src/triangle.rs - triangle::Triangle::barycentric_coordinates (line 152) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.41s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests gfx
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests loader
[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 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 math
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::div (line 456) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix3<T>::determinant (line 331) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::add (line 312) ... ok
[INFO] [stdout] test src/vector.rs - vector::i32::mul (line 439) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::index_mut (line 559) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vec3<T>::cross (line 273) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix3<T>::rotation (line 252) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::sub (line 347) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::iter (line 164) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,N>::add (line 380) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::dot (line 191) ... ok
[INFO] [stdout] test src/vector.rs - vector::f32::mul (line 422) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::mul (line 401) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vec3<T>::outer (line 242) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix3<T>::cross (line 214) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix3<T>::is_orthogonal (line 353) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,N>::mul (line 431) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,N>::transpose (line 62) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix<T,N>::mul (line 404) ... ok
[INFO] [stdout] test src/matrix.rs - matrix::Matrix3<T>::inverse (line 276) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::index (line 544) ... ok
[INFO] [stdout] test src/vector.rs - vector::Vector<T,N>::neg (line 378) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.71s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "716bdb74b6a8bb77fe4b6064c76b999db5af202ffa00ffad69ce1f1e430cfc46", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "716bdb74b6a8bb77fe4b6064c76b999db5af202ffa00ffad69ce1f1e430cfc46", kill_on_drop: false }`
[INFO] [stdout] 716bdb74b6a8bb77fe4b6064c76b999db5af202ffa00ffad69ce1f1e430cfc46