Dec 13 20:57:25.306 INFO testing drewchandler/nes-rs against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 20:57:25.308 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 13 20:57:25.535 INFO [stdout] 89c7f30f64eea1eab7ed0f461a0fd02ca18ab126bc78e1cd2de5a2fcab61ffe8
Dec 13 20:57:25.537 INFO running `"docker" "start" "-a" "89c7f30f64eea1eab7ed0f461a0fd02ca18ab126bc78e1cd2de5a2fcab61ffe8"`
Dec 13 20:57:26.295 INFO [stderr] usermod: no changes
Dec 13 20:57:26.411 INFO [stderr]    Compiling nes-rs v0.1.0 (/source)
Dec 13 20:57:27.323 INFO [stderr] warning: unreachable pattern
Dec 13 20:57:27.323 INFO [stderr]  --> src/ppu/vram.rs:9:9
Dec 13 20:57:27.323 INFO [stderr]   |
Dec 13 20:57:27.323 INFO [stderr] 9 |         _ => panic!("UNIMPLEMENTED ADDR {:x}", addr),
Dec 13 20:57:27.323 INFO [stderr]   |         ^
Dec 13 20:57:27.323 INFO [stderr]   |
Dec 13 20:57:27.323 INFO [stderr]   = note: #[warn(unreachable_patterns)] on by default
Dec 13 20:57:27.323 INFO [stderr] 
Dec 13 20:57:27.427 INFO [stderr] warning: method is never used: `interrupt_disable`
Dec 13 20:57:27.427 INFO [stderr]    --> src/cpu/mod.rs:271:5
Dec 13 20:57:27.427 INFO [stderr]     |
Dec 13 20:57:27.427 INFO [stderr] 271 |     fn interrupt_disable(&self) -> bool {
Dec 13 20:57:27.427 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:27.427 INFO [stderr]     |
Dec 13 20:57:27.427 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 13 20:57:27.427 INFO [stderr] 
Dec 13 20:57:27.427 INFO [stderr] warning: method is never used: `decimal_mode`
Dec 13 20:57:27.427 INFO [stderr]    --> src/cpu/mod.rs:283:5
Dec 13 20:57:27.427 INFO [stderr]     |
Dec 13 20:57:27.427 INFO [stderr] 283 |     fn decimal_mode(&self) -> bool {
Dec 13 20:57:27.427 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:27.427 INFO [stderr] 
Dec 13 20:57:27.427 INFO [stderr] warning: method is never used: `break_command`
Dec 13 20:57:27.427 INFO [stderr]    --> src/cpu/mod.rs:295:5
Dec 13 20:57:27.427 INFO [stderr]     |
Dec 13 20:57:27.427 INFO [stderr] 295 |     fn break_command(&self) -> bool {
Dec 13 20:57:27.427 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:27.427 INFO [stderr] 
Dec 13 20:57:28.315 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.97s
Dec 13 20:57:28.315 INFO [stderr] su: No module specific data is present
Dec 13 20:57:29.482 INFO running `"docker" "inspect" "89c7f30f64eea1eab7ed0f461a0fd02ca18ab126bc78e1cd2de5a2fcab61ffe8"`
Dec 13 20:57:29.892 INFO running `"docker" "rm" "-f" "89c7f30f64eea1eab7ed0f461a0fd02ca18ab126bc78e1cd2de5a2fcab61ffe8"`
Dec 13 20:57:30.331 INFO [stdout] 89c7f30f64eea1eab7ed0f461a0fd02ca18ab126bc78e1cd2de5a2fcab61ffe8
Dec 13 20:57:30.339 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 13 20:57:30.735 INFO [stdout] f52962987b00bf57eaf2d6ae62270f8c82e4a8e0a382ad9b6e0df5c40cbcaea4
Dec 13 20:57:30.735 INFO running `"docker" "start" "-a" "f52962987b00bf57eaf2d6ae62270f8c82e4a8e0a382ad9b6e0df5c40cbcaea4"`
Dec 13 20:57:31.779 INFO [stderr] usermod: no changes
Dec 13 20:57:31.891 INFO [stderr]    Compiling nes-rs v0.1.0 (/source)
Dec 13 20:57:34.335 INFO [stderr] warning: unreachable pattern
Dec 13 20:57:34.335 INFO [stderr]  --> src/ppu/vram.rs:9:9
Dec 13 20:57:34.335 INFO [stderr]   |
Dec 13 20:57:34.335 INFO [stderr] 9 |         _ => panic!("UNIMPLEMENTED ADDR {:x}", addr),
Dec 13 20:57:34.335 INFO [stderr]   |         ^
Dec 13 20:57:34.335 INFO [stderr]   |
Dec 13 20:57:34.335 INFO [stderr]   = note: #[warn(unreachable_patterns)] on by default
Dec 13 20:57:34.335 INFO [stderr] 
Dec 13 20:57:35.251 INFO [stderr] warning: method is never used: `interrupt_disable`
Dec 13 20:57:35.251 INFO [stderr]    --> src/cpu/mod.rs:271:5
Dec 13 20:57:35.251 INFO [stderr]     |
Dec 13 20:57:35.251 INFO [stderr] 271 |     fn interrupt_disable(&self) -> bool {
Dec 13 20:57:35.251 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:35.251 INFO [stderr]     |
Dec 13 20:57:35.251 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 13 20:57:35.251 INFO [stderr] 
Dec 13 20:57:35.251 INFO [stderr] warning: method is never used: `decimal_mode`
Dec 13 20:57:35.251 INFO [stderr]    --> src/cpu/mod.rs:283:5
Dec 13 20:57:35.251 INFO [stderr]     |
Dec 13 20:57:35.251 INFO [stderr] 283 |     fn decimal_mode(&self) -> bool {
Dec 13 20:57:35.251 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:35.251 INFO [stderr] 
Dec 13 20:57:35.251 INFO [stderr] warning: method is never used: `break_command`
Dec 13 20:57:35.251 INFO [stderr]    --> src/cpu/mod.rs:295:5
Dec 13 20:57:35.251 INFO [stderr]     |
Dec 13 20:57:35.251 INFO [stderr] 295 |     fn break_command(&self) -> bool {
Dec 13 20:57:35.251 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 20:57:35.251 INFO [stderr] 
Dec 13 20:57:38.377 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.56s
Dec 13 20:57:38.381 INFO [stderr] su: No module specific data is present
Dec 13 20:57:38.748 INFO running `"docker" "inspect" "f52962987b00bf57eaf2d6ae62270f8c82e4a8e0a382ad9b6e0df5c40cbcaea4"`
Dec 13 20:57:38.840 INFO running `"docker" "rm" "-f" "f52962987b00bf57eaf2d6ae62270f8c82e4a8e0a382ad9b6e0df5c40cbcaea4"`
Dec 13 20:57:38.953 INFO [stdout] f52962987b00bf57eaf2d6ae62270f8c82e4a8e0a382ad9b6e0df5c40cbcaea4
Dec 13 20:57:38.958 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 13 20:57:39.152 INFO [stdout] cf609c4d58e1537a0022cbf8ffda00ce8619f0bec2a195f98e6d34db54a6845d
Dec 13 20:57:39.154 INFO running `"docker" "start" "-a" "cf609c4d58e1537a0022cbf8ffda00ce8619f0bec2a195f98e6d34db54a6845d"`
Dec 13 20:57:39.724 INFO [stderr] usermod: no changes
Dec 13 20:57:39.803 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 13 20:57:39.803 INFO [stderr]      Running /target/debug/deps/nes_rs-c55bd7ee45dcf9ea
Dec 13 20:57:39.803 INFO [stdout] 
Dec 13 20:57:39.803 INFO [stdout] running 60 tests
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_bcc ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_asl ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_adc ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_bpl ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_brk ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_bne ... ok
Dec 13 20:57:39.803 INFO [stdout] test cpu::tests::test_bvs ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_cld ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_bit ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_bvc ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_bmi ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_bcs ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_cli ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_clc ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_dex ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_cpx ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_dey ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_beq ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_dec ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_cpy ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_inc ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_eor ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_inx ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_jsr ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_ldy ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_lda ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_clv ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_iny ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_ldx ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_cmp ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_jmp ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_and ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_pla ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_rol ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_ror ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_rti ... ok
Dec 13 20:57:39.804 INFO [stdout] test cpu::tests::test_rts ... ok
Dec 13 20:57:39.814 INFO [stdout] test cpu::tests::test_nop ... ok
Dec 13 20:57:39.814 INFO [stdout] test cpu::tests::test_ora ... ok
Dec 13 20:57:39.814 INFO [stdout] test cpu::tests::test_sei ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_sed ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_pha ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_lsr ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_php ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_sec ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_plp ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_sbc ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_sta ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_stx ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_tay ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_sty ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_txa ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_tsx ... ok
Dec 13 20:57:39.816 INFO [stdout] test cpu::tests::test_tax ... ok
Dec 13 20:57:39.817 INFO [stdout] test ppu::tests::test_writing_to_spr_ram ... ok
Dec 13 20:57:39.817 INFO [stdout] test cpu::tests::test_txs ... ok
Dec 13 20:57:39.817 INFO [stdout] test ppu::tests::test_writing_to_vram ... ok
Dec 13 20:57:39.820 INFO [stdout] test cpu::tests::test_tya ... ok
Dec 13 20:57:39.820 INFO [stdout] test ppu::tests::test_write_ctrl ... ok
Dec 13 20:57:39.820 INFO [stdout] test ppu::tests::test_write_scroll ... ok
Dec 13 20:57:39.820 INFO [stdout] 
Dec 13 20:57:39.820 INFO [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 20:57:39.820 INFO [stdout] 
Dec 13 20:57:39.822 INFO [stderr] su: No module specific data is present
Dec 13 20:57:40.176 INFO running `"docker" "inspect" "cf609c4d58e1537a0022cbf8ffda00ce8619f0bec2a195f98e6d34db54a6845d"`
Dec 13 20:57:40.277 INFO running `"docker" "rm" "-f" "cf609c4d58e1537a0022cbf8ffda00ce8619f0bec2a195f98e6d34db54a6845d"`
Dec 13 20:57:40.405 INFO [stdout] cf609c4d58e1537a0022cbf8ffda00ce8619f0bec2a195f98e6d34db54a6845d