[INFO] cloning repository https://github.com/redforks/nes_sim
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/redforks/nes_sim" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fredforks%2Fnes_sim", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fredforks%2Fnes_sim'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 29df68547ed01ac02daeee3d09ce10780605086b
[INFO] testing redforks/nes_sim against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fredforks%2Fnes_sim" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-4-tc1/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/redforks/nes_sim
[INFO] finished tweaking git repo https://github.com/redforks/nes_sim
[INFO] tweaked toml for git repo https://github.com/redforks/nes_sim written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/redforks/nes_sim on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/redforks/nes_sim already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded uuid v0.2.3
[INFO] [stderr]   Downloaded rand v0.3.23
[INFO] [stderr]   Downloaded unicode-bidi v0.2.6
[INFO] [stderr]   Downloaded matches v0.1.10
[INFO] [stderr]   Downloaded predicates-core v1.0.10
[INFO] [stderr]   Downloaded rmcp-macros v0.3.2
[INFO] [stderr]   Downloaded test-log-macros v0.2.19
[INFO] [stderr]   Downloaded predicates-tree v1.0.13
[INFO] [stderr]   Downloaded md5 v0.8.0
[INFO] [stderr]   Downloaded env_filter v1.0.0
[INFO] [stderr]   Downloaded env_logger v0.11.9
[INFO] [stderr]   Downloaded mockall v0.14.0
[INFO] [stderr]   Downloaded predicates v3.1.4
[INFO] [stderr]   Downloaded fragile v2.1.0
[INFO] [stderr]   Downloaded arraydeque v0.5.1
[INFO] [stderr]   Downloaded schemars_derive v1.2.1
[INFO] [stderr]   Downloaded bitfield-struct v0.12.1
[INFO] [stderr]   Downloaded console_log v1.0.0
[INFO] [stderr]   Downloaded relative-path v1.9.3
[INFO] [stderr]   Downloaded rustc-serialize v0.3.25
[INFO] [stderr]   Downloaded test-log v0.2.19
[INFO] [stderr]   Downloaded rstest v0.23.0
[INFO] [stderr]   Downloaded mockall_derive v0.14.0
[INFO] [stderr]   Downloaded rstest_macros v0.23.0
[INFO] [stderr]   Downloaded url v0.5.10
[INFO] [stderr]   Downloaded schemars v1.2.1
[INFO] [stderr]   Downloaded rmcp v0.3.2
[INFO] [stderr]   Downloaded sdl2 v0.38.0
[INFO] [stderr]   Downloaded tokio v1.52.1
[INFO] [stderr]   Downloaded sdl2-sys v0.38.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171
[INFO] running `Command { std: "docker" "start" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling rustversion v1.0.22
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.114
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling simd-adler32 v0.3.8
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling tinyvec v1.11.0
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling bumpalo v3.20.2
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling fdeflate v0.3.7
[INFO] [stderr]    Compiling pxfm v0.1.28
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling version-compare v0.1.1
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling wasm-bindgen v0.2.114
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling sdl2-sys v0.38.0
[INFO] [stderr]    Compiling ident_case v1.0.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling byteorder-lite v0.1.0
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling png v0.18.1
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling winnow v1.0.0
[INFO] [stderr]    Compiling md5 v0.8.0
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling sdl2 v0.38.0
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling matches v0.1.10
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling jiff v0.2.23
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling unicode-bidi v0.2.6
[INFO] [stderr]    Compiling rand v0.3.23
[INFO] [stderr]    Compiling uuid v0.2.3
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling rustc-serialize v0.3.25
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling moxcms v0.8.1
[INFO] [stderr]    Compiling url v0.5.10
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.114
[INFO] [stderr]    Compiling darling_core v0.21.3
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling env_filter v1.0.0
[INFO] [stderr]    Compiling env_logger v0.11.9
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling bytemuck_derive v1.10.2
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling bitfield-struct v0.12.1
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tokio v1.52.1
[INFO] [stderr]    Compiling bytemuck v1.25.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling darling_macro v0.21.3
[INFO] [stderr]    Compiling darling v0.21.3
[INFO] [stderr]    Compiling rmcp-macros v0.3.2
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling image v0.25.10
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.114
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling nes_mcp_protocol v0.1.0 (/opt/rustwide/workdir/nes_mcp_protocol)
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling js-sys v0.3.91
[INFO] [stderr]    Compiling console_error_panic_hook v0.1.7
[INFO] [stderr]    Compiling nes_core v0.1.0 (/opt/rustwide/workdir/nes_core)
[INFO] [stderr]    Compiling nes_sdl v0.1.0 (/opt/rustwide/workdir/nes_sdl)
[INFO] [stderr]    Compiling nes_cpu_test v0.1.0 (/opt/rustwide/workdir/nes_cpu_test)
[INFO] [stderr]    Compiling nescli v0.1.0 (/opt/rustwide/workdir/nescli)
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling rmcp v0.3.2
[INFO] [stderr]    Compiling nes_mcp_server v0.1.0 (/opt/rustwide/workdir/nes_mcp_server)
[INFO] [stderr]    Compiling web-sys v0.3.91
[INFO] [stderr]    Compiling console_log v1.0.0
[INFO] [stderr]    Compiling nes_web v0.1.0 (/opt/rustwide/workdir/nes_web)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 20s
[INFO] running `Command { std: "docker" "inspect" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling predicates-core v1.0.10
[INFO] [stderr]    Compiling mockall_derive v0.14.0
[INFO] [stderr]    Compiling test-case-core v3.3.1
[INFO] [stderr]    Compiling mockall v0.14.0
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling relative-path v1.9.3
[INFO] [stderr]    Compiling test-log-macros v0.2.19
[INFO] [stderr]    Compiling fragile v2.1.0
[INFO] [stderr]    Compiling md5 v0.7.0
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling nes_web v0.1.0 (/opt/rustwide/workdir/nes_web)
[INFO] [stderr]    Compiling nescli v0.1.0 (/opt/rustwide/workdir/nescli)
[INFO] [stderr]    Compiling nes_sdl v0.1.0 (/opt/rustwide/workdir/nes_sdl)
[INFO] [stderr]    Compiling nes_mcp_protocol v0.1.0 (/opt/rustwide/workdir/nes_mcp_protocol)
[INFO] [stderr]    Compiling predicates-tree v1.0.13
[INFO] [stderr]    Compiling predicates v3.1.4
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling nes_mcp_server v0.1.0 (/opt/rustwide/workdir/nes_mcp_server)
[INFO] [stderr]    Compiling test-log v0.2.19
[INFO] [stderr]    Compiling rstest_macros v0.23.0
[INFO] [stderr]    Compiling test-case-macros v3.3.1
[INFO] [stderr]    Compiling test-case v3.3.1
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling nes_core v0.1.0 (/opt/rustwide/workdir/nes_core)
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling rstest v0.23.0
[INFO] [stderr]    Compiling nes_cpu_test v0.1.0 (/opt/rustwide/workdir/nes_cpu_test)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 24.30s
[INFO] running `Command { std: "docker" "inspect" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.26s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nes_core-2054bf1b7fb8e4d6)
[INFO] [stdout] 
[INFO] [stdout] running 570 tests
[INFO] [stdout] test cpu::tests::adc_immediate_uses_carry_and_updates_flags ... ok
[INFO] [stdout] test cpu::tests::branch_relative_taken_and_not_taken_behaves ... ok
[INFO] [stdout] test cpu::tests::bit_updates_flags_from_alu_and_accumulator ... ok
[INFO] [stdout] test cpu::tests::and_immediate_and_memory_microcodes_update_accumulator_and_flags ... ok
[INFO] [stdout] test cpu::tests::compare_and_bit_microcodes_update_flags ... ok
[INFO] [stdout] test cpu::tests::peek_byte_uses_non_mutating_mcu_path ... ok
[INFO] [stdout] test cpu::tests::stack_and_misc_microcodes_manipulate_state ... ok
[INFO] [stdout] test cpu::tests::load_immediate_x_and_y_read_operand_and_update_flags ... ok
[INFO] [stdout] test cpu::tests::load_immediate_a_reads_operand_and_updates_flags ... ok
[INFO] [stdout] test cpu::tests::ora_and_eor_microcodes_update_accumulator_and_flags ... ok
[INFO] [stdout] test cpu::tests::test_adc_absolute_x ... ok
[INFO] [stdout] test cpu::tests::store_and_load_microcodes_use_alu_and_memory ... ok
[INFO] [stdout] test cpu::tests::test_adc_absolute ... ok
[INFO] [stdout] test cpu::tests::test_adc_decimal_mode_not_supported ... ok
[INFO] [stdout] test cpu::tests::store_microcodes_write_registers_to_memory ... ok
[INFO] [stdout] test cpu::tests::test_adc_overflow_negative_plus_negative ... ok
[INFO] [stdout] test cpu::tests::inc_read_byte_advances_pc_and_ticks ... ok
[INFO] [stdout] test cpu::tests::test_adc_overflow_positive_plus_positive ... ok
[INFO] [stdout] test cpu::tests::test_adc_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_adc_with_carry ... ok
[INFO] [stdout] test cpu::tests::sbc_immediate_and_memory_microcodes_update_accumulator_and_flags ... ok
[INFO] [stdout] test cpu::tests::test_adc_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_alr_immediate ... ok
[INFO] [stdout] test cpu::tests::test_adc_no_overflow_positive_plus_negative ... ok
[INFO] [stdout] test cpu::tests::test_adc_overflow_positive ... ok
[INFO] [stdout] test cpu::tests::test_adc_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_anc_without_carry ... ok
[INFO] [stdout] test cpu::tests::test_adc_with_carry_overflow ... ok
[INFO] [stdout] test cpu::tests::test_anc_with_carry ... ok
[INFO] [stdout] test cpu::tests::test_adc_overflow_negative ... ok
[INFO] [stdout] test cpu::tests::test_and_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_adc_with_overflow ... ok
[INFO] [stdout] test cpu::tests::test_anc_immediate ... ok
[INFO] [stdout] test cpu::tests::test_and_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_adc_basic ... ok
[INFO] [stdout] test cpu::tests::test_and_absolute ... ok
[INFO] [stdout] test cpu::tests::test_adc_all_flags ... ok
[INFO] [stdout] test cpu::tests::test_alr_with_carry ... ok
[INFO] [stdout] test cpu::tests::test_asl_absolute ... ok
[INFO] [stdout] test cpu::tests::test_arr_immediate ... ok
[INFO] [stdout] test cpu::tests::test_arr_without_carry ... ok
[INFO] [stdout] test cpu::tests::test_asl_with_carry ... ok
[INFO] [stdout] test cpu::tests::test_aso_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_and_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_aso_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_aso_absolute ... ok
[INFO] [stdout] test cpu::tests::test_and_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_aso_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_asl_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_asl_accumulator ... ok
[INFO] [stdout] test cpu::tests::test_asl_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_aso_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_adc_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_and_operation ... ok
[INFO] [stdout] test cpu::tests::test_and_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_aso_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_aso_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_bcc_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_bcs_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_bmi_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_bpl_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_branch_cross_page_boundary ... ok
[INFO] [stdout] test cpu::tests::test_brk_instruction ... ok
[INFO] [stdout] test cpu::tests::test_branch_forward ... ok
[INFO] [stdout] test cpu::tests::test_bne_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_branch_all_conditions ... ok
[INFO] [stdout] test cpu::tests::test_beq_branch_not_taken ... ok
[INFO] [stdout] test cpu::tests::test_bit_instruction ... ok
[INFO] [stdout] test cpu::tests::test_bit_absolute ... ok
[INFO] [stdout] test cpu::tests::test_bvs_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_bit_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_branch_backward_max ... ok
[INFO] [stdout] test cpu::tests::test_bvc_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_beq_branch_taken ... ok
[INFO] [stdout] test cpu::tests::test_brk_pushes_b_flag ... ok
[INFO] [stdout] test cpu::tests::test_clv_instruction ... ok
[INFO] [stdout] test cpu::tests::test_cmp_absolute ... ok
[INFO] [stdout] test cpu::tests::test_cmp_indirect_x_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_cmp_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_cmp_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_cmp_indirect_y_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_cmp_instruction ... ok
[INFO] [stdout] test cpu::tests::test_cmp_instruction_less ... ok
[INFO] [stdout] test cpu::tests::test_cmp_instruction_greater ... ok
[INFO] [stdout] test cpu::tests::test_compare_clears_zero_flag ... ok
[INFO] [stdout] test cpu::tests::test_cpy_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_dcp_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_cpy_instruction ... ok
[INFO] [stdout] test cpu::tests::test_cpy_absolute ... ok
[INFO] [stdout] test cpu::tests::test_dcp_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_dcp_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_dcp_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_cpx_instruction ... ok
[INFO] [stdout] test cpu::tests::test_cmp_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_dcp_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_dcp_absolute ... ok
[INFO] [stdout] test cpu::tests::test_dcp_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_cpx_absolute ... ok
[INFO] [stdout] test cpu::tests::test_cpx_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_cpu_initialization ... ok
[INFO] [stdout] test cpu::tests::test_compare_sets_zero_flag ... ok
[INFO] [stdout] test cpu::tests::test_eor_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_eor_operation ... ok
[INFO] [stdout] test cpu::tests::test_dec_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_halt_flag ... ok
[INFO] [stdout] test cpu::tests::test_hlt_instruction ... ok
[INFO] [stdout] test cpu::tests::test_dey ... ok
[INFO] [stdout] test cpu::tests::test_eor_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_hlt_various_opcodes ... ok
[INFO] [stdout] test cpu::tests::test_dec_register ... ok
[INFO] [stdout] test cpu::tests::test_flag_toggle ... ok
[INFO] [stdout] test cpu::tests::test_dey_to_zero ... ok
[INFO] [stdout] test cpu::tests::test_dec_absolute ... ok
[INFO] [stdout] test cpu::tests::test_eor_absolute ... ok
[INFO] [stdout] test cpu::tests::test_eor_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_dec_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_dex ... ok
[INFO] [stdout] test cpu::tests::test_inc_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_inc_read_byte ... ok
[INFO] [stdout] test cpu::tests::test_irq_flag_operations ... ok
[INFO] [stdout] test cpu::tests::test_isc_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_inc_absolute ... ok
[INFO] [stdout] test cpu::tests::test_isc_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_inx_wrapping ... ok
[INFO] [stdout] test cpu::tests::test_inc_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_inc_pc_wrapping ... ok
[INFO] [stdout] test cpu::tests::test_inc_pc_edge_cases ... ok
[INFO] [stdout] test cpu::tests::test_isc_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_inc_pc ... ok
[INFO] [stdout] test cpu::tests::test_isc_absolute ... ok
[INFO] [stdout] test cpu::tests::test_iny_wrapping ... ok
[INFO] [stdout] test cpu::tests::test_irq_detector ... ok
[INFO] [stdout] test cpu::tests::test_inc_register ... ok
[INFO] [stdout] test cpu::tests::test_isc_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_jmp_indirect_no_page_boundary ... ok
[INFO] [stdout] test cpu::tests::test_jmp_indirect ... ok
[INFO] [stdout] test cpu::tests::test_jmp_indirect_page_boundary_bug ... ok
[INFO] [stdout] test cpu::tests::test_isc_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_lax_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_lax_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_lax_zero_page_y ... ok
[INFO] [stdout] test cpu::tests::test_lax_absolute ... ok
[INFO] [stdout] test cpu::tests::test_jmp_absolute ... ok
[INFO] [stdout] test cpu::tests::test_jsr_pushes_pc_and_jumps ... ok
[INFO] [stdout] test cpu::tests::test_jsr_rts_round_trip ... ok
[INFO] [stdout] test cpu::tests::test_isc_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_lax_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_lax_immediate ... ok
[INFO] [stdout] test cpu::tests::test_lda_absolute ... ok
[INFO] [stdout] test cpu::tests::test_lda_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_lda_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_ldx_absolute ... ok
[INFO] [stdout] test cpu::tests::test_lda_indirect_y_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_ldy_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_ldx_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_ldy_absolute ... ok
[INFO] [stdout] test cpu::tests::test_lda_zero_page_y ... ok
[INFO] [stdout] test cpu::tests::test_lda_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_lda_negative_flag ... ok
[INFO] [stdout] test cpu::tests::test_ldy_immediate ... ok
[INFO] [stdout] test cpu::tests::test_lda_zero_flag ... ok
[INFO] [stdout] test cpu::tests::test_lda_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_ldx_immediate ... ok
[INFO] [stdout] test cpu::tests::test_ldx_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_lda_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_lda_indirect_x_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_lse_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_mcu_access ... ok
[INFO] [stdout] test cpu::tests::test_lse_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_ldy_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_lsr_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_lsr_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_lsr_absolute ... ok
[INFO] [stdout] test cpu::tests::test_lsr_accumulator ... ok
[INFO] [stdout] test cpu::tests::test_lsr_accumulator_with_carry ... ok
[INFO] [stdout] test cpu::tests::test_lse_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_multiple_instructions ... ok
[INFO] [stdout] test cpu::tests::test_lda_immediate ... ok
[INFO] [stdout] test cpu::tests::test_nmi_detector ... ok
[INFO] [stdout] test cpu::tests::test_multiple_flags_simultaneously ... ok
[INFO] [stdout] test cpu::tests::test_ora_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_ora_operation ... ok
[INFO] [stdout] test cpu::tests::test_nop_absolute ... ok
[INFO] [stdout] test cpu::tests::test_nop_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_ora_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_pop_stack_into_pc ... ok
[INFO] [stdout] test cpu::tests::test_nop_instruction ... ok
[INFO] [stdout] test cpu::tests::test_plp_restores_flags ... ok
[INFO] [stdout] test cpu::tests::test_ora_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_peek_stack ... ok
[INFO] [stdout] test cpu::tests::test_php_pla ... ok
[INFO] [stdout] test cpu::tests::test_ora_absolute ... ok
[INFO] [stdout] test cpu::tests::test_nop_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_push_status_with_all_flags ... ok
[INFO] [stdout] test cpu::tests::test_read_write_byte ... ok
[INFO] [stdout] test cpu::tests::test_pop_stack_wrap_around ... ok
[INFO] [stdout] test cpu::tests::test_push_status ... ok
[INFO] [stdout] test cpu::tests::test_nop_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_ora_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_rla_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_rla_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_lse_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_reset ... ok
[INFO] [stdout] test cpu::tests::test_rla_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_rla_absolute ... ok
[INFO] [stdout] test cpu::tests::test_rol_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_rla_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_rol_absolute ... ok
[INFO] [stdout] test cpu::tests::test_rla_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_rla_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_ror_absolute ... ok
[INFO] [stdout] test cpu::tests::test_ror_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_rra_absolute ... ok
[INFO] [stdout] test cpu::tests::test_rol_accumulator ... ok
[INFO] [stdout] test cpu::tests::test_rol_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_rra_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_rra_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_ror_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_rra_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_rra_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_rra_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_rra_zero_page_x ... ok
[INFO] [stdout] test cpu::tests::test_ror_accumulator ... ok
[INFO] [stdout] test cpu::tests::test_rti_clears_b_flag ... ok
[INFO] [stdout] test cpu::tests::test_rts_adds_one_to_pc ... ok
[INFO] [stdout] test cpu::tests::test_rti_restores_pc_and_flags ... ok
[INFO] [stdout] test cpu::tests::test_sax_absolute ... ok
[INFO] [stdout] test cpu::tests::test_sax_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_sax_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_rts_pops_pc ... ok
[INFO] [stdout] test cpu::tests::test_sbc_absolute ... ok
[INFO] [stdout] test cpu::tests::test_sbc_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_sbc_all_flags ... ok
[INFO] [stdout] test cpu::tests::test_sbc_basic ... ok
[INFO] [stdout] test cpu::tests::test_sbc_indirect_y_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_sed_cld_instructions ... ok
[INFO] [stdout] test cpu::tests::test_sbc_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_sbc_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_sbc_overflow_positive_minus_negative ... ok
[INFO] [stdout] test cpu::tests::test_sbx_immediate ... ok
[INFO] [stdout] test cpu::tests::test_sbx_with_borrow ... ok
[INFO] [stdout] test cpu::tests::test_sei_cli_instructions ... ok
[INFO] [stdout] test cpu::tests::test_sbc_overflow ... ok
[INFO] [stdout] test cpu::tests::test_sbc_no_overflow_negative_minus_positive ... ok
[INFO] [stdout] test cpu::tests::test_sbc_with_borrow ... ok
[INFO] [stdout] test cpu::tests::test_sec_clc_instructions ... ok
[INFO] [stdout] test cpu::tests::test_sbc_underflow ... ok
[INFO] [stdout] test cpu::tests::test_set_get_flag ... ok
[INFO] [stdout] test cpu::tests::test_sta_absolute ... ok
[INFO] [stdout] test cpu::tests::test_sta_absolute_y ... ok
[INFO] [stdout] test cpu::tests::test_sta_indirect_x ... ok
[INFO] [stdout] test cpu::tests::test_sta_indirect_y_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_sta_indirect_y ... ok
[INFO] [stdout] test cpu::tests::test_sbc_indirect_x_unofficial ... ok
[INFO] [stdout] test cpu::tests::test_stack_push_pop ... ok
[INFO] [stdout] test cpu::tests::test_stack_operations_pla ... ok
[INFO] [stdout] test cpu::tests::test_stack_operations_pha ... ok
[INFO] [stdout] test cpu::tests::test_stack_push_pop_wrapping ... ok
[INFO] [stdout] test cpu::tests::test_stx_zero_page_y ... ok
[INFO] [stdout] test cpu::tests::test_stack_wrap_around ... ok
[INFO] [stdout] test cpu::tests::test_sta_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_sta_absolute_x ... ok
[INFO] [stdout] test cpu::tests::test_stx_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_status_register_all_flags ... ok
[INFO] [stdout] test cpu::tests::test_sty_absolute ... ok
[INFO] [stdout] test cpu::tests::test_sty_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_transfer_instruction_tax ... ok
[INFO] [stdout] test cpu::tests::test_transfer_instruction_tay ... ok
[INFO] [stdout] test cpu::tests::test_tsx_instruction ... ok
[INFO] [stdout] test cpu::tests::test_transfer_no_touch_flags_zero_page ... ok
[INFO] [stdout] test cpu::tests::test_transfer_instruction_txa ... ok
[INFO] [stdout] test ines::parser::tests::test_check_signature ... ok
[INFO] [stdout] test ines::tests::test_ines_file_new_invalid_signature ... ok
[INFO] [stdout] test cpu::tests::test_txs_instruction ... ok
[INFO] [stdout] test cpu::tests::transfer_microcodes_copy_registers_and_update_flags ... ok
[INFO] [stdout] test cpu::tests::test_txa_affects_flags ... ok
[INFO] [stdout] test ines::tests::test_format_error_display ... ok
[INFO] [stdout] test cpu::tests::test_tya ... ok
[INFO] [stdout] test cpu::tests::test_stx_absolute ... ok
[INFO] [stdout] test ines::tests::test_ines_file_new_too_short ... ok
[INFO] [stdout] test cpu::tests::test_update_zero_flag ... ok
[INFO] [stdout] test cpu::tests::test_update_negative_flag ... ok
[INFO] [stdout] test cpu::tests::test_tay ... ok
[INFO] [stdout] test cpu::tests::test_sty_zero_page_x ... ok
[INFO] [stdout] test ines::tests::test_ines_header_reports_file_version ... ok
[INFO] [stdout] test ines::tests::test_is_valid_with_valid_rom ... ok
[INFO] [stdout] test ines::tests::test_ines_file_new_empty ... ok
[INFO] [stdout] test ines::tests::test_nes20_extended_console_and_exponent_sizes_are_parsed ... ok
[INFO] [stdout] test ines::tests::test_nes20_header_fields_are_parsed ... ok
[INFO] [stdout] test ines::tests::test_is_valid_with_empty ... ok
[INFO] [stdout] test machine::tests::test_reset ... ok
[INFO] [stdout] test cpu::tests::test_transfer_no_touch_flags_indirect ... ok
[INFO] [stdout] test machine::tests::test_machine_creation ... ok
[INFO] [stdout] test machine::tests::test_set_pc ... ok
[INFO] [stdout] test mcu::ram::tests::test_to_index ... ok
[INFO] [stdout] test mcu::tests::test_read_write ... ok
[INFO] [stdout] test movie::tests::gamepad_flag ... ok
[INFO] [stdout] test movie::tests::command_parser ... ok
[INFO] [stdout] test movie::tests::gamepad_input_parser ... ok
[INFO] [stdout] test machine::tests::test_set_pc_drains_pending_reset_microcodes ... ok
[INFO] [stdout] test mcu::ram::tests::start_from ... ok
[INFO] [stdout] test ines::tests::test_is_valid_with_too_short ... ok
[INFO] [stdout] test ines::tests::test_is_valid_with_invalid_rom ... ok
[INFO] [stdout] test ines::parser::tests::test_parse_file ... ok
[INFO] [stdout] test movie::tests::parse_file ... ok
[INFO] [stdout] test machine::tests::test_machine_with_plugin ... ok
[INFO] [stdout] test movie::tests::test_deserializer ... ok
[INFO] [stdout] test cpu::tests::test_transfer_instruction_tya ... ok
[INFO] [stdout] test nes::apu::pulse::tests::shifter_update_period_negate_clears_when_out_of_range ... ok
[INFO] [stdout] test nes::apu::pulse::tests::shifter_update_period_add_mode ... ok
[INFO] [stdout] test nes::apu::pulse::tests::shifter_update_period_negate_first_channel ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_new_creates_sweep_enabled_from_bits ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_config_updates_enabled_and_shifter ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_controller_read_status ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_controller_write_control_flags ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_controller_driver_control_flags_status ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_status_bitfield ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_second_channel_affects_negate_subtraction ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_does_not_update_period_when_disabled ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_does_not_update_period_when_shifter_disabled ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_updates_period_when_divider_ticks ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_zero_output_when_period_less_than_8 ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_zero_output_returns_false_for_valid_period ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_zero_output_when_new_period_exceeds_0x7ff ... ok
[INFO] [stdout] test nes::apu::tests::divider ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_new_creates_sweep_disabled_when_enabled_false ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_controller_write_frame_counter ... ok
[INFO] [stdout] test nes::apu::pulse::tests::sweep_tick_does_not_update_period_when_zero_output ... ok
[INFO] [stdout] test nes::apu::tests::test_apu_status_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_control_flags_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_dmc_irq_loop_freq_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_duty_cycle_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_dmc_irq_loop_freq_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_duty_cycle_various_values ... ok
[INFO] [stdout] test nes::apu::tests::test_frame_counter_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_frame_counter_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_duty_cycle_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_linear_counter_control ... ok
[INFO] [stdout] test nes::apu::tests::test_linear_counter_control_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_envelop_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_control_flags_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_length_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_length_to_from_u8 ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_period_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_sweep_bitfield ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_period_to_from_u8 ... ok
[INFO] [stdout] test nes::controller::tests::test_a_controller ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_new ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_reads_return_one_after_eight_buttons ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_write_1_resets_and_latches ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_write_4017_does_nothing ... ok
[INFO] [stdout] test nes::apu::tests::test_noise_envelop_to_from_u8 ... ok
[INFO] [stdout] test nes::controller::tests::test_a_controller_stroke_mode_reads_a_button_only ... ok
[INFO] [stdout] test nes::controller::tests::test_all_button_values ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_read ... ok
[INFO] [stdout] test nes::controller::tests::test_press_multiple_buttons ... ok
[INFO] [stdout] test nes::dmc_dma::tests::dma_not_activated ... ok
[INFO] [stdout] test nes::controller::tests::test_release_buttons ... ok
[INFO] [stdout] test nes::controller::tests::test_controller_write ... ok
[INFO] [stdout] test nes::dmc_dma::tests::load_dmc_dma ... ok
[INFO] [stdout] test nes::dmc_dma::tests::reload_dmc_dma ... ok
[INFO] [stdout] test nes::lower_ram::tests::test ... ok
[INFO] [stdout] test nes::dmc_dma::tests::reload_dmc_dma_delayed_2_cycle ... ok
[INFO] [stdout] test nes::dmc_dma::tests::load_dmc_dmadelayed ... ok
[INFO] [stdout] test nes::mapper::bxrom::tests::chr_flat_access ... ok
[INFO] [stdout] test nes::mapper::chr_storage::tests::direct_chr_reads_stored_value ... ok
[INFO] [stdout] test nes::mapper::axrom::tests::switches_32k_prg_banks ... ok
[INFO] [stdout] test nes::dmc_dma::tests::reload_dmc_dma_delayed_1_cycle ... ok
[INFO] [stdout] test nes::dmc_dma::tests::reload_dmc_dma_delayed_3_cycle ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::chr_ram_writes_and_reads_cache ... ok
[INFO] [stdout] test nes::mapper::chr_storage::tests::direct_chr_constructs_from_8kb_slice ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::chr_write_register_switches_bank ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::chr_initial_state_reads_bank_0 ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::chr_refresh_copies_source_to_cache ... ok
[INFO] [stdout] test nes::mapper::j87::tests::chr_band_switching ... ok
[INFO] [stdout] test nes::mapper::axrom::tests::switches_single_screen_mirroring ... ok
[INFO] [stdout] test nes::mapper::chr_storage::tests::direct_chr_wraps_at_0x2000_boundary ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::chr_select_chr_bank0_in_4k_mode ... ok
[INFO] [stdout] test nes::mapper::bxrom::tests::switches_32k_prg_banks ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::chr_bank_wraps_at_bank_count ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::chr_select_chr_bank1_in_4k_mode ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::mirrors_16k_prg_into_upper_bank ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::control_prg_rom_mode ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::reads_and_writes_cartridge_ram ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::prg_ram_respects_enable_bit ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::prg_rom_switching_uses_serial_load_register ... ok
[INFO] [stdout] test nes::mapper::cnrom::tests::chr_initial_state_reads_bank_0 ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::control_flags_to_mirroring ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::chr_writes_to_chr_ram_persists ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper2 ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::reset_write_keeps_mirroring_and_chr_mode ... ok
[INFO] [stdout] test nes::mapper::mmc3::tests::switches_chr_layout_in_chr_mode_0 ... ok
[INFO] [stdout] test nes::mapper::nrom::tests::mcu ... ok
[INFO] [stdout] test nes::mapper::mmc3::tests::switches_chr_layout_in_chr_mode_1 ... ok
[INFO] [stdout] test nes::mapper::nrom::tests::mirrors_16k_prg_into_upper_bank ... ok
[INFO] [stdout] test nes::mapper::mmc3::tests::writes_to_chr_ram_through_current_mapping ... ok
[INFO] [stdout] test nes::mapper::nina001::tests::chr_banking ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::control_flags_to_prg_rom_mode ... ok
[INFO] [stdout] test nes::mapper::mmc1::tests::control_ppu_mirroring ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper1 ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper34_bnrom ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper0 ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper3 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_four_0x2000_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_four_0x2400_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_four_0x2800_expects_0x800 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_four_0x2c00_expects_0xc00 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2000_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2400_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2001_expects_1 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2401_expects_1 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2c02_expects_0x402 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2800_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2801_expects_0x401 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_lowerbank_0x27ff_expects_1023 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_upperbank_0x2001_expects_0x401 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_lowerbank_0x2001_expects_1 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_upperbank_0x23ff_expects_0x7ff ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_lowerbank_0x2000_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_lowerbank_0x23ff_expects_1023 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_upperbank_0x2000_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper4 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2000_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper7 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_horizontal_0x2c00_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_upperbank_0x27ff_expects_0x7ff ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2400_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2001_expects_1 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2401_expects_0x401 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2800_expects_0 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2c01_expects_0x401 ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2c00_expects_0x400 ... ok
[INFO] [stdout] test nes::mapper::vrc24::tests::vrc4f_high_nibble ... ok
[INFO] [stdout] test nes::mapper::vrc24::tests::writes_to_chr_ram ... ok
[INFO] [stdout] test nes::mapper::uxrom::tests::switches_lower_prg_bank_and_keeps_last_bank_fixed ... ok
[INFO] [stdout] test nes::mapper::uxrom::tests::reads_and_writes_cartridge_ram ... ok
[INFO] [stdout] test nes::ppu::oam::tests::attribute_flip_vertically_bit ... ok
[INFO] [stdout] test nes::mapper::vrc24::tests::vrc4f_banking ... ok
[INFO] [stdout] test nes::ppu::oam::tests::attribute_flip_horizontally_bit ... ok
[INFO] [stdout] test nes::ppu::oam::tests::oam_as_bytes_round_trip ... ok
[INFO] [stdout] test nes::ppu::oam::tests::attribute_behind_background_bit ... ok
[INFO] [stdout] test nes::ppu::oam::tests::oam_default_is_zeroed ... ok
[INFO] [stdout] test nes::ppu::oam::tests::attribute_bit_positions_combined ... ok
[INFO] [stdout] test nes::ppu::oam::tests::attribute_palette_bits ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_8x16_tile_position::even_tile_idx ... ok
[INFO] [stdout] test nes::ppu::oam::tests::sprite_size_is_4_bytes ... ok
[INFO] [stdout] test nes::ppu::oam::tests::oam_as_bytes_mut_modifies_sprites ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_8x8_tile_position::first_bank ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_mapper4_with_chr_ram ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_8x16_tile_position::odd_tile_idx ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_first_bank_tile0_y15_wraps_to_tile1 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::oam_size_is_256_bytes ... ok
[INFO] [stdout] test nes::mapper::tests::test_name_table_offset::mirroring_vertical_0x2801_expects_1 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size8_first_bank_tile0_y7 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size8_first_bank_tile0_y0 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size8_first_bank_tile1_y3 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size8_second_bank_tile0_y0 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size8_second_bank_tile3_y5 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_first_bank_tile0_y0 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_second_bank_tile1_y0 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_first_bank_tile0_y7 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_8x8_tile_position::second_bank ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_first_bank_tile0_y8_wraps_to_tile1 ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_second_bank_tile4_y10_uses_tile5 ... ok
[INFO] [stdout] test nes::ppu::palette::tests::background_sprite_shares_transparent::_0x3f08_0x3f18_0x08_expects ... ok
[INFO] [stdout] test nes::ppu::palette::tests::background_sprite_shares_transparent::_0x3f0c_0x3f1c_0x0c_expects ... ok
[INFO] [stdout] test nes::ppu::palette::tests::background_sprite_shares_transparent::_0x3f00_0x3f10_0_expects ... ok
[INFO] [stdout] test nes::ppu::palette::tests::load_from_pal_buf_all_black ... ok
[INFO] [stdout] test nes::ppu::palette::tests::load_from_pal_buf_specific_colors ... ok
[INFO] [stdout] test nes::ppu::palette::tests::palette_ram_read_write ... ok
[INFO] [stdout] test nes::ppu::palette::tests::test_addr_to_index::_0x3f00_expects_0 ... ok
[INFO] [stdout] test nes::ppu::palette::tests::test_addr_to_index::_0x3f11_expects_0x11 ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::all_three_tints ... ok
[INFO] [stdout] test nes::ppu::palette::tests::background_sprite_shares_transparent::_0x3f04_0x3f14_0x04_expects ... ok
[INFO] [stdout] test nes::ppu::oam::tests::test_resolve_pixel_addr::size16_first_bank_tile2_y9_uses_tile3 ... ok
[INFO] [stdout] test nes::ppu::palette::tests::palette_ram_get_color ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::green_tint_only ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::blue_tint_only ... ok
[INFO] [stdout] test nes::ppu::palette::tests::test_addr_to_index::_0x3f1f_expects_0x1f ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::grayscale_only ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::grayscale_all_tints ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::green_blue_tint ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_background_tile_position::background_at_second_bank ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_background_tile_position::background_at_first_bank ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::no_effects ... ok
[INFO] [stdout] test nes::ppu::tests::test_open_bus_bits_decay_to_zero ... ok
[INFO] [stdout] test nes::ppu::tests::test_read_status_clears_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_applies_left_column_clipping ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::grayscale_red_tint ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::red_blue_tint ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_both_disabled ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::red_green_tint ... ok
[INFO] [stdout] test nes::ppu::tests::repr_ppu_status ... ok
[INFO] [stdout] test nes::ppu::tests::test_peek_status_does_not_clear_vblank ... ok
[INFO] [stdout] test nes::ppu::registers::tests::test_apply_effects::red_tint_only ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_does_not_set_sprite_overflow_with_eight_sprites_on_scanline ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_no_emphasis_no_change ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_does_not_set_sprite_overflow_when_rendering_disabled ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_behind_transparent_background ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_applies_sprite_priority_before_background_priority ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_returns_background_color ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_background_priority_when_sprite_is_behind ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_respects_sprite_pattern_table_selection ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sets_sprite_overflow_with_nine_sprites_on_scanline ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_returns_sprite_color_when_background_disabled ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_skips_transparent_higher_priority_sprite ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_respects_sprite_flipping ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_hit ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_hit_requires_sprite_zero ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_respects_background_pattern_table_selection ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_hit_respects_background_left_mask ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_hit_requires_opaque_background ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_not_at_x255 ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_transparent_sprite_falls_back_to_background ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_uses_odd_tile_bank_for_8x16_sprites ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_in_front_of_background ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_uses_second_tile_for_8x16_sprites ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::frame_wraps ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::odd_frame_skip ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_transparent_bg_and_sprite_use_backdrop_color ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_uses_vertical_flip_for_8x16_sprites ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_sprite_zero_hit_respects_sprite_left_mask ... ok
[INFO] [stdout] test nes::ppu::tests::test_tick_renders_palette_color_when_rendering_disabled_and_vram_points_to_palette ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::normal_frame_wrap_from_last_dot ... ok
[INFO] [stdout] test nes::ppu::tests::test_tick_renders_background_color_when_rendering_disabled_and_vram_not_palette ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::skip_requires_correct_dot ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::skip_requires_correct_scanline ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::skip_requires_odd_frame ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::skip_requires_rendering ... ok
[INFO] [stdout] test nes::ppu::tests::timing_advance_state::dot_wraps_at_scanline_end ... ok
[INFO] [stdout] test nes::ppu::tests::test_render_pixel_uses_highest_priority_opaque_sprite ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::one_dot_before_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::one_scanline_before_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::arbitrary_timing_not_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::pre_render_scanline_not_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::scanline_241_dot_1_enters_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::one_scanline_after_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::dot_257_is_not_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::dot_0_is_not_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::hblank_dot_is_not_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::pre_render_scanline_is_not_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::scanline_0_dot_256_is_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_enter_vblank::one_dot_after_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::test_status_read_only_refreshes_high_bits ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::scanline_239_dot_128_is_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::scanline_240_dot_1_is_not_visible ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::arbitrary_timing_not_leave_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::one_dot_before_leave_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::one_scanline_before_leave_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::frame_start_not_leave_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::one_dot_after_leave_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::scanline_261_dot_1_leaves_vblank ... ok
[INFO] [stdout] test nes::ppu::tests::timing_is_visible::scanline_0_dot_1_is_visible ... ok
[INFO] [stdout] test render::image_render::tests::test_image_render_set_pixel ... ok
[INFO] [stdout] test test_utils::tests::test_mock_mcu_flags ... ok
[INFO] [stdout] test nes::ppu::tests::test_sprite_overflow_does_not_set_for_next_scanline_at_y240 ... ok
[INFO] [stdout] test nes::ppu::tests::test_sprite_overflow_sets_for_next_scanline_at_y239 ... ok
[INFO] [stdout] test test_utils::tests::test_mcu_utils_word_rw ... ok
[INFO] [stdout] test test_utils::tests::test_mock_mcu_basic ... ok
[INFO] [stdout] test test_utils::tests::test_mock_mcu_regional ... ok
[INFO] [stdout] test nes::ppu::tests::timing_leave_vblank::vblank_set_not_leave_vblank ... ok
[INFO] [stdout] test nes::tests::test_length_counter_status_comes_from_apu_controller ... ok
[INFO] [stdout] test nes::tests::test_lower_ram_mirroring ... ok
[INFO] [stdout] test nes::tests::test_controller_reads_route_through_nes_mcu ... ok
[INFO] [stdout] test render::image_render::tests::test_image_render_borrow ... ok
[INFO] [stdout] test test_utils::tests::test_mock_mcu_write_word ... ok
[INFO] [stdout] test test_utils::tests::test_mock_mcu_with_program ... ok
[INFO] [stdout] test nes::tests::test_frame_counter_inhibit_clears_irq ... ok
[INFO] [stdout] test nes::mapper::tests::create_cartridge_unsupported_mapper - should panic ... ok
[INFO] [stdout] test nes_machine::tests::test_process_frame_waits_for_vblank ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 570 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.36s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/nes_cpu_test-67df2ad51081e732)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test plugin::detect_dead_loop::tests::dead_loop_without_success_signature_returns_nonzero_exit_code ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_1 ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::self_jmp_with_success_status_returns_zero_exit_code ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_2 ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_3 ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_5 ... ok
[INFO] [stdout] test plugin::nametable_console::tests::matches_magic_success_word ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_7 ... ok
[INFO] [stdout] test plugin::nametable_console::tests::decodes_tall_text_characters ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_4 ... ok
[INFO] [stdout] test plugin::detect_dead_loop::tests::test::case_6 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nes_mcp_protocol-408598e30cc68c2a)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_format_hexdump ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/nes_mcp_server-06cfb18960038cf6)
[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] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-585aac35c1a87c76)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_mcp_server_basics ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nes_sdl-f007283cb249a981)
[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] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nes_web-15bcc4e49d6b81df)
[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] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/nescli-f4db60172077e1b6)
[INFO] [stdout] running 16 tests
[INFO] [stdout] test actions::play_movie::tests::active_frame_breaks_idle_stretch ... ok
[INFO] [stdout] test actions::play_movie::tests::active_frame_within_lookahead_window ... ok
[INFO] [stdout] test actions::play_movie::tests::custom_idle_frames ... ok
[INFO] [stdout] test actions::play_movie::tests::both_ports_must_be_empty ... ok
[INFO] [stdout] test actions::play_movie::tests::empty_logs ... ok
[INFO] [stdout] test actions::play_movie::tests::exactly_idle_frames_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::exactly_idle_plus_one_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::idle_stretch_too_short ... ok
[INFO] [stdout] test actions::play_movie::tests::less_than_idle_frames_all_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::no_idle_frames ... ok
[INFO] [stdout] test actions::play_movie::tests::only_last_idle_frames_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::port0_active_counts_as_non_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::two_separate_idle_ranges ... ok
[INFO] [stdout] test actions::play_movie::tests::port1_active_counts_as_non_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::first_frame_active_rest_idle ... ok
[INFO] [stdout] test actions::play_movie::tests::hundred_idle_frames ... ok
[INFO] [stderr]    Doc-tests nes_mcp_protocol
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 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] [stderr]    Doc-tests nes_sdl
[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" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171", kill_on_drop: false }`
[INFO] [stdout] 25ce77393f44ee69975dc9da704d6f294e83ec80a6f2206c18223ce83e545171
