[INFO] cloning repository https://github.com/joeygibson/chip-8
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/joeygibson/chip-8" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoeygibson%2Fchip-8", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoeygibson%2Fchip-8'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 131d9b50575a0b2dc707f8043639d128e8188204
[INFO] testing joeygibson/chip-8 against beta-2022-04-10 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoeygibson%2Fchip-8" "/workspace/builds/worker-29/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-29/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/joeygibson/chip-8 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/joeygibson/chip-8
[INFO] finished tweaking git repo https://github.com/joeygibson/chip-8
[INFO] tweaked toml for git repo https://github.com/joeygibson/chip-8 written to /workspace/builds/worker-29/source/Cargo.toml
[INFO] crate git repo https://github.com/joeygibson/chip-8 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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-29/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/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" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 89db26f75e9b9f749fcfc6313e68ea72b58e6001c1416561fd02ea0a335670c4
[INFO] running `Command { std: "docker" "start" "-a" "89db26f75e9b9f749fcfc6313e68ea72b58e6001c1416561fd02ea0a335670c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "89db26f75e9b9f749fcfc6313e68ea72b58e6001c1416561fd02ea0a335670c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "89db26f75e9b9f749fcfc6313e68ea72b58e6001c1416561fd02ea0a335670c4", kill_on_drop: false }`
[INFO] [stdout] 89db26f75e9b9f749fcfc6313e68ea72b58e6001c1416561fd02ea0a335670c4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/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" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bfb550c2ae329ef51109c93a9c2020c8b8c61ecb95e5c9d5aa262be4ee207241
[INFO] running `Command { std: "docker" "start" "-a" "bfb550c2ae329ef51109c93a9c2020c8b8c61ecb95e5c9d5aa262be4ee207241", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.70
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling pkg-config v0.3.17
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling cc v1.0.54
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling ppv-lite86 v0.2.8
[INFO] [stderr]    Compiling unicode-width v0.1.7
[INFO] [stderr]    Compiling getopts v0.2.21
[INFO] [stderr]    Compiling ncurses v5.99.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling pancurses v0.16.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling easycurses v0.12.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling chip-8 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: panic message is not a string literal
[INFO] [stdout]   --> src/main.rs:49:26
[INFO] [stdout]    |
[INFO] [stdout] 49 |         Err(f) => panic!(f.to_string()),
[INFO] [stdout]    |                          ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(non_fmt_panics)]` on by default
[INFO] [stdout]    = note: this usage of panic!() is deprecated; it will be a hard error in Rust 2021
[INFO] [stdout]    = note: for more information, see <https://doc.rust-lang.org/nightly/edition-guide/rust-2021/panic-macro-consistency.html>
[INFO] [stdout] help: add a "{}" format string to Display the message
[INFO] [stdout]    |
[INFO] [stdout] 49 |         Err(f) => panic!("{}", f.to_string()),
[INFO] [stdout]    |                          +++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 14s
[INFO] running `Command { std: "docker" "inspect" "bfb550c2ae329ef51109c93a9c2020c8b8c61ecb95e5c9d5aa262be4ee207241", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bfb550c2ae329ef51109c93a9c2020c8b8c61ecb95e5c9d5aa262be4ee207241", kill_on_drop: false }`
[INFO] [stdout] bfb550c2ae329ef51109c93a9c2020c8b8c61ecb95e5c9d5aa262be4ee207241
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/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" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c679b8bf86bd842f95729e8e910f5563fa6eb08766c453079dc190e14461f5c1
[INFO] running `Command { std: "docker" "start" "-a" "c679b8bf86bd842f95729e8e910f5563fa6eb08766c453079dc190e14461f5c1", kill_on_drop: false }`
[INFO] [stderr]    Compiling chip-8 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: panic message is not a string literal
[INFO] [stdout]   --> src/main.rs:49:26
[INFO] [stdout]    |
[INFO] [stdout] 49 |         Err(f) => panic!(f.to_string()),
[INFO] [stdout]    |                          ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(non_fmt_panics)]` on by default
[INFO] [stdout]    = note: this usage of panic!() is deprecated; it will be a hard error in Rust 2021
[INFO] [stdout]    = note: for more information, see <https://doc.rust-lang.org/nightly/edition-guide/rust-2021/panic-macro-consistency.html>
[INFO] [stdout] help: add a "{}" format string to Display the message
[INFO] [stdout]    |
[INFO] [stdout] 49 |         Err(f) => panic!("{}", f.to_string()),
[INFO] [stdout]    |                          +++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.68s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/chip_8-5b3c13b804848bf3)
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/chip_8-d4d094459e10191a)
[INFO] running `Command { std: "docker" "inspect" "c679b8bf86bd842f95729e8e910f5563fa6eb08766c453079dc190e14461f5c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c679b8bf86bd842f95729e8e910f5563fa6eb08766c453079dc190e14461f5c1", kill_on_drop: false }`
[INFO] [stdout] c679b8bf86bd842f95729e8e910f5563fa6eb08766c453079dc190e14461f5c1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-29/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" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 168b81abfb131ffe5a0946e2bb8e090be1c000b4c9095baa2ce655c3012cfd6a
[INFO] running `Command { std: "docker" "start" "-a" "168b81abfb131ffe5a0946e2bb8e090be1c000b4c9095baa2ce655c3012cfd6a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stdout] 
[INFO] [stderr] warning: panic message is not a string literal
[INFO] [stdout] running 45 tests
[INFO] [stderr]   --> src/main.rs:49:26
[INFO] [stdout] test tests::test_add_vx_to_i_with_no_overflow ... ok
[INFO] [stderr]    |
[INFO] [stdout] test tests::test_add_nn_to_vx ... ok
[INFO] [stderr] 49 |         Err(f) => panic!(f.to_string()),
[INFO] [stdout] test tests::test_add_vx_to_i_with_overflow ... ok
[INFO] [stderr]    |                          ^^^^^^^^^^^^^
[INFO] [stdout] test tests::test_add_nn_to_vx_wrapping ... ok
[INFO] [stderr]    |
[INFO] [stdout] test tests::test_add_vy_to_vx_with_carry ... ok
[INFO] [stderr]    = note: `#[warn(non_fmt_panics)]` on by default
[INFO] [stdout] test tests::test_add_vy_to_vx_without_carry ... ok
[INFO] [stderr]    = note: this usage of panic!() is deprecated; it will be a hard error in Rust 2021
[INFO] [stdout] test tests::test_call_subroutine_at_nnn ... ok
[INFO] [stderr]    = note: for more information, see <https://doc.rust-lang.org/nightly/edition-guide/rust-2021/panic-macro-consistency.html>
[INFO] [stdout] test tests::test_clear_screen ... ok
[INFO] [stderr] help: add a "{}" format string to Display the message
[INFO] [stdout] test tests::test_draw_sprite_at_x_y_with_height_n_with_no_collision ... ok
[INFO] [stderr]    |
[INFO] [stdout] test tests::test_jump_to_nnn_plus_v0 ... ok
[INFO] [stderr] 49 |         Err(f) => panic!("{}", f.to_string()),
[INFO] [stdout] test tests::test_draw_sprite_at_x_y_with_height_n_with_collision ... ok
[INFO] [stderr]    |                          +++++
[INFO] [stdout] test tests::test_load_program_that_is_too_big ... ok
[INFO] [stderr] 
[INFO] [stdout] test tests::test_jump_to_address ... ok
[INFO] [stderr] warning: `chip-8` (bin "chip-8" test) generated 1 warning
[INFO] [stdout] test tests::test_fill_v0_to_vx_with_values_from_memory_starting_at_address_i ... ok
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.56s
[INFO] [stdout] test tests::test_load_program ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/chip_8-5b3c13b804848bf3)
[INFO] [stdout] test tests::test_set_i_to_address_nnn ... ok
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/chip_8-d4d094459e10191a)
[INFO] [stdout] test tests::test_return_from_subroutine ... ok
[INFO] [stderr]    Doc-tests chip-8
[INFO] [stdout] test tests::test_set_vx_to_vx_and_vy ... ok
[INFO] [stdout] test tests::test_set_delay_timer_to_vx ... ok
[INFO] [stdout] test tests::test_set_i_to_location_of_sprite_for_character_in_vx ... ok
[INFO] [stdout] test tests::test_set_sound_timer_to_vx ... ok
[INFO] [stdout] test tests::test_set_vx_to_value_of_vy ... ok
[INFO] [stdout] test tests::test_set_vx_to_value_of_delay_timer ... ok
[INFO] [stdout] test tests::test_set_vx_to_nn ... ok
[INFO] [stdout] test tests::test_set_vx_to_vx_or_vy ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_key_in_vx_is_pressed_positive ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_key_in_vx_is_pressed_negative ... ok
[INFO] [stdout] test tests::test_set_vx_to_vx_xor_vy ... ok
[INFO] [stdout] test tests::test_set_vx_to_vy_minus_vx_with_borrow ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_key_in_vx_is_not_pressed_positive ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_key_in_vx_is_not_pressed_negative ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_does_not_equal_nn_negative ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_does_not_equal_vy_positive ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_does_not_equal_nn_positive ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_equals_nn_negative ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_does_not_equal_vy_negative ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_equals_nn_positive ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_equals_vy_negative ... ok
[INFO] [stdout] test tests::test_skip_next_instruction_if_vx_equals_vy_positive ... ok
[INFO] [stdout] test tests::test_store_binary_coded_decimal_representation_of_vx ... ok
[INFO] [stdout] test tests::test_store_least_significant_bit_of_vx_in_vf_and_shift_vx_right_by_1 ... ok
[INFO] [stdout] test tests::test_store_most_significant_bit_of_vx_in_vf_and_shift_vx_right_by_1 ... ok
[INFO] [stdout] test tests::test_wait_for_keypress ... ok
[INFO] [stdout] test tests::test_store_v0_to_vx_in_memory_starting_at_address_i ... ok
[INFO] [stdout] test tests::test_subtract_vy_from_vx_with_borrow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 45 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[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] [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" "168b81abfb131ffe5a0946e2bb8e090be1c000b4c9095baa2ce655c3012cfd6a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "168b81abfb131ffe5a0946e2bb8e090be1c000b4c9095baa2ce655c3012cfd6a", kill_on_drop: false }`
[INFO] [stdout] 168b81abfb131ffe5a0946e2bb8e090be1c000b4c9095baa2ce655c3012cfd6a