[INFO] fetching crate vibe-emu-core 0.0.2... [INFO] testing vibe-emu-core-0.0.2 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1 [INFO] extracting crate vibe-emu-core 0.0.2 into /workspace/builds/worker-3-tc1/source [INFO] started tweaking crates.io crate vibe-emu-core 0.0.2 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate vibe-emu-core 0.0.2 [INFO] tweaked toml for crates.io crate vibe-emu-core 0.0.2 written to /workspace/builds/worker-3-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate vibe-emu-core 0.0.2 on toolchain 562dee4820c458d823175268e41601d4c060588a [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate vibe-emu-core 0.0.2 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded escape8259 v0.5.3 [INFO] [stderr] Downloaded ppmd-rust v1.4.0 [INFO] [stderr] Downloaded libtest-mimic v0.8.1 [INFO] [stderr] Downloaded typed-path v0.12.2 [INFO] [stderr] Downloaded aws-lc-rs v1.15.4 [INFO] [stderr] Downloaded zip v8.1.0 [INFO] [stderr] Downloaded zlib-rs v0.6.0 [INFO] [stderr] Downloaded lzma-rust2 v0.16.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] a840456e04ed245660c9ac164b6236f4965cee16707601a2910a6b4e24585546 [INFO] running `Command { std: "docker" "start" "-a" "a840456e04ed245660c9ac164b6236f4965cee16707601a2910a6b4e24585546", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "a840456e04ed245660c9ac164b6236f4965cee16707601a2910a6b4e24585546", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a840456e04ed245660c9ac164b6236f4965cee16707601a2910a6b4e24585546", kill_on_drop: false }` [INFO] [stdout] a840456e04ed245660c9ac164b6236f4965cee16707601a2910a6b4e24585546 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 5a37f50821962e701d9fb74e0d7b0275596487275ac8904edfa0f4b6e213c1fa [INFO] running `Command { std: "docker" "start" "-a" "5a37f50821962e701d9fb74e0d7b0275596487275ac8904edfa0f4b6e213c1fa", kill_on_drop: false }` [INFO] [stderr] Compiling vibe-emu-core v0.0.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.07s [INFO] running `Command { std: "docker" "inspect" "5a37f50821962e701d9fb74e0d7b0275596487275ac8904edfa0f4b6e213c1fa", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5a37f50821962e701d9fb74e0d7b0275596487275ac8904edfa0f4b6e213c1fa", kill_on_drop: false }` [INFO] [stdout] 5a37f50821962e701d9fb74e0d7b0275596487275ac8904edfa0f4b6e213c1fa [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4fde6c80fbd59e3b0e466bbabf15f58b06248b54b207699b69cbf08ad488717d [INFO] running `Command { std: "docker" "start" "-a" "4fde6c80fbd59e3b0e466bbabf15f58b06248b54b207699b69cbf08ad488717d", kill_on_drop: false }` [INFO] [stderr] Compiling syn v2.0.114 [INFO] [stderr] Compiling jobserver v0.1.34 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling socket2 v0.6.2 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling simd-adler32 v0.3.8 [INFO] [stderr] Compiling aws-lc-rs v1.15.4 [INFO] [stderr] Compiling memchr v2.7.6 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling cc v1.2.56 [INFO] [stderr] Compiling zlib-rs v0.6.0 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling tokio v1.49.0 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling rustls v0.23.36 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling getrandom v0.4.1 [INFO] [stderr] Compiling cmake v0.1.57 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling inout v0.1.4 [INFO] [stderr] Compiling ipnet v2.11.0 [INFO] [stderr] Compiling cipher v0.4.4 [INFO] [stderr] Compiling deranged v0.5.5 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling aws-lc-sys v0.37.1 [INFO] [stderr] Compiling zstd-sys v2.0.16+zstd.1.5.7 [INFO] [stderr] Compiling iri-string v0.7.10 [INFO] [stderr] Compiling bumpalo v3.19.1 [INFO] [stderr] Compiling zopfli v0.8.3 [INFO] [stderr] Compiling time v0.3.47 [INFO] [stderr] Compiling flate2 v1.1.9 [INFO] [stderr] Compiling pbkdf2 v0.12.2 [INFO] [stderr] Compiling lzma-rust2 v0.16.2 [INFO] [stderr] Compiling compression-codecs v0.4.36 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling aes v0.8.4 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling fdeflate v0.3.7 [INFO] [stderr] Compiling tokio-util v0.7.18 [INFO] [stderr] Compiling tower v0.5.3 [INFO] [stderr] Compiling async-compression v0.4.37 [INFO] [stderr] Compiling h2 v0.4.13 [INFO] [stderr] Compiling typed-path v0.12.2 [INFO] [stderr] Compiling tower-http v0.6.8 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.1 [INFO] [stderr] Compiling zerovec-derive v0.11.2 [INFO] [stderr] Compiling zeroize_derive v1.4.3 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling clap_derive v4.5.55 [INFO] [stderr] Compiling rustls-pki-types v1.14.0 [INFO] [stderr] Compiling constant_time_eq v0.4.2 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.1 [INFO] [stderr] Compiling zerovec v0.11.5 [INFO] [stderr] Compiling ppmd-rust v1.4.0 [INFO] [stderr] Compiling zerotrie v0.2.3 [INFO] [stderr] Compiling rustls-native-certs v0.8.3 [INFO] [stderr] Compiling deflate64 v0.1.10 [INFO] [stderr] Compiling tinystr v0.8.2 [INFO] [stderr] Compiling potential_utf v0.1.4 [INFO] [stderr] Compiling icu_locale_core v2.1.1 [INFO] [stderr] Compiling icu_collections v2.1.1 [INFO] [stderr] Compiling hyper v1.8.1 [INFO] [stderr] Compiling escape8259 v0.5.3 [INFO] [stderr] Compiling tempfile v3.25.0 [INFO] [stderr] Compiling png v0.18.1 [INFO] [stderr] Compiling clap v4.5.60 [INFO] [stderr] Compiling libtest-mimic v0.8.1 [INFO] [stderr] Compiling icu_provider v2.1.1 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling icu_properties v2.1.2 [INFO] [stderr] Compiling icu_normalizer v2.1.1 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.1.0 [INFO] [stderr] Compiling zstd-safe v7.2.4 [INFO] [stderr] Compiling zstd v0.13.3 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling zip v8.1.0 [INFO] [stderr] Compiling rustls-webpki v0.103.9 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling rustls-platform-verifier v0.6.2 [INFO] [stderr] Compiling hyper-rustls v0.27.7 [INFO] [stderr] Compiling reqwest v0.13.2 [INFO] [stderr] Compiling vibe-emu-core v0.0.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2m 20s [INFO] running `Command { std: "docker" "inspect" "4fde6c80fbd59e3b0e466bbabf15f58b06248b54b207699b69cbf08ad488717d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4fde6c80fbd59e3b0e466bbabf15f58b06248b54b207699b69cbf08ad488717d", kill_on_drop: false }` [INFO] [stdout] 4fde6c80fbd59e3b0e466bbabf15f58b06248b54b207699b69cbf08ad488717d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 365db23ac7642342e7a6b73d3cc6b36600c70776e774a038b711246dff832065 [INFO] running `Command { std: "docker" "start" "-a" "365db23ac7642342e7a6b73d3cc6b36600c70776e774a038b711246dff832065", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.21s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/vibe_emu_core-bd7c7e43f93ab9d9) [INFO] [stdout] [INFO] [stdout] running 70 tests [INFO] [stdout] test apu::tests::dc_filter_active_when_dac_on ... ok [INFO] [stdout] test apu::tests::dc_filter_channels_independent ... ok [INFO] [stdout] test apu::tests::dc_filter_reduces_constant_input ... ok [INFO] [stdout] test apu::tests::dc_filter_reset_when_all_dacs_off ... ok [INFO] [stdout] test apu::tests::square_clock_2mhz_batches_multiple_edges ... ok [INFO] [stdout] test apu::tests::wave_step_batches_to_exact_boundary ... ok [INFO] [stdout] test apu::tests::dc_filter_converges_to_zero ... ok [INFO] [stdout] test apu::tests::square_clock_2mhz_consumes_remainder_after_batch ... ok [INFO] [stdout] test apu::tests::wave_step_clears_just_read_after_remainder ... ok [INFO] [stdout] test cartridge::tests::rtc_halt_preserves_subseconds ... ok [INFO] [stdout] test cartridge::tests::rtc_ticks_through_invalid_values ... ok [INFO] [stdout] test cartridge::tests::rtc_seconds_write_resets_phase ... ok [INFO] [stdout] test cartridge::tests::no_mbc_small_ram_mirrors ... ok [INFO] [stdout] test cartridge::tests::mbc3_rom_bank_wraps ... ok [INFO] [stdout] test cartridge::tests::cart_ram_initializes_to_ff ... ok [INFO] [stdout] test cartridge::tests::rtc_day_overflow_sets_carry ... ok [INFO] [stdout] test cartridge::tests::tpp1_features_battery_and_rtc ... ok [INFO] [stdout] test cartridge::tests::tpp1_control_register_readback ... ok [INFO] [stdout] test cartridge::tests::tpp1_rom_banking ... ok [INFO] [stdout] test cartridge::tests::tpp1_rtc_full_rollover ... ok [INFO] [stdout] test cartridge::tests::tpp1_initial_state ... ok [INFO] [stdout] test cartridge::tests::tpp1_rtc_serialize_roundtrip ... ok [INFO] [stdout] test cartridge::tests::tpp1_rtc_latch_and_readback ... ok [INFO] [stdout] test cartridge::tests::tpp1_rtc_ticks_seconds ... ok [INFO] [stdout] test cartridge::tests::tpp1_header_detected ... ok [INFO] [stdout] test cartridge::tests::tpp1_ram_size_parsing ... ok [INFO] [stdout] test cartridge::tests::tpp1_rumble_speed_clamped ... ok [INFO] [stdout] test cartridge::tests::tpp1_sram_read_write ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x0 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x1 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x2 ... ok [INFO] [stdout] test ppu::lcd_off_frame_timing_tests::lcd_off_keeps_frame_cadence ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x3 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x8 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x1 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_split_0_and_160 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_single_sprite_x4 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x167 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x168 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x160 ... ok [INFO] [stdout] test gameboy::tests::reset_power_on_preserves_cart_and_boot_rom ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x6 ... ok [INFO] [stdout] test gameboy::tests::reset_preserves_cart_and_boot_rom ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x2 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x4 ... ok [INFO] [stdout] test serial::tests::external_clock_completes_with_pulses ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x7 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_two_sprites_x0 ... ok [INFO] [stdout] test serial::tests::external_clock_latches_and_shifts_partner_byte ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_three_sprites_x0 ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_ten_sprites_x8 ... ok [INFO] [stdout] test serial::tests::external_clock_stalls_without_pulses ... ok [INFO] [stdout] test serial::tests::internal_clock_rate_cgb_double_speed ... ok [INFO] [stdout] test serial::tests::internal_clock_irq_only_on_final_bit_dmg ... ok [INFO] [stdout] test serial::tests::internal_clock_rate_cgb_fast_clock ... ok [INFO] [stdout] test serial::tests::internal_clock_rate_cgb_fast_clock_double_speed ... ok [INFO] [stdout] test ppu::step_fast_path_tests::oam_fast_path_advances_without_contention ... ok [INFO] [stdout] test serial::tests::internal_clock_rate_cgb_normal_speed ... ok [INFO] [stdout] test serial::tests::internal_clock_shifts_bits_into_sb ... ok [INFO] [stdout] test serial::tests::internal_clock_waits_for_partner_byte_before_clocking ... ok [INFO] [stdout] test serial::tests::open_bus_no_partner_external_clock_receives_ff ... ok [INFO] [stdout] test serial::tests::open_bus_no_partner_internal_clock_receives_ff ... ok [INFO] [stdout] test serial::tests::internal_clock_transfer_completes_and_requests_irq ... ok [INFO] [stdout] test serial::tests::sc_write_during_active_transfer_does_not_cancel ... ok [INFO] [stdout] test watchpoints::tests::read_watchpoint_hits_and_records_details ... ok [INFO] [stdout] test serial::tests::sc_write_with_bit7_restarts_transfer_using_current_sb ... ok [INFO] [stdout] test serial::tests::serial_dot_cycles_match_speed_table ... ok [INFO] [stdout] test watchpoints::tests::value_match_filters_hits ... ok [INFO] [stdout] test watchpoints::tests::suspended_disables_hits ... ok [INFO] [stdout] test ppu::mode3_timing_tests::dmg_mode3_cycles_mooneye_intr2_patterns ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/apu.rs (/opt/rustwide/target/debug/deps/apu-77d74dad999ecd39) [INFO] [stdout] [INFO] [stdout] running 66 tests [INFO] [stdout] test dac_off_disables_channel ... ok [INFO] [stdout] test nr12_write_requires_retrigger ... ok [INFO] [stdout] test nr12_bit3_enables_dac ... ok [INFO] [stdout] test double_speed_preserves_lf_div_phase ... ok [INFO] [stdout] test nr12_period_zero_sets_timer_to_8 ... ok [INFO] [stdout] test nr11_write_sets_duty_and_length ... ok [INFO] [stdout] test nr12_zero_turns_off_dac ... ok [INFO] [stdout] test nr14_length_enable_read_write ... ok [INFO] [stdout] test nr13_write_sets_frequency_low_bits_and_is_write_only ... ok [INFO] [stdout] test nr14_write_sets_frequency_high_bits_and_is_write_only ... ok [INFO] [stdout] test nr21_write_sets_duty_and_length ... ok [INFO] [stdout] test nr22_bit3_enables_dac ... ok [INFO] [stdout] test nr22_period_zero_sets_timer_to_8 ... ok [INFO] [stdout] test nr13_period_change_delayed_until_sample_end ... ok [INFO] [stdout] test nr22_write_requires_retrigger ... ok [INFO] [stdout] test nr22_zero_turns_off_dac ... ok [INFO] [stdout] test nr23_write_sets_frequency_low_bits_and_is_write_only ... ok [INFO] [stdout] test nr24_length_enable_read_write ... ok [INFO] [stdout] test nr30_dac_off_disables_channel ... ok [INFO] [stdout] test nr24_write_sets_frequency_high_bits_and_is_write_only ... ok [INFO] [stdout] test nr31_write_sets_length ... ok [INFO] [stdout] test nr31_write_updates_length_when_disabled_on_dmg ... ok [INFO] [stdout] test nr33_write_sets_frequency_low_bits_and_is_write_only ... ok [INFO] [stdout] test nr34_length_enable_read_write ... ok [INFO] [stdout] test nr23_period_change_delayed_until_sample_end ... ok [INFO] [stdout] test nr34_retrigger_resets_wave_position ... ok [INFO] [stdout] test nr34_write_sets_frequency_high_bits_and_is_write_only ... ok [INFO] [stdout] test nr41_high_bits_ignored ... ok [INFO] [stdout] test duty_step_reset_when_apu_powered_off ... ok [INFO] [stdout] test nr41_write_sets_length ... ok [INFO] [stdout] test nr41_zero_sets_full_length ... ok [INFO] [stdout] test nr42_write_requires_retrigger ... ok [INFO] [stdout] test nr42_bit3_enables_dac ... ok [INFO] [stdout] test nr42_writes_ignored_when_disabled ... ok [INFO] [stdout] test nr43_bit15_copies_to_bit7_in_short_mode ... ok [INFO] [stdout] test nr42_zero_turns_off_dac ... ok [INFO] [stdout] test nr43_lfsr_first_step ... ok [INFO] [stdout] test nr43_output_depends_on_lfsr ... ok [INFO] [stdout] test nr44_length_enable_read_write ... ok [INFO] [stdout] test nr50_left_vs_right_volume ... ok [INFO] [stdout] test nr50_vin_bits_ignored ... ok [INFO] [stdout] test nr50_volume_zero_not_muted ... ok [INFO] [stdout] test nr51_ch2_center ... ok [INFO] [stdout] test nr51_ch2_left_only ... ok [INFO] [stdout] test nr52_bits_ignore_dac_only ... ok [INFO] [stdout] test nr51_ch2_off ... ok [INFO] [stdout] test nr52_power_toggle ... ok [INFO] [stdout] test nr52_wave_ram_persist ... ok [INFO] [stdout] test nr52_channel_status_bits ... ok [INFO] [stdout] test pcm_mask_defaults_to_full_on_reve ... ok [INFO] [stdout] test nr51_ch2_right_only ... ok [INFO] [stdout] test pcm_register_open_bus ... ok [INFO] [stdout] test read_mask_unused_bits ... ok [INFO] [stdout] test nr52_clears_registers_when_off ... ok [INFO] [stdout] test pcm_mask_glitch_releases_after_first_sample ... ok [INFO] [stdout] test retrigger_preserves_timer_low_bits_ch1 ... ok [INFO] [stdout] test wave_ram_access ... ok [INFO] [stdout] test sample_generation ... ok [INFO] [stdout] test register_write_read_fidelity ... ok [INFO] [stdout] test wave_retrigger_emits_last_sample ... ok [INFO] [stdout] test wave_ram_locked_read_redirects_on_cgb_e ... ok [INFO] [stdout] test wave_ram_locked_read_returns_latched_nibble_on_dmg ... ok [INFO] [stdout] test wave_ram_accessible_with_dac_on_when_inactive ... ok [INFO] [stdout] test wave_ram_locked_write_commits_after_byte_advance ... ok [INFO] [stdout] test pcm_mmu_mapping ... ok [INFO] [stdout] test frame_sequencer_tick ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/apu_quirks.rs (/opt/rustwide/target/debug/deps/apu_quirks-4a17c077724c7828) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test wave_retrigger_corrupts_ram ... ok [INFO] [stdout] test zombie_mode_volume_change ... ok [INFO] [stdout] test noise_shift_15_freezes_lfsr ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/bgb_protocol.rs (/opt/rustwide/target/debug/deps/bgb_protocol-7c0d3053be9e13d6) [INFO] [stdout] [INFO] [stdout] running 24 tests [INFO] [stdout] test bgb_sync3_sent_only_when_not_ready ... ok [INFO] [stdout] test handshake_sequence ... ok [INFO] [stdout] test correct_sync1_response_logic ... ok [INFO] [stdout] test complete_transfer_cycle ... ok [INFO] [stdout] test packet_roundtrip ... ok [INFO] [stdout] test parse_real_log_packets ... ok [INFO] [stdout] test pokemon_trade_handshake_81 ... ok [INFO] [stdout] test rapid_data_exchange ... ok [INFO] [stdout] test serial_no_data_byte_pattern ... ok [INFO] [stdout] test status_packet_running_paused_reconnect ... ok [INFO] [stdout] test status_packet_running_reconnect ... ok [INFO] [stdout] test sync1_creates_correct_packet ... ok [INFO] [stdout] test sync1_packet_from_log ... ok [INFO] [stdout] test sync1_sync2_when_slave_ready ... ok [INFO] [stdout] test sync1_sync3_ack_when_slave_not_ready ... ok [INFO] [stdout] test sync2_packet_from_log ... ok [INFO] [stdout] test sync2_creates_correct_packet ... ok [INFO] [stdout] test sync3_ack_creates_correct_packet ... ok [INFO] [stdout] test sync3_ack_packet_from_log ... ok [INFO] [stdout] test sync3_timestamp_creates_correct_packet ... ok [INFO] [stdout] test sync3_timestamp_vs_ack_distinction ... ok [INFO] [stdout] test timestamp_encoding ... ok [INFO] [stdout] test version_packet_format ... ok [INFO] [stdout] test vibe_incorrect_sync3_for_every_sync1 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/boot_handoff_state.rs (/opt/rustwide/target/debug/deps/boot_handoff_state-04374f82ef790fef) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test cgb_no_boot_matches_bootrom_handoff ... FAILED [INFO] [stdout] test dmg_no_boot_matches_bootrom_handoff ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- cgb_no_boot_matches_bootrom_handoff stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'cgb_no_boot_matches_bootrom_handoff' (184) panicked at tests/common/mod.rs:72:34: [INFO] [stdout] failed to create test_roms directory: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5bcfbae519da - std[31e582c13f4e914f]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5bcfbae519da - std[31e582c13f4e914f]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5bcfbae519da - std[31e582c13f4e914f]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5bcfbae519da - <::print::DisplayBacktrace as core[fa0eadad68403074]::fmt::Display>::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5bcfbae67c4a - ::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5bcfbae67c4a - core[fa0eadad68403074]::fmt::write [INFO] [stdout] 6: 0x5bcfbae56ba2 - std[31e582c13f4e914f]::io::default_write_fmt::> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5bcfbae56ba2 - as std[31e582c13f4e914f]::io::Write>::write_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5bcfbae2d68f - ::print [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5bcfbae2d68f - std[31e582c13f4e914f]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5bcfbae489a9 - std[31e582c13f4e914f]::panicking::default_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5bcfbad5e47c - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x5bcfbad5e47c - test[7530e63dc052480e]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5bcfbae48c22 - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x5bcfbae48c22 - std[31e582c13f4e914f]::panicking::panic_with_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5bcfbae2d748 - std[31e582c13f4e914f]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5bcfbae22559 - std[31e582c13f4e914f]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5bcfbae2e82d - __rustc[fc8e3a9f23f26cb]::rust_begin_unwind [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5bcfbae6840c - core[fa0eadad68403074]::panicking::panic_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5bcfbae68182 - core[fa0eadad68403074]::result::unwrap_failed [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/result.rs:1867:5 [INFO] [stdout] 20: 0x5bcfbac6dbec - >::expect [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5bcfba4c7ce6 - boot_handoff_state[234e622aa2a1bed9]::common::ensure_test_roms::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:72:34 [INFO] [stdout] 22: 0x5bcfba4ae926 - >::get_or_init::::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1120:57 [INFO] [stdout] 23: 0x5bcfba495f0d - >::initialize::<>::get_or_init::{closure#0}, >::get_or_init::Void>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:72:23 [INFO] [stdout] 24: 0x5bcfbae156d6 - <&mut dyn core[fa0eadad68403074]::ops::function::FnMut<(), Output = bool> as core[fa0eadad68403074]::ops::function::FnMut<()>>::call_mut [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:298:21 [INFO] [stdout] 25: 0x5bcfbae153cb - once_cell[9f652223467bafb4]::imp::initialize_or_wait [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:196:20 [INFO] [stdout] 26: 0x5bcfba494e6f - >::initialize::<>::get_or_init::{closure#0}, >::get_or_init::Void> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:68:9 [INFO] [stdout] 27: 0x5bcfba4ae04a - >::get_or_try_init::<>::get_or_init::{closure#0}, >::get_or_init::Void> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1161:20 [INFO] [stdout] 28: 0x5bcfba4adf9e - >::get_or_init:: [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1120:24 [INFO] [stdout] 29: 0x5bcfba4c9aed - boot_handoff_state[234e622aa2a1bed9]::common::ensure_test_roms [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:70:10 [INFO] [stdout] 30: 0x5bcfba4cb663 - boot_handoff_state[234e622aa2a1bed9]::common::roms_dir [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:296:5 [INFO] [stdout] 31: 0x5bcfba4c8d7d - boot_handoff_state[234e622aa2a1bed9]::common::bootroms_dir [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:312:15 [INFO] [stdout] 32: 0x5bcfba4c9987 - boot_handoff_state[234e622aa2a1bed9]::common::ensure_bootrom [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:318:16 [INFO] [stdout] 33: 0x5bcfba4c9b16 - boot_handoff_state[234e622aa2a1bed9]::common::cgb_boot_rom_path [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:335:5 [INFO] [stdout] 34: 0x5bcfba4987a0 - boot_handoff_state[234e622aa2a1bed9]::capture_bootrom_handoff_snapshot [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:50:9 [INFO] [stdout] 35: 0x5bcfba498b94 - boot_handoff_state[234e622aa2a1bed9]::cgb_no_boot_matches_bootrom_handoff [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:288:27 [INFO] [stdout] 36: 0x5bcfba4960f7 - boot_handoff_state[234e622aa2a1bed9]::cgb_no_boot_matches_bootrom_handoff::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:287:41 [INFO] [stdout] 37: 0x5bcfba49f9f6 - >::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 38: 0x5bcfbad5255b - core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 39: 0x5bcfbad5255b - test[7530e63dc052480e]::__rust_begin_short_backtrace::, fn() -> core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:663:18 [INFO] [stdout] 40: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:74 [INFO] [stdout] 41: 0x5bcfbad5ef4b - as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 42: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 43: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panicking::catch_unwind::, core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 44: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panic::catch_unwind::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 45: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test_in_process [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:27 [INFO] [stdout] 46: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:607:43 [INFO] [stdout] 47: 0x5bcfbad593a4 - test[7530e63dc052480e]::run_test::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:637:41 [INFO] [stdout] 48: 0x5bcfbad593a4 - std[31e582c13f4e914f]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 49: 0x5bcfbad61b52 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 50: 0x5bcfbad61b52 - ::{closure#1}::{closure#0}> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 51: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 52: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panicking::catch_unwind::<(), core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 53: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 54: 0x5bcfbad61b52 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 55: 0x5bcfbad61b52 - ::{closure#1} as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 56: 0x5bcfbae50ddf - + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 57: 0x5bcfbae50ddf - ::new::thread_start [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 58: 0x71fad68aaaa4 - [INFO] [stdout] 59: 0x71fad6937a64 - clone [INFO] [stdout] 60: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- dmg_no_boot_matches_bootrom_handoff stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'dmg_no_boot_matches_bootrom_handoff' (185) panicked at tests/common/mod.rs:72:34: [INFO] [stdout] failed to create test_roms directory: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5bcfbae519da - std[31e582c13f4e914f]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5bcfbae519da - std[31e582c13f4e914f]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5bcfbae519da - std[31e582c13f4e914f]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5bcfbae519da - <::print::DisplayBacktrace as core[fa0eadad68403074]::fmt::Display>::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5bcfbae67c4a - ::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5bcfbae67c4a - core[fa0eadad68403074]::fmt::write [INFO] [stdout] 6: 0x5bcfbae56ba2 - std[31e582c13f4e914f]::io::default_write_fmt::> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5bcfbae56ba2 - as std[31e582c13f4e914f]::io::Write>::write_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5bcfbae2d68f - ::print [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5bcfbae2d68f - std[31e582c13f4e914f]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5bcfbae489a9 - std[31e582c13f4e914f]::panicking::default_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5bcfbad5e47c - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x5bcfbad5e47c - test[7530e63dc052480e]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5bcfbae48c22 - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x5bcfbae48c22 - std[31e582c13f4e914f]::panicking::panic_with_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5bcfbae2d748 - std[31e582c13f4e914f]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5bcfbae22559 - std[31e582c13f4e914f]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5bcfbae2e82d - __rustc[fc8e3a9f23f26cb]::rust_begin_unwind [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5bcfbae6840c - core[fa0eadad68403074]::panicking::panic_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5bcfbae68182 - core[fa0eadad68403074]::result::unwrap_failed [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/result.rs:1867:5 [INFO] [stdout] 20: 0x5bcfbac6dbec - >::expect [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5bcfba4c7ce6 - boot_handoff_state[234e622aa2a1bed9]::common::ensure_test_roms::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:72:34 [INFO] [stdout] 22: 0x5bcfba4ae926 - >::get_or_init::::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1120:57 [INFO] [stdout] 23: 0x5bcfba495f0d - >::initialize::<>::get_or_init::{closure#0}, >::get_or_init::Void>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:72:23 [INFO] [stdout] 24: 0x5bcfbae156d6 - <&mut dyn core[fa0eadad68403074]::ops::function::FnMut<(), Output = bool> as core[fa0eadad68403074]::ops::function::FnMut<()>>::call_mut [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:298:21 [INFO] [stdout] 25: 0x5bcfbae153cb - once_cell[9f652223467bafb4]::imp::initialize_or_wait [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:196:20 [INFO] [stdout] 26: 0x5bcfba494e6f - >::initialize::<>::get_or_init::{closure#0}, >::get_or_init::Void> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/imp_std.rs:68:9 [INFO] [stdout] 27: 0x5bcfba4ae04a - >::get_or_try_init::<>::get_or_init::{closure#0}, >::get_or_init::Void> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1161:20 [INFO] [stdout] 28: 0x5bcfba4adf9e - >::get_or_init:: [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/once_cell-1.21.3/src/lib.rs:1120:24 [INFO] [stdout] 29: 0x5bcfba4c9aed - boot_handoff_state[234e622aa2a1bed9]::common::ensure_test_roms [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:70:10 [INFO] [stdout] 30: 0x5bcfba4cb663 - boot_handoff_state[234e622aa2a1bed9]::common::roms_dir [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:296:5 [INFO] [stdout] 31: 0x5bcfba4c8d7d - boot_handoff_state[234e622aa2a1bed9]::common::bootroms_dir [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:312:15 [INFO] [stdout] 32: 0x5bcfba4c9987 - boot_handoff_state[234e622aa2a1bed9]::common::ensure_bootrom [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:318:16 [INFO] [stdout] 33: 0x5bcfba4c9b46 - boot_handoff_state[234e622aa2a1bed9]::common::dmg_boot_rom_path [INFO] [stdout] at /opt/rustwide/workdir/tests/common/mod.rs:327:5 [INFO] [stdout] 34: 0x5bcfba498794 - boot_handoff_state[234e622aa2a1bed9]::capture_bootrom_handoff_snapshot [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:52:9 [INFO] [stdout] 35: 0x5bcfba498bf1 - boot_handoff_state[234e622aa2a1bed9]::dmg_no_boot_matches_bootrom_handoff [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:280:27 [INFO] [stdout] 36: 0x5bcfba496127 - boot_handoff_state[234e622aa2a1bed9]::dmg_no_boot_matches_bootrom_handoff::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/boot_handoff_state.rs:279:41 [INFO] [stdout] 37: 0x5bcfba49fa36 - >::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 38: 0x5bcfbad5255b - core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 39: 0x5bcfbad5255b - test[7530e63dc052480e]::__rust_begin_short_backtrace::, fn() -> core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:663:18 [INFO] [stdout] 40: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:74 [INFO] [stdout] 41: 0x5bcfbad5ef4b - as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 42: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 43: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panicking::catch_unwind::, core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 44: 0x5bcfbad5ef4b - std[31e582c13f4e914f]::panic::catch_unwind::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 45: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test_in_process [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:27 [INFO] [stdout] 46: 0x5bcfbad5ef4b - test[7530e63dc052480e]::run_test::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:607:43 [INFO] [stdout] 47: 0x5bcfbad593a4 - test[7530e63dc052480e]::run_test::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:637:41 [INFO] [stdout] 48: 0x5bcfbad593a4 - std[31e582c13f4e914f]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 49: 0x5bcfbad61b52 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 50: 0x5bcfbad61b52 - ::{closure#1}::{closure#0}> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 51: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 52: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panicking::catch_unwind::<(), core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 53: 0x5bcfbad61b52 - std[31e582c13f4e914f]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 54: 0x5bcfbad61b52 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 55: 0x5bcfbad61b52 - ::{closure#1} as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 56: 0x5bcfbae50ddf - + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 57: 0x5bcfbae50ddf - ::new::thread_start [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 58: 0x71fad68aaaa4 - [INFO] [stdout] 59: 0x71fad6937a64 - clone [INFO] [stdout] 60: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] cgb_no_boot_matches_bootrom_handoff [INFO] [stdout] dmg_no_boot_matches_bootrom_handoff [INFO] [stdout] [INFO] [stdout] test result: FAILED. 0 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test boot_handoff_state` [INFO] running `Command { std: "docker" "inspect" "365db23ac7642342e7a6b73d3cc6b36600c70776e774a038b711246dff832065", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "365db23ac7642342e7a6b73d3cc6b36600c70776e774a038b711246dff832065", kill_on_drop: false }` [INFO] [stdout] 365db23ac7642342e7a6b73d3cc6b36600c70776e774a038b711246dff832065