[INFO] cloning repository https://github.com/alarsyo/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/alarsyo/advent-of-code" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falarsyo%2Fadvent-of-code", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falarsyo%2Fadvent-of-code'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] a5fd485c1031746f85a291702e751bfb0bc0b2d5
[INFO] testing alarsyo/advent-of-code against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Falarsyo%2Fadvent-of-code" "/workspace/builds/worker-22/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-22/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/alarsyo/advent-of-code 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/alarsyo/advent-of-code
[INFO] finished tweaking git repo https://github.com/alarsyo/advent-of-code
[INFO] tweaked toml for git repo https://github.com/alarsyo/advent-of-code written to /workspace/builds/worker-22/source/Cargo.toml
[INFO] crate git repo https://github.com/alarsyo/advent-of-code 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-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 8fcd7d5dcdbba28252591b0d2029ecc0d3c149b0c8d9539264daff941f744ea7
[INFO] running `Command { std: "docker" "start" "-a" "8fcd7d5dcdbba28252591b0d2029ecc0d3c149b0c8d9539264daff941f744ea7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8fcd7d5dcdbba28252591b0d2029ecc0d3c149b0c8d9539264daff941f744ea7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8fcd7d5dcdbba28252591b0d2029ecc0d3c149b0c8d9539264daff941f744ea7", kill_on_drop: false }`
[INFO] [stdout] 8fcd7d5dcdbba28252591b0d2029ecc0d3c149b0c8d9539264daff941f744ea7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 54b92e52a4a0d4ad54f882c0f59ebbfd5a8f202c660e65d5f64ff75bf30a38d4
[INFO] running `Command { std: "docker" "start" "-a" "54b92e52a4a0d4ad54f882c0f59ebbfd5a8f202c660e65d5f64ff75bf30a38d4", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.112
[INFO] [stderr]    Compiling anyhow v1.0.51
[INFO] [stderr]    Compiling radium v0.6.2
[INFO] [stderr]    Compiling ppv-lite86 v0.2.15
[INFO] [stderr]    Compiling funty v1.2.0
[INFO] [stderr]    Compiling wyz v0.4.0
[INFO] [stderr]    Compiling bitvec v0.22.3
[INFO] [stderr]    Compiling aoc v0.1.0 (/opt/rustwide/workdir/aoc)
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling aoc2021 v0.1.0 (/opt/rustwide/workdir/aoc2021)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.60s
[INFO] running `Command { std: "docker" "inspect" "54b92e52a4a0d4ad54f882c0f59ebbfd5a8f202c660e65d5f64ff75bf30a38d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "54b92e52a4a0d4ad54f882c0f59ebbfd5a8f202c660e65d5f64ff75bf30a38d4", kill_on_drop: false }`
[INFO] [stdout] 54b92e52a4a0d4ad54f882c0f59ebbfd5a8f202c660e65d5f64ff75bf30a38d4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 8e059b2a83d472dae0c8c3045aea596a38cc7437c977f950fb47090687b692a4
[INFO] running `Command { std: "docker" "start" "-a" "8e059b2a83d472dae0c8c3045aea596a38cc7437c977f950fb47090687b692a4", kill_on_drop: false }`
[INFO] [stderr]    Compiling aoc2021 v0.1.0 (/opt/rustwide/workdir/aoc2021)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.15s
[INFO] running `Command { std: "docker" "inspect" "8e059b2a83d472dae0c8c3045aea596a38cc7437c977f950fb47090687b692a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8e059b2a83d472dae0c8c3045aea596a38cc7437c977f950fb47090687b692a4", kill_on_drop: false }`
[INFO] [stdout] 8e059b2a83d472dae0c8c3045aea596a38cc7437c977f950fb47090687b692a4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 08e962a8d92081d6f1cfc9e0b446f20449155feee262e336345a0b40defa6afd
[INFO] running `Command { std: "docker" "start" "-a" "08e962a8d92081d6f1cfc9e0b446f20449155feee262e336345a0b40defa6afd", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3m 32s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/aoc2021-2f685553bb178e43)
[INFO] [stdout] 
[INFO] [stdout] running 73 tests
[INFO] [stdout] test day01::tests::part1_provided ... ok
[INFO] [stdout] test day01::tests::part2_provided ... ok
[INFO] [stdout] test day02::tests::part1_provided ... ok
[INFO] [stdout] test day02::tests::part2_provided ... ok
[INFO] [stdout] test day03::tests::part1_provided ... ok
[INFO] [stdout] test day03::tests::part2_provided ... ok
[INFO] [stdout] test day04::tests::part1_provided ... ok
[INFO] [stdout] test day04::tests::part2_provided ... ok
[INFO] [stdout] test day01::tests::part1_real ... ok
[INFO] [stdout] test day02::tests::part1_real ... ok
[INFO] [stdout] test day01::tests::part2_real ... ok
[INFO] [stdout] test day03::tests::part2_real ... ok
[INFO] [stdout] test day05::tests::part2_provided ... ok
[INFO] [stdout] test day05::tests::part1_provided ... ok
[INFO] [stdout] test day06::tests::part1_provided ... ok
[INFO] [stdout] test day02::tests::part2_real ... ok
[INFO] [stdout] test day06::tests::part2_provided ... ok
[INFO] [stdout] test day06::tests::part1_real ... ok
[INFO] [stdout] test day06::tests::part2_real ... ok
[INFO] [stdout] test day07::tests::part2_provided ... ok
[INFO] [stdout] test day07::tests::part1_provided ... ok
[INFO] [stdout] test day04::tests::part1_real ... ok
[INFO] [stdout] test day07::tests::part2_real ... ok
[INFO] [stdout] test day07::tests::part1_real ... ok
[INFO] [stdout] test day08::tests::part1_provided ... ok
[INFO] [stdout] test day09::tests::part1_provided ... ok
[INFO] [stdout] test day08::tests::part2_provided ... ok
[INFO] [stdout] test day09::tests::part2_provided ... ok
[INFO] [stdout] test day10::tests::part1_provided ... ok
[INFO] [stdout] test day10::tests::part2_provided ... ok
[INFO] [stdout] test day08::tests::part1_real ... ok
[INFO] [stdout] test day03::tests::part1_real ... ok
[INFO] [stdout] test day04::tests::part2_real ... ok
[INFO] [stdout] test day13::tests::part1_provided ... ok
[INFO] [stdout] test day10::tests::part1_real ... ok
[INFO] [stdout] test day11::tests::part1_provided ... ok
[INFO] [stdout] test day08::tests::part2_real ... ok
[INFO] [stdout] test day10::tests::part2_real ... ok
[INFO] [stdout] test day09::tests::part1_real ... ok
[INFO] [stdout] test day13::tests::part2_provided ... ok
[INFO] [stdout] test day11::tests::part1_real ... ok
[INFO] [stdout] test day12::tests::part1_provided ... ok
[INFO] [stdout] test day15::tests::part1_provided ... ok
[INFO] [stdout] test day14::tests::part1_provided ... ok
[INFO] [stdout] test day16::tests::part1_provided ... ok
[INFO] [stdout] test day14::tests::part2_provided ... ok
[INFO] [stdout] test day16::tests::part2_provided ... ok
[INFO] [stdout] test day14::tests::part1_real ... ok
[INFO] [stdout] test day21::tests::part1_provided ... ok
[INFO] [stdout] test day17::tests::part2_provided ... ok
[INFO] [stdout] test day21::tests::part1_real ... ok
[INFO] [stdout] test day17::tests::part1_provided ... ok
[INFO] [stdout] test day11::tests::part2_provided ... ok
[INFO] [stdout] test day16::tests::part1_real ... ok
[INFO] [stdout] test day13::tests::part1_real ... ok
[INFO] [stdout] test day16::tests::part2_real ... ok
[INFO] [stdout] test day13::tests::part2_real ... ok
[INFO] [stdout] test day14::tests::part2_real ... ok
[INFO] [stdout] test day15::tests::part2_provided ... ok
[INFO] [stdout] test day17::tests::part1_real ... ok
[INFO] [stdout] test day17::tests::part2_real ... ok
[INFO] [stdout] test day11::tests::part2_real ... ok
[INFO] [stdout] test day15::tests::part1_real ... ok
[INFO] [stdout] test day09::tests::part2_real ... ok
[INFO] [stdout] test day12::tests::part1_real ... ok
[INFO] [stdout] test day12::tests::part2_provided ... ok
[INFO] [stdout] test day21::tests::part2_real ... ok
[INFO] [stdout] test day21::tests::part2_provided ... ok
[INFO] [stdout] test day05::tests::part1_real ... ok
[INFO] [stdout] test day07::tests::test_selection ... ok
[INFO] [stdout] test day05::tests::part2_real ... ok
[INFO] [stdout] test day15::tests::part2_real ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/aoc2021-fdba17a9870c5642)
[INFO] [stdout] test day12::tests::part2_real ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.52s
[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 aoc2021
[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" "08e962a8d92081d6f1cfc9e0b446f20449155feee262e336345a0b40defa6afd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "08e962a8d92081d6f1cfc9e0b446f20449155feee262e336345a0b40defa6afd", kill_on_drop: false }`
[INFO] [stdout] 08e962a8d92081d6f1cfc9e0b446f20449155feee262e336345a0b40defa6afd