[INFO] cloning repository https://github.com/marcusradell/lab_fractions
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/marcusradell/lab_fractions" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmarcusradell%2Flab_fractions", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmarcusradell%2Flab_fractions'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 1a12f367fafdccab818dfd34e851cfaed6a19494
[INFO] testing marcusradell/lab_fractions against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmarcusradell%2Flab_fractions" "/workspace/builds/worker-37/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-37/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/marcusradell/lab_fractions 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/marcusradell/lab_fractions
[INFO] finished tweaking git repo https://github.com/marcusradell/lab_fractions
[INFO] tweaked toml for git repo https://github.com/marcusradell/lab_fractions written to /workspace/builds/worker-37/source/Cargo.toml
[INFO] crate git repo https://github.com/marcusradell/lab_fractions 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]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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] 7692fc7915ab2ce5798a37e3cb4ba5d54df28e93acd508e39286ddffc5c962c3
[INFO] running `Command { std: "docker" "start" "-a" "7692fc7915ab2ce5798a37e3cb4ba5d54df28e93acd508e39286ddffc5c962c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7692fc7915ab2ce5798a37e3cb4ba5d54df28e93acd508e39286ddffc5c962c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7692fc7915ab2ce5798a37e3cb4ba5d54df28e93acd508e39286ddffc5c962c3", kill_on_drop: false }`
[INFO] [stdout] 7692fc7915ab2ce5798a37e3cb4ba5d54df28e93acd508e39286ddffc5c962c3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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] ba347e5c4999fd7caf2e398b946f4630290234ce47b43f928e5ac33594acf0bd
[INFO] running `Command { std: "docker" "start" "-a" "ba347e5c4999fd7caf2e398b946f4630290234ce47b43f928e5ac33594acf0bd", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling lab_fractions v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.70s
[INFO] running `Command { std: "docker" "inspect" "ba347e5c4999fd7caf2e398b946f4630290234ce47b43f928e5ac33594acf0bd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ba347e5c4999fd7caf2e398b946f4630290234ce47b43f928e5ac33594acf0bd", kill_on_drop: false }`
[INFO] [stdout] ba347e5c4999fd7caf2e398b946f4630290234ce47b43f928e5ac33594acf0bd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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] 18d267be481ea096fce5768e74dc591749f20c86f45455a94cbf05f323141da0
[INFO] running `Command { std: "docker" "start" "-a" "18d267be481ea096fce5768e74dc591749f20c86f45455a94cbf05f323141da0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling lab_fractions v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.91s
[INFO] running `Command { std: "docker" "inspect" "18d267be481ea096fce5768e74dc591749f20c86f45455a94cbf05f323141da0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "18d267be481ea096fce5768e74dc591749f20c86f45455a94cbf05f323141da0", kill_on_drop: false }`
[INFO] [stdout] 18d267be481ea096fce5768e74dc591749f20c86f45455a94cbf05f323141da0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-37/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] a6c4d63209e18bef10892e0812562a62e519d65a9777462657ca33b9abf2b53f
[INFO] running `Command { std: "docker" "start" "-a" "a6c4d63209e18bef10892e0812562a62e519d65a9777462657ca33b9abf2b53f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 38.51s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/lab_fractions-5be15bf062f49ad0)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test math::equals_test::tests::different_denominators ... ok
[INFO] [stdout] test math::fractions_test::tests::denominator_multiple_of_other ... ok
[INFO] [stdout] test math::fractions_test::tests::different_denominators_no_reduction ... ok
[INFO] [stdout] test math::gcd::tests::one_is_multiple_of_the_other ... ok
[INFO] [stdout] test math::gcd::tests::reflexive ... ok
[INFO] [stdout] test math::gcd::tests::negatives ... ok
[INFO] [stdout] test math::gcd::tests::relatively_prime ... ok
[INFO] [stdout] test math::reduce_test::tests::reduce_to_whole_numbers ... ok
[INFO] [stdout] test math::fractions_test::tests::non_trivial_denominator ... ok
[INFO] [stdout] test math::equals_test::tests::same_numerator_and_denominator ... ok
[INFO] [stdout] test math::fractions_test::tests::non_zero_integers ... ok
[INFO] [stdout] test math::equals_test::tests::negative_denominator ... ok
[INFO] [stdout] test math::fractions_test::tests::add_non_zero_to_zero ... ok
[INFO] [stdout] test math::gcd::tests::common_factor ... ok
[INFO] [stdout] test math::equals_test::tests::whole_number_equals_same_fraction ... ok
[INFO] [stdout] test math::fractions_test::tests::negative_fraction_and_reducing ... ok
[INFO] [stdout] test math::fractions_test::tests::add_zero_to_zero ... ok
[INFO] [stdout] test math::fractions_test::tests::add_zero_to_non_zero ... ok
[INFO] [stdout] test math::fractions_test::tests::common_factor_in_denominators ... ok
[INFO] [stdout] test math::fractions_test::tests::reduce_result_to_whole_number ... ok
[INFO] [stdout] test math::fractions_test::tests::reduce_result_when_denominators_are_equal ... ok
[INFO] [stdout] test math::equals_test::tests::different_numerators ... ok
[INFO] [stdout] test math::equals_test::tests::whole_numbers_not_equal ... ok
[INFO] [stdout] test math::reduce_test::tests::already_in_lowest_terms ... ok
[INFO] [stdout] test math::reduce_test::tests::reduce_zero ... ok
[INFO] [stdout] test math::reduce_test::tests::reduce_to_not_whole_numbers ... ok
[INFO] [stdout] test math::gcd::tests::zero ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/lab_fractions-7b89cd566a90cac3)
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests lab_fractions
[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] running `Command { std: "docker" "inspect" "a6c4d63209e18bef10892e0812562a62e519d65a9777462657ca33b9abf2b53f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a6c4d63209e18bef10892e0812562a62e519d65a9777462657ca33b9abf2b53f", kill_on_drop: false }`
[INFO] [stdout] a6c4d63209e18bef10892e0812562a62e519d65a9777462657ca33b9abf2b53f