[INFO] fetching crate advent-of-code 2019.12.351...
[INFO] testing advent-of-code-2019.12.351 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate advent-of-code 2019.12.351 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate advent-of-code 2019.12.351 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 advent-of-code 2019.12.351
[INFO] finished tweaking crates.io crate advent-of-code 2019.12.351
[INFO] tweaked toml for crates.io crate advent-of-code 2019.12.351 written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] crate crates.io crate advent-of-code 2019.12.351 already has a lockfile, it will not be regenerated
[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-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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] 354c659ac88ca946a0261214662f9c9e8a149f06c0041984e14f3f36af212874
[INFO] running `Command { std: "docker" "start" "-a" "354c659ac88ca946a0261214662f9c9e8a149f06c0041984e14f3f36af212874", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "354c659ac88ca946a0261214662f9c9e8a149f06c0041984e14f3f36af212874", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "354c659ac88ca946a0261214662f9c9e8a149f06c0041984e14f3f36af212874", kill_on_drop: false }`
[INFO] [stdout] 354c659ac88ca946a0261214662f9c9e8a149f06c0041984e14f3f36af212874
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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] 7e1e7aab2052bee976cee798aa8ab15d8c6d898a87efa066c45cf2a6acc69ef4
[INFO] running `Command { std: "docker" "start" "-a" "7e1e7aab2052bee976cee798aa8ab15d8c6d898a87efa066c45cf2a6acc69ef4", kill_on_drop: false }`
[INFO] [stderr]    Compiling advent-of-code v2019.12.351 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.20s
[INFO] running `Command { std: "docker" "inspect" "7e1e7aab2052bee976cee798aa8ab15d8c6d898a87efa066c45cf2a6acc69ef4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7e1e7aab2052bee976cee798aa8ab15d8c6d898a87efa066c45cf2a6acc69ef4", kill_on_drop: false }`
[INFO] [stdout] 7e1e7aab2052bee976cee798aa8ab15d8c6d898a87efa066c45cf2a6acc69ef4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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] 6242c3620d5516ad830c87901dce54657fa8cf6d61e564a414b15d543eadcc00
[INFO] running `Command { std: "docker" "start" "-a" "6242c3620d5516ad830c87901dce54657fa8cf6d61e564a414b15d543eadcc00", kill_on_drop: false }`
[INFO] [stderr]    Compiling criterion v0.3.4
[INFO] [stderr]    Compiling advent-of-code v2019.12.351 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 19.81s
[INFO] running `Command { std: "docker" "inspect" "6242c3620d5516ad830c87901dce54657fa8cf6d61e564a414b15d543eadcc00", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6242c3620d5516ad830c87901dce54657fa8cf6d61e564a414b15d543eadcc00", kill_on_drop: false }`
[INFO] [stdout] 6242c3620d5516ad830c87901dce54657fa8cf6d61e564a414b15d543eadcc00
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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] 4efab52a9414f54b593ced3b30a9f2bbec6a145ea86c3f45137652899ce10527
[INFO] running `Command { std: "docker" "start" "-a" "4efab52a9414f54b593ced3b30a9f2bbec6a145ea86c3f45137652899ce10527", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/advent_of_code-f8f889936ef3b007)
[INFO] [stdout] 
[INFO] [stdout] running 163 tests
[INFO] [stdout] test common::md5::tests::compute ... ok
[INFO] [stdout] test common::md5::tests::index ... ok
[INFO] [stdout] test year2015::day01::tests ... ok
[INFO] [stdout] test year2015::day08::tests ... ok
[INFO] [stdout] test year2015::day02::tests ... ok
[INFO] [stdout] test year2015::day23::tests ... ok
[INFO] [stdout] test year2015::day21::tests ... ok
[INFO] [stdout] test year2016::day02::tests ... ok
[INFO] [stdout] test year2015::day14::tests ... ok
[INFO] [stdout] test year2015::day16::tests ... ok
[INFO] [stdout] test year2015::day12::test_parse ... ok
[INFO] [stdout] test year2016::day08::tests ... ok
[INFO] [stdout] test year2016::day01::tests ... ok
[INFO] [stdout] test year2016::day09::tests ... ok
[INFO] [stdout] test year2016::day10::tests ... ok
[INFO] [stdout] test year2015::day05::tests ... ok
[INFO] [stdout] test year2016::day03::tests ... ok
[INFO] [stdout] test year2016::day06::tests ... ok
[INFO] [stdout] test year2016::day13::tests ... ok
[INFO] [stdout] test year2015::day03::tests ... ok
[INFO] [stdout] test year2016::day07::tests ... ok
[INFO] [stdout] test year2015::day07::tests ... ok
[INFO] [stdout] test year2016::day20::tests ... ok
[INFO] [stdout] test year2016::day23::tests ... ok
[INFO] [stdout] test year2017::day01::test ... ok
[INFO] [stdout] test year2016::day25::tests ... ok
[INFO] [stdout] test year2017::day02::test ... ok
[INFO] [stdout] test year2015::day19::tests ... ok
[INFO] [stdout] test year2016::day22::tests ... ok
[INFO] [stdout] test year2015::day12::tests ... ok
[INFO] [stdout] test year2017::day03::test ... ok
[INFO] [stdout] test year2015::day17::tests ... ok
[INFO] [stdout] test year2015::day25::tests ... ok
[INFO] [stdout] test year2017::day09::test ... ok
[INFO] [stdout] test year2017::day04::test ... ok
[INFO] [stdout] test year2017::day10::test ... ok
[INFO] [stdout] test year2017::day08::tests ... ok
[INFO] [stdout] test year2017::day11::test ... ok
[INFO] [stdout] test year2015::day24::tests ... ok
[INFO] [stdout] test year2017::day12::tests ... ok
[INFO] [stdout] test year2016::day04::tests ... ok
[INFO] [stdout] test year2017::day07::test ... ok
[INFO] [stdout] test year2017::day18::tests ... ok
[INFO] [stdout] test year2017::day16::tests ... ok
[INFO] [stdout] test year2015::day09::tests ... ok
[INFO] [stdout] test year2016::day15::tests ... ok
[INFO] [stdout] test year2017::day21::tile_tests ... ok
[INFO] [stdout] test year2016::day24::tests ... ok
[INFO] [stdout] test year2017::day23::tests ... ok
[INFO] [stdout] test year2017::day06::test_part1 ... ok
[INFO] [stdout] test year2015::day13::tests ... ok
[INFO] [stdout] test year2017::disjoint_set::test_disjoint_set ... ok
[INFO] [stdout] test year2017::day19::tests ... ok
[INFO] [stdout] test year2018::day02::test ... ok
[INFO] [stdout] test year2017::day13::tests ... ok
[INFO] [stdout] test year2018::day01::test ... ok
[INFO] [stdout] test year2018::day04::test ... ok
[INFO] [stdout] test year2016::day17::tests ... ok
[INFO] [stdout] test year2018::day07::tests ... ok
[INFO] [stdout] test year2018::day08::tests ... ok
[INFO] [stdout] test year2018::day03::tests ... ok
[INFO] [stdout] test year2017::day21::tests ... ok
[INFO] [stdout] test year2015::day11::tests ... ok
[INFO] [stdout] test year2018::day05::test ... ok
[INFO] [stdout] test year2017::day14::test_part1 ... ok
[INFO] [stdout] test year2018::day06::test ... ok
[INFO] [stdout] test year2017::day14::test_part2 ... ok
[INFO] [stdout] test year2016::day12::tests ... ok
[INFO] [stdout] test year2018::day16::tests ... ok
[INFO] [stdout] test year2018::day13::tests ... ok
[INFO] [stdout] test year2018::day10::tests ... ok
[INFO] [stdout] test year2016::day19::tests ... ok
[INFO] [stdout] test year2018::day21::tests ... ok
[INFO] [stdout] test year2018::day12::tests ... ok
[INFO] [stdout] test year2018::day20::tests ... ok
[INFO] [stdout] test year2018::day23::tests ... ok
[INFO] [stdout] test year2017::day17::tests ... ok
[INFO] [stdout] test year2019::day01::tests ... ok
[INFO] [stdout] test year2018::day17::tests ... ok
[INFO] [stdout] test year2019::day03::tests ... ok
[INFO] [stdout] test year2019::day03::tests_line_segment ... ok
[INFO] [stdout] test year2019::day02::tests ... ok
[INFO] [stdout] test year2019::day05::tests ... ok
[INFO] [stdout] test year2019::day06::tests ... ok
[INFO] [stdout] test year2019::day04::tests ... ok
[INFO] [stdout] test year2019::day08::tests ... ok
[INFO] [stdout] test year2018::day25::tests ... ok
[INFO] [stdout] test year2018::day15::tests ... ok
[INFO] [stdout] test year2019::day07::tests ... ok
[INFO] [stdout] test year2019::day11::tests ... ok
[INFO] [stdout] test year2015::day15::tests ... ok
[INFO] [stdout] test year2019::day13::tests_part1 ... ok
[INFO] [stdout] test year2019::day09::tests ... ok
[INFO] [stdout] test year2019::day14::tests ... ok
[INFO] [stdout] test year2019::day15::tests ... ok
[INFO] [stdout] test year2015::day22::tests ... ok
[INFO] [stdout] test year2019::day13::tests_part2 ... ok
[INFO] [stdout] test year2019::day18::tests_part2 ... ok
[INFO] [stdout] test year2019::day17::tests ... ok
[INFO] [stdout] test year2015::day18::tests ... ok
[INFO] [stdout] test year2019::day12::tests ... ok
[INFO] [stdout] test year2019::day22::tests ... ok
[INFO] [stdout] test year2018::day19::tests ... ok
[INFO] [stdout] test year2019::day23::test ... ok
[INFO] [stdout] test year2019::day21::tests ... ok
[INFO] [stdout] test year2020::day01::tests ... ok
[INFO] [stdout] test year2019::day10::tests ... ok
[INFO] [stdout] test year2020::day03::tests ... ok
[INFO] [stdout] test year2020::day02::tests ... ok
[INFO] [stdout] test year2020::day04::tests ... ok
[INFO] [stdout] test year2020::day05::tests ... ok
[INFO] [stdout] test year2020::day06::tests ... ok
[INFO] [stdout] test year2020::day07::tests ... ok
[INFO] [stdout] test year2020::day08::tests ... ok
[INFO] [stdout] test year2020::day10::tests ... ok
[INFO] [stdout] test year2020::day09::tests ... ok
[INFO] [stdout] test year2020::day12::tests ... ok
[INFO] [stdout] test year2020::day13::tests ... ok
[INFO] [stdout] test year2020::day14::tests ... ok
[INFO] [stdout] test year2019::day18::tests_part1 ... ok
[INFO] [stdout] test year2020::day16::tests ... ok
[INFO] [stdout] test year2020::day11::tests ... ok
[INFO] [stdout] test year2020::day18::tests ... ok
[INFO] [stdout] test year2019::day24::tests ... ok
[INFO] [stdout] test year2020::day20::test_flip ... ok
[INFO] [stdout] test year2020::day20::test_rotate ... ok
[INFO] [stdout] test year2020::day20::tests ... ok
[INFO] [stdout] test year2020::day21::tests ... ok
[INFO] [stdout] test year2020::day22::tests ... ok
[INFO] [stdout] test year2018::day18::tests ... ok
[INFO] [stdout] test year2020::day17::tests ... ok
[INFO] [stdout] test year2020::day25::tests ... ok
[INFO] [stdout] test year2020::day19::tests ... ok
[INFO] [stdout] test year2019::day19::tests ... ok
[INFO] [stdout] test year2018::day09::tests ... ok
[INFO] [stdout] test year2018::day24::tests ... ok
[INFO] [stdout] test year2017::day15::tests ... ok
[INFO] [stdout] test year2019::day25::test ... ok
[INFO] [stdout] test year2017::day05::test ... ok
[INFO] [stdout] test year2018::day22::tests ... ok
[INFO] [stdout] test year2018::day14::tests ... ok
[INFO] [stdout] test year2015::day06::tests ... ok
[INFO] [stdout] test year2020::day24::tests ... ok
[INFO] [stdout] test year2017::day24::tests ... ok
[INFO] [stdout] test year2019::day20::tests ... ok
[INFO] [stdout] test year2018::day11::tests ... ok
[INFO] [stdout] test year2016::day18::tests ... ok
[INFO] [stdout] test year2017::day22::tests ... ok
[INFO] [stdout] test year2015::day20::tests ... ok
[INFO] [stdout] test year2017::day20::tests ... ok
[INFO] [stdout] test year2020::day15::tests ... ok
[INFO] [stdout] test year2016::day16::tests ... ok
[INFO] [stdout] test year2016::day11::tests ... ok
[INFO] [stdout] test year2019::day16::tests ... ok
[INFO] [stdout] test year2020::day23::tests ... ok
[INFO] [stdout] test year2015::day10::tests ... ok
[INFO] [stdout] test common::md5::tests::overflow_count has been running for over 60 seconds
[INFO] [stdout] test common::md5::tests::overflow_length has been running for over 60 seconds
[INFO] [stdout] test year2015::day04::tests has been running for over 60 seconds
[INFO] [stdout] test year2016::day05::tests has been running for over 60 seconds
[INFO] [stdout] test year2016::day14::tests has been running for over 60 seconds
[INFO] [stdout] test year2016::day21::tests has been running for over 60 seconds
[INFO] [stdout] test year2016::day21::tests ... ok
[INFO] [stdout] test year2017::day25::tests has been running for over 60 seconds
[INFO] [stdout] test year2017::day25::tests ... ok
[INFO] [stdout] test year2015::day04::tests ... ok
[INFO] [stdout] test common::md5::tests::overflow_count ... ok
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "4efab52a9414f54b593ced3b30a9f2bbec6a145ea86c3f45137652899ce10527", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4efab52a9414f54b593ced3b30a9f2bbec6a145ea86c3f45137652899ce10527", kill_on_drop: false }`
[INFO] [stdout] 4efab52a9414f54b593ced3b30a9f2bbec6a145ea86c3f45137652899ce10527