[INFO] cloning repository https://github.com/steve-edmans/advent2022
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/steve-edmans/advent2022" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsteve-edmans%2Fadvent2022", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsteve-edmans%2Fadvent2022'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 30f8c20d536d5cd4b2a7713d7e35e3907e22833c
[INFO] testing steve-edmans/advent2022 against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsteve-edmans%2Fadvent2022" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/steve-edmans/advent2022
[INFO] finished tweaking git repo https://github.com/steve-edmans/advent2022
[INFO] tweaked toml for git repo https://github.com/steve-edmans/advent2022 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/steve-edmans/advent2022 on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/steve-edmans/advent2022 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "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
[ERROR] error running command: no output for 300 seconds
[INFO] testing steve-edmans/advent2022 against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsteve-edmans%2Fadvent2022" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/steve-edmans/advent2022
[INFO] finished tweaking git repo https://github.com/steve-edmans/advent2022
[INFO] tweaked toml for git repo https://github.com/steve-edmans/advent2022 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/steve-edmans/advent2022 on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/steve-edmans/advent2022 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "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-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8d020d0be9ec343e84d77018d75a2b14070b47f8c47393afc963bc26afcf1e42
[INFO] running `Command { std: "docker" "start" "-a" "8d020d0be9ec343e84d77018d75a2b14070b47f8c47393afc963bc26afcf1e42", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8d020d0be9ec343e84d77018d75a2b14070b47f8c47393afc963bc26afcf1e42", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d020d0be9ec343e84d77018d75a2b14070b47f8c47393afc963bc26afcf1e42", kill_on_drop: false }`
[INFO] [stdout] 8d020d0be9ec343e84d77018d75a2b14070b47f8c47393afc963bc26afcf1e42
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d5ae4171107f5e9ff2ad685dad98a04dd57e0c0659d9670af89b57db436ada4f
[INFO] running `Command { std: "docker" "start" "-a" "d5ae4171107f5e9ff2ad685dad98a04dd57e0c0659d9670af89b57db436ada4f", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex v1.7.0
[INFO] [stderr]    Compiling advent2022 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.99s
[INFO] running `Command { std: "docker" "inspect" "d5ae4171107f5e9ff2ad685dad98a04dd57e0c0659d9670af89b57db436ada4f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d5ae4171107f5e9ff2ad685dad98a04dd57e0c0659d9670af89b57db436ada4f", kill_on_drop: false }`
[INFO] [stdout] d5ae4171107f5e9ff2ad685dad98a04dd57e0c0659d9670af89b57db436ada4f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ea0315d22bf42cb04160a12f22aa5a3bb40d58e51429ba3cd16c86fc87cae449
[INFO] running `Command { std: "docker" "start" "-a" "ea0315d22bf42cb04160a12f22aa5a3bb40d58e51429ba3cd16c86fc87cae449", kill_on_drop: false }`
[INFO] [stderr]    Compiling advent2022 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.88s
[INFO] running `Command { std: "docker" "inspect" "ea0315d22bf42cb04160a12f22aa5a3bb40d58e51429ba3cd16c86fc87cae449", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ea0315d22bf42cb04160a12f22aa5a3bb40d58e51429ba3cd16c86fc87cae449", kill_on_drop: false }`
[INFO] [stdout] ea0315d22bf42cb04160a12f22aa5a3bb40d58e51429ba3cd16c86fc87cae449
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a46f0f47b1e72e9923e799ef338d9b65386e8a34c712d05c28548f4aeb3fa268
[INFO] running `Command { std: "docker" "start" "-a" "a46f0f47b1e72e9923e799ef338d9b65386e8a34c712d05c28548f4aeb3fa268", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/advent2022-fb50ecf76dc95ef7)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/advent2022-07b2ae4cab81cf52)
[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 95 tests
[INFO] [stdout] test days::five::tests::determine_first_layer_of_crates ... ok
[INFO] [stdout] test days::five::tests::check_test_movements2 ... ok
[INFO] [stdout] test days::five::tests::extract_stack_of_crates ... ok
[INFO] [stdout] test days::five::tests::extract_movement_command ... ok
[INFO] [stdout] test days::five::tests::fail_to_extract_movement_command ... ok
[INFO] [stdout] test days::five::tests::extract_smaller_movement_command ... ok
[INFO] [stdout] test days::five::tests::find_fifth_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_first_column_from_row ... ok
[INFO] [stdout] test days::five::tests::determine_second_layer_of_crates ... ok
[INFO] [stdout] test days::five::tests::find_eight_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_forth_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_ninth_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_second_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_sixth_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_seventh_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_third_column_from_row ... ok
[INFO] [stdout] test days::five::tests::find_top_elements_on_each_crate ... ok
[INFO] [stdout] test days::five::tests::test_crate_mover_9001 ... ok
[INFO] [stdout] test days::four::tests::create_assignments ... ok
[INFO] [stdout] test days::four::tests::first_fully_contains_second ... ok
[INFO] [stdout] test days::four::tests::first_fully_overlaps_second ... ok
[INFO] [stdout] test days::four::tests::fully_contain_disjoint ... ok
[INFO] [stdout] test days::four::tests::fully_contain_overlap_end ... ok
[INFO] [stdout] test days::four::tests::fully_contain_overlap_start ... ok
[INFO] [stdout] test days::four::tests::overlap_disjoint ... ok
[INFO] [stdout] test days::five::tests::find_tenth_column_from_row ... ok
[INFO] [stdout] test days::four::tests::overlap_end ... ok
[INFO] [stdout] test days::four::tests::overlap_start ... ok
[INFO] [stdout] test days::four::tests::second_fully_contains_first ... ok
[INFO] [stdout] test days::four::tests::second_fully_overlaps_first ... ok
[INFO] [stdout] test days::three::tests::check_first_group_of_rucksacks ... ok
[INFO] [stdout] test days::three::tests::check_second_group_of_rucksacks ... ok
[INFO] [stdout] test days::three::tests::create_rucksack ... ok
[INFO] [stdout] test days::three::tests::fifth_rucksack ... ok
[INFO] [stdout] test days::three::tests::find_first_shared_item ... ok
[INFO] [stdout] test days::three::tests::first_rucksack ... ok
[INFO] [stdout] test days::three::tests::forth_rucksack ... ok
[INFO] [stdout] test days::three::tests::priority_of_a ... ok
[INFO] [stdout] test days::three::tests::priority_of_an_illegal_char ... ok
[INFO] [stdout] test days::three::tests::priority_of_j ... ok
[INFO] [stdout] test days::three::tests::priority_of_uppercase_a ... ok
[INFO] [stdout] test days::three::tests::priority_of_uppercase_j ... ok
[INFO] [stdout] test days::three::tests::priority_of_uppercase_z ... ok
[INFO] [stdout] test days::three::tests::priority_of_z ... ok
[INFO] [stdout] test days::three::tests::second_rucksack ... ok
[INFO] [stdout] test days::three::tests::sixth_rucksack ... ok
[INFO] [stdout] test days::three::tests::third_rucksack ... ok
[INFO] [stdout] test days::two::tests::a_y_alternate_score ... ok
[INFO] [stdout] test days::two::tests::a_y_game_score ... ok
[INFO] [stdout] test days::two::tests::alternate_paper_draw ... ok
[INFO] [stdout] test days::two::tests::alternate_paper_lose ... ok
[INFO] [stdout] test days::two::tests::alternate_paper_win ... ok
[INFO] [stdout] test days::two::tests::alternate_recommendation_draw ... ok
[INFO] [stdout] test days::two::tests::alternate_recommendation_lose ... ok
[INFO] [stdout] test days::two::tests::a_z_alternate_score ... ok
[INFO] [stdout] test days::two::tests::alternate_recommendation_win ... ok
[INFO] [stdout] test days::two::tests::alternate_rock_lose ... ok
[INFO] [stdout] test days::two::tests::alternate_scissors_draw ... ok
[INFO] [stdout] test days::two::tests::alternate_rock_win ... ok
[INFO] [stdout] test days::two::tests::alternate_scissors_win ... ok
[INFO] [stdout] test days::two::tests::b_x_alternate_score ... ok
[INFO] [stdout] test days::two::tests::alternate_scissors_lose ... ok
[INFO] [stdout] test days::two::tests::alternate_rock_draw ... ok
[INFO] [stdout] test days::two::tests::b_z_alternate_score ... ok
[INFO] [stdout] test days::two::tests::c_y_alternate_score ... ok
[INFO] [stdout] test days::two::tests::b_x_game_score ... ok
[INFO] [stdout] test days::two::tests::b_y_alternate_score ... ok
[INFO] [stdout] test days::two::tests::c_z_alternate_score ... ok
[INFO] [stdout] test days::two::tests::c_x_alternate_score ... ok
[INFO] [stdout] test days::two::tests::c_z_game_score ... ok
[INFO] [stdout] test days::two::tests::a_x_alternate_score ... ok
[INFO] [stdout] test days::two::tests::convert_line ... ok
[INFO] [stdout] test days::two::tests::decode_a_to_rock ... ok
[INFO] [stdout] test days::two::tests::decode_b_to_paper ... ok
[INFO] [stdout] test days::two::tests::scissors_draws_with_scissors ... ok
[INFO] [stdout] test days::two::tests::decode_c_to_scissors ... ok
[INFO] [stdout] test days::two::tests::decode_invalid_line ... ok
[INFO] [stdout] test days::two::tests::decode_unkown_choice ... ok
[INFO] [stdout] test days::two::tests::decode_x_to_rock ... ok
[INFO] [stdout] test days::two::tests::decode_y_to_paper ... ok
[INFO] [stdout] test days::two::tests::decode_z_to_scissors ... ok
[INFO] [stdout] test days::two::tests::paper_beats_rock ... ok
[INFO] [stdout] test days::two::tests::paper_draws_with_paper ... ok
[INFO] [stdout] test days::two::tests::paper_loses_to_scissors ... ok
[INFO] [stdout] test days::two::tests::rock_beats_scissors ... ok
[INFO] [stdout] test days::two::tests::rock_draws_with_rock ... ok
[INFO] [stdout] test days::two::tests::rock_loses_to_paper ... ok
[INFO] [stdout] test days::two::tests::score_for_draw ... ok
[INFO] [stdout] test days::two::tests::score_for_lose ... ok
[INFO] [stdout] test days::two::tests::score_for_rock_is_1 ... ok
[INFO] [stdout] test days::two::tests::score_for_scissors_is_3 ... ok
[INFO] [stdout] test days::two::tests::score_for_paper_is_2 ... ok
[INFO] [stdout] test days::two::tests::scissors_loses_to_rock ... ok
[INFO] [stdout] test days::two::tests::score_for_win ... ok
[INFO] [stdout] test days::two::tests::scissors_beats_paper ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 95 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests advent2022
[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" "a46f0f47b1e72e9923e799ef338d9b65386e8a34c712d05c28548f4aeb3fa268", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a46f0f47b1e72e9923e799ef338d9b65386e8a34c712d05c28548f4aeb3fa268", kill_on_drop: false }`
[INFO] [stdout] a46f0f47b1e72e9923e799ef338d9b65386e8a34c712d05c28548f4aeb3fa268
