[INFO] cloning repository https://github.com/lijunzhang-disabled/VibePS
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/lijunzhang-disabled/VibePS" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flijunzhang-disabled%2FVibePS", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flijunzhang-disabled%2FVibePS'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0d07ab276edfac1258ff2e0b1e26fa77c737bbec
[INFO] testing lijunzhang-disabled/VibePS against 1.97.0-beta.6 for beta-1.98-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flijunzhang-disabled%2FVibePS" "/workspace/builds/worker-6-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/lijunzhang-disabled/VibePS
[INFO] finished tweaking git repo https://github.com/lijunzhang-disabled/VibePS
[INFO] tweaked toml for git repo https://github.com/lijunzhang-disabled/VibePS written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/lijunzhang-disabled/VibePS 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/lijunzhang-disabled/VibePS 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f
[INFO] running `Command { std: "docker" "start" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", 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" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f" "/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" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", 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" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.46
[INFO] [stderr]    Compiling log v0.4.33
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling ps1-core v0.1.0 (/opt/rustwide/workdir/ps1-core)
[INFO] [stderr]    Compiling ps1-frontend v0.1.0 (/opt/rustwide/workdir/ps1-frontend)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.93s
[INFO] running `Command { std: "docker" "inspect" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", 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" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f" "/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 ps1-core v0.1.0 (/opt/rustwide/workdir/ps1-core)
[INFO] [stderr]    Compiling ps1-frontend v0.1.0 (/opt/rustwide/workdir/ps1-frontend)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.94s
[INFO] running `Command { std: "docker" "inspect" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", 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" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f" "/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.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ps1_core-cea668c3c6ac4deb)
[INFO] [stdout] 
[INFO] [stdout] running 103 tests
[INFO] [stdout] test bus::tests::maps_ram_through_kseg0_and_kseg1 ... ok
[INFO] [stdout] test bus::tests::dma2_sync1_vram_upload_updates_madr_and_block_count ... ok
[INFO] [stdout] test bus::tests::dma6_otc_clears_ordering_table_and_requests_irq_when_enabled ... ok
[INFO] [stdout] test bus::tests::dma3_reads_cdrom_sector_data_into_ram ... ok
[INFO] [stdout] test bus::tests::cache_control_register_round_trips ... ok
[INFO] [stdout] test bus::tests::maps_scratchpad ... ok
[INFO] [stdout] test bus::tests::isolated_cache_tag_and_code_modes_do_not_touch_ram ... ok
[INFO] [stdout] test cdrom::tests::getid_returns_licensed_disc_identity_after_ack ... ok
[INFO] [stdout] test bus::tests::dma2_sync1_vram_readback_writes_ram ... ok
[INFO] [stdout] test bus::tests::reads_bios_from_boot_mirror ... ok
[INFO] [stdout] test bus::tests::peek32_reads_memory_without_changing_open_bus ... ok
[INFO] [stdout] test bus::tests::dma2_linked_list_sends_gp0_packets_and_updates_madr ... ok
[INFO] [stdout] test cdrom::tests::gettn_and_gettd_report_single_data_track_and_leadout ... ok
[INFO] [stdout] test cdrom::tests::readn_without_disc_reports_error_interrupt ... ok
[INFO] [stdout] test cdrom::tests::rejects_misaligned_disc_images ... ok
[INFO] [stdout] test cdrom::tests::raw_disc_reads_mode2_payload_area ... ok
[INFO] [stdout] test cdrom::tests::seek_and_read_toc_emit_ack_then_complete ... ok
[INFO] [stdout] test cdrom::tests::setmode_and_getparam_round_trip_mode_byte ... ok
[INFO] [stdout] test cdrom::tests::setloc_and_readn_queue_cooked_sector_data_after_ack ... ok
[INFO] [stdout] test cpu::gte::tests::dpcs_and_intpl_interpolate_to_far_color_and_push_rgb_fifo ... ok
[INFO] [stdout] test cpu::gte::tests::gpf_and_gpl_update_ir_and_color_fifo ... ok
[INFO] [stdout] test cpu::gte::tests::irgb_orgb_lzcr_and_flag_registers_match_hardware_shape ... ok
[INFO] [stdout] test cpu::gte::tests::avsz3_and_avsz4_average_depth_and_saturate_otz ... ok
[INFO] [stdout] test cpu::gte::tests::mvmva_handles_basic_matrix_vector_and_limit_modes ... ok
[INFO] [stdout] test cpu::gte::tests::mvmva_handles_reserved_matrix_and_bugged_far_color_vector ... ok
[INFO] [stdout] test cpu::gte::tests::mvmva_supports_light_color_matrix_with_background ... ok
[INFO] [stdout] test cpu::gte::tests::control_single_halfword_registers_sign_extend ... ok
[INFO] [stdout] test cpu::gte::tests::nclip_computes_screen_space_area_and_mac0_overflow_flags ... ok
[INFO] [stdout] test cpu::gte::tests::dcpl_dpct_cc_and_cdp_update_color_fifo ... ok
[INFO] [stdout] test cdrom::tests::setfilter_and_mute_are_visible_through_getparam ... ok
[INFO] [stdout] test cpu::gte::tests::register_io_applies_gte_special_cases ... ok
[INFO] [stdout] test cpu::gte::tests::ncs_and_nccs_use_light_and_color_matrices ... ok
[INFO] [stdout] test cpu::gte::tests::rtps_projects_single_vertex_and_sets_depth_cue ... ok
[INFO] [stdout] test cpu::gte::tests::rtps_saturates_screen_and_reports_division_overflow ... ok
[INFO] [stdout] test cpu::gte::tests::rtpt_projects_three_vertices_and_pushes_sz_fifo ... ok
[INFO] [stdout] test cpu::tests::consecutive_loads_to_same_register_keep_first_load_invisible ... ok
[INFO] [stdout] test cpu::gte::tests::sqr_and_op_execute_vector_arithmetic ... ok
[INFO] [stdout] test cpu::tests::exception_in_taken_branch_delay_slot_sets_bd_and_branch_epc ... ok
[INFO] [stdout] test cpu::tests::exception_in_not_taken_branch_delay_slot_still_sets_bd ... ok
[INFO] [stdout] test cpu::tests::isolated_cache_mode_redirects_data_stores_away_from_ram ... ok
[INFO] [stdout] test cpu::tests::invalid_cop0_register_read_raises_reserved_instruction ... ok
[INFO] [stdout] test cpu::tests::cop2_command_dispatch_executes_gte_rtps ... ok
[INFO] [stdout] test cpu::tests::executes_branch_delay_slot ... ok
[INFO] [stdout] test cpu::tests::jal_link_cancels_pending_load_to_ra ... ok
[INFO] [stdout] test cpu::tests::kseg0_instruction_fetch_uses_icache_line ... ok
[INFO] [stdout] test cpu::tests::executes_basic_integer_and_memory_ops ... ok
[INFO] [stdout] test cpu::tests::exception_vector_uses_ram_vector_when_bev_is_clear ... ok
[INFO] [stdout] test cpu::tests::kseg1_instruction_fetch_bypasses_icache ... ok
[INFO] [stdout] test cpu::tests::pcsx_bltzal_not_taken_still_writes_link_register ... ok
[INFO] [stdout] test cpu::tests::pcsx_branch_in_branch_delay_slot_execution_order ... ok
[INFO] [stdout] test cpu::tests::misaligned_store_sets_bad_vaddr_and_address_store_code ... ok
[INFO] [stdout] test cpu::tests::misaligned_instruction_fetch_sets_bad_vaddr ... ok
[INFO] [stdout] test cpu::tests::pcsx_lwl_lwr_delayed_cases_merge_pending_loads ... ok
[INFO] [stdout] test cpu::tests::pcsx_branch_in_branch_delay_slot_uses_current_pc_base ... ok
[INFO] [stdout] test cpu::tests::pcsx_jump_in_jump_delay_slot_execution_order ... ok
[INFO] [stdout] test cpu::tests::pcsx_jump_in_jump_delay_slot_uses_absolute_second_target ... ok
[INFO] [stdout] test cpu::tests::pcsx_divide_by_zero_results_match_r3000a ... ok
[INFO] [stdout] test cpu::tests::pcsx_lwl_lwr_no_delay_reads_original_register ... ok
[INFO] [stdout] test cpu::tests::pcsx_unaligned_load_pairs_merge_different_words_and_lw_base ... ok
[INFO] [stdout] test cpu::tests::raises_syscall_exception_to_boot_vector ... ok
[INFO] [stdout] test cpu::tests::scratchpad_instruction_fetch_raises_instruction_bus_error ... ok
[INFO] [stdout] test cpu::tests::register_write_cancels_pending_load_to_same_register ... ok
[INFO] [stdout] test cpu::tests::software_interrupt_uses_status_mask_and_cause_pending_bits ... ok
[INFO] [stdout] test cpu::tests::unmapped_load_raises_data_bus_error ... ok
[INFO] [stdout] test cpu::tests::unaligned_store_and_load_pairs_use_little_endian_byte_order ... ok
[INFO] [stdout] test dma::tests::pending_channel_selection_uses_priority_then_high_channel_number ... ok
[INFO] [stdout] test cpu::tests::rfe_restores_current_mode_bits_from_status_stack ... ok
[INFO] [stdout] test cpu::tests::unusable_coprocessor_exception_sets_cause_ce ... ok
[INFO] [stdout] test cpu::tests::unusable_lwc_swc_cop0_paths_set_cause_ce_zero ... ok
[INFO] [stdout] test dma::tests::completion_sets_dicr_flag_only_when_channel_is_enabled ... ok
[INFO] [stdout] test dma::tests::dicr_bus_error_forces_master_irq_flag ... ok
[INFO] [stdout] test gpu::tests::flat_triangle_renders_inside_pixels ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase1_rectangles_use_expected_extents_and_clipping ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase11_dither_matrix_is_screen_space_anchored ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase1_triangle_uses_hardware_edge_inclusion ... ok
[INFO] [stdout] test dma::tests::dma6_chcr_only_exposes_otc_control_bits ... ok
[INFO] [stdout] test dma::tests::sync0_channel_waits_for_force_start_bit ... ok
[INFO] [stdout] test gpu::tests::cpu_to_vram_and_vram_to_cpu_round_trip_pixels ... ok
[INFO] [stdout] test gpu::tests::draw_area_and_offset_clip_flat_rectangle ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase2_lines_match_selected_bresenham_probes ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase2_mask_bits_apply_to_drawn_pixels ... ok
[INFO] [stdout] test test_runner::tests::mailbox_runner_passes_when_guest_writes_expected_code ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase4_textured_triangles_sample_clut_and_direct_texels ... ok
[INFO] [stdout] test test_runner::tests::runner_stops_on_break_exception_by_default ... ok
[INFO] [stdout] test gpu::tests::vram_to_vram_copy_respects_mask_check ... ok
[INFO] [stdout] test test_runner::tests::runner_can_stop_on_pc_and_check_registers ... ok
[INFO] [stdout] test gpu::tests::pcsx_redux_phase7_gouraud_triangle_matches_selected_probes ... ok
[INFO] [stdout] test gpu::tests::textured_rectangle_samples_4bpp_clut ... ok
[INFO] [stdout] test tests::boots_from_supplied_bios_image ... ok
[INFO] [stdout] test tests::loads_psx_exe_payload_and_initial_registers ... ok
[INFO] [stdout] test test_runner::tests::runner_times_out_when_no_stop_condition_matches ... ok
[INFO] [stdout] test test_runner::tests::psx_exe_runner_executes_cdrom_command_and_dma_smoke_test ... ok
[INFO] [stdout] test timer::tests::repeat_pulse_target_irq_requests_every_target_event ... ok
[INFO] [stdout] test timer::tests::one_shot_target_irq_suppresses_later_target_events ... ok
[INFO] [stdout] test test_runner::tests::mailbox_runner_fails_when_guest_writes_unexpected_code ... ok
[INFO] [stdout] test timer::tests::repeat_toggle_irq_requests_on_every_other_event ... ok
[INFO] [stdout] test timer::tests::sync_pause_mode_stops_timer0_during_hblank ... ok
[INFO] [stdout] test timer::tests::timer1_hblank_clock_counts_hblank_edges ... ok
[INFO] [stdout] test timer::tests::timer2_clock_source_can_divide_system_clock_by_eight ... ok
[INFO] [stdout] test tests::reset_returns_cpu_to_bios_boot_vector ... ok
[INFO] [stdout] test tests::rejects_psx_exe_payload_that_crosses_ram_end ... ok
[INFO] [stdout] test tests::rejects_invalid_psx_exe_header ... ok
[INFO] [stdout] test tests::rejects_truncated_psx_exe_payload ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/ps1_frontend-71a0d14ea0f4a17c)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test harness::tests::load_disc_image_mounts_cue_and_applies_index_offset ... ok
[INFO] [stdout] test harness::tests::parses_cue_comments_whitespace_and_raw_mode_alias ... ok
[INFO] [stdout] test harness::tests::parses_cue_data_track_with_quoted_file_and_index ... ok
[INFO] [stdout] test harness::tests::parses_test_runner_cli_values ... ok
[INFO] [stdout] test harness::tests::parses_cue_msf_to_frames ... ok
[INFO] [stdout] test harness::tests::load_disc_image_rejects_cue_index_past_image ... ok
[INFO] [stdout] test harness::tests::rejects_cue_track_before_file ... ok
[INFO] [stderr]    Doc-tests ps1_core
[INFO] [stdout] test harness::tests::parses_cue_skipping_audio_track_before_data_track ... ok
[INFO] [stdout] test harness::tests::rejects_cue_data_track_without_index01 ... ok
[INFO] [stdout] test harness::tests::parses_and_detects_disc_sector_size ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 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] running `Command { std: "docker" "inspect" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f", kill_on_drop: false }`
[INFO] [stdout] 1ec545becac5aacca1d863a80e8f6a41e7fbfd87d2a849881ee144df0ca75a7f
