Result:
git-log-oneline igt_runner0 run0 runtimes0 results0.json boot0 dmesg0
| Detail | Value |
|---|---|
| Duration | 6.17 seconds |
| Igt-Version |
IGT-Version: 1.28-g5652fea13 (x86_64) (Linux: 6.7.0-linus-v6.7-g0dd3ee311255+ x86_64) |
| Out |
Using IGT_SRANDOM=1704660028 for randomisation Opened device: /dev/dri/card0 Starting subtest: basic-S3 Starting dynamic subtest: smem [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Jan 7 20:40:48 2024 Dynamic subtest smem: SUCCESS (6.172s) Subtest basic-S3: SUCCESS (6.177s) |
| Err |
Starting subtest: basic-S3 Starting dynamic subtest: smem Dynamic subtest smem: SUCCESS (6.172s) Subtest basic-S3: SUCCESS (6.177s) |
| Dmesg |
<6> [496.435621] Console: switching to colour dummy device 80x25
<6> [496.437805] [IGT] gem_exec_suspend: executing
<7> [496.463113] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [496.467468] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [496.469602] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [496.472062] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [496.531239] [IGT] gem_exec_suspend: starting subtest basic-S3
<6> [496.534149] [IGT] gem_exec_suspend: starting dynamic subtest smem
<7> [496.545344] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [498.085252] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [498.096172] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [499.931992] PM: suspend entry (deep)
<6> [499.937864] Filesystems sync: 0.005 seconds
<6> [499.941087] Freezing user space processes
<6> [499.949262] Freezing user space processes completed (elapsed 0.008 seconds)
<6> [499.949306] OOM killer disabled.
<6> [499.949321] Freezing remaining freezable tasks
<6> [499.952624] Freezing remaining freezable tasks completed (elapsed 0.003 seconds)
<5> [499.988883] sd 0:0:0:0: [sda] Synchronizing SCSI cache
<5> [499.989821] ata1.00: Entering standby power mode
<6> [499.993966] serial 00:06: disabled
<6> [499.996011] serial 00:05: disabled
<6> [499.997376] r8169 0000:01:00.0 enp1s0: Link is Down
<7> [500.002438] 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> [500.003457] 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> [500.004483] 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> [500.005626] 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> [500.006975] 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> [500.008129] 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 1024, found 0)
<7> [500.009157] 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 1344, found 0)
<7> [500.010343] 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 1024, found 0)
<7> [500.011643] 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 1344, found 0)
<7> [500.012793] 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 1048, found 0)
<7> [500.013806] 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 1184, found 0)
<7> [500.014828] 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 768, found 0)
<7> [500.015852] 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 768, found 0)
<7> [500.016905] 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 771, found 0)
<7> [500.017924] 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 777, found 0)
<7> [500.018949] 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 806, found 0)
<7> [500.019972] 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 806, found 0)
<7> [500.021030] 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 1024, found 0)
<7> [500.022048] 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 1344, found 0)
<7> [500.023069] 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 1024, found 0)
<7> [500.024157] 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 1344, found 0)
<7> [500.025274] 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 1048, found 0)
<7> [500.026333] 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 1184, found 0)
<7> [500.027436] 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 768, found 0)
<7> [500.028564] 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 768, found 0)
<7> [500.029491] 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 771, found 0)
<7> [500.030565] 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 777, found 0)
<7> [500.031587] 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 806, found 0)
<7> [500.032587] 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 806, found 0)
<7> [500.033582] 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> [500.034490] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [500.035487] 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> [500.036489] 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 64960, found 0)
<7> [500.037486] 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 64960, found 0)
<7> [500.038482] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in port_clock (expected 64960, found 0)
<7> [500.039480] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [500.040635] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz
<7> [500.041625] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [500.042626] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: no [modeset]
<7> [500.043619] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:plane A] fb: [NOFB], visible: no
<7> [500.045013] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled)
<7> [500.050434] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [500.079703] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was disabled)
<7> [500.080853] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:46:CRT]
<7> [500.081920] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:45:VGA-1]
<7> [500.083243] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:37:pipe A]
<7> [500.291595] PM: suspend of devices complete after 314.225 msecs
<7> [500.291642] PM: start suspend of devices complete after 338.176 msecs
<7> [500.304025] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [500.317947] PM: late suspend of devices complete after 26.266 msecs
<7> [500.346904] PM: noirq suspend of devices complete after 27.054 msecs
<6> [500.346937] ACPI: PM: Preparing to enter system sleep state S3
<6> [500.373323] ACPI: PM: Saving platform NVS memory
<6> [500.385001] Disabling non-boot CPUs ...
<6> [500.396214] smpboot: CPU 1 is now offline
<6> [500.410355] smpboot: CPU 2 is now offline
<6> [500.423101] smpboot: CPU 3 is now offline
<7> [500.443704] Checking wakeup interrupts
<7> [500.443728] Calling mce_syscore_suspend+0x0/0x10
<7> [500.443754] Calling timekeeping_suspend+0x0/0x320
<7> [500.443826] Calling save_ioapic_entries+0x0/0xa0
<7> [500.443967] Calling i8259A_suspend+0x0/0x30
<7> [500.443988] Calling fw_suspend+0x0/0x20
<7> [500.444004] Calling acpi_save_bm_rld+0x0/0x20
<7> [500.444028] Calling lapic_suspend+0x0/0x180
<6> [500.444028] ACPI: PM: Low-level resume complete
<6> [500.444028] ACPI: PM: Restoring platform NVS memory
<7> [500.444028] Calling lapic_resume+0x0/0x280
<7> [500.444028] Calling acpi_restore_bm_rld+0x0/0x70
<7> [500.444028] Calling irqrouter_resume+0x0/0x50
<7> [500.444028] Calling i8259A_resume+0x0/0x30
<7> [500.444028] Calling i8237A_resume+0x0/0xa0
<7> [500.444028] Calling ioapic_resume+0x0/0xb0
<7> [500.444028] Calling irq_pm_syscore_resume+0x0/0x10
<7> [500.444028] Calling timekeeping_resume+0x0/0x1c0
<7> [500.444028] Timekeeping suspended for 16.327 seconds
<7> [500.444028] Calling mce_syscore_resume+0x0/0x30
<7> [500.444028] Calling microcode_bsp_resume+0x0/0xc0
<6> [500.444028] Enabling non-boot CPUs ...
<6> [500.445156] smpboot: Booting Node 0 Processor 1 APIC 0x1
<6> [500.456335] CPU1 is up
<6> [500.457222] smpboot: Booting Node 0 Processor 2 APIC 0x2
<6> [500.471280] CPU2 is up
<6> [500.472137] smpboot: Booting Node 0 Processor 3 APIC 0x3
<6> [500.483278] CPU3 is up
<6> [500.493915] ACPI: PM: Waking up from system sleep state S3
<7> [500.525883] PM: noirq resume of devices complete after 10.093 msecs
<7> [500.534056] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [500.536209] PM: early resume of devices complete after 8.466 msecs
<5> [500.543687] usb usb1: root hub lost power or was reset
<5> [500.546012] usb usb3: root hub lost power or was reset
<5> [500.550674] usb usb4: root hub lost power or was reset
<7> [500.551460] i915 0000:00:02.0: [drm:intel_vga_redisable_power_on [i915]] Something enabled VGA plane, disabling it
<7> [500.554037] i915 0000:00:02.0: [drm:intel_cdclk_dump_config [i915]] Current CDCLK 333333 kHz, VCO 0 kHz, ref 0 kHz, bypass 0 kHz, voltage level 0
<7> [500.555918] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:37:pipe A] hw state readout: disabled
<7> [500.557314] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:44:pipe B] hw state readout: disabled
<7> [500.558680] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:plane A] hw state readout: disabled, pipe A
<7> [500.560109] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:34:cursor A] hw state readout: disabled, pipe A
<7> [500.561653] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:38:plane B] hw state readout: disabled, pipe A
<7> [500.563071] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor B] hw state readout: disabled, pipe A
<7> [500.564495] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [ENCODER:46:CRT] hw state readout: disabled, pipe A
<7> [500.565911] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CONNECTOR:45:VGA-1] hw state readout: disabled
<7> [500.567229] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:plane A] min_cdclk 0 kHz
<7> [500.568592] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:34:cursor A] min_cdclk 0 kHz
<7> [500.569895] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe A data rate 0 num active planes 0
<7> [500.571204] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:38:plane B] min_cdclk 0 kHz
<7> [500.572466] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor B] min_cdclk 0 kHz
<7> [500.573700] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe B data rate 0 num active planes 0
<7> [500.575046] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: no [setup_hw_state]
<7> [500.576071] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:44:pipe B] enable: no [setup_hw_state]
<5> [500.577640] usb usb5: root hub lost power or was reset
<7> [500.580015] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:37:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [500.581442] 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> [500.583588] 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> [500.584880] 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)
<6> [500.586130] serial 00:05: activated
<7> [500.586166] 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> [500.587257] 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 1024)
<7> [500.588352] 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 1344)
<7> [500.589622] 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 1024)
<7> [500.590903] 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 1344)
<7> [500.592227] 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 1048)
<7> [500.593589] 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 1184)
<7> [500.594876] 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 768)
<7> [500.596168] 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 768)
<7> [500.597464] 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 771)
<7> [500.598737] 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 777)
<7> [500.600042] 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 806)
<7> [500.601329] 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 806)
<7> [500.602613] 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 1024)
<7> [500.603909] 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 1344)
<7> [500.605193] 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 1024)
<7> [500.606600] 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 1344)
<7> [500.607856] 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 1048)
<7> [500.609151] 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 1184)
<7> [500.610447] 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 768)
<7> [500.611719] 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 768)
<7> [500.613019] 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 771)
<7> [500.614296] 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 777)
<7> [500.615621] 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 806)
<7> [500.616893] 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 806)
<7> [500.618170] 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> [500.619446] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<6> [500.620145] serial 00:06: activated
<7> [500.620714] 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> [500.622021] 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 64960)
<7> [500.623331] 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 64960)
<7> [500.624623] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:37:pipe A] fastset requirement not met in port_clock (expected 0, found 64960)
<7> [500.625642] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [500.626659] 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)
<7> [500.627691] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [500.628833] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:31:plane A] min cdclk (64960 kHz) > [CRTC:37:pipe A] min cdclk (0 kHz)
<7> [500.629862] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz
<7> [500.630876] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [500.631907] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:37:pipe A] enable: yes [modeset]
<7> [500.632924] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [500.633980] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [500.634993] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [500.636006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [500.637024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bigjoiner: no, pipes: 0x0
<7> [500.638039] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [500.639059] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [500.640076] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [500.641109] 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> [500.642131] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [500.643188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [500.644208] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=64960, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [500.645233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64960 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [500.646255] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=64960, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [500.647281] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960
<7> [500.648300] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [500.649315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000
<7> [500.650333] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [500.651383] i915 0000:00:02.0: [drm:intel_dpll_dump_hw_state [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9
<7> [500.652408] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [500.653440] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [500.654461] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:plane A] fb: [FB:47] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [500.655603] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [500.656600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [500.657593] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:cursor A] fb: [NOFB], visible: no
<7> [500.658583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:44:pipe B] enable: no [modeset]
<7> [500.659489] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:38:plane B] fb: [NOFB], visible: no
<7> [500.660476] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:cursor B] fb: [NOFB], visible: no
<7> [500.662115] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:46:CRT]
<7> [500.663794] [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24
<7> [500.664808] [drm:intel_calculate_wm [i915]] FIFO watermark level: 488
<7> [500.665834] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f
<7> [500.666800] [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21
<7> [500.667759] [drm:intel_calculate_wm [i915]] FIFO watermark level: 491
<7> [500.668722] [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146
<7> [500.669684] [drm:intel_calculate_wm [i915]] FIFO watermark level: 366
<7> [500.670647] [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143
<7> [500.671607] [drm:intel_calculate_wm [i915]] FIFO watermark level: 369
<7> [500.672486] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e
<7> [500.673479] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled)
<7> [500.674495] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [500.692606] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:45:VGA-1]
<7> [500.693745] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:37:pipe A]
<7> [500.695012] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:44:pipe B]
<7> [500.697096] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:45:VGA-1] force=0
<7> [500.698198] i915 0000:00:02.0: [drm:intel_opregion_resume [i915]] 1 outputs detected
<7> [500.709501] i915 0000:00:02.0: [drm:intel_get_hpd_pins [i915]] hotplug event received, stat 0x00000800, dig 0x00000800, pins 0x00000002, long 0x00000000
<7> [500.710389] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 1 - cnt: 10
<7> [500.712041] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [500.713252] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] running encoder hotplug functions
<7> [500.714420] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] Connector VGA-1 (pin 1) received hotplug event. (retry 0)
<7> [500.715418] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:45:VGA-1] force=0
<6> [500.718823] r8169 0000:01:00.0 enp1s0: Link is Down
<7> [500.728583] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [500.750818] PM: resume of devices complete after 214.569 msecs
<6> [500.755668] OOM killer enabled.
<6> [500.755695] Restarting tasks ...
<6> [500.757689] pci 0000:00:1e.0: PCI bridge to [bus 05]
<6> [500.768935] pci 0000:00:1e.0: PCI bridge to [bus 05]
<4> [500.773393] done.
<5> [500.773471] random: crng reseeded on system resumption
<6> [500.777693] PM: suspend exit
<6> [500.779961] pci 0000:00:1e.0: PCI bridge to [bus 05]
<6> [500.784992] pci 0000:00:1e.0: PCI bridge to [bus 05]
<6> [500.792830] pci 0000:00:1e.0: PCI bridge to [bus 05]
<7> [500.813970] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [500.837075] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [500.856688] ata2: SATA link down (SStatus 0 SControl 300)
<6> [500.858640] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
<6> [500.877408] ata1.00: configured for UDMA/133
<7> [502.698059] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [502.710862] [IGT] gem_exec_suspend: finished subtest smem, SUCCESS
<6> [502.713096] [IGT] gem_exec_suspend: finished subtest basic-S3, SUCCESS
<6> [502.854078] [IGT] gem_exec_suspend: exiting, ret=0
<7> [502.857948] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<6> [502.895862] Console: switching to colour frame buffer device 128x48
|