<6>[ 125.001215] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 125.004805] ata1.00: configured for UDMA/33 <6>[ 126.988207] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 126.991238] ata1.00: configured for UDMA/33 <6>[ 127.975197] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 127.978419] ata1.00: configured for UDMA/33 <6>[ 128.832190] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 128.835817] ata1.00: configured for UDMA/33 <6>[ 128.853984] Console: switching to colour dummy device 80x25 <7>[ 128.855362] [IGT] syncobj_timeline: executing <7>[ 128.921874] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 128.929752] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 128.933170] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 128.948913] [IGT] syncobj_timeline: starting subtest invalid-wait-bad-flags <7>[ 128.950699] [IGT] syncobj_timeline: finished subtest invalid-wait-bad-flags, SUCCESS <7>[ 128.954897] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 128.957830] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 128.984941] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 129.003626] Console: switching to colour frame buffer device 128x48 <6>[ 129.911182] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 129.914244] ata1.00: configured for UDMA/33 <6>[ 130.270215] Console: switching to colour dummy device 80x25 <7>[ 130.270859] [IGT] gem_exec_schedule: executing <7>[ 130.305975] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 130.312263] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 130.315376] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 130.323463] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 130.354769] [IGT] gem_exec_schedule: exiting, ret=77 <7>[ 130.358014] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 130.368023] Console: switching to colour frame buffer device 128x48 <7>[ 130.432126] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 130.895798] Console: switching to colour dummy device 80x25 <7>[ 130.896789] [IGT] syncobj_timeline: executing <6>[ 131.344206] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 131.347393] ata1.00: configured for UDMA/33 <7>[ 131.376747] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 131.382160] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 131.385153] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 131.406865] [IGT] syncobj_timeline: starting subtest etime-multi-wait-all-available-unsubmitted-signaled <7>[ 131.520031] [IGT] syncobj_timeline: finished subtest etime-multi-wait-all-available-unsubmitted-signaled, SUCCESS <7>[ 131.521796] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 131.525357] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 131.532756] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 131.550455] Console: switching to colour frame buffer device 128x48 <3>[ 131.639187] ata1.00: exception Emask 0x10 SAct 0x100 SErr 0x4050000 action 0xe frozen <3>[ 131.642554] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 131.642700] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 131.642832] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 131.642954] ata1.00: cmd 61/08:40:08:11:ae/00:00:00:00:00/40 tag 8 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 131.643327] ata1.00: status: { DRDY } <6>[ 131.643498] ata1: hard resetting link <6>[ 132.367202] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 132.370377] ata1.00: configured for UDMA/33 <6>[ 132.370561] ata1: EH complete <6>[ 133.215173] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 133.218390] ata1.00: configured for UDMA/33 <6>[ 133.574926] Console: switching to colour dummy device 80x25 <7>[ 133.575985] [IGT] gem_ctx_isolation: executing <7>[ 133.604493] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 133.611351] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 133.614859] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 133.617949] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 133.634724] [IGT] gem_ctx_isolation: exiting, ret=77 <7>[ 133.639666] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 133.651459] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 133.668997] Console: switching to colour frame buffer device 128x48 <6>[ 134.279005] Console: switching to colour dummy device 80x25 <7>[ 134.280311] [IGT] i915_pipe_stress: executing <7>[ 134.300921] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 134.305607] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 134.308234] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 134.329393] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 134.329623] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 134.334700] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 134.337465] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 134.338920] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 134.344966] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 134.346294] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 134.346331] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 134.347700] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 134.349898] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 134.349941] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 134.352998] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 134.353276] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 134.353390] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 134.353486] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 134.353581] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 134.353677] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 134.355036] [IGT] i915_pipe_stress: exiting, ret=77 <7>[ 134.359985] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 134.369948] Console: switching to colour frame buffer device 128x48 <7>[ 134.434450] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 134.916257] Console: switching to colour dummy device 80x25 <7>[ 134.916925] [IGT] kms_flip: executing <7>[ 134.938168] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 134.944034] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 134.946827] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 134.970670] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 134.970828] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 134.986195] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 134.987966] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 134.989534] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 134.991432] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 134.993109] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 134.993160] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 134.994714] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 134.996881] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 134.996936] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 134.999391] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 134.999538] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 134.999684] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 134.999826] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 134.999966] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 135.000195] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 135.006760] [IGT] kms_flip: starting subtest 2x-flip-vs-blocking-wf-vblank <7>[ 135.008537] [IGT] kms_flip: finished subtest 2x-flip-vs-blocking-wf-vblank, SKIP <7>[ 135.138663] [IGT] kms_flip: exiting, ret=77 <7>[ 135.144687] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 135.152032] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 135.169218] Console: switching to colour frame buffer device 128x48 <6>[ 136.072163] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 136.075475] ata1.00: configured for UDMA/33 <6>[ 136.438274] Console: switching to colour dummy device 80x25 <7>[ 136.438957] [IGT] gem_mmap_gtt: executing <7>[ 136.455713] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 136.460649] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 136.463267] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 136.465792] [IGT] gem_mmap_gtt: starting subtest big-bo-tiledY <7>[ 136.580541] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <6>[ 136.583515] gem_mmap_gtt (1463): drop_caches: 4 <7>[ 136.584889] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <6>[ 137.273208] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 137.279294] ata1.00: configured for UDMA/33 <7>[ 138.700383] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <6>[ 138.813232] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 138.817419] ata1.00: configured for UDMA/33 <6>[ 140.025404] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 140.030982] ata1.00: configured for UDMA/33 <6>[ 141.380297] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 141.387158] ata1.00: configured for UDMA/33 <7>[ 141.966690] [IGT] gem_mmap_gtt: finished subtest big-bo-tiledY, SUCCESS <7>[ 141.978547] [IGT] gem_mmap_gtt: exiting, ret=0 <7>[ 141.980956] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 142.476199] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 142.509716] Console: switching to colour frame buffer device 128x48 <6>[ 143.652239] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 143.656972] ata1.00: configured for UDMA/33 <6>[ 144.297167] Console: switching to colour dummy device 80x25 <7>[ 144.297853] [IGT] gem_ctx_param: executing <7>[ 144.326661] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 144.330414] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 144.340242] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 144.343902] [IGT] gem_ctx_param: exiting, ret=77 <7>[ 144.353422] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 144.374716] Console: switching to colour frame buffer device 128x48 <7>[ 144.457688] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 145.169319] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 145.174174] ata1.00: configured for UDMA/33 <6>[ 146.071272] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 146.075181] ata1.00: configured for UDMA/33 <6>[ 146.383780] Console: switching to colour dummy device 80x25 <7>[ 146.385688] [IGT] gem_mmap_gtt: executing <7>[ 146.412016] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 146.417239] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 146.419672] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 146.423485] [IGT] gem_mmap_gtt: starting subtest cpuset-big-copy <7>[ 146.545912] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 146.549516] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 146.820493] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 146.952858] [IGT] gem_mmap_gtt: finished subtest cpuset-big-copy, SKIP <7>[ 146.955489] [IGT] gem_mmap_gtt: exiting, ret=77 <7>[ 146.958700] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 146.975732] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 146.992362] Console: switching to colour frame buffer device 128x48 <6>[ 147.225197] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 147.228468] ata1.00: configured for UDMA/33 <6>[ 148.199223] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 148.202444] ata1.00: configured for UDMA/33 <6>[ 149.544218] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 149.547439] ata1.00: configured for UDMA/33 <6>[ 149.582018] Console: switching to colour dummy device 80x25 <7>[ 149.583214] [IGT] gem_basic: executing <7>[ 149.608966] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.614181] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.616816] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 149.619831] [IGT] gem_basic: starting subtest bad-close <7>[ 149.621332] [IGT] gem_basic: finished subtest bad-close, SUCCESS <7>[ 149.622516] [IGT] gem_basic: exiting, ret=0 <7>[ 149.625599] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 149.644465] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 149.661037] Console: switching to colour frame buffer device 128x48 <6>[ 150.141631] perf: interrupt took too long (3944 > 3930), lowering kernel.perf_event_max_sample_rate to 50000 <6>[ 150.207974] Console: switching to colour dummy device 80x25 <7>[ 150.209008] [IGT] kms_writeback: executing <3>[ 150.248378] ata1.00: exception Emask 0x10 SAct 0x7ec0000f SErr 0x4050000 action 0xe frozen <3>[ 150.248504] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 150.248584] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 150.248660] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.248730] ata1.00: cmd 61/08:00:30:a0:21/00:00:00:00:00/40 tag 0 ncq dma 4096 out res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.248906] ata1.00: status: { DRDY } <3>[ 150.248965] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.249035] ata1.00: cmd 61/10:08:f0:c0:21/00:00:00:00:00/40 tag 1 ncq dma 8192 out res 40/00:01:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.249375] ata1.00: status: { DRDY } <3>[ 150.249477] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.249595] ata1.00: cmd 61/08:10:00:31:27/00:00:00:00:00/40 tag 2 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.249880] ata1.00: status: { DRDY } <3>[ 150.249980] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.250165] ata1.00: cmd 61/08:18:b0:10:2b/00:00:00:00:00/40 tag 3 ncq dma 4096 out res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.250447] ata1.00: status: { DRDY } <3>[ 150.250546] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.250660] ata1.00: cmd 61/08:b0:00:a0:a1/00:00:05:00:00/40 tag 22 ncq dma 4096 out res 40/00:01:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.250943] ata1.00: status: { DRDY } <3>[ 150.251040] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.251267] ata1.00: cmd 61/08:b8:80:a0:a1/00:00:05:00:00/40 tag 23 ncq dma 4096 out res 40/00:01:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.251544] ata1.00: status: { DRDY } <3>[ 150.251642] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.251753] ata1.00: cmd 61/08:c8:d0:10:2b/00:00:00:00:00/40 tag 25 ncq dma 4096 out res 40/00:ff:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.252035] ata1.00: status: { DRDY } <3>[ 150.252198] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.252317] ata1.00: cmd 61/08:d0:40:a1:a1/00:00:05:00:00/40 tag 26 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.252596] ata1.00: status: { DRDY } <3>[ 150.252696] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.252814] ata1.00: cmd 61/08:d8:a8:a3:a2/00:00:05:00:00/40 tag 27 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.253142] ata1.00: status: { DRDY } <3>[ 150.253243] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.253354] ata1.00: cmd 61/08:e0:08:a6:a2/00:00:05:00:00/40 tag 28 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.253635] ata1.00: status: { DRDY } <3>[ 150.253732] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.253849] ata1.00: cmd 61/08:e8:00:a1:a1/00:00:16:00:00/40 tag 29 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.254185] ata1.00: status: { DRDY } <3>[ 150.254288] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 150.254400] ata1.00: cmd 61/08:f0:08:a0:21/00:00:00:00:00/40 tag 30 ncq dma 4096 out res 40/00:ff:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 150.254680] ata1.00: status: { DRDY } <6>[ 150.254793] ata1: hard resetting link <6>[ 150.983191] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 150.986248] ata1.00: configured for UDMA/33 <6>[ 150.986642] ata1: EH complete <7>[ 151.023574] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 151.029645] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 151.032519] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 151.036435] [IGT] kms_writeback: exiting, ret=77 <7>[ 151.040913] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 151.050858] Console: switching to colour frame buffer device 128x48 <7>[ 151.112018] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 151.588431] Console: switching to colour dummy device 80x25 <7>[ 151.589232] [IGT] syncobj_basic: executing <7>[ 151.610292] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 151.615519] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 151.617937] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 151.620413] [IGT] syncobj_basic: starting subtest bad-pad-fd-to-handle <7>[ 151.621632] [IGT] syncobj_basic: finished subtest bad-pad-fd-to-handle, SUCCESS <7>[ 151.623548] [IGT] syncobj_basic: exiting, ret=0 <7>[ 151.626488] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 151.645140] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 151.662482] Console: switching to colour frame buffer device 128x48 <6>[ 152.197647] Console: switching to colour dummy device 80x25 <7>[ 152.198826] [IGT] kms_frontbuffer_tracking: executing <7>[ 152.220297] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 152.227518] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 152.230515] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 152.268200] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 152.268319] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 152.279188] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 152.280586] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 152.282399] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 152.284232] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 152.285758] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 152.285813] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 152.287378] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 152.289787] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 152.289850] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 152.291979] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 152.292224] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 152.292369] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 152.292508] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 152.292644] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 152.292743] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 152.307669] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 152.311927] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 152.322771] Console: switching to colour frame buffer device 128x48 <7>[ 152.378449] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <3>[ 152.475238] ata1.00: exception Emask 0x10 SAct 0x20000 SErr 0x4050000 action 0xe frozen <3>[ 152.475554] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 152.475764] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 152.475963] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 152.476287] ata1.00: cmd 61/48:88:60:4a:f0/00:00:0d:00:00/40 tag 17 ncq dma 36864 out res 40/00:01:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 152.476744] ata1.00: status: { DRDY } <6>[ 152.476916] ata1: hard resetting link <6>[ 153.199188] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 153.204044] ata1.00: configured for UDMA/33 <6>[ 153.204305] ata1: EH complete <6>[ 153.999231] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 154.002190] ata1.00: configured for UDMA/33 <6>[ 154.365969] Console: switching to colour dummy device 80x25 <7>[ 154.366968] [IGT] drm_fdinfo: executing <6>[ 154.855173] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 154.858411] ata1.00: configured for UDMA/33 <7>[ 154.882745] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 154.885632] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 154.903593] [IGT] drm_fdinfo: exiting, ret=77 <6>[ 154.911366] Console: switching to colour frame buffer device 128x48 <7>[ 154.963287] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 155.438425] Console: switching to colour dummy device 80x25 <7>[ 155.439232] [IGT] api_intel_bb: executing <7>[ 155.457979] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 155.463651] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 155.466333] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 155.471032] [IGT] api_intel_bb: starting subtest blit-noreloc-purge-cache <7>[ 155.472010] [IGT] api_intel_bb: finished subtest blit-noreloc-purge-cache, SKIP <7>[ 155.473753] [IGT] api_intel_bb: exiting, ret=77 <7>[ 155.476909] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 155.499945] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 155.514707] Console: switching to colour frame buffer device 128x48 <3>[ 155.613222] ata1.00: exception Emask 0x10 SAct 0x800000 SErr 0x4050000 action 0xe frozen <3>[ 155.613450] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 155.613592] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 155.613721] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 155.613844] ata1.00: cmd 61/08:b8:a8:11:ae/00:00:00:00:00/40 tag 23 ncq dma 4096 out res 40/00:01:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 155.614301] ata1.00: status: { DRDY } <6>[ 155.614472] ata1: hard resetting link <6>[ 156.343215] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 156.346197] ata1.00: configured for UDMA/33 <6>[ 156.346384] ata1: EH complete <6>[ 156.835950] Console: switching to colour dummy device 80x25 <7>[ 156.836994] [IGT] syncobj_wait: executing <6>[ 157.327164] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 157.330200] ata1.00: configured for UDMA/33 <7>[ 157.359580] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 157.366194] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 157.368891] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 157.416767] [IGT] syncobj_wait: starting subtest single-wait-all-for-submit-unsubmitted <7>[ 157.519966] [IGT] syncobj_wait: finished subtest single-wait-all-for-submit-unsubmitted, SUCCESS <7>[ 157.522366] [IGT] syncobj_wait: exiting, ret=0 <7>[ 157.525457] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 157.534311] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 157.548702] Console: switching to colour frame buffer device 128x48 <6>[ 158.344220] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 158.347464] ata1.00: configured for UDMA/33 <6>[ 159.183176] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 159.186495] ata1.00: configured for UDMA/33 <6>[ 159.546816] Console: switching to colour dummy device 80x25 <7>[ 159.547823] [IGT] gem_userptr_blits: executing <7>[ 159.563503] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 159.570815] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 159.573641] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 159.576441] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 159.603130] [IGT] gem_userptr_blits: starting subtest set-cache-level <7>[ 159.606569] [IGT] gem_userptr_blits: finished subtest set-cache-level, SUCCESS <7>[ 159.833830] [IGT] gem_userptr_blits: exiting, ret=0 <7>[ 159.837276] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 159.866297] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 159.883574] Console: switching to colour frame buffer device 128x48 <6>[ 160.792206] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 160.795645] ata1.00: configured for UDMA/33 <6>[ 161.154868] Console: switching to colour dummy device 80x25 <7>[ 161.155860] [IGT] kms_cursor_crc: executing <7>[ 161.174774] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.180306] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 161.183220] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 161.201776] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 161.201895] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 161.217210] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 161.218642] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 161.219948] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 161.222003] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 161.223543] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 161.223592] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 161.224951] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 161.226995] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 161.227198] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 161.229549] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 161.229698] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 161.229838] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 161.229977] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 161.230231] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 161.230373] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 161.233700] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 161.270608] [IGT] kms_cursor_crc: starting subtest cursor-dpms <7>[ 161.277162] [IGT] kms_cursor_crc: starting dynamic subtest pipe-A-VGA-1 <7>[ 161.279660] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:51] <7>[ 161.281032] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:54] <7>[ 161.282743] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:55] <7>[ 161.303807] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 161.304183] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 161.370395] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 161.374987] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A <3>[ 161.395301] ata1.00: exception Emask 0x10 SAct 0x2000 SErr 0x4050000 action 0xe frozen <3>[ 161.395374] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 161.395418] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 161.395469] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 161.395512] ata1.00: cmd 61/08:68:00:11:2b/00:00:00:00:00/40 tag 13 ncq dma 4096 out res 40/00:01:01:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 161.395580] ata1.00: status: { DRDY } <6>[ 161.395641] ata1: hard resetting link <6>[ 162.119194] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 162.122849] ata1.00: configured for UDMA/33 <6>[ 162.123192] ata1: EH complete <7>[ 162.397840] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A <7>[ 162.467757] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 162.467915] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 162.485436] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 162.486678] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 162.487950] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 162.489554] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 162.491174] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 162.492797] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 162.494272] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 162.495810] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 162.497418] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 162.498993] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 162.500846] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 162.553623] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.554829] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7>[ 162.556184] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 162.560813] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.562231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7>[ 162.563829] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 162.565602] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 162.567198] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 162.568753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: yes [modeset] <7>[ 162.570217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: no, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 162.571790] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7>[ 162.573360] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 162.574927] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 162.576513] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 162.578129] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 162.579624] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 162.581133] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 162.582711] 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>[ 162.584255] 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>[ 162.585834] 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>[ 162.587348] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.588631] 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>[ 162.589900] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.591324] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 162.592916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 162.594500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 162.596032] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 162.597357] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 162.598863] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 162.600443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 162.602045] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: no <7>[ 162.603650] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.605200] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:cursor A] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 162.606807] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.608859] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 162.618612] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7>[ 162.644217] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 162.645430] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 162.646663] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 162.648222] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 162.649807] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 162.651324] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 162.652742] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 162.654294] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 162.655832] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 162.657395] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 162.658966] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 162.660426] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 162.662485] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 162.664244] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 162.669532] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.671178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7>[ 162.672771] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 162.676923] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.678483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7>[ 162.680100] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 162.681814] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 162.683310] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 162.683469] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 162.684865] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: yes [modeset] <7>[ 162.686453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 162.688024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7>[ 162.689615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 162.691184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 162.692738] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 162.694306] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 162.695753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 162.697200] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 162.698769] 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>[ 162.700335] 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>[ 162.701912] 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>[ 162.703528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.704994] 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>[ 162.706429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.707989] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 162.709551] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 162.711154] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 162.712722] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 162.714188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 162.715715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 162.717288] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 162.718843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 162.720423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.721983] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 162.723539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:cursor A] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 162.724988] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.728530] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 162.730219] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 162.732514] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 162.733971] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 162.735406] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 162.736991] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 162.738563] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 162.740189] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 162.741689] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 162.743172] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 162.744749] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 162.746301] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 162.747895] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 162.749250] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7>[ 162.767404] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 162.768812] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 162.772857] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A <7>[ 162.903253] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.904465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7>[ 162.905708] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 162.907464] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 162.909177] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 162.910583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: yes [modeset] <7>[ 162.911833] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: no, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 162.913138] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7>[ 162.914463] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 162.915752] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 162.917004] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 162.918447] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 162.919772] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 162.921237] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 162.922546] 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>[ 162.923847] 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>[ 162.925162] 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>[ 162.926529] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.927809] 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>[ 162.929108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 162.930659] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 162.931897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 162.933395] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 162.934680] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 162.936201] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 162.937447] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 162.938949] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 162.940208] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: no <7>[ 162.941721] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.943030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:cursor A] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 162.944467] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 162.946018] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 162.951227] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7>[ 162.976215] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 162.977420] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 162.978703] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 162.980174] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 162.981390] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 162.982833] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 162.984126] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 162.985555] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 162.986807] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 162.988233] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 162.989489] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 162.990939] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 162.992288] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 162.993800] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 162.997811] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 162.999039] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7>[ 163.000340] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 163.001965] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 163.003564] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 163.004830] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: yes [modeset] <7>[ 163.006249] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 163.007490] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7>[ 163.008961] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 163.010227] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 163.011695] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 163.013212] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 163.013261] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 163.014727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 163.016032] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 163.017291] 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>[ 163.018527] 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>[ 163.019768] 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>[ 163.021117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.022361] 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>[ 163.023574] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.024784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 163.026021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 163.027273] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 163.028493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 163.029717] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 163.030948] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 163.032243] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 163.033497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 163.034740] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.035992] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 163.037277] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:cursor A] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: yes <7>[ 163.038528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.039735] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 256.000000x256.000000+0.000000+0.000000 dst: 256x256-119-183 <7>[ 163.041284] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 163.042547] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 163.044436] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.045640] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.046868] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.048171] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 163.049400] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 163.050635] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 163.051845] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 163.053119] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 163.054361] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 163.055602] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 163.056838] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 163.058101] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7>[ 163.076264] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 163.077575] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 163.080458] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A <7>[ 163.176296] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.177512] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.178720] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.179973] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 163.181234] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 163.182484] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 163.183713] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 163.184975] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 163.186217] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 163.187473] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 163.188740] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 163.196464] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 163.196615] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 163.228356] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 163.228507] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 163.279022] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 163.279614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7>[ 163.280843] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7>[ 163.282143] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7>[ 163.283396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000) <7>[ 163.284792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7>[ 163.286043] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0) <7>[ 163.287301] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0) <7>[ 163.288565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0) <7>[ 163.289800] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0) <7>[ 163.291087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0) <7>[ 163.292441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0) <7>[ 163.293684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0) <7>[ 163.294967] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0) <7>[ 163.296286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0) <7>[ 163.297647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0) <7>[ 163.298888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0) <7>[ 163.300265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0) <7>[ 163.301533] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0) <7>[ 163.302931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0) <7>[ 163.304211] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0) <7>[ 163.305615] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0) <7>[ 163.306903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0) <7>[ 163.308342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0) <7>[ 163.309613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0) <7>[ 163.310956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0) <7>[ 163.312298] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0) <7>[ 163.313658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0) <7>[ 163.314918] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0) <7>[ 163.316327] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0) <7>[ 163.317599] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7>[ 163.318998] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7>[ 163.320542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7>[ 163.321947] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64960, found 0) <7>[ 163.323232] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64960, found 0) <7>[ 163.324654] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in port_clock (expected 64960, found 0) <7>[ 163.325936] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 163.327473] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 163.328772] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 163.330196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: no [modeset] <7>[ 163.331533] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [NOFB], visible: no <7>[ 163.333159] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 163.343452] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7>[ 163.369212] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was disabled) <7>[ 163.370439] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 163.371674] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 163.373332] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 163.376615] [IGT] kms_cursor_crc: finished subtest pipe-A-VGA-1, SUCCESS <7>[ 163.381016] [IGT] kms_cursor_crc: starting dynamic subtest pipe-B-VGA-1 <7>[ 163.383027] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:51] <7>[ 163.383986] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:53] <7>[ 163.384913] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:54] <7>[ 163.385874] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 163.389267] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 163.389418] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 163.391466] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 163.392753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.enable (expected no, found yes) <7>[ 163.394011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7>[ 163.395574] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002) <7>[ 163.396859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1) <7>[ 163.398197] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024) <7>[ 163.399511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344) <7>[ 163.400849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024) <7>[ 163.402155] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344) <7>[ 163.403557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048) <7>[ 163.404840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184) <7>[ 163.406243] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768) <7>[ 163.406301] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 163.407793] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768) <7>[ 163.409199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771) <7>[ 163.410515] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777) <7>[ 163.411864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806) <7>[ 163.413378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806) <7>[ 163.414905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024) <7>[ 163.416236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344) <7>[ 163.417740] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024) <7>[ 163.419105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344) <7>[ 163.420627] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048) <7>[ 163.421892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184) <7>[ 163.423419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768) <7>[ 163.424688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768) <7>[ 163.426197] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771) <7>[ 163.427483] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777) <7>[ 163.428972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806) <7>[ 163.430213] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806) <7>[ 163.431764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7>[ 163.433041] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7>[ 163.434511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7>[ 163.435810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in dpll_hw_state <7>[ 163.437301] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7>[ 163.438537] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x0, dpll_md: 0x0, fp0: 0x0, fp1: 0x0 <7>[ 163.440027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7>[ 163.441337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 163.442806] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64960) <7>[ 163.444152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64960) <7>[ 163.445647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in port_clock (expected 0, found 64960) <7>[ 163.446929] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 163.448659] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:40:plane B] min cdclk (64960 kHz) > [CRTC:47:pipe B] min cdclk (0 kHz) <7>[ 163.450135] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 163.451659] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 163.452950] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: yes [modeset] <7>[ 163.454455] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 163.455959] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7>[ 163.457196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 163.458629] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 163.459882] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 163.461315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 163.462570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 163.464007] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 163.465266] 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>[ 163.466756] 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>[ 163.468002] 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>[ 163.469453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.470713] 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>[ 163.472156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.473397] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 163.474849] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 163.476138] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 163.477560] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 163.478812] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 163.480252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 163.481525] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 163.482962] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [FB:53] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 163.484233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.485639] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 163.515730] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 163.516990] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 163.518900] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.520263] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.521576] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.523117] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 163.524405] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 163.525900] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 163.527166] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 163.528642] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 163.529883] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 163.531334] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 163.532594] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 163.534005] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7>[ 163.552186] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 163.553556] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 163.557797] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe B <6>[ 163.571227] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 163.574664] ata1.00: configured for UDMA/33 <7>[ 163.681133] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe B <7>[ 163.737401] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 163.737601] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 163.753639] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.755351] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.756740] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.758020] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 163.759498] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 163.761128] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 163.762690] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 163.764198] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 163.765542] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 163.766859] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 163.768509] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <3>[ 163.773383] ata1.00: exception Emask 0x10 SAct 0x80 SErr 0x4050000 action 0xe frozen <3>[ 163.773450] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 163.773490] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 163.773536] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 163.773575] ata1.00: cmd 61/10:38:50:c3:3d/00:00:00:00:00/40 tag 7 ncq dma 8192 out res 40/00:ff:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 163.773639] ata1.00: status: { DRDY } <6>[ 163.773696] ata1: hard resetting link <7>[ 163.823338] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 163.824913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7>[ 163.826569] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 163.829572] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 163.831183] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 163.832823] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: yes [modeset] <7>[ 163.834369] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: no, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 163.835999] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7>[ 163.837664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 163.839211] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 163.840834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 163.842419] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 163.843991] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 163.845590] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 163.847204] 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>[ 163.848800] 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>[ 163.850366] 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>[ 163.851961] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.853562] 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>[ 163.855184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.856768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 163.858405] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 163.859991] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 163.861610] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 163.863217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 163.864818] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 163.866423] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 163.868024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: no <7>[ 163.869647] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.871211] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:cursor B] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 163.872881] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.874848] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 163.894029] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7>[ 163.914307] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.915868] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.917437] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.918979] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 163.920516] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 163.922126] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 163.923675] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 163.925212] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 163.926749] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 163.928285] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 163.929828] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 163.931386] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 163.933110] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 163.934787] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 163.939224] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 163.940448] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7>[ 163.941793] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 163.945494] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 163.946778] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7>[ 163.948103] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 163.949709] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 163.950998] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 163.952471] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: yes [modeset] <7>[ 163.953829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 163.955326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7>[ 163.956281] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 163.956642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 163.958320] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 163.959830] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 163.961187] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 163.962635] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 163.963928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 163.965411] 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>[ 163.966695] 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>[ 163.968207] 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>[ 163.969496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.970964] 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>[ 163.972241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 163.973722] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 163.975015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 163.976493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 163.977821] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 163.979291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 163.980578] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 163.982119] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 163.983527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 163.984819] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.986269] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 163.987519] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:cursor B] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: yes <7>[ 163.988976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 163.990277] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 256.000000x256.000000+0.000000+0.000000 dst: 256x256+336+102 <7>[ 163.991984] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 163.993323] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 163.995439] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 163.996845] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 163.998142] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 163.999589] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 164.000881] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 164.002355] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 164.003630] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 164.005164] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 164.006386] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 164.007849] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 164.009175] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 164.010692] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7>[ 164.029126] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 164.030509] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 164.033546] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe B <7>[ 164.164745] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 164.165944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7>[ 164.167296] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 164.170244] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 164.171689] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 164.172970] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: yes [modeset] <7>[ 164.174482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: no, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 164.175724] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7>[ 164.177218] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 164.178465] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 164.179919] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 164.181244] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 164.182723] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 164.183975] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 164.185476] 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>[ 164.186752] 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>[ 164.188220] 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>[ 164.189488] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.190935] 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>[ 164.192199] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.193704] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 164.195171] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 164.196411] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 164.197878] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 164.199209] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 164.200637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 164.201892] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 164.203391] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: no <7>[ 164.204642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 164.206128] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:cursor B] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 164.207378] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 164.209166] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 164.212807] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7>[ 164.238210] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 164.239433] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 164.240639] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 164.242122] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 164.243360] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 164.244788] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 164.246015] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 164.247469] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 164.248708] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 164.250174] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 164.251390] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 164.252809] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 164.254207] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 164.255728] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 164.259807] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 164.261119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7>[ 164.262561] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 164.264146] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 164.265532] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 164.266773] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: yes [modeset] <7>[ 164.268264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 164.269497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7>[ 164.270944] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 164.272203] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 164.273616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 164.274869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 164.276324] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 164.276387] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 164.277842] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 164.279305] 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>[ 164.280567] 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>[ 164.282001] 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>[ 164.283247] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.284693] 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>[ 164.285945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.287410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 164.288692] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 164.290182] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 164.291415] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 164.292879] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 164.294152] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 164.295606] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 164.296854] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [FB:51] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 164.298305] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 164.299554] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 164.301028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:cursor B] fb: [FB:56] 256x256 format = AR24 little-endian (0x34325241) modifier = 0x0, visible: no <7>[ 164.302293] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 164.304168] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 164.305596] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 164.307492] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 164.308773] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 164.310020] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 164.311466] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 164.312728] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 164.314147] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 164.315433] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 164.316867] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 164.318165] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 164.319573] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 7f3f016e <7>[ 164.320811] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was enabled) <7>[ 164.322262] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7>[ 164.340371] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 164.341720] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 164.344676] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe B <7>[ 164.443942] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 164.444214] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 164.475748] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 164.475894] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <6>[ 164.496207] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 164.499210] ata1.00: configured for UDMA/33 <6>[ 164.499383] ata1: EH complete <7>[ 164.525942] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 164.527602] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.enable (expected yes, found no) <7>[ 164.529107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7>[ 164.530734] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1) <7>[ 164.532374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000) <7>[ 164.534173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0) <7>[ 164.535944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0) <7>[ 164.537583] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0) <7>[ 164.539227] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0) <7>[ 164.540849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0) <7>[ 164.542545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0) <7>[ 164.544212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0) <7>[ 164.545838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0) <7>[ 164.547431] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0) <7>[ 164.549116] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0) <7>[ 164.550738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0) <7>[ 164.552345] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0) <7>[ 164.553948] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0) <7>[ 164.555574] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0) <7>[ 164.557215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0) <7>[ 164.558799] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0) <7>[ 164.560370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0) <7>[ 164.562015] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0) <7>[ 164.563710] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0) <7>[ 164.565304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0) <7>[ 164.566871] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0) <7>[ 164.568504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0) <7>[ 164.570143] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0) <7>[ 164.571772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0) <7>[ 164.573381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0) <7>[ 164.575013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7>[ 164.576552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7>[ 164.578192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7>[ 164.579814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64960, found 0) <7>[ 164.581438] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64960, found 0) <7>[ 164.583031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe B] fastset requirement not met in port_clock (expected 64960, found 0) <7>[ 164.584635] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe B] fastset requirement not met, forcing full modeset <7>[ 164.586498] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 164.588161] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 164.589741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe B] enable: no [modeset] <7>[ 164.591334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:40:plane B] fb: [NOFB], visible: no <7>[ 164.593306] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 164.607502] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7>[ 164.633278] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was disabled) <7>[ 164.634855] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 164.636417] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 164.638303] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe B] <7>[ 164.642271] [IGT] kms_cursor_crc: finished subtest pipe-B-VGA-1, SUCCESS <7>[ 164.643283] [IGT] kms_cursor_crc: finished subtest cursor-dpms, SUCCESS <7>[ 164.658364] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on <7>[ 164.667522] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.673833] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.679839] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.686862] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.692897] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.699706] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.705576] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.714589] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.720985] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.740649] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.750741] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:50] <7>[ 164.760434] [IGT] kms_cursor_crc: exiting, ret=0 <7>[ 164.765422] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 164.782018] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7>[ 164.783595] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7>[ 164.785199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7>[ 164.787146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7>[ 164.788788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002) <7>[ 164.790447] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7>[ 164.792105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024) <7>[ 164.793708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344) <7>[ 164.795359] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024) <7>[ 164.796960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344) <7>[ 164.798573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048) <7>[ 164.800237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184) <7>[ 164.801859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768) <7>[ 164.803477] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768) <7>[ 164.805133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771) <7>[ 164.806753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777) <7>[ 164.808352] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806) <7>[ 164.809970] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806) <7>[ 164.811575] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024) <7>[ 164.813202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344) <7>[ 164.814804] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024) <7>[ 164.816398] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344) <7>[ 164.817932] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048) <7>[ 164.819544] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184) <7>[ 164.821173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768) <7>[ 164.822792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768) <7>[ 164.824392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771) <7>[ 164.825991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777) <7>[ 164.827602] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806) <7>[ 164.829194] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806) <7>[ 164.830815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7>[ 164.832410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7>[ 164.834021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7>[ 164.835688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64960) <7>[ 164.837305] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64960) <7>[ 164.838935] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in port_clock (expected 0, found 64960) <7>[ 164.840547] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:39:pipe A] fastset requirement not met, forcing full modeset <7>[ 164.842425] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane A] min cdclk (64960 kHz) > [CRTC:39:pipe A] min cdclk (0 kHz) <7>[ 164.844035] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 333333 kHz, actual 333333 kHz <7>[ 164.845637] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7>[ 164.847222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:39:pipe A] enable: yes [modeset] <7>[ 164.848823] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB <7>[ 164.850410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7>[ 164.852028] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7>[ 164.853583] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7>[ 164.855204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7>[ 164.856790] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7>[ 164.858433] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7>[ 164.860031] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7>[ 164.861624] 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>[ 164.863198] 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>[ 164.864811] 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>[ 164.866402] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.868028] 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>[ 164.869669] i915 0000:00:02.0: [drm:intel_crtc_state_dump [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>[ 164.871266] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64960, pipe src: 1024x768+0+0, pixel rate 64960 <7>[ 164.872885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0 <7>[ 164.874483] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 <7>[ 164.875924] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7>[ 164.877502] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x94080000, dpll_md: 0x0, fp0: 0x4000c9, fp1: 0x4000c9 <7>[ 164.879176] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7>[ 164.880835] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7>[ 164.882499] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane A] fb: [FB:52] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7>[ 164.884006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7>[ 164.885634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0 <7>[ 164.887215] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:cursor A] fb: [NOFB], visible: no <7>[ 164.891357] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on <7>[ 164.893221] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:49:CRT] <7>[ 164.895621] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 164.897242] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 164.898876] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 164.900501] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 164.902144] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 164.903751] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 164.905363] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 164.906957] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 164.908565] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 164.910187] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 164.911845] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 164.913481] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7>[ 164.932217] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:48:VGA-1] <7>[ 164.933914] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:39:pipe A] <7>[ 164.936854] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 164.950327] Console: switching to colour frame buffer device 128x48 <6>[ 165.887192] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 165.890415] ata1.00: configured for UDMA/33 <6>[ 166.251429] Console: switching to colour dummy device 80x25 <7>[ 166.253199] [IGT] kms_pm_rpm: executing <7>[ 166.276581] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 166.298729] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 166.298848] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 166.317223] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 166.318997] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 166.320605] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 166.322467] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 166.323996] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 166.324040] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 166.325688] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 166.327935] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 166.327993] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 166.330426] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 166.330572] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 166.330814] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 166.330964] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 166.331186] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 166.331337] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 166.331886] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 166.332040] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 166.350606] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 166.352452] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 166.354025] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 166.355752] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 166.357320] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 166.357369] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 166.358974] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 166.361287] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 166.361351] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 166.363792] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 166.363947] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 166.364178] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 166.364330] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 166.364474] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 166.364616] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 166.369411] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:51] <7>[ 166.555581] [IGT] kms_pm_rpm: exiting, ret=77 <6>[ 166.565991] Console: switching to colour frame buffer device 128x48 <7>[ 166.633470] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 167.123109] Console: switching to colour dummy device 80x25 <7>[ 167.123769] [IGT] drm_fdinfo: executing <6>[ 167.559181] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 167.562522] ata1.00: configured for UDMA/33 <7>[ 167.589189] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 167.593185] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 167.609568] [IGT] drm_fdinfo: exiting, ret=77 <6>[ 167.618799] Console: switching to colour frame buffer device 128x48 <7>[ 167.684306] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 168.158740] Console: switching to colour dummy device 80x25 <7>[ 168.159738] [IGT] kms_big_fb: executing <7>[ 168.176026] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 168.180904] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 168.183300] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 168.201859] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 168.201977] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 168.217850] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 168.219375] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 168.220715] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 168.222780] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 168.224354] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 168.224399] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 168.225888] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 168.228220] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 168.228278] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 168.230701] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 168.230850] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 168.230992] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 168.231259] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 168.231405] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 168.231545] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 168.346718] [IGT] kms_big_fb: starting subtest linear-16bpp-rotate-270 <7>[ 168.382813] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:51] <7>[ 168.386352] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:53] <7>[ 168.400922] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:39:pipe A] <7>[ 168.401236] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:48:VGA-1] <7>[ 168.453125] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe B] <7>[ 168.457019] i915 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [i915]] Re-arming FIFO underruns on pipe A <7>[ 168.459971] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was enabled) <7>[ 168.484165] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was disabled) <7>[ 168.489302] [IGT] kms_big_fb: finished subtest linear-16bpp-rotate-270, SKIP <7>[ 168.495183] [IGT] kms_big_fb: exiting, ret=77 <7>[ 168.500273] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 168.538703] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is disabled (was disabled) <7>[ 168.539940] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 24 <7>[ 168.541240] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 488 <7>[ 168.543024] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW1 register is f4030f0f <7>[ 168.544633] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 21 <7>[ 168.546255] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 491 <7>[ 168.547668] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 146 <7>[ 168.549189] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 366 <7>[ 168.550868] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO entries required for mode: 143 <7>[ 168.552437] i915 0000:00:02.0: [drm:intel_calculate_wm [i915]] FIFO watermark level: 369 <7>[ 168.553989] i915 0000:00:02.0: [drm:pnv_update_wm [i915]] DSPFW3 register is 3f3f016e <7>[ 168.555513] i915 0000:00:02.0: [drm:_intel_set_memory_cxsr [i915]] memory self-refresh is enabled (was disabled) <7>[ 168.568459] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 168.585289] Console: switching to colour frame buffer device 128x48 <3>[ 168.688457] ata1.00: exception Emask 0x10 SAct 0x40 SErr 0x4050000 action 0xe frozen <3>[ 168.688685] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 168.688827] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 168.688955] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 168.689170] ata1.00: cmd 61/08:30:d8:11:ae/00:00:00:00:00/40 tag 6 ncq dma 4096 out res 40/00:01:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 168.689484] ata1.00: status: { DRDY } <6>[ 168.689596] ata1: hard resetting link <6>[ 169.415200] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 169.418390] ata1.00: configured for UDMA/33 <6>[ 169.418575] ata1: EH complete <6>[ 169.905857] Console: switching to colour dummy device 80x25 <7>[ 169.907740] [IGT] kms_plane_scaling: executing <6>[ 170.399169] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 170.401964] ata1.00: configured for UDMA/33 <7>[ 170.430674] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 170.435195] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 170.437415] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 170.455736] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 170.455853] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 170.469162] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 170.470601] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 170.471944] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 170.473816] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 170.475366] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 170.475402] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 170.476684] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 170.478711] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 170.478755] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 170.480993] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 170.481221] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 170.481362] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 170.481499] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 170.481638] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 170.481774] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 170.483560] [IGT] kms_plane_scaling: exiting, ret=77 <7>[ 170.487218] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 170.496285] Console: switching to colour frame buffer device 128x48 <7>[ 170.552674] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 171.058342] Console: switching to colour dummy device 80x25 <7>[ 171.058995] [IGT] sw_sync: executing <7>[ 171.090021] [IGT] sw_sync: starting subtest sync_expired_merge <7>[ 172.168859] [IGT] sw_sync: finished subtest sync_expired_merge, SUCCESS <7>[ 172.169810] [IGT] sw_sync: exiting, ret=0 <6>[ 172.186806] Console: switching to colour frame buffer device 128x48 <3>[ 172.293292] ata1.00: exception Emask 0x10 SAct 0x20000 SErr 0x4050000 action 0xe frozen <3>[ 172.295588] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 172.295738] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 172.295870] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 172.295992] ata1.00: cmd 61/08:88:f0:11:ae/00:00:00:00:00/40 tag 17 ncq dma 4096 out res 40/00:01:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 172.296362] ata1.00: status: { DRDY } <6>[ 172.296533] ata1: hard resetting link <6>[ 173.023198] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 173.026712] ata1.00: configured for UDMA/33 <6>[ 173.026948] ata1: EH complete <6>[ 173.517993] Console: switching to colour dummy device 80x25 <7>[ 173.518805] [IGT] gem_exec_whisper: executing <7>[ 173.540305] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.544694] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 173.546977] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 173.549276] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <3>[ 173.658188] ata1.00: exception Emask 0x10 SAct 0x80000 SErr 0x4050000 action 0xe frozen <3>[ 173.658312] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 173.658393] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 173.658470] ata1.00: failed command: READ FPDMA QUEUED <3>[ 173.658539] ata1.00: cmd 60/08:98:00:a1:a2/00:00:16:00:00/40 tag 19 ncq dma 4096 in res 40/00:01:01:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 173.658715] ata1.00: status: { DRDY } <6>[ 173.658783] ata1: hard resetting link <6>[ 174.383226] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 174.386545] ata1.00: configured for UDMA/33 <6>[ 174.386780] ata1: EH complete <7>[ 174.402638] [IGT] gem_exec_whisper: starting subtest basic-queues-forked-all <7>[ 174.410860] [IGT] gem_exec_whisper: finished subtest basic-queues-forked-all, SKIP <7>[ 174.561302] [IGT] gem_exec_whisper: exiting, ret=77 <7>[ 174.565157] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 174.571853] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 174.588344] Console: switching to colour frame buffer device 128x48 <6>[ 175.383181] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 175.386997] ata1.00: configured for UDMA/33 <6>[ 175.863727] Console: switching to colour dummy device 80x25 <7>[ 175.864712] [IGT] gem_ctx_persistence: executing <7>[ 175.882804] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 175.888284] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 175.890902] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 175.893428] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 175.909448] [IGT] gem_ctx_persistence: exiting, ret=77 <7>[ 175.913957] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 175.925200] Console: switching to colour frame buffer device 128x48 <7>[ 175.988923] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 176.461429] Console: switching to colour dummy device 80x25 <7>[ 176.462202] [IGT] gem_render_copy: executing <7>[ 176.481171] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 176.484434] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 176.492483] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 176.495132] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 176.575417] [IGT] gem_render_copy: starting subtest linear-to-vebox-yf-tiled <7>[ 176.576848] [IGT] gem_render_copy: finished subtest linear-to-vebox-yf-tiled, SKIP <7>[ 176.721133] [IGT] gem_render_copy: exiting, ret=77 <7>[ 176.727022] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 176.738943] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 176.755985] Console: switching to colour frame buffer device 128x48 <6>[ 177.383187] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 177.386493] ata1.00: configured for UDMA/33 <6>[ 177.874122] Console: switching to colour dummy device 80x25 <7>[ 177.874791] [IGT] kms_frontbuffer_tracking: executing <7>[ 177.887912] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 177.892782] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 177.895573] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 177.916029] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 177.916238] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 177.923211] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 177.924900] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 177.926558] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 177.928316] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 177.929998] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 177.930130] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 177.931695] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 177.933956] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 177.934013] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 177.936450] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 177.936604] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 177.936744] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 177.936881] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 177.937019] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 177.937292] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 177.952239] [IGT] kms_frontbuffer_tracking: exiting, ret=77 <7>[ 177.956929] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 177.966860] Console: switching to colour frame buffer device 128x48 <7>[ 178.023527] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 178.521852] Console: switching to colour dummy device 80x25 <7>[ 178.522900] [IGT] gem_exec_gttfill: executing <7>[ 178.539745] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 178.545535] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 178.548409] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 178.550935] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 178.657271] [IGT] gem_exec_gttfill: starting subtest all-engines <7>[ 178.664467] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 178.670303] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 179.029004] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000070 [0x00000070] <7>[ 179.168390] [IGT] gem_exec_gttfill: finished subtest all-engines, SKIP <7>[ 179.316212] [IGT] gem_exec_gttfill: exiting, ret=77 <7>[ 179.319817] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 179.340849] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 179.357859] Console: switching to colour frame buffer device 128x48 <6>[ 180.201871] Console: switching to colour dummy device 80x25 <7>[ 180.202891] [IGT] syncobj_timeline: executing <7>[ 180.223284] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 180.229409] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 180.232908] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 180.282512] [IGT] syncobj_timeline: starting subtest wait-delayed-signal <7>[ 180.393169] [IGT] syncobj_timeline: finished subtest wait-delayed-signal, SUCCESS <7>[ 180.395264] [IGT] syncobj_timeline: exiting, ret=0 <7>[ 180.398692] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 180.407704] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 180.431925] Console: switching to colour frame buffer device 128x48 <6>[ 180.975357] Console: switching to colour dummy device 80x25 <7>[ 180.976165] [IGT] kms_big_fb: executing <7>[ 180.991938] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 180.996924] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 180.999177] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 181.035535] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 181.035655] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 181.043206] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 181.044656] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 181.045911] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 181.047829] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 181.049372] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 181.049421] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 181.050896] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 181.053143] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 181.053201] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 181.055459] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 181.055609] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 181.055752] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 181.055859] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 181.055956] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 181.056150] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 181.174978] [IGT] kms_big_fb: starting subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip <7>[ 181.177186] [IGT] kms_big_fb: finished subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip, SKIP <7>[ 181.179304] [IGT] kms_big_fb: exiting, ret=77 <7>[ 181.184556] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 181.192219] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 181.208534] Console: switching to colour frame buffer device 128x48 <3>[ 181.291231] ata1.00: exception Emask 0x10 SAct 0x4000 SErr 0x4050000 action 0xe frozen <3>[ 181.291472] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 181.291614] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 181.291742] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 181.291865] ata1.00: cmd 61/08:70:c0:31:27/00:00:00:00:00/40 tag 14 ncq dma 4096 out res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 181.292298] ata1.00: status: { DRDY } <6>[ 181.292468] ata1: hard resetting link <6>[ 182.015188] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 182.018159] ata1.00: configured for UDMA/33 <6>[ 182.018330] ata1: EH complete <6>[ 182.871222] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 182.874511] ata1.00: configured for UDMA/33 <6>[ 183.233905] Console: switching to colour dummy device 80x25 <7>[ 183.234918] [IGT] gem_exec_balancer: executing <7>[ 183.251632] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 183.256964] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 183.259771] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 183.261939] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 183.277700] [IGT] gem_exec_balancer: exiting, ret=77 <7>[ 183.281165] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 183.293477] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 183.309677] Console: switching to colour frame buffer device 128x48 <6>[ 183.853843] Console: switching to colour dummy device 80x25 <7>[ 183.854646] [IGT] kms_big_fb: executing <6>[ 184.215198] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 184.218674] ata1.00: configured for UDMA/33 <7>[ 184.241307] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 184.246865] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 184.249560] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 184.269888] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 184.270006] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 184.277174] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 184.278852] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 184.280245] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 184.282574] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 184.283940] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 184.283977] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 184.285381] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 184.287724] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 184.287783] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 184.290251] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 184.290405] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 184.290544] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 184.290681] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 184.290821] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 184.290960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 184.378805] [IGT] kms_big_fb: starting subtest yf-tiled-64bpp-rotate-180 <6>[ 185.095213] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 185.098524] ata1.00: configured for UDMA/33 <7>[ 185.102777] [IGT] kms_big_fb: finished subtest yf-tiled-64bpp-rotate-180, SKIP <7>[ 185.107689] [IGT] kms_big_fb: exiting, ret=77 <7>[ 185.111895] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 185.126968] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 185.144503] Console: switching to colour frame buffer device 128x48 <6>[ 185.681645] Console: switching to colour dummy device 80x25 <7>[ 185.682530] [IGT] gem_exec_schedule: executing <6>[ 186.185170] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 186.187987] ata1.00: configured for UDMA/33 <7>[ 186.234632] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 186.240038] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 186.243595] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 186.249712] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 186.266283] [IGT] gem_exec_schedule: exiting, ret=77 <7>[ 186.269712] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 186.288981] Console: switching to colour frame buffer device 128x48 <7>[ 186.344288] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 186.822191] Console: switching to colour dummy device 80x25 <7>[ 186.822845] [IGT] syncobj_wait: executing <7>[ 186.836397] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 186.842751] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 186.845940] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 186.863677] [IGT] syncobj_wait: starting subtest invalid-multi-wait-unsubmitted-submitted <7>[ 186.869735] [IGT] syncobj_wait: finished subtest invalid-multi-wait-unsubmitted-submitted, SUCCESS <7>[ 186.871851] [IGT] syncobj_wait: exiting, ret=0 <7>[ 186.875288] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 186.894569] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 186.912222] Console: switching to colour frame buffer device 128x48 <6>[ 187.457484] Console: switching to colour dummy device 80x25 <7>[ 187.459408] [IGT] kms_psr: executing <6>[ 187.943242] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 187.946468] ata1.00: configured for UDMA/33 <7>[ 187.970968] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 187.977539] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 187.980272] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 188.000714] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] <7>[ 188.000832] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:48:VGA-1] force=1 <7>[ 188.013237] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug <7>[ 188.014671] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 188.015970] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry <7>[ 188.017843] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1) <7>[ 188.019370] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 188.019407] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging <7>[ 188.020664] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1 <7>[ 188.022603] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga <7>[ 188.022655] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0 <7>[ 188.024975] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:48:VGA-1] probed modes: <7>[ 188.025199] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7>[ 188.025343] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7>[ 188.025483] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5 <7>[ 188.025621] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5 <7>[ 188.025760] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7>[ 188.028226] [IGT] kms_psr: exiting, ret=77 <7>[ 188.031922] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 188.041147] Console: switching to colour frame buffer device 128x48 <7>[ 188.097434] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <3>[ 188.131294] ata1.00: exception Emask 0x10 SAct 0x10000 SErr 0x4050000 action 0xe frozen <3>[ 188.131621] ata1.00: irq_stat 0x00000040, connection status changed <3>[ 188.131832] ata1: SError: { PHYRdyChg CommWake DevExch } <3>[ 188.132034] ata1.00: failed command: WRITE FPDMA QUEUED <3>[ 188.132321] ata1.00: cmd 61/08:80:70:11:2b/00:00:00:00:00/40 tag 16 ncq dma 4096 out res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x10 (ATA bus error) <3>[ 188.132769] ata1.00: status: { DRDY } <6>[ 188.132940] ata1: hard resetting link <6>[ 188.856189] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 188.860249] ata1.00: configured for UDMA/33 <6>[ 188.860506] ata1: EH complete <6>[ 189.356309] Console: switching to colour dummy device 80x25 <7>[ 189.356999] [IGT] kms_ccs: executing <7>[ 189.372802] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.377671] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 189.380259] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 189.383782] [IGT] kms_ccs: exiting, ret=77 <7>[ 189.386564] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <6>[ 189.394971] Console: switching to colour frame buffer device 128x48 <7>[ 189.462648] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6>[ 190.311186] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310) <6>[ 190.314946] ata1.00: configured for UDMA/33 <6>[ 190.671970] Console: switching to colour dummy device 80x25 <7>[ 190.675747] [IGT] gem_eio: executing <7>[ 190.693532] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.700342] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7>[ 190.703442] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7>[ 190.709515] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <5>[ 190.727022] i915 0000:00:02.0: [drm] rcs0 heartbeat interval adjusted to a non-default value which may cause engine resets to target innocent contexts! <6>[ 190.732629] i915 0000:00:02.0: [drm] GPU HANG: ecode 3:0:00000000 <7>[ 190.757660] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7>[ 190.759028] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7>[ 190.760406] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7>[ 190.762007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000) <7>[ 190.763723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7>[ 190.765269] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0) <7>[ 190.766663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0) <7>[ 190.768261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0) <7>[ 190.769855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0) <7>[ 190.771437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:39:pipe A] fastset requireme