[INFO] cloning repository machinetech/chip8
[INFO] running `"git" "clone" "--bare" "git://github.com/machinetech/chip8.git" "work/cache/sources/gh/machinetech/chip8"`
[INFO] [stderr] Cloning into bare repository 'work/cache/sources/gh/machinetech/chip8'...
[INFO] running `"git" "clone" "work/cache/sources/gh/machinetech/chip8" "work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/machinetech/chip8"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/machinetech/chip8'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/machinetech/chip8" "work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 1675db84df597274394935091bef2b0b62c258a8
[INFO] sha for GitHub repo machinetech/chip8: 1675db84df597274394935091bef2b0b62c258a8
[INFO] validating manifest of machinetech/chip8 on toolchain master#c8865d8e195813ade6b84434ac9f8850e7112d1a
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of machinetech/chip8 on toolchain try#e212b7d492c96d3837691ba29d32d5f468933fb8
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing machinetech/chip8
[INFO] finished frobbing machinetech/chip8
[INFO] frobbed toml for machinetech/chip8 written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/machinetech/chip8/Cargo.toml
[INFO] started frobbing machinetech/chip8
[INFO] finished frobbing machinetech/chip8
[INFO] frobbed toml for machinetech/chip8 written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8/Cargo.toml
[INFO] crate machinetech/chip8 already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] [stderr] error: the lock file /mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/machinetech/chip8/Cargo.lock needs to be updated but --locked was passed to prevent this
[INFO] the lockfile is outdated, regenerating it
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing machinetech/chip8 against try#e212b7d492c96d3837691ba29d32d5f468933fb8 for pr-61629
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "build" "--frozen"`
[INFO] [stdout] 8a9cbd03cc7580fff5f9312e635e8e344eb0c68aae523cfd1e1794f219f9650a
[INFO] running `"docker" "start" "-a" "8a9cbd03cc7580fff5f9312e635e8e344eb0c68aae523cfd1e1794f219f9650a"`
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]    Compiling chip8 v1.0.2 (/opt/crater/workdir)
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]   --> src/main.rs:47:9
[INFO] [stderr]    |
[INFO] [stderr] 47 |         thread::sleep_ms(1);    
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/main.rs:139:9
[INFO] [stderr]     |
[INFO] [stderr] 139 |         thread::sleep_ms(1);    
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.14s
[INFO] running `"docker" "inspect" "8a9cbd03cc7580fff5f9312e635e8e344eb0c68aae523cfd1e1794f219f9650a"`
[INFO] running `"docker" "rm" "-f" "8a9cbd03cc7580fff5f9312e635e8e344eb0c68aae523cfd1e1794f219f9650a"`
[INFO] [stdout] 8a9cbd03cc7580fff5f9312e635e8e344eb0c68aae523cfd1e1794f219f9650a
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 1eba3b9ba3369a277ecf46cb0e85d823f0977a64e70fafc48dad0e444e904f96
[INFO] running `"docker" "start" "-a" "1eba3b9ba3369a277ecf46cb0e85d823f0977a64e70fafc48dad0e444e904f96"`
[INFO] [stderr]    Compiling chip8 v1.0.2 (/opt/crater/workdir)
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]   --> src/main.rs:47:9
[INFO] [stderr]    |
[INFO] [stderr] 47 |         thread::sleep_ms(1);    
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/main.rs:139:9
[INFO] [stderr]     |
[INFO] [stderr] 139 |         thread::sleep_ms(1);    
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_A` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1847:8
[INFO] [stderr]      |
[INFO] [stderr] 1847 |     fn test_opcode_dxyn_draw_font_A() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_a`
[INFO] [stderr]      |
[INFO] [stderr]      = note: #[warn(non_snake_case)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_B` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1868:8
[INFO] [stderr]      |
[INFO] [stderr] 1868 |     fn test_opcode_dxyn_draw_font_B() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_b`
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_C` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1889:8
[INFO] [stderr]      |
[INFO] [stderr] 1889 |     fn test_opcode_dxyn_draw_font_C() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_c`
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_D` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1910:8
[INFO] [stderr]      |
[INFO] [stderr] 1910 |     fn test_opcode_dxyn_draw_font_D() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_d`
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_E` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1931:8
[INFO] [stderr]      |
[INFO] [stderr] 1931 |     fn test_opcode_dxyn_draw_font_E() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_e`
[INFO] [stderr] 
[INFO] [stderr] warning: function `test_opcode_dxyn_draw_font_F` should have a snake case name
[INFO] [stderr]     --> src/chip8/emu.rs:1952:8
[INFO] [stderr]      |
[INFO] [stderr] 1952 |     fn test_opcode_dxyn_draw_font_F() {
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `test_opcode_dxyn_draw_font_f`
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.05s
[INFO] running `"docker" "inspect" "1eba3b9ba3369a277ecf46cb0e85d823f0977a64e70fafc48dad0e444e904f96"`
[INFO] running `"docker" "rm" "-f" "1eba3b9ba3369a277ecf46cb0e85d823f0977a64e70fafc48dad0e444e904f96"`
[INFO] [stdout] 1eba3b9ba3369a277ecf46cb0e85d823f0977a64e70fafc48dad0e444e904f96
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/try#e212b7d492c96d3837691ba29d32d5f468933fb8:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/machinetech/chip8:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "test" "--frozen"`
[INFO] [stdout] e3ad137c00f6acc2b5bc3a92148c07b50b47512fd44e038f66c4ab244f298c14
[INFO] running `"docker" "start" "-a" "e3ad137c00f6acc2b5bc3a92148c07b50b47512fd44e038f66c4ab244f298c14"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/chip8-904b296bcf84888c
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[INFO] [stdout] test chip8::emu::tests::test_opcode_00ff ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00e0 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00ee ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00fe ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00cn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_2nnn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_4xnn_given_vx_equals_nn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_3xnn_given_vx_equals_nn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00fb ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_3xnn_given_vx_not_equals_nn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_5xy0_given_vx_does_not_equal_vy ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_4xnn_given_vx_not_equals_nn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_00fc ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_5xy0_given_vx_equals_vy ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_7xnn_without_overflow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_1nnn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_6xnn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy2 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy1 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy0 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy4_with_carry ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_7xnn_with_overflow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy3 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy5_with_borrow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy6_least_significant_bit_not_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy4_without_carry ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy6_least_significant_bit_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy5_without_borrow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy6_orig_not_used_least_significant_bit_not_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy6_orig_not_used_least_significant_bit_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy7_with_borrow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xy7_without_borrow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xye_orig_not_used_most_significant_bit_not_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xye_orig_not_used_most_significant_bit_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xye_most_significant_bit_not_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_8xye_most_significant_bit_set ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_9xy0_vx_does_not_match_vy ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_9xy0_vx_matches_vy ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_annn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_bnnn ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_0 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_1 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_2 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_3 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_4 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_5 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_6 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_7 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_8 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_9 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_A ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_B ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_C ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_D ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_E ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_draw_font_F ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_overflow_height ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_overflow_width ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_simple_draw ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_simple_partial_redraw ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_dxyn_simple_undraw ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_ex9e_key_not_pressed ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_ex9e_key_pressed ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_exa1_key_not_pressed ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_exa1_key_pressed ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx07 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx0a_with_keypress ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx0a_without_keypress ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx15 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx18 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx1e_with_overflow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx1e_without_overflow ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx29 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx30 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx33 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx55 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx65 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx75 ... ok
[INFO] [stdout] test chip8::emu::tests::test_opcode_fx75_safe_against_x_greater_than_7 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "e3ad137c00f6acc2b5bc3a92148c07b50b47512fd44e038f66c4ab244f298c14"`
[INFO] running `"docker" "rm" "-f" "e3ad137c00f6acc2b5bc3a92148c07b50b47512fd44e038f66c4ab244f298c14"`
[INFO] [stdout] e3ad137c00f6acc2b5bc3a92148c07b50b47512fd44e038f66c4ab244f298c14