[INFO] cloning repository https://github.com/azdavis/advent-of-code
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/azdavis/advent-of-code" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fazdavis%2Fadvent-of-code", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fazdavis%2Fadvent-of-code'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] b7f60250e4243bb179e8bfe92b69f33f3e0446ea
[INFO] testing azdavis/advent-of-code against try#8262275854dc0e5381c9d42d56257d94932c5a87 for pr-90799
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fazdavis%2Fadvent-of-code" "/workspace/builds/worker-93/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-93/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/azdavis/advent-of-code on toolchain 8262275854dc0e5381c9d42d56257d94932c5a87
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/azdavis/advent-of-code
[INFO] finished tweaking git repo https://github.com/azdavis/advent-of-code
[INFO] tweaked toml for git repo https://github.com/azdavis/advent-of-code written to /workspace/builds/worker-93/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating git repository `https://github.com/azdavis/language-util.git`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "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-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f852966686a5c720e1c91777dd732ecad6062825a92e094c3e43597eb3c1fe34
[INFO] running `Command { std: "docker" "start" "-a" "f852966686a5c720e1c91777dd732ecad6062825a92e094c3e43597eb3c1fe34", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f852966686a5c720e1c91777dd732ecad6062825a92e094c3e43597eb3c1fe34", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f852966686a5c720e1c91777dd732ecad6062825a92e094c3e43597eb3c1fe34", kill_on_drop: false }`
[INFO] [stdout] f852966686a5c720e1c91777dd732ecad6062825a92e094c3e43597eb3c1fe34
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ce709813e8346c19b6468ac8a0c45e30946c442f8a2b735e54fca1db15764170
[INFO] running `Command { std: "docker" "start" "-a" "ce709813e8346c19b6468ac8a0c45e30946c442f8a2b735e54fca1db15764170", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling topo-sort v0.1.0 (https://github.com/azdavis/language-util.git#0a3e40a8)
[INFO] [stderr]    Compiling float-ord v0.2.0
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling helpers v0.1.0 (/opt/rustwide/workdir/helpers)
[INFO] [stderr]    Compiling y2019 v0.1.0 (/opt/rustwide/workdir/years/y2019)
[INFO] [stderr]    Compiling y2018 v0.1.0 (/opt/rustwide/workdir/years/y2018)
[INFO] [stderr]    Compiling y2021 v0.1.0 (/opt/rustwide/workdir/years/y2021)
[INFO] [stderr]    Compiling y2020 v0.1.0 (/opt/rustwide/workdir/years/y2020)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 58.84s
[INFO] running `Command { std: "docker" "inspect" "ce709813e8346c19b6468ac8a0c45e30946c442f8a2b735e54fca1db15764170", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ce709813e8346c19b6468ac8a0c45e30946c442f8a2b735e54fca1db15764170", kill_on_drop: false }`
[INFO] [stdout] ce709813e8346c19b6468ac8a0c45e30946c442f8a2b735e54fca1db15764170
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4fcac57be495c6e575fcc442f59de2c1563d186e53fb703af2d2e78f3c06e942
[INFO] running `Command { std: "docker" "start" "-a" "4fcac57be495c6e575fcc442f59de2c1563d186e53fb703af2d2e78f3c06e942", kill_on_drop: false }`
[INFO] [stderr]    Compiling helpers v0.1.0 (/opt/rustwide/workdir/helpers)
[INFO] [stderr]    Compiling y2021 v0.1.0 (/opt/rustwide/workdir/years/y2021)
[INFO] [stderr]    Compiling y2019 v0.1.0 (/opt/rustwide/workdir/years/y2019)
[INFO] [stderr]    Compiling y2018 v0.1.0 (/opt/rustwide/workdir/years/y2018)
[INFO] [stderr]    Compiling y2020 v0.1.0 (/opt/rustwide/workdir/years/y2020)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.92s
[INFO] running `Command { std: "docker" "inspect" "4fcac57be495c6e575fcc442f59de2c1563d186e53fb703af2d2e78f3c06e942", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4fcac57be495c6e575fcc442f59de2c1563d186e53fb703af2d2e78f3c06e942", kill_on_drop: false }`
[INFO] [stdout] 4fcac57be495c6e575fcc442f59de2c1563d186e53fb703af2d2e78f3c06e942
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8dcef94b43a9469c4ca2a92fd465676ed7c8a4fb987eacf461d3fa189baa9ff1
[INFO] running `Command { std: "docker" "start" "-a" "8dcef94b43a9469c4ca2a92fd465676ed7c8a4fb987eacf461d3fa189baa9ff1", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/helpers-bf7b2302492657f5)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test bit_set::t ... ok
[INFO] [stdout] test ceil_div::t ... ok
[INFO] [stdout] test compass::t ... ok
[INFO] [stdout] test gcd::t ... ok
[INFO] [stdout] test digits::tests::t ... ok
[INFO] [stdout] test dijkstra::elem_cmp ... ok
[INFO] [stdout] test infinitable::partial_ord ... ok
[INFO] [stdout] test infinitable::add ... ok
[INFO] [stdout] test matrix::t_rotate_left ... ok
[INFO] [stdout] test matrix::t_transpose ... ok
[INFO] [stdout] test permute::t ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/y2018-b6e0189c56d9919c)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test d05::ex1 ... ok
[INFO] [stdout] test d05::ex2 ... ok
[INFO] [stdout] test d09::examples::ex1 ... ok
[INFO] [stdout] test d09::examples::ex2 ... ok
[INFO] [stdout] test d09::examples::ex4 ... ok
[INFO] [stdout] test d11::ex0 ... ok
[INFO] [stdout] test d09::examples::ex5 ... ok
[INFO] [stdout] test d09::examples::ex3 ... ok
[INFO] [stdout] test d09::examples::ex6 ... ok
[INFO] [stdout] test d12::ex1 ... ok
[INFO] [stdout] test d12::t ... ok
[INFO] [stdout] test d07::ex1_p1 ... ok
[INFO] [stdout] test d02::t ... ok
[INFO] [stdout] test d07::ex1_p2 ... ok
[INFO] [stdout] test d08::t ... ok
[INFO] [stdout] test d07::t ... ok
[INFO] [stdout] test d04::t ... ok
[INFO] [stdout] test d10::t ... ok
[INFO] [stdout] test d11::ex1 ... ok
[INFO] [stdout] test d11::ex2 ... ok
[INFO] [stdout] test d03::t ... ok
[INFO] [stdout] test d01::t ... ok
[INFO] [stdout] test d05::t ... ok
[INFO] [stdout] test d06::t ... ok
[INFO] [stdout] test d09::t ... ok
[INFO] [stdout] test d11::ex3 has been running for over 60 seconds
[INFO] [stdout] test d11::ex4 has been running for over 60 seconds
[INFO] [stdout] test d11::t has been running for over 60 seconds
[INFO] [stdout] test d11::ex3 ... ok
[INFO] [stdout] test d11::ex4 ... ok
[INFO] [stdout] test d11::t ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 341.25s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/y2019-1f8340cbd3a92753)
[INFO] [stdout] 
[INFO] [stdout] running 65 tests
[INFO] [stdout] test d08::t ... ok
[INFO] [stdout] test d01::t ... ok
[INFO] [stdout] test d16::t_p1 ... ok
[INFO] [stdout] test d14::t ... ok
[INFO] [stdout] test d16::t_pat_digit ... ok
[INFO] [stdout] test d07::t ... ok
[INFO] [stdout] test d14::t_p1 ... ok
[INFO] [stdout] test d18::t_p2 ... ok
[INFO] [stdout] test d05::t ... ok
[INFO] [stdout] test d22::examples::inc_3_explanation ... ok
[INFO] [stdout] test d22::examples::t2 ... ok
[INFO] [stdout] test d22::examples::t1 ... ok
[INFO] [stdout] test d18::t_p1 ... ok
[INFO] [stdout] test d22::examples::t3 ... ok
[INFO] [stdout] test d14::t_p2 ... ok
[INFO] [stdout] test d12::t_p1 ... ok
[INFO] [stdout] test d22::examples::t4 ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tb ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::td ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tj ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tc ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tf ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tp ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::ta ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::th ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tl ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::to ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::ti ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::te ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tk ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tg ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tr ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tv ... ok
[INFO] [stdout] test d12::t_p2 ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::ts ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tt ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tn ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tu ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tx ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::ty ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tw ... ok
[INFO] [stdout] test d24::examples::every_neighbors3_n5::tq ... ok
[INFO] [stdout] test d24::examples::t_biodiversity_rating ... ok
[INFO] [stdout] test d06::t ... ok
[INFO] [stdout] test intcode::tests::cmp_8 ... ok
[INFO] [stdout] test d04::t ... ok
[INFO] [stdout] test d22::t ... ok
[INFO] [stdout] test d24::examples::t_p2_small ... ok
[INFO] [stdout] test d10::t ... ok
[INFO] [stdout] test d25::t ... ok
[INFO] [stdout] test d11::t ... ok
[INFO] [stdout] test d15::t ... ok
[INFO] [stdout] test d02::t ... ok
[INFO] [stdout] test d23::t ... ok
[INFO] [stdout] test d09::t ... ok
[INFO] [stdout] test d12::t ... ok
[INFO] [stdout] test d21::t ... ok
[INFO] [stdout] test d17::t ... ok
[INFO] [stdout] test d03::t ... ok
[INFO] [stdout] test d13::t ... ok
[INFO] [stdout] test d24::t ... ok
[INFO] [stdout] test d19::t ... ok
[INFO] [stdout] test d16::t ... ok
[INFO] [stdout] test d20::t ... ok
[INFO] [stdout] test d18::t ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 65 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 38.18s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/y2020-9d8c8c30df84098f)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test d03::t ... ok
[INFO] [stdout] test d12::t ... ok
[INFO] [stdout] test d10::t ... ok
[INFO] [stdout] test d05::t ... ok
[INFO] [stdout] test d18::t_p2 ... ok
[INFO] [stdout] test d13::t ... ok
[INFO] [stdout] test d01::t ... ok
[INFO] [stdout] test d18::t_p1 ... ok
[INFO] [stdout] test d18::t ... ok
[INFO] [stdout] test d08::t ... ok
[INFO] [stdout] test d22::t_p2_infinite ... ok
[INFO] [stdout] test d22::t_p2 ... ok
[INFO] [stdout] test d23::tests::t_mk_map_p1 ... ok
[INFO] [stdout] test d23::tests::t_p1 ... ok
[INFO] [stdout] test d15::t_p1 ... ok
[INFO] [stdout] test d06::t ... ok
[INFO] [stdout] test d09::t ... ok
[INFO] [stdout] test d25::t_p1 ... ok
[INFO] [stdout] test d16::t ... ok
[INFO] [stdout] test d07::t ... ok
[INFO] [stdout] test d21::t ... ok
[INFO] [stdout] test d04::t ... ok
[INFO] [stdout] test d02::t ... ok
[INFO] [stdout] test d23::tests::t_mk_map_p2 ... ok
[INFO] [stdout] test d14::t ... ok
[INFO] [stdout] test d25::t ... ok
[INFO] [stdout] test d19::t ... ok
[INFO] [stdout] test d11::t ... ok
[INFO] [stdout] test d24::t ... ok
[INFO] [stdout] test d22::t ... ok
[INFO] [stdout] test d17::t ... ok
[INFO] [stdout] test d23::t ... ok
[INFO] [stdout] test d23::tests::t_p2 ... ok
[INFO] [stdout] test d15::t ... ok
[INFO] [stdout] test d20::t ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 55.59s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/y2021-3b84ca128f8d962d)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test d01::t ... ok
[INFO] [stdout] test d02::t ... ok
[INFO] [stdout] test d03::ex1 ... ok
[INFO] [stdout] test d03::t ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "8dcef94b43a9469c4ca2a92fd465676ed7c8a4fb987eacf461d3fa189baa9ff1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8dcef94b43a9469c4ca2a92fd465676ed7c8a4fb987eacf461d3fa189baa9ff1", kill_on_drop: false }`
[INFO] [stdout] 8dcef94b43a9469c4ca2a92fd465676ed7c8a4fb987eacf461d3fa189baa9ff1