Nov 16 20:41:33.333 INFO testing mafraba/chip8r against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 20:41:33.333 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 20:41:33.987 INFO [stdout] 02bd27d038debee982af45ab39b1a970682a13e67ac84e550c68b734a7ab7aad
Nov 16 20:41:33.990 INFO running `"docker" "start" "-a" "02bd27d038debee982af45ab39b1a970682a13e67ac84e550c68b734a7ab7aad"`
Nov 16 20:41:35.706 INFO [stderr] usermod: no changes
Nov 16 20:41:35.815 INFO [stderr]    Compiling term_size v0.2.3
Nov 16 20:41:35.815 INFO [stderr]    Compiling termion v1.5.1
Nov 16 20:41:35.815 INFO [stderr]    Compiling chan v0.1.19
Nov 16 20:41:36.439 INFO [stderr]    Compiling clap v2.19.3
Nov 16 20:41:55.690 INFO [stderr]    Compiling chip8r v0.1.0 (/source)
Nov 16 20:41:59.053 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.31s
Nov 16 20:41:59.059 INFO [stderr] su: No module specific data is present
Nov 16 20:41:59.816 INFO running `"docker" "inspect" "02bd27d038debee982af45ab39b1a970682a13e67ac84e550c68b734a7ab7aad"`
Nov 16 20:42:00.125 INFO running `"docker" "rm" "-f" "02bd27d038debee982af45ab39b1a970682a13e67ac84e550c68b734a7ab7aad"`
Nov 16 20:42:00.475 INFO [stdout] 02bd27d038debee982af45ab39b1a970682a13e67ac84e550c68b734a7ab7aad
Nov 16 20:42:00.485 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 20:42:00.877 INFO [stdout] d7ab51c6891872a0e60a3c6de2d2758f4d86f9cd4fcd37726b2bc96e376585e1
Nov 16 20:42:00.878 INFO running `"docker" "start" "-a" "d7ab51c6891872a0e60a3c6de2d2758f4d86f9cd4fcd37726b2bc96e376585e1"`
Nov 16 20:42:02.275 INFO [stderr] usermod: no changes
Nov 16 20:42:02.375 INFO [stderr]    Compiling chip8r v0.1.0 (/source)
Nov 16 20:42:06.116 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.81s
Nov 16 20:42:06.120 INFO [stderr] su: No module specific data is present
Nov 16 20:42:07.867 INFO running `"docker" "inspect" "d7ab51c6891872a0e60a3c6de2d2758f4d86f9cd4fcd37726b2bc96e376585e1"`
Nov 16 20:42:08.273 INFO running `"docker" "rm" "-f" "d7ab51c6891872a0e60a3c6de2d2758f4d86f9cd4fcd37726b2bc96e376585e1"`
Nov 16 20:42:08.575 INFO [stdout] d7ab51c6891872a0e60a3c6de2d2758f4d86f9cd4fcd37726b2bc96e376585e1
Nov 16 20:42:08.580 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 20:42:09.042 INFO [stdout] 8b1da65ce9d7db7692098c4b53a391285eab5d67daeeee0e3c9f4619a59abef8
Nov 16 20:42:09.047 INFO running `"docker" "start" "-a" "8b1da65ce9d7db7692098c4b53a391285eab5d67daeeee0e3c9f4619a59abef8"`
Nov 16 20:42:10.626 INFO [stderr] usermod: no changes
Nov 16 20:42:10.727 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 16 20:42:10.747 INFO [stderr]      Running /target/debug/deps/chip8r-e864b3c03882f1af
Nov 16 20:42:10.747 INFO [stdout] 
Nov 16 20:42:10.748 INFO [stdout] running 69 tests
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::draw_byte_no_collision ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::draw_byte_with_collision ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::draw_sprite_no_collision ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::keyboard::tests::key_pressed_event ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::termui::tests::display_bench ... ignored
Nov 16 20:42:10.750 INFO [stdout] test chip8::keyboard::tests::initial_key_state_is_false ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::flip_unset_pixel ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::draw_sprite_with_collision ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::display::tests::flip_set_pixel ... ok
Nov 16 20:42:10.750 INFO [stdout] test chip8::keyboard::tests::key_released_event ... ok
Nov 16 20:42:10.753 INFO [stdout] test chip8::benchs::decrease_timers_bench ... ok
Nov 16 20:42:10.753 INFO [stdout] test chip8::benchs::instruction_execution_bench ... ok
Nov 16 20:42:10.754 INFO [stdout] test chip8::tests::add_immediate ... ok
Nov 16 20:42:10.756 INFO [stdout] test chip8::tests::binary_coded_decimal_conversion ... ok
Nov 16 20:42:10.756 INFO [stdout] test chip8::tests::and_register ... ok
Nov 16 20:42:10.756 INFO [stdout] test chip8::tests::add_registers_no_carry ... ok
Nov 16 20:42:10.756 INFO [stdout] test chip8::tests::add_registers_carry ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::draw_sprite_no_collision ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::clear_screen_instruction ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::add_register_to_i ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::dump_some_registers ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::dump_all_registers ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::decrease_timers ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::call_instruction ... ok
Nov 16 20:42:10.771 INFO [stdout] test chip8::tests::draw_sprite_with_collision ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::font_sprites_are_loaded ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::load_data ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::load_all_registers ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::load_some_registers ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::load_immediate ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::jump_instruction ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::indexed_jump_instruction ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::masked_random ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::key_arrives_while_waiting_for_key ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::move_delay_timer_value_to_register ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::read_instruction ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::or_register ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::move_register ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::read_return_address ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::nibble_extraction ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::return_from_subroutine_instruction ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::set_delay_timer ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::set_i ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::set_sound_timer ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::shl_register_carry ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::shl_register_no_carry ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::shr_register_carry ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::shr_register_no_carry ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_equals_immediate_negative ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_equals_immediate_positive ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_equals_registers_negative ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_equals_registers_positive ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_not_pressed_when_not_pressed ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_not_pressed_when_pressed ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_not_pressed_when_released ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_pressed_negative_case ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_pressed_negative_case_after_release ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_key_pressed_positive_case ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_registers_not_equal_positive ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::sub_registers_borrow ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::sub_registers_no_borrow ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::subn_registers_borrow ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::skip_if_not_equals_immediate_negative ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::subn_registers_no_borrow ... ok
Nov 16 20:42:10.775 INFO [stdout] test chip8::tests::wait_for_key ... ok
Nov 16 20:42:10.781 INFO [stdout] test chip8::tests::xor_register ... ok
Nov 16 20:42:10.781 INFO [stdout] test chip8::tests::location_of_sprite ... ok
Nov 16 20:42:10.781 INFO [stdout] test chip8::tests::skip_if_registers_not_equal_negative ... ok
Nov 16 20:42:10.781 INFO [stdout] test chip8::tests::skip_if_not_equals_immediate_positive ... ok
Nov 16 20:42:10.781 INFO [stdout] 
Nov 16 20:42:10.781 INFO [stdout] test result: ok. 68 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Nov 16 20:42:10.781 INFO [stdout] 
Nov 16 20:42:10.787 INFO [stderr] su: No module specific data is present
Nov 16 20:42:11.983 INFO running `"docker" "inspect" "8b1da65ce9d7db7692098c4b53a391285eab5d67daeeee0e3c9f4619a59abef8"`
Nov 16 20:42:12.335 INFO running `"docker" "rm" "-f" "8b1da65ce9d7db7692098c4b53a391285eab5d67daeeee0e3c9f4619a59abef8"`
Nov 16 20:42:12.704 INFO [stdout] 8b1da65ce9d7db7692098c4b53a391285eab5d67daeeee0e3c9f4619a59abef8