Results for igt@gem_exec_suspend@basic-s3@smem

Result: Pass

git-log-oneline igt_runner0 run0 runtimes0 results0.json boot0 dmesg0

DetailValue
Igt-Version 
IGT-Version: 1.27.1-gb7a2382f1 (x86_64) (Linux: 6.5.0-rc5-linus-v6.5-rc5-g52a93d39b17d+ x86_64)
Out 
Opened device: /dev/dri/card0
Starting subtest: basic-S3
Starting dynamic subtest: smem
[cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Aug  6 22:23:44 2023
Dynamic subtest smem: SUCCESS (1.887s)
Subtest basic-S3: SUCCESS (1.888s)
Err 
Starting subtest: basic-S3
Starting dynamic subtest: smem
Dynamic subtest smem: SUCCESS (1.887s)
Subtest basic-S3: SUCCESS (1.888s)
Dmesg
<6> [293.780370] Console: switching to colour dummy device 80x25
<6> [293.780898] [IGT] gem_exec_suspend: executing
<7> [293.791720] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [293.793309] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [293.793706] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [293.794076] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [293.809523] [IGT] gem_exec_suspend: starting subtest basic-S3
<6> [293.810040] [IGT] gem_exec_suspend: starting dynamic subtest smem
<7> [293.811447] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [294.163572] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [294.168436] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [294.556311] PM: suspend entry (deep)
<6> [294.557082] Filesystems sync: 0.000 seconds
<6> [294.558420] Freezing user space processes
<6> [294.561156] Freezing user space processes completed (elapsed 0.002 seconds)
<6> [294.561170] OOM killer disabled.
<6> [294.561224] Freezing remaining freezable tasks
<6> [294.562941] Freezing remaining freezable tasks completed (elapsed 0.001 seconds)
<5> [294.612300] sd 0:0:0:0: [sda] Synchronizing SCSI cache
<5> [294.613417] sd 0:0:0:0: [sda] Stopping disk
<6> [294.615686] serial 00:02: disabled
<6> [294.616248] e1000e: EEE TX LPI TIMER: 00000000
<7> [294.616698] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.enable (expected 1, found 0)
<7> [294.617147] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.active (expected 1, found 0)
<7> [294.617488] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [294.617789] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [294.618089] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [294.618413] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [294.618713] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2080, found 0)
<7> [294.619012] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [294.619324] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2080, found 0)
<7> [294.619625] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1968, found 0)
<7> [294.620121] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2000, found 0)
<7> [294.620451] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1200, found 0)
<7> [294.620751] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1235, found 0)
<7> [294.621051] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1200, found 0)
<7> [294.621364] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1235, found 0)
<7> [294.621664] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1203, found 0)
<7> [294.621963] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1209, found 0)
<7> [294.622279] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [294.622578] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2080, found 0)
<7> [294.622877] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [294.623249] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2080, found 0)
<7> [294.623550] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1968, found 0)
<7> [294.623849] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2000, found 0)
<7> [294.624148] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1200, found 0)
<7> [294.624464] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1235, found 0)
<7> [294.624763] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1200, found 0)
<7> [294.625062] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1235, found 0)
<7> [294.625375] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1203, found 0)
<7> [294.625675] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1209, found 0)
<7> [294.625974] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [294.626289] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [294.626589] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [294.626889] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 153600, found 0)
<7> [294.627216] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 153600, found 0)
<7> [294.627520] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in port_clock (expected 153600, found 0)
<7> [294.627823] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [294.628186] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz
<7> [294.628489] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [294.628795] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: no [modeset]
<7> [294.629099] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:plane A] fb: [NOFB], visible: no
<7> [294.629636] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [294.643225] i915 0000:00:02.0: [drm:i9xx_get_fifo_size [i915]] FIFO size - (0x00001d9c) A: 28
<7> [294.643568] i915 0000:00:02.0: [drm:i9xx_get_fifo_size [i915]] FIFO size - (0x00001d9c) B: 31
<7> [294.643856] i915 0000:00:02.0: [drm:i9xx_update_wm [i915]] FIFO watermarks - A: 26, B: 29
<7> [294.644146] i915 0000:00:02.0: [drm:i9xx_update_wm [i915]] Setting FIFO watermarks - A: 26, B: 29, C: 2, SR 1
<7> [294.644457] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:46:CRT]
<7> [294.644764] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:45:VGA-1]
<7> [294.645102] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:37:pipe A]
<7> [294.766438] PM: suspend of devices complete after 192.778 msecs
<7> [294.766449] PM: start suspend of devices complete after 203.306 msecs
<7> [294.770243] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [294.782792] PM: late suspend of devices complete after 16.335 msecs
<7> [294.799270] PM: noirq suspend of devices complete after 15.783 msecs
<6> [294.799287] ACPI: PM: Preparing to enter system sleep state S3
<6> [294.803126] ACPI: PM: Saving platform NVS memory
<6> [294.805509] Disabling non-boot CPUs ...
<6> [294.808988] smpboot: CPU 1 is now offline
<7> [294.810603] Checking wakeup interrupts
<7> [294.810614] Calling mce_syscore_suspend+0x0/0x10
<7> [294.810625] Calling timekeeping_suspend+0x0/0x320
<7> [294.810660] Calling save_ioapic_entries+0x0/0xa0
<7> [294.810733] Calling i8259A_suspend+0x0/0x30
<7> [294.810741] Calling fw_suspend+0x0/0x20
<7> [294.810748] Calling acpi_save_bm_rld+0x0/0x20
<7> [294.810756] Calling lapic_suspend+0x0/0x240
<6> [294.811463] ACPI: PM: Low-level resume complete
<6> [294.811496] ACPI: PM: Restoring platform NVS memory
<7> [294.811634] Calling lapic_resume+0x0/0x340
<7> [294.811659] Calling acpi_restore_bm_rld+0x0/0x70
<7> [294.811665] Calling irqrouter_resume+0x0/0x50
<7> [294.811672] Calling i8259A_resume+0x0/0x30
<7> [294.811807] Calling i8237A_resume+0x0/0xa0
<7> [294.811864] Calling ioapic_resume+0x0/0xb0
<7> [294.811897] Calling irq_pm_syscore_resume+0x0/0x10
<7> [294.812330] Calling timekeeping_resume+0x0/0x1c0
<7> [294.812365] Timekeeping suspended for 15.864 seconds
<7> [294.812395] Calling mce_syscore_resume+0x0/0x30
<6> [294.812448] Enabling non-boot CPUs ...
<6> [294.812652] smpboot: Booting Node 0 Processor 1 APIC 0x1
<6> [294.819351] CPU1 is up
<6> [294.822668] ACPI: PM: Waking up from system sleep state S3
<7> [294.844239] PM: noirq resume of devices complete after 2.752 msecs
<7> [294.845813] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [294.847191] PM: early resume of devices complete after 2.375 msecs
<5> [294.849649] usb usb1: root hub lost power or was reset
<5> [294.849730] usb usb7: root hub lost power or was reset
<5> [294.853048] usb usb4: root hub lost power or was reset
<5> [294.853347] usb usb5: root hub lost power or was reset
<5> [294.853513] usb usb6: root hub lost power or was reset
<7> [294.855261] i915 0000:00:02.0: [drm:intel_vga_redisable_power_on [i915]] Something enabled VGA plane, disabling it
<7> [294.856498] i915 0000:00:02.0: [drm:intel_hpll_vco [i915]] HPLL VCO 4000000 kHz
<7> [294.856761] i915 0000:00:02.0: [drm:intel_cdclk_dump_config [i915]] Current CDCLK 333333 kHz, VCO 4000000 kHz, ref 0 kHz, bypass 0 kHz, voltage level 0
<7> [294.857848] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:37:pipe A] hw state readout: disabled
<7> [294.858314] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:44:pipe B] hw state readout: disabled
<7> [294.858554] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:plane A] hw state readout: disabled, pipe A
<7> [294.858790] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:34:cursor A] hw state readout: disabled, pipe A
<7> [294.859157] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:38:plane B] hw state readout: disabled, pipe A
<7> [294.859394] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor B] hw state readout: disabled, pipe A
<7> [294.859630] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [ENCODER:46:CRT] hw state readout: disabled, pipe A
<7> [294.859868] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CONNECTOR:45:VGA-1] hw state readout: disabled
<7> [294.860108] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:plane A] min_cdclk 0 kHz
<7> [294.860361] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:34:cursor A] min_cdclk 0 kHz
<7> [294.860589] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe A data rate 0 num active planes 0
<7> [294.860820] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:38:plane B] min_cdclk 0 kHz
<7> [294.861055] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor B] min_cdclk 0 kHz
<7> [294.861281] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe B data rate 0 num active planes 0
<7> [294.861539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: no [setup_hw_state]
<7> [294.861772] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:44:pipe B] enable: no [setup_hw_state]
<7> [294.862239] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:37:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [294.862503] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.enable (expected 0, found 1)
<7> [294.862738] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.active (expected 0, found 1)
<7> [294.863246] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [294.863489] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [294.863722] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [294.863964] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2080)
<7> [294.864197] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [294.864429] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2080)
<7> [294.864661] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1968)
<7> [294.864936] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2000)
<7> [294.865198] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1200)
<7> [294.865431] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1235)
<7> [294.865663] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1200)
<7> [294.865905] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1235)
<7> [294.866138] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1203)
<7> [294.866370] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1209)
<7> [294.866602] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [294.866834] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2080)
<7> [294.867075] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [294.867307] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2080)
<7> [294.867540] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1968)
<7> [294.867772] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2000)
<7> [294.868038] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1200)
<7> [294.868298] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1235)
<7> [294.868530] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1200)
<7> [294.868763] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1235)
<7> [294.869005] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1203)
<7> [294.869238] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1209)
<7> [294.869470] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [294.869702] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [294.869944] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [294.870178] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 153600)
<7> [294.870411] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 153600)
<7> [294.870643] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in port_clock (expected 0, found 153600)
<7> [294.870884] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [294.871117] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:44:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<6> [294.871393] serial 00:02: activated
<7> [294.871351] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [294.871616] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:31:plane A] min cdclk (153600 kHz) > [CRTC:37:pipe A] min cdclk (0 kHz)
<7> [294.871854] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz
<7> [294.872127] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [294.872393] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: yes [modeset]
<7> [294.872626] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [294.872858] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [294.873099] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [294.873330] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [294.873561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bigjoiner: no, pipes: 0x0
<7> [294.873792] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [294.874032] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [294.874263] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [294.874495] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [294.874727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x48 0x9
<7> [294.874969] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x48 0x9
<7> [294.875202] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=153600, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1200 vb=1200-1235 vs=1203-1209 vt=1235, flags=0x9
<7> [294.875436] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1200": 60 153600 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [294.875668] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=153600, hd=1920 hb=1920-2080 hs=1968-2000 ht=2080, vd=1200 vb=1200-1235 vs=1203-1209 vt=1235, flags=0x9
<7> [294.875910] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 153600, pipe src: 1920x1200+0+0, pixel rate 153600
<7> [294.876142] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [294.876373] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000
<7> [294.876604] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [294.876835] i915 0000:00:02.0: [drm:intel_dpll_dump_hw_state [i915]] dpll_hw_state: dpll: 0x94010000, dpll_md: 0x0, fp0: 0x30d03, fp1: 0x30d03
<7> [294.877102] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [294.877359] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [294.877591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:plane A] fb: [FB:48] 1920x1200 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [294.877825] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [294.878065] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1200.000000+0.000000+0.000000 dst: 1920x1200+0+0
<7> [294.878299] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:cursor A] fb: [NOFB], visible: no
<7> [294.878530] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:44:pipe B] enable: no [modeset]
<7> [294.878762] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:38:plane B] fb: [NOFB], visible: no
<7> [294.879002] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:cursor B] fb: [NOFB], visible: no
<7> [294.882200] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:46:CRT]
<7> [294.883055] i915 0000:00:02.0: [drm:i9xx_get_fifo_size [i915]] FIFO size - (0x00001d9c) A: 28
<7> [294.883280] [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 50
<7> [294.883503] [drm:intel_calculate_wm [i915]] FIFO watermark level: -22
<7> [294.883725] i915 0000:00:02.0: [drm:i9xx_get_fifo_size [i915]] FIFO size - (0x00001d9c) B: 31
<7> [294.883958] i915 0000:00:02.0: [drm:i9xx_update_wm [i915]] FIFO watermarks - A: 8, B: 29
<7> [294.884184] i915 0000:00:02.0: [drm:i9xx_update_wm [i915]] self-refresh entries: 120
<7> [294.884406] i915 0000:00:02.0: [drm:i9xx_update_wm [i915]] Setting FIFO watermarks - A: 8, B: 29, C: 2, SR 1
<7> [294.884631] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [294.906501] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:45:VGA-1]
<7> [294.906746] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:37:pipe A]
<7> [294.907012] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:44:pipe B]
<7> [294.907439] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:45:VGA-1] force=0
<7> [294.918644] i915 0000:00:02.0: [drm:intel_get_hpd_pins [i915]] hotplug event received, stat 0x00000800, dig 0x00000800, pins 0x00000002, long 0x00000000
<7> [294.918968] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 1 - cnt: 10
<7> [294.919556] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [294.919856] i915 0000:00:02.0: [drm:check_connector_changed [drm_kms_helper]] [CONNECTOR:45:VGA-1] Same epoch counter 1
<7> [294.919946] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] running encoder hotplug functions
<7> [294.920179] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] Connector VGA-1 (pin 1) received hotplug event. (retry 0)
<7> [294.920409] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:45:VGA-1] force=0
<7> [294.935907] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<6> [295.168460] ata2: SATA link down (SStatus 0 SControl 300)
<6> [295.168502] ata6: SATA link down (SStatus 4 SControl 300)
<7> [295.220810] PM: resume of devices complete after 373.609 msecs
<6> [295.222249] OOM killer enabled.
<6> [295.222254] Restarting tasks ...
<6> [295.222285] ACPI: \_SB_.PCI0.IDE1.PRI1.MAS1: docking
<3> [295.229667] ACPI: \_SB_.PCI0.IDE1.PRI1.MAS1: Unable to dock!
<4> [295.233485] done.
<5> [295.233505] random: crng reseeded on system resumption
<6> [295.236135] PM: suspend exit
<7> [295.241398] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [295.253723] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [295.323911] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
<6> [295.338175] ata1.00: configured for UDMA/133
<7> [295.694305] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [295.699464] [IGT] gem_exec_suspend: finished subtest smem, SUCCESS
<6> [295.700053] [IGT] gem_exec_suspend: finished subtest basic-S3, SUCCESS
<6> [295.809755] [IGT] gem_exec_suspend: exiting, ret=0
<7> [295.810382] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<6> [295.838616] Console: switching to colour frame buffer device 240x75
Created at 2023-08-07 00:00:43