Result:
git-log-oneline igt_runner0 run0 runtimes0 results0.json boot0 dmesg0
| Detail | Value |
|---|---|
| Igt-Version |
IGT-Version: 1.28-gd1db7333d (x86_64) (Linux: 6.6.0-rc5-linus-v6.6-rc5-g94f6f0550c62+ x86_64) |
| Out |
Opened device: /dev/dri/card0 Starting subtest: suspend-read-crc Starting dynamic subtest: pipe-A-VGA-1 [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Oct 8 21:12:32 2023 Dynamic subtest pipe-A-VGA-1: SUCCESS (1.707s) |
| Err |
Starting subtest: suspend-read-crc Starting dynamic subtest: pipe-A-VGA-1 Dynamic subtest pipe-A-VGA-1: SUCCESS (1.707s) |
| Dmesg |
<6> [325.061544] Console: switching to colour dummy device 80x25
<6> [325.062322] [IGT] kms_pipe_crc_basic: executing
<7> [325.118548] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [325.119432] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [325.119861] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [325.127789] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:64:HDMI-A-1]
<7> [325.127806] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:64:HDMI-A-1]
<7> [325.128886] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [325.129169] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7> [325.129539] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [325.129774] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [325.129786] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] HDMI GMBUS EDID read failed, retry using GPIO bit-banging
<7> [325.130029] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus dpc. force bit now 1
<7> [325.131065] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [325.131073] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus dpc. force bit now 0
<7> [325.131264] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:64:HDMI-A-1] disconnected
<7> [325.131929] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:72:DP-1]
<7> [325.131939] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:72:DP-1]
<7> [325.132144] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:72:DP-1] disconnected
<7> [325.132457] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:61:VGA-1]
<7> [325.132466] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:61:VGA-1] force=1
<7> [325.132728] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0x83f40000, result 1
<7> [325.132964] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [325.133353] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [325.133539] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [325.134198] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [325.134392] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [325.134398] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [325.134586] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [325.135541] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [325.135549] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [325.135941] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:61:VGA-1] probed modes :
<7> [325.135950] [drm:drm_mode_debug_printmodeline] Modeline "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [325.135960] [drm:drm_mode_debug_printmodeline] Modeline "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [325.135969] [drm:drm_mode_debug_printmodeline] Modeline "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [325.135976] [drm:drm_mode_debug_printmodeline] Modeline "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [325.135985] [drm:drm_mode_debug_printmodeline] Modeline "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [325.136030] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:64:HDMI-A-1]
<7> [325.136041] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:64:HDMI-A-1]
<7> [325.136903] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [325.137167] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7> [325.137562] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [325.137797] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [325.137807] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] HDMI GMBUS EDID read failed, retry using GPIO bit-banging
<7> [325.138018] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus dpc. force bit now 1
<7> [325.139030] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [325.139038] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus dpc. force bit now 0
<7> [325.139231] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:64:HDMI-A-1] disconnected
<7> [325.139270] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:72:DP-1]
<7> [325.139278] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:72:DP-1]
<7> [325.139479] [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:72:DP-1] disconnected
<6> [325.140296] [IGT] kms_pipe_crc_basic: starting subtest suspend-read-crc
<6> [325.141429] [IGT] kms_pipe_crc_basic: starting dynamic subtest pipe-A-VGA-1
<7> [325.141885] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [325.188095] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [325.188143] [drm:drm_mode_setcrtc] [CONNECTOR:61:VGA-1]
<7> [325.205640] [drm:drm_mode_setcrtc] [CRTC:60:pipe B]
<7> [325.208637] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<7> [325.209717] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<7> [325.322048] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:79] from all active usage due to RMFB ioctl
<7> [325.322114] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:31:primary A] because [FB:79] is removed
<7> [325.339136] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:79]
<7> [325.351635] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [325.351673] [drm:drm_mode_setcrtc] [CONNECTOR:61:VGA-1]
<7> [325.372423] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<7> [325.489136] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:79] from all active usage due to RMFB ioctl
<7> [325.489218] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:31:primary A] because [FB:79] is removed
<7> [325.506139] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [325.506240] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.enable (expected 1, found 0)
<7> [325.506538] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.active (expected 1, found 0)
<7> [325.506798] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [325.507003] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [325.507207] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_lanes (expected 1, found 0)
<7> [325.507410] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6039797/8388608 link 125829/524288, found tu 0, data 0/0 link 0/0)
<7> [325.507647] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [325.507907] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [325.508112] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [325.508316] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [325.508545] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [325.508774] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [325.508979] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [325.509182] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [325.509386] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [325.509616] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [325.509887] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [325.510092] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [325.510295] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [325.510559] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [325.510870] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [325.511204] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [325.511537] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [325.511845] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [325.512151] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [325.512456] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [325.512715] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [325.512920] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [325.513123] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [325.513327] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [325.513572] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [325.513797] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [325.514001] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [325.514205] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [325.514409] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [325.514668] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [325.514917] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64800, found 0)
<7> [325.515162] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64800, found 0)
<7> [325.515367] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in port_clock (expected 64800, found 0)
<7> [325.515601] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [325.515854] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:45:pipe A] releasing PCH DPLL A
<7> [325.516092] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 450000 kHz, actual 450000 kHz
<7> [325.516297] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [325.516526] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:45:pipe A] enable: no [modeset]
<7> [325.516779] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:primary A] fb: [NOFB], visible: no
<7> [325.517192] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [325.539787] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:45:pipe A]
<7> [325.540521] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [325.541008] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:62:CRT]
<7> [325.541214] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:63:HDMI C]
<7> [325.541406] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:71:DP C]
<7> [325.541621] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:61:VGA-1]
<7> [325.541860] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL A
<7> [325.542065] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL B
<7> [325.542305] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:45:pipe A]
<7> [325.560501] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<6> [325.696783] PM: suspend entry (deep)
<6> [325.704682] Filesystems sync: 0.007 seconds
<6> [325.705496] Freezing user space processes
<6> [325.731061] Freezing user space processes completed (elapsed 0.025 seconds)
<6> [325.731077] OOM killer disabled.
<6> [325.731083] Freezing remaining freezable tasks
<6> [325.733027] Freezing remaining freezable tasks completed (elapsed 0.001 seconds)
<6> [325.749580] serial 00:04: disabled
<6> [325.751001] e1000e: EEE TX LPI TIMER: 00000000
<5> [325.752876] sd 0:0:0:0: [sda] Synchronizing SCSI cache
<5> [325.760672] ata1.00: Entering standby power mode
<7> [326.048281] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.067702] PM: suspend of devices complete after 331.334 msecs
<7> [326.067722] PM: start suspend of devices complete after 334.708 msecs
<7> [326.073704] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.086718] PM: late suspend of devices complete after 18.992 msecs
<7> [326.104313] PM: noirq suspend of devices complete after 16.644 msecs
<6> [326.104330] ACPI: PM: Preparing to enter system sleep state S3
<6> [326.108624] ACPI: PM: Saving platform NVS memory
<6> [326.108928] Disabling non-boot CPUs ...
<6> [326.113800] smpboot: CPU 1 is now offline
<6> [326.121011] smpboot: CPU 2 is now offline
<6> [326.127642] smpboot: CPU 3 is now offline
<7> [326.130324] Checking wakeup interrupts
<7> [326.130339] Calling mce_syscore_suspend+0x0/0x10
<7> [326.130358] Calling timekeeping_suspend+0x0/0x320
<7> [326.130406] Calling save_ioapic_entries+0x0/0xa0
<7> [326.130500] Calling i8259A_suspend+0x0/0x30
<7> [326.130513] Calling fw_suspend+0x0/0x20
<7> [326.130526] Calling acpi_save_bm_rld+0x0/0x20
<7> [326.130542] Calling lapic_suspend+0x0/0x180
<6> [326.131002] ACPI: PM: Low-level resume complete
<6> [326.131039] ACPI: PM: Restoring platform NVS memory
<7> [326.131047] Calling init_counter_refs+0x0/0x70
<7> [326.131055] Calling lapic_resume+0x0/0x280
<7> [326.131071] Calling acpi_restore_bm_rld+0x0/0x70
<7> [326.131080] Calling irqrouter_resume+0x0/0x50
<7> [326.131085] Calling i8259A_resume+0x0/0x30
<7> [326.131221] Calling i8237A_resume+0x0/0xa0
<7> [326.131283] Calling ioapic_resume+0x0/0xb0
<7> [326.131315] Calling irq_pm_syscore_resume+0x0/0x10
<7> [326.131699] Calling timekeeping_resume+0x0/0x1c0
<7> [326.131737] Timekeeping suspended for 15.716 seconds
<7> [326.131768] Calling mce_syscore_resume+0x0/0x30
<7> [326.131784] Calling microcode_bsp_resume+0x0/0xc0
<6> [326.131840] Enabling non-boot CPUs ...
<6> [326.132051] smpboot: Booting Node 0 Processor 1 APIC 0x1
<6> [326.139373] CPU1 is up
<6> [326.139594] smpboot: Booting Node 0 Processor 2 APIC 0x4
<6> [326.147174] CPU2 is up
<6> [326.147355] smpboot: Booting Node 0 Processor 3 APIC 0x5
<6> [326.154623] CPU3 is up
<6> [326.156855] ACPI: PM: Waking up from system sleep state S3
<7> [326.160524] PM: noirq resume of devices complete after 2.533 msecs
<7> [326.162239] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.163255] PM: early resume of devices complete after 2.132 msecs
<6> [326.170486] serial 00:04: activated
<7> [326.173740] i915 0000:00:02.0: [drm:intel_vga_redisable_power_on [i915]] Something enabled VGA plane, disabling it
<7> [326.174297] i915 0000:00:02.0: [drm:intel_init_pch_refclk [i915]] has_panel 0 has_lvds 0 has_ck505 0 using_ssc_source 0
<7> [326.174512] i915 0000:00:02.0: [drm:intel_init_pch_refclk [i915]] Disabling CPU source output
<7> [326.175163] i915 0000:00:02.0: [drm:intel_init_pch_refclk [i915]] Disabling SSC source
<7> [326.175680] i915 0000:00:02.0: [drm:intel_crt_reset [i915]] crt adpa set to 0xf40000
<7> [326.176359] i915 0000:00:02.0: [drm:intel_cdclk_dump_config [i915]] Current CDCLK 450000 kHz, VCO 0 kHz, ref 0 kHz, bypass 0 kHz, voltage level 0
<7> [326.176766] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:45:pipe A] hw state readout: disabled
<7> [326.177112] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CRTC:60:pipe B] hw state readout: disabled
<7> [326.177452] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:primary A] hw state readout: disabled, pipe A
<7> [326.177787] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:35:sprite A] hw state readout: disabled, pipe A
<7> [326.178111] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor A] hw state readout: disabled, pipe A
<7> [326.178753] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:46:primary B] hw state readout: disabled, pipe B
<7> [326.179331] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:50:sprite B] hw state readout: disabled, pipe B
<7> [326.179931] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:56:cursor B] hw state readout: disabled, pipe B
<7> [326.180526] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [ENCODER:62:CRT] hw state readout: disabled, pipe A
<7> [326.181076] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [ENCODER:63:HDMI C] hw state readout: disabled, pipe A
<7> [326.181672] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [ENCODER:71:DP C] hw state readout: disabled, pipe A
<7> [326.182223] i915 0000:00:02.0: [drm:intel_dpll_readout_hw_state [i915]] PCH DPLL A hw state readout: pipe_mask 0x0, on 0
<7> [326.182833] i915 0000:00:02.0: [drm:intel_dpll_readout_hw_state [i915]] PCH DPLL B hw state readout: pipe_mask 0x0, on 0
<7> [326.183392] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CONNECTOR:61:VGA-1] hw state readout: disabled
<7> [326.184056] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CONNECTOR:64:HDMI-A-1] hw state readout: disabled
<7> [326.184638] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [CONNECTOR:72:DP-1] hw state readout: disabled
<7> [326.185167] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:31:primary A] min_cdclk 0 kHz
<7> [326.185722] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:35:sprite A] min_cdclk 0 kHz
<7> [326.186246] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:41:cursor A] min_cdclk 0 kHz
<7> [326.186799] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe A data rate 0 num active planes 0
<7> [326.187337] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:46:primary B] min_cdclk 0 kHz
<7> [326.187889] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:50:sprite B] min_cdclk 0 kHz
<7> [326.188413] i915 0000:00:02.0: [drm:intel_modeset_setup_hw_state [i915]] [PLANE:56:cursor B] min_cdclk 0 kHz
<7> [326.188966] i915 0000:00:02.0: [drm:intel_bw_crtc_update [i915]] pipe B data rate 0 num active planes 0
<7> [326.189574] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:45:pipe A] enable: no [setup_hw_state]
<7> [326.190114] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:60:pipe B] enable: no [setup_hw_state]
<7> [326.190848] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [326.191392] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in dpll_hw_state.dpll (expected 0x00000000, found 0x84100010)
<7> [326.191964] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in dpll_hw_state.fp0 (expected 0x00000000, found 0x00010c09)
<7> [326.192532] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in dpll_hw_state.fp1 (expected 0x00000000, found 0x00010c09)
<7> [326.193074] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [326.193640] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:60:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [326.194182] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [326.194814] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:45:pipe A] enable: no [modeset]
<7> [326.195355] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:primary A] fb: [NOFB], visible: no
<7> [326.195923] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:sprite A] fb: [NOFB], visible: no
<7> [326.196489] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:cursor A] fb: [NOFB], visible: no
<7> [326.197028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:60:pipe B] enable: no [modeset]
<7> [326.197595] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:46:primary B] fb: [NOFB], visible: no
<7> [326.198133] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:sprite B] fb: [NOFB], visible: no
<7> [326.198698] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:56:cursor B] fb: [NOFB], visible: no
<7> [326.199470] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:62:CRT]
<7> [326.199998] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:63:HDMI C]
<7> [326.200642] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:71:DP C]
<7> [326.201464] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:61:VGA-1]
<7> [326.202279] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:HDMI-A-1]
<7> [326.203132] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:72:DP-1]
<7> [326.203979] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL A
<7> [326.204838] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL B
<7> [326.205712] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:45:pipe A]
<7> [326.206574] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:60:pipe B]
<7> [326.208271] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:61:VGA-1] force=0
<7> [326.209117] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] trigger hotplug detect cycle: adpa=0xf40000
<7> [326.216452] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port B
<7> [326.216668] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port C
<7> [326.216874] i915 0000:00:02.0: [drm:i915_audio_component_get_eld [i915]] Not valid for port D
<7> [326.217898] i915 0000:00:02.0: [drm:intel_get_hpd_pins [i915]] hotplug event received, stat 0x00000800, dig 0x00001000, pins 0x00000002, long 0x00000000
<7> [326.218072] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0x3f40000, result 1
<7> [326.218101] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 1 - cnt: 10
<7> [326.218308] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [326.218536] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.219127] i915 0000:00:02.0: [drm:check_connector_changed] [CONNECTOR:61:VGA-1] Same epoch counter 1
<7> [326.219141] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:64:HDMI-A-1]
<7> [326.219441] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.220098] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [326.220706] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7> [326.221561] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7> [326.222328] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [326.222354] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] HDMI GMBUS EDID read failed, retry using GPIO bit-banging
<7> [326.223118] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus dpc. force bit now 1
<7> [326.224658] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7> [326.224687] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus dpc. force bit now 0
<7> [326.225490] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.226334] i915 0000:00:02.0: [drm:check_connector_changed] [CONNECTOR:64:HDMI-A-1] Same epoch counter 1
<7> [326.226367] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:72:DP-1]
<7> [326.227206] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.228107] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.228999] i915 0000:00:02.0: [drm:check_connector_changed] [CONNECTOR:72:DP-1] Same epoch counter 1
<7> [326.229123] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] running encoder hotplug functions
<7> [326.229422] i915 0000:00:02.0: [drm:i915_hotplug_work_func [i915]] Connector VGA-1 (pin 1) received hotplug event. (retry 0)
<7> [326.229629] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:61:VGA-1] force=0
<7> [326.229843] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.230048] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0x3f40000, result 1
<7> [326.230243] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [326.230477] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.400142] PM: resume of devices complete after 236.996 msecs
<6> [326.401958] OOM killer enabled.
<6> [326.401963] Restarting tasks ... done.
<5> [326.408366] random: crng reseeded on system resumption
<6> [326.408389] PM: suspend exit
<7> [326.412852] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:78]
<7> [326.428013] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.429171] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [326.429225] [drm:drm_mode_setcrtc] [CONNECTOR:61:VGA-1]
<7> [326.429383] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:61:VGA-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [326.429723] i915 0000:00:02.0: [drm:ilk_fdi_compute_config [i915]] checking fdi config on pipe A, lanes 1
<7> [326.430021] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:45:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [326.430291] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.enable (expected 0, found 1)
<7> [326.430677] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.active (expected 0, found 1)
<7> [326.430972] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [326.431264] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [326.431617] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [326.431945] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [326.432244] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [326.432603] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [326.432899] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [326.433196] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [326.433742] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [326.434028] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [326.434370] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [326.434670] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [326.434974] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [326.435282] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [326.435613] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [326.435923] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [326.436232] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [326.436584] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [326.436880] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [326.437204] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [326.437530] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [326.437832] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [326.438125] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [326.438444] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [326.438735] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [326.439028] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [326.439346] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [326.439645] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [326.439947] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [326.440230] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [326.440589] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [326.440882] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [326.441174] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [326.441496] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [326.441790] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [326.442089] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [326.442426] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [326.442723] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [326.443064] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:31:primary A] min cdclk (64800 kHz) > [CRTC:45:pipe A] min cdclk (0 kHz)
<7> [326.443388] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 450000 kHz, actual 450000 kHz
<7> [326.443684] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [326.443966] i915 0000:00:02.0: [drm:ibx_get_dpll [i915]] [CRTC:45:pipe A] using pre-allocated PCH DPLL A
<7> [326.444257] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc.isra.0 [i915]] [CRTC:45:pipe A] reserving PCH DPLL A
<7> [326.444647] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:45:pipe A] enable: yes [modeset]
<7> [326.444943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [326.445234] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [326.445545] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [326.445823] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [326.446123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bigjoiner: no, pipes: 0x0
<7> [326.446455] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [326.446752] i915 0000:00:02.0: [drm:intel_dump_m_n_config.isra.0 [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [326.447043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [326.447098] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [326.447368] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [326.447700] 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> [326.448000] 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> [326.448314] 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> [326.448622] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [326.448930] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [326.449242] i915 0000:00:02.0: [drm:intel_dump_crtc_timings [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [326.449616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [326.449928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [326.450235] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [326.450555] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [326.450849] i915 0000:00:02.0: [drm:ibx_dump_hw_state [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [326.451143] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [326.451458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [326.451752] i915 0000:00:02.0: [drm:ilk_dump_csc [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [326.452044] i915 0000:00:02.0: [drm:ilk_dump_csc [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [326.452351] i915 0000:00:02.0: [drm:ilk_dump_csc [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [326.452654] i915 0000:00:02.0: [drm:ilk_dump_csc [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [326.452982] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:primary A] fb: [FB:78] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [326.453357] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [326.453644] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [326.454598] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [326.454954] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:62:CRT]
<7> [326.455240] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:63:HDMI C]
<7> [326.455553] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:71:DP C]
<7> [326.455835] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL A
<7> [326.456129] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL B
<7> [326.456936] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [326.457591] i915 0000:00:02.0: [drm:ilk_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [326.457882] i915 0000:00:02.0: [drm:ilk_fdi_link_train [i915]] FDI train 1 done.
<7> [326.458360] i915 0000:00:02.0: [drm:ilk_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [326.458652] i915 0000:00:02.0: [drm:ilk_fdi_link_train [i915]] FDI train 2 done.
<7> [326.458941] i915 0000:00:02.0: [drm:ilk_pch_enable [i915]] FDI train done
<7> [326.459229] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable PCH DPLL A (active 0x1, on? 0) for [CRTC:45:pipe A]
<7> [326.459557] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<6> [326.485375] ata3: SATA link down (SStatus 0 SControl 300)
<6> [326.485527] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
<5> [326.485538] ata1.00: Entering active power mode
<6> [326.488173] ata5: SATA link down (SStatus 0 SControl 300)
<6> [326.488584] ata2: SATA link down (SStatus 0 SControl 300)
<6> [326.496928] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0(SET FEATURES) filtered out
<6> [326.496934] ata1.00: ACPI cmd ef/03:45:00:00:00:a0(SET FEATURES) filtered out
<6> [326.507897] ata1.00: ACPI cmd f5/00:00:00:00:00:a0(SECURITY FREEZE LOCK) filtered out
<6> [326.507903] ata1.00: ACPI cmd ef/10:03:00:00:00:a0(SET FEATURES) filtered out
<7> [326.511495] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:61:VGA-1]
<7> [326.511781] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:45:pipe A]
<7> [326.512015] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL A
<7> [326.513598] [drm:drm_mode_setcrtc] [CRTC:60:pipe B]
<7> [326.515134] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<7> [326.515524] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<6> [326.559491] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0(SET FEATURES) filtered out
<6> [326.559497] ata1.00: ACPI cmd ef/03:45:00:00:00:a0(SET FEATURES) filtered out
<6> [326.570613] ata1.00: ACPI cmd f5/00:00:00:00:00:a0(SECURITY FREEZE LOCK) filtered out
<6> [326.570629] ata1.00: ACPI cmd ef/10:03:00:00:00:a0(SET FEATURES) filtered out
<6> [326.612657] ata1.00: configured for UDMA/133
<7> [326.628836] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:78] from all active usage due to RMFB ioctl
<7> [326.628887] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:31:primary A] because [FB:78] is removed
<7> [326.645695] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:78]
<7> [326.655388] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [326.655440] [drm:drm_mode_setcrtc] [CONNECTOR:61:VGA-1]
<7> [326.679145] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A
<7> [326.796169] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:78] from all active usage due to RMFB ioctl
<7> [326.796287] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:31:primary A] because [FB:78] is removed
<7> [326.813572] [drm:drm_mode_setcrtc] [CRTC:45:pipe A]
<7> [326.813895] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.enable (expected 1, found 0)
<7> [326.815252] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.active (expected 1, found 0)
<7> [326.815642] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [326.815979] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [326.816223] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_lanes (expected 1, found 0)
<7> [326.816464] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6039797/8388608 link 125829/524288, found tu 0, data 0/0 link 0/0)
<7> [326.816671] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [326.816875] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [326.817079] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [326.817303] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [326.817554] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [326.817758] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [326.817962] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [326.818247] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [326.818574] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [326.818901] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [326.819253] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [326.819583] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [326.819916] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [326.820260] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [326.820586] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [326.820896] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [326.821171] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [326.821368] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [326.821565] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [326.821760] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [326.821956] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [326.822184] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [326.822404] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [326.822600] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [326.822811] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [326.823032] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [326.823257] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [326.823486] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [326.823683] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [326.823881] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [326.824077] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64800, found 0)
<7> [326.824302] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64800, found 0)
<7> [326.824517] i915 0000:00:02.0: [drm:pipe_config_mismatch [i915]] [CRTC:45:pipe A] fastset requirement not met in port_clock (expected 64800, found 0)
<7> [326.824715] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] fastset requirement not met, forcing full modeset
<7> [326.824912] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:45:pipe A] releasing PCH DPLL A
<7> [326.825167] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 450000 kHz, actual 450000 kHz
<7> [326.825377] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [326.825580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:45:pipe A] enable: no [modeset]
<7> [326.825777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:31:primary A] fb: [NOFB], visible: no
<7> [326.826127] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [326.846359] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:45:pipe A]
<7> [326.846786] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [326.847447] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:62:CRT]
<7> [326.847860] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:63:HDMI C]
<7> [326.848263] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:71:DP C]
<7> [326.848614] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:61:VGA-1]
<7> [326.848936] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL A
<7> [326.849233] i915 0000:00:02.0: [drm:verify_single_dpll_state.isra.0 [i915]] PCH DPLL B
<7> [326.849589] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:45:pipe A]
<6> [326.850901] [IGT] kms_pipe_crc_basic: finished subtest pipe-A-VGA-1, SUCCESS
|