[INFO] cloning repository quelledanielle/rusty_chip
[INFO] running `"git" "clone" "--bare" "git://github.com/quelledanielle/rusty_chip.git" "work/cache/sources/gh/quelledanielle/rusty_chip"`
[INFO] [stderr] Cloning into bare repository 'work/cache/sources/gh/quelledanielle/rusty_chip'...
[INFO] running `"git" "clone" "work/cache/sources/gh/quelledanielle/rusty_chip" "work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/quelledanielle/rusty_chip"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/quelledanielle/rusty_chip'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/quelledanielle/rusty_chip" "work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/quelledanielle/rusty_chip"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/quelledanielle/rusty_chip'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 28e597442290fcfdc90891e2997ee1a0c0c3415f
[INFO] sha for GitHub repo quelledanielle/rusty_chip: 28e597442290fcfdc90891e2997ee1a0c0c3415f
[INFO] validating manifest of quelledanielle/rusty_chip 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 quelledanielle/rusty_chip 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 quelledanielle/rusty_chip
[INFO] finished frobbing quelledanielle/rusty_chip
[INFO] frobbed toml for quelledanielle/rusty_chip written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/quelledanielle/rusty_chip/Cargo.toml
[INFO] started frobbing quelledanielle/rusty_chip
[INFO] finished frobbing quelledanielle/rusty_chip
[INFO] frobbed toml for quelledanielle/rusty_chip written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/quelledanielle/rusty_chip/Cargo.toml
[INFO] crate quelledanielle/rusty_chip 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] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing quelledanielle/rusty_chip 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/quelledanielle/rusty_chip:/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] 6365518b9f87e2d2272385113771d3611cbfefdeb7172c3bd1ae4f109c48d88c
[INFO] running `"docker" "start" "-a" "6365518b9f87e2d2272385113771d3611cbfefdeb7172c3bd1ae4f109c48d88c"`
[INFO] [stderr]    Compiling rand v0.4.2
[INFO] [stderr]    Compiling rand v0.3.22
[INFO] [stderr]    Compiling rusty_chip v0.1.0 (/opt/crater/workdir)
[INFO] [stderr] warning: the feature `range_contains` has been stable since 1.35.0 and no longer requires an attribute to enable
[INFO] [stderr]  --> src/lib.rs:1:12
[INFO] [stderr]   |
[INFO] [stderr] 1 | #![feature(range_contains)]
[INFO] [stderr]   |            ^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: #[warn(stable_features)] on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.03s
[INFO] running `"docker" "inspect" "6365518b9f87e2d2272385113771d3611cbfefdeb7172c3bd1ae4f109c48d88c"`
[INFO] running `"docker" "rm" "-f" "6365518b9f87e2d2272385113771d3611cbfefdeb7172c3bd1ae4f109c48d88c"`
[INFO] [stdout] 6365518b9f87e2d2272385113771d3611cbfefdeb7172c3bd1ae4f109c48d88c
[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/quelledanielle/rusty_chip:/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] 1d00c3ec3b54c143c56d8d038f0186cb963fc6599a71b778c439963585779636
[INFO] running `"docker" "start" "-a" "1d00c3ec3b54c143c56d8d038f0186cb963fc6599a71b778c439963585779636"`
[INFO] [stderr]    Compiling rusty_chip v0.1.0 (/opt/crater/workdir)
[INFO] [stderr] warning: the feature `range_contains` has been stable since 1.35.0 and no longer requires an attribute to enable
[INFO] [stderr]  --> src/lib.rs:1:12
[INFO] [stderr]   |
[INFO] [stderr] 1 | #![feature(range_contains)]
[INFO] [stderr]   |            ^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: #[warn(stable_features)] on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.16s
[INFO] running `"docker" "inspect" "1d00c3ec3b54c143c56d8d038f0186cb963fc6599a71b778c439963585779636"`
[INFO] running `"docker" "rm" "-f" "1d00c3ec3b54c143c56d8d038f0186cb963fc6599a71b778c439963585779636"`
[INFO] [stdout] 1d00c3ec3b54c143c56d8d038f0186cb963fc6599a71b778c439963585779636
[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/quelledanielle/rusty_chip:/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] 37eb45dbcf6727aeb1da2620ca6c73cae283266d0db7ac08f7135b11fe299c31
[INFO] running `"docker" "start" "-a" "37eb45dbcf6727aeb1da2620ca6c73cae283266d0db7ac08f7135b11fe299c31"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rusty_chip-a93d73e7a9c6145f
[INFO] [stdout] 
[INFO] [stdout] running 87 tests
[INFO] [stdout] test cpu::opcode::tests::mask_kk ... ok
[INFO] [stdout] test cpu::opcode::tests::mask_k ... ok
[INFO] [stdout] test cpu::opcode::tests::mask_first_hex_digit ... ok
[INFO] [stdout] test cpu::pointer::tests::move_forward_adds_2_to_current ... ok
[INFO] [stdout] test cpu::tests::beep_while_sound_timer_active ... ok
[INFO] [stdout] test cpu::pointer::tests::set_current ... ok
[INFO] [stdout] test cpu::pointer::tests::current_defaults_to_range_start ... ok
[INFO] [stdout] test cpu::pointer::tests::move_backward_subtracts_2_from_current ... ok
[INFO] [stdout] test cpu::opcode::tests::mask_y ... ok
[INFO] [stdout] test cpu::opcode::tests::mask_nnn ... ok
[INFO] [stdout] test cpu::opcode::tests::mask_x ... ok
[INFO] [stdout] test cpu::tests::fetch_opcode_fetches_two_current_bytes ... ok
[INFO] [stdout] test cpu::tests::operation_3xkk_skip_equal_vx_byte ... ok
[INFO] [stdout] test cpu::tests::operation_3xkk_skip_equal_vx_byte_no_skip ... ok
[INFO] [stdout] test cpu::tests::new_loads_rom_to_memory ... ok
[INFO] [stdout] test cpu::tests::operation_00e0_clear_display ... ok
[INFO] [stdout] test cpu::tests::operation_00ee_return_from_subroutine ... ok
[INFO] [stdout] test cpu::tests::new_loads_font_to_memory ... ok
[INFO] [stdout] test cpu::tests::operation_1nnn_jump_addr ... ok
[INFO] [stdout] test cpu::tests::operation_0000_no_op ... ok
[INFO] [stdout] test cpu::tests::operation_4xkk_skip_not_equal_vx_byte_no_skip ... ok
[INFO] [stdout] test cpu::tests::operation_5xy0_skip_equal_vx_vy_no_skip ... ok
[INFO] [stdout] test cpu::tests::operation_7xkk_add_vx_byte ... ok
[INFO] [stdout] test cpu::tests::operation_6xkk_load_vx_byte ... ok
[INFO] [stdout] test cpu::tests::operation_5xy0_skip_equal_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_4xkk_skip_not_equal_vx_byte ... ok
[INFO] [stdout] test cpu::tests::operation_2nnn_call_subroutine ... ok
[INFO] [stdout] test cpu::tests::operation_7xkk_add_vx_byte_wrap ... ok
[INFO] [stdout] test cpu::tests::operation_8xy0_load_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_8xy2_and_vx_vy_01 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy2_and_vx_vy_00 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy2_and_vx_vy_11 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy3_xor_vx_vy_00 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy3_xor_vx_vy_10 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy3_xor_vx_vy_01 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy3_xor_vx_vy_11 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy1_or_vx_vy_10 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy5_sub_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_8xy4_add_vx_vy_carry ... ok
[INFO] [stdout] test cpu::tests::operation_8xy1_or_vx_vy_01 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy5_sub_vx_vy_carry ... ok
[INFO] [stdout] test cpu::tests::operation_8xy2_and_vx_vy_10 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy1_or_vx_vy_00 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy1_or_vx_vy_11 ... ok
[INFO] [stdout] test cpu::tests::operation_8xy6_shr_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_8xy4_add_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_annn_load_i_addr ... ok
[INFO] [stdout] test cpu::tests::operation_8xy7_subn_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_bnnn_jump_v0_addr ... ok
[INFO] [stdout] test cpu::tests::operation_cxkk_rand_vx_byte ... ok
[INFO] [stdout] test cpu::tests::operation_9xy0_skip_not_equal_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_9xy0_skip_not_equal_vx_vy_no_skip ... ok
[INFO] [stdout] test cpu::tests::operation_dxyn_draw_vx_vy_n ... ok
[INFO] [stdout] test cpu::tests::operation_8xy6_shr_vx_vy_sig_bit ... ok
[INFO] [stdout] test cpu::tests::operation_dxyn_draw_vx_vy_n_collision ... ok
[INFO] [stdout] test cpu::tests::operation_8xye_shl_vx_vy ... ok
[INFO] [stdout] test cpu::tests::operation_fx15_load_dt_vx ... ok
[INFO] [stdout] test cpu::tests::operation_8xye_shl_vx_vy_sig_bit ... ok
[INFO] [stdout] test cpu::tests::operation_8xy7_subn_vx_vy_carry ... ok
[INFO] [stdout] test cpu::tests::operation_dxyn_draw_vx_vy_n_with_vy_wrap ... ok
[INFO] [stdout] test cpu::tests::operation_fx55_load_through_vx ... ok
[INFO] [stdout] test cpu::tests::operation_fx18_load_st_vx ... ok
[INFO] [stdout] test cpu::tests::operation_dxyn_draw_vx_vy_n_with_vx_wrap ... ok
[INFO] [stdout] test cpu::tests::operation_fx65_read_through_vx ... ok
[INFO] [stdout] test cpu::timer::tests::init_inactive ... ok
[INFO] [stdout] test cpu::timer::tests::init_active ... ok
[INFO] [stdout] test cpu::timer::tests::tick_inactive_no_op ... ok
[INFO] [stdout] test cpu::tests::operation_fx29_load_i_vx_font ... ok
[INFO] [stdout] test cpu::tests::operation_fx33_load_bcd_vx ... ok
[INFO] [stdout] test cpu::timer::tests::set_current_value ... ok
[INFO] [stdout] test memory::tests::load_data_with_len_equal_range ... ok
[INFO] [stdout] test memory::tests::load_data_with_len_less_than_range ... ok
[INFO] [stdout] test output::graphics::tests::clear_display ... ok
[INFO] [stdout] test output::graphics::tests::new_display ... ok
[INFO] [stdout] test output::graphics::tests::draw_resets_redraw_to_false ... ok
[INFO] [stdout] test cpu::tests::operation_fx1e_add_i_vx ... ok
[INFO] [stdout] test output::graphics::tests::read_pixel_value ... ok
[INFO] [stdout] test cpu::tests::operation_fx07_load_vx_dt ... ok
[INFO] [stdout] test output::graphics::tests::update_pixel_true_xor_false ... ok
[INFO] [stdout] test output::graphics::tests::update_pixel_false_xor_false ... ok
[INFO] [stdout] test output::graphics::tests::update_pixel_false_xor_true ... ok
[INFO] [stdout] test output::graphics::tests::read_pixel_value_wrap ... ok
[INFO] [stdout] test output::graphics::tests::update_pixel_wrap ... ok
[INFO] [stdout] test output::graphics::tests::update_pixel_true_xor_true ... ok
[INFO] [stdout] test cpu::timer::tests::tick_deactivates_at_zero ... ok
[INFO] [stdout] test memory::tests::load_data_with_len_greater_than_range_panics ... ok
[INFO] [stdout] test cpu::timer::tests::tick_active_decrements_current_at_rate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 87 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rusty_chip-779c0e36ab5b2f68
[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
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rusty_chip
[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
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "37eb45dbcf6727aeb1da2620ca6c73cae283266d0db7ac08f7135b11fe299c31"`
[INFO] running `"docker" "rm" "-f" "37eb45dbcf6727aeb1da2620ca6c73cae283266d0db7ac08f7135b11fe299c31"`
[INFO] [stdout] 37eb45dbcf6727aeb1da2620ca6c73cae283266d0db7ac08f7135b11fe299c31