[69.863055] Initializing watchdogs
[69.863188]   /dev/watchdog0
[69.885903] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[69.896836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.900472] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.903910] [001/133] (960s left) kms_chamelium_edid (hdmi-mode-timings)
[70.491365] Subtest hdmi-mode-timings: SKIP (0.000s)
[70.910317] [002/133] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[71.419913] Starting subtest: psr-1p-primscrn-spr-indfb-move
[71.422090] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[72.025109] [003/133] (958s left) gem_exec_reloc (basic-gtt-wc)
[72.087278] Starting subtest: basic-gtt-wc
[72.092979] Subtest basic-gtt-wc: SUCCESS (0.006s)
[73.126142] [004/133] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[73.624690] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[73.626922] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[74.223486] [005/133] (956s left) gem_exec_schedule (pi-shared-iova)
[74.293145] Subtest pi-shared-iova: SKIP (0.000s)
[74.520548] [006/133] (956s left) api_intel_bb (lot-of-buffers)
[74.577903] Starting subtest: lot-of-buffers
[75.304393] Subtest lot-of-buffers: SUCCESS (0.724s)
[75.651732] [007/133] (955s left) kms_atomic_interruptible (legacy-pageflip)
[76.148883] Starting subtest: legacy-pageflip
[76.150038] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.475971] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.325s)
[82.477095] Subtest legacy-pageflip: SUCCESS (6.327s)
[83.192056] [008/133] (947s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[83.694655] Starting subtest: cursorB-vs-flipA-legacy
[83.697759] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[84.309194] [009/133] (946s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[84.808172] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[84.809225] Starting dynamic subtest: pipe-A
[84.813016] Dynamic subtest pipe-A: SKIP (0.002s)
[84.823115] Starting dynamic subtest: pipe-B
[84.826209] Dynamic subtest pipe-B: SKIP (0.001s)
[84.828284] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.003s)
[85.422612] [010/133] (945s left) i915_query (engine-info)
[85.478995] Starting subtest: engine-info
[85.480057] Subtest engine-info: SUCCESS (0.001s)
[85.603471] [011/133] (945s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[86.104890] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[86.395244] [012/133] (944s left) kms_plane_cursor (overlay)
[86.888451] Starting subtest: overlay
[86.890544] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[89.586223] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.697s)
[89.644759] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[92.347036] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.711s)
[92.406378] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[95.108084] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.711s)
[95.253201] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[98.032919] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.788s)
[98.092103] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[100.794026] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.711s)
[100.853998] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[103.555340] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.711s)
[103.688582] Subtest overlay: SUCCESS (16.801s)
[104.400846] [013/133] (926s left) kms_psr (fbc-psr2-sprite-plane-move)
[104.891197] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[105.205595] [014/133] (925s left) kms_pm_rpm (i2c)
[117.050077] Subtest i2c: SKIP (0.000s)
[117.335732] [015/133] (913s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[117.831214] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[117.832302] Starting dynamic subtest: pipe-A
[117.835551] Dynamic subtest pipe-A: SKIP (0.001s)
[117.845098] Starting dynamic subtest: pipe-B
[117.848289] Dynamic subtest pipe-B: SKIP (0.001s)
[117.850328] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.003s)
[118.434706] [016/133] (912s left) device_reset (unbind-cold-reset-rebind)
[118.509587] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[118.564876] [017/133] (912s left) gem_unfence_active_buffers
[118.782865] [018/133] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[119.278863] Starting subtest: basic-busy-flip-before-cursor-legacy
[120.254926] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.976s)
[120.967829] [019/133] (910s left) gen3_render_tiledy_blits
[121.075944] [020/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[121.577621] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[123.499268] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.923s)
[124.125554] [021/133] (907s left) gem_eio (execbuf)
[124.188572] Starting subtest: execbuf
[124.217017] Subtest execbuf: SUCCESS (0.028s)
[125.272552] [022/133] (906s left) syncobj_wait (reset-during-wait-for-submit)
[125.327698] Starting subtest: reset-during-wait-for-submit
[125.430577] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[125.560108] [023/133] (905s left) gem_mmap_gtt (cpuset-big-copy-xy)
[125.614621] Starting subtest: cpuset-big-copy-XY
[129.221565] Subtest cpuset-big-copy-XY: SUCCESS (3.607s)
[129.469393] [024/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[130.072229] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[130.074391] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[130.679827] [025/133] (900s left) kms_addfb_basic (invalid-set-prop-any)
[130.735271] Starting subtest: invalid-set-prop-any
[130.736349] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[131.760268] [026/133] (899s left) gem_flink_basic (flink-lifetime)
[131.817397] Starting subtest: flink-lifetime
[131.818507] Subtest flink-lifetime: SUCCESS (0.002s)
[131.958856] [027/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[132.459528] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[132.461763] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.069388] [028/133] (898s left) gem_exec_balancer (parallel)
[133.128366] Subtest parallel: SKIP (0.000s)
[133.260382] [029/133] (898s left) kms_vblank (accuracy-idle)
[133.754296] Starting subtest: accuracy-idle
[133.755541] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.973719] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.219s)
[135.984447] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.216552] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.241s)
[138.220198] Subtest accuracy-idle: SUCCESS (4.463s)
[138.930657] [030/133] (892s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[138.989849] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[139.038758] [031/133] (892s left) gen7_exec_parse (basic-allocation)
[139.094441] Subtest basic-allocation: SKIP (0.000s)
[139.155480] [032/133] (892s left) kms_frontbuffer_tracking (fbc-tiling-4)
[139.656137] Starting subtest: fbc-tiling-4
[139.658126] Subtest fbc-tiling-4: SKIP (0.000s)
[140.265965] [033/133] (891s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[140.323938] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[140.368447] [034/133] (891s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[140.438388] Starting subtest: etime-multi-wait-for-submit-submitted
[140.547190] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[140.682563] [035/133] (891s left) kms_pm_lpsp (screens-disabled)
[152.213119] Starting subtest: screens-disabled
[152.363047] Subtest screens-disabled: SKIP (0.151s)
[153.080467] [036/133] (878s left) gem_exec_capture (capture-invisible)
[153.142533] Subtest capture-invisible: SKIP (0.000s)
[153.208504] [037/133] (878s left) kms_flip (absolute-wf_vblank)
[153.698275] Starting subtest: absolute-wf_vblank
[153.699376] Starting dynamic subtest: A-VGA1
[161.503922] Dynamic subtest A-VGA1: SUCCESS (7.805s)
[161.517053] Starting dynamic subtest: B-VGA1
[169.228265] Dynamic subtest B-VGA1: SUCCESS (7.722s)
[169.241034] Starting dynamic subtest: A-HDMI-A1
[177.118476] Dynamic subtest A-HDMI-A1: SUCCESS (7.887s)
[177.130615] Starting dynamic subtest: B-HDMI-A1
[185.036686] Dynamic subtest B-HDMI-A1: SUCCESS (7.916s)
[185.038222] Subtest absolute-wf_vblank: SUCCESS (31.338s)
[185.849473] [038/133] (846s left) kms_psr (fbc-psr2-sprite-blt)
[186.344162] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[186.631348] [039/133] (845s left) i915_drm_fdinfo (virtual-busy)
[186.690819] Subtest virtual-busy: SKIP (0.000s)
[186.745903] [040/133] (845s left) gem_exec_parallel (contexts)
[186.808214] Starting subtest: contexts
[186.809334] Starting dynamic subtest: rcs0
[188.579278] Dynamic subtest rcs0: SUCCESS (1.770s)
[188.595255] Starting dynamic subtest: bcs0
[190.161551] Dynamic subtest bcs0: SUCCESS (1.582s)
[190.162781] Subtest contexts: SUCCESS (3.354s)
[190.400662] [041/133] (841s left) kms_lease (master-vs-lease)
[190.890322] Starting subtest: master-vs-lease
[190.894110] Subtest master-vs-lease: SUCCESS (0.001s)
[191.473495] [042/133] (840s left) gem_ccs (suspend-resume)
[191.529871] Subtest suspend-resume: SKIP (0.000s)
[191.594385] [043/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[192.089325] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[192.092645] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[192.687504] [044/133] (839s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[193.181944] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[193.184123] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[193.784381] [045/133] (838s left) kms_properties (crtc-properties-legacy)
[194.275218] Starting subtest: crtc-properties-legacy
[194.276344] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.508957] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.232s)
[194.522134] Starting dynamic subtest: pipe-B-HDMI-A-1
[194.819039] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.309s)
[194.820233] Subtest crtc-properties-legacy: SUCCESS (0.545s)
[195.534492] [046/133] (836s left) gem_mmap_gtt (hang-busy)
[195.591168] Starting subtest: hang-busy
[201.909576] Subtest hang-busy: SUCCESS (6.318s)
[202.056829] [047/133] (830s left) syncobj_timeline (invalid-signal-zero-handles)
[202.115177] Starting subtest: invalid-signal-zero-handles
[202.116223] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[202.233995] [048/133] (830s left) syncobj_timeline (wait-zero-handles)
[202.291339] Starting subtest: wait-zero-handles
[202.292383] Subtest wait-zero-handles: SUCCESS (0.000s)
[202.417991] [049/133] (830s left) perf_pmu (rc6-suspend)
[202.478020] Starting subtest: rc6-suspend
[225.472597] Subtest rc6-suspend: SUCCESS (6.887s)
[229.941162] [050/133] (806s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[230.472465] Starting subtest: x-tiled-16bpp-rotate-90
[230.489489] Subtest x-tiled-16bpp-rotate-90: SKIP (0.016s)
[231.123060] [051/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[231.636423] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[231.638724] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[232.270932] [052/133] (804s left) kms_content_protection (legacy-hdcp14)
[232.794194] Starting subtest: legacy-hdcp14
[232.797820] Subtest legacy-hdcp14: SKIP (0.000s)
[233.427813] [053/133] (803s left) gem_exec_params (invalid-batch-start-offset)
[233.485820] Starting subtest: invalid-batch-start-offset
[233.490387] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[233.664248] [054/133] (803s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[234.167054] Starting subtest: psr-rgb101010-draw-mmap-wc
[234.169292] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[234.786808] [055/133] (802s left) vgem_basic (second-client)
[234.903862] Starting subtest: second-client
[234.939939] Subtest second-client: SUCCESS (0.034s)
[235.058848] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[235.061922] [056/133] (801s left) prime_udl
[235.194056] [057/133] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[235.698790] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[235.702692] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[236.310926] [058/133] (800s left) i915_pm_freq_api (freq-suspend)
[236.369223] Subtest freq-suspend: SKIP (0.000s)
[236.437669] [059/133] (800s left) kms_dp_link_training (non-uhbr-mst)
[236.935830] Starting subtest: non-uhbr-mst
[236.940476] Subtest non-uhbr-mst: SKIP (0.000s)
[237.305467] [060/133] (799s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[237.800765] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[237.803016] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[238.414831] [061/133] (798s left) kms_atomic_interruptible (universal-setplane-primary)
[238.909967] Starting subtest: universal-setplane-primary
[238.911143] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.246176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.289s)
[245.247441] Subtest universal-setplane-primary: SUCCESS (6.291s)
[245.989768] [062/133] (791s left) kms_psr (psr-primary-render)
[246.480038] Subtest psr-primary-render: SKIP (0.000s)
[246.781038] [063/133] (790s left) perf (stress-open-close)
[246.940538] Subtest stress-open-close: SKIP (0.000s)
[247.002193] [064/133] (790s left) gem_exec_schedule (reorder-wide)
[247.070626] Subtest reorder-wide: SKIP (0.000s)
[247.295039] [065/133] (790s left) gem_pxp (verify-pxp-stale-buf-execution)
[249.872192] Starting subtest: verify-pxp-stale-buf-execution
[249.876496] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[250.007906] [066/133] (787s left) gem_render_copy_redux (flink)
[250.068117] Starting subtest: flink
[251.196199] Subtest flink: SUCCESS (1.125s)
[251.342016] [067/133] (786s left) api_intel_allocator (open-vm)
[251.396899] Starting subtest: open-vm
[251.401458] Subtest open-vm: SUCCESS (0.005s)
[251.561961] [068/133] (786s left) gem_busy (parallel)
[251.748847] Starting subtest: parallel
[251.749957] Starting dynamic subtest: rcs0
[251.780910] Dynamic subtest rcs0: SUCCESS (0.033s)
[251.800367] Starting dynamic subtest: bcs0
[251.803936] Dynamic subtest bcs0: SUCCESS (0.019s)
[251.805170] Subtest parallel: SUCCESS (0.058s)
[252.076778] [069/133] (785s left) kms_psr (pr-cursor-mmap-cpu)
[252.557747] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[252.853223] [070/133] (784s left) kms_draw_crc (draw-method-mmap-gtt)
[253.340300] Starting subtest: draw-method-mmap-gtt
[253.341454] Starting dynamic subtest: xrgb8888-untiled
[253.620862] Dynamic subtest xrgb8888-untiled: SUCCESS (0.281s)
[253.638614] Starting dynamic subtest: rgb565-untiled
[253.887582] Dynamic subtest rgb565-untiled: SUCCESS (0.263s)
[253.903911] Starting dynamic subtest: xrgb2101010-untiled
[254.187389] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.296s)
[254.203522] Starting dynamic subtest: xbgr16161616f-untiled
[254.506461] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.313s)
[254.523112] Starting dynamic subtest: xrgb8888-xtiled
[254.654016] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.147s)
[254.671609] Starting dynamic subtest: rgb565-xtiled
[254.788785] Dynamic subtest rgb565-xtiled: SUCCESS (0.130s)
[254.803814] Starting dynamic subtest: xrgb2101010-xtiled
[254.937852] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.147s)
[254.954220] Starting dynamic subtest: xbgr16161616f-xtiled
[255.104189] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.163s)
[255.107554] Subtest draw-method-mmap-gtt: SUCCESS (1.764s)
[255.738263] [071/133] (782s left) kms_cursor_edge_walk (128x128-top-edge)
[256.228497] Starting subtest: 128x128-top-edge
[256.229560] Starting dynamic subtest: pipe-A-HDMI-A-1
[259.661930] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.431s)
[259.677486] Starting dynamic subtest: pipe-B-HDMI-A-1
[262.996330] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.330s)
[262.997429] Subtest 128x128-top-edge: SUCCESS (6.765s)
[263.698167] [072/133] (774s left) kms_busy (extended-pageflip-hang-newfb)
[264.193796] Starting subtest: extended-pageflip-hang-newfb
[264.195002] Starting dynamic subtest: pipe-A
[270.101642] Dynamic subtest pipe-A: SUCCESS (5.904s)
[270.115975] Starting dynamic subtest: pipe-B
[276.109525] Dynamic subtest pipe-B: SUCCESS (6.004s)
[276.112753] Subtest extended-pageflip-hang-newfb: SUCCESS (11.914s)
[276.847692] [073/133] (761s left) gem_eio (unwedge-stress)
[276.919544] Starting subtest: unwedge-stress
[276.920606] Starting dynamic subtest: render
[278.639550] Dynamic subtest render: SUCCESS (1.719s)
[278.655659] Starting dynamic subtest: bsd
[279.865324] Dynamic subtest bsd: FAIL (1.187s)
[279.866448] Subtest unwedge-stress: FAIL (2.909s)
[280.842126] [074/133] (757s left) syncobj_timeline (single-wait-available-signaled)
[280.898792] Starting subtest: single-wait-available-signaled
[280.899888] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[281.041294] [075/133] (757s left) kms_plane_multiple (tiling-4)
[281.531667] Starting subtest: tiling-4
[281.533645] Subtest tiling-4: SKIP (0.000s)
[282.134858] [076/133] (756s left) sw_sync (sync_busy)
[282.194100] Starting subtest: sync_busy
[282.198144] Subtest sync_busy: SUCCESS (0.005s)
[282.319888] [077/133] (755s left) kms_atomic_transition (plane-all-transition-fencing)
[282.803782] Starting subtest: plane-all-transition-fencing
[282.804901] Starting dynamic subtest: pipe-A-HDMI-A-1
[283.981287] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.175s)
[284.078496] Starting dynamic subtest: pipe-B-HDMI-A-1
[285.385642] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.318s)
[285.468350] Subtest plane-all-transition-fencing: SUCCESS (2.664s)
[286.186148] [078/133] (752s left) i915_pm_rc6_residency (rc6-fence)
[286.243449] Starting subtest: rc6-fence
[286.249986] Starting dynamic subtest: gt0
[298.477031] Dynamic subtest gt0: SUCCESS (12.221s)
[298.478596] Subtest rc6-fence: SUCCESS (12.229s)
[298.618401] [079/133] (739s left) gem_partial_pwrite_pread (write)
[298.676621] Starting subtest: write
[302.451731] Subtest write: SUCCESS (3.773s)
[302.628066] [080/133] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[303.128837] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[303.132284] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.742879] [081/133] (734s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[304.241921] Starting subtest: yf-tiled-8bpp-rotate-180
[304.245291] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[304.862804] [082/133] (733s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[305.359255] Starting subtest: blocking-absolute-wf_vblank-interruptible
[305.360530] Starting dynamic subtest: A-VGA1
[313.108301] Dynamic subtest A-VGA1: SUCCESS (7.745s)
[313.124765] Starting dynamic subtest: B-VGA1
[320.804343] Dynamic subtest B-VGA1: SUCCESS (7.689s)
[320.821392] Starting dynamic subtest: A-HDMI-A1
[328.676080] Dynamic subtest A-HDMI-A1: SUCCESS (7.871s)
[328.691041] Starting dynamic subtest: B-HDMI-A1
[336.572830] Dynamic subtest B-HDMI-A1: SUCCESS (7.898s)
[336.577723] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.216s)
[337.348807] [083/133] (701s left) gen7_exec_parse (basic-rejected)
[337.406241] Subtest basic-rejected: SKIP (0.000s)
[337.471515] [084/133] (701s left) kms_big_fb (4-tiled-addfb)
[337.973807] Starting subtest: 4-tiled-addfb
[337.976011] Subtest 4-tiled-addfb: SKIP (0.000s)
[338.579642] [085/133] (700s left) kms_cursor_crc (cursor-random-128x128)
[339.083934] Starting subtest: cursor-random-128x128
[339.086581] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.763706] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.677s)
[342.807392] Starting dynamic subtest: pipe-B-HDMI-A-1
[346.480941] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.689s)
[346.482008] Subtest cursor-random-128x128: SUCCESS (7.399s)
[347.204725] [086/133] (691s left) gem_exec_params (sol-reset-not-gen7)
[347.267526] Starting subtest: sol-reset-not-gen7
[347.270082] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[347.435903] [087/133] (691s left) gem_exec_fence (syncobj-invalid-wait)
[347.639286] Starting subtest: syncobj-invalid-wait
[347.640534] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[348.037165] [088/133] (690s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[348.534374] Starting subtest: y-tiled-32bpp-rotate-90
[348.536586] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[349.150127] [089/133] (689s left) gem_ctx_isolation (dirty-create)
[349.218758] Starting subtest: dirty-create
[349.219809] Starting dynamic subtest: rcs0
[349.805681] Dynamic subtest rcs0: SUCCESS (0.586s)
[349.806775] Subtest dirty-create: SUCCESS (0.588s)
[350.084116] [090/133] (688s left) gem_exec_suspend (basic-s3-devices)
[350.150699] Starting subtest: basic-S3-devices
[350.151815] Starting dynamic subtest: smem
[356.453446] Dynamic subtest smem: SUCCESS (6.302s)
[356.454512] Subtest basic-S3-devices: SUCCESS (6.304s)
[364.709027] [091/133] (682s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[365.260163] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[365.668430] [092/133] (681s left) gem_lmem_swapping (parallel-random)
[365.726170] Subtest parallel-random: SKIP (0.000s)
[365.782767] [093/133] (681s left) gem_exec_alignment (pi-isolated)
[365.843860] Starting subtest: pi-isolated
[365.846280] Subtest pi-isolated: SKIP (0.000s)
[366.008464] [094/133] (681s left) kms_psr (fbc-pr-cursor-plane-move)
[366.494356] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[366.798339] [095/133] (680s left) kms_cursor_crc (cursor-onscreen-128x128)
[367.292899] Starting subtest: cursor-onscreen-128x128
[367.296958] Starting dynamic subtest: pipe-A-HDMI-A-1
[369.511452] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.216s)
[369.556624] Starting dynamic subtest: pipe-B-HDMI-A-1
[371.767814] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.226s)
[371.768881] Subtest cursor-onscreen-128x128: SUCCESS (4.475s)
[372.505725] [096/133] (674s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[372.997475] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[373.296341] [097/133] (674s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[373.794685] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[376.374582] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.581s)
[377.015642] [098/133] (670s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[377.079595] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[377.080670] Starting dynamic subtest: smem
[377.083065] Dynamic subtest smem: SKIP (0.000s)
[377.085751] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.002s)
[377.343445] [099/133] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[377.833693] Starting subtest: psr-1p-primscrn-cur-indfb-move
[377.835966] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[378.443056] [100/133] (669s left) perf_pmu (busy-double-start)
[378.502485] Starting subtest: busy-double-start
[378.503628] Starting dynamic subtest: rcs0
[382.036954] Dynamic subtest rcs0: SUCCESS (3.534s)
[382.056462] Starting dynamic subtest: bcs0
[385.561899] Dynamic subtest bcs0: SUCCESS (3.521s)
[385.581643] Starting dynamic subtest: vcs0
[389.583905] Dynamic subtest vcs0: SUCCESS (4.018s)
[389.588490] Subtest busy-double-start: SUCCESS (11.083s)
[389.721465] [101/133] (657s left) gem_partial_pwrite_pread (reads-uncached)
[389.779555] Starting subtest: reads-uncached
[390.885077] Subtest reads-uncached: SUCCESS (1.104s)
[391.036196] [102/133] (656s left) kms_joiner (basic-max-non-joiner)
[391.525077] Starting subtest: basic-max-non-joiner
[391.527206] Subtest basic-max-non-joiner: SKIP (0.000s)
[392.114025] [103/133] (655s left) gem_fence_thrash (bo-write-verify-threaded-x)
[392.167443] Starting subtest: bo-write-verify-threaded-x
[393.835954] Subtest bo-write-verify-threaded-x: SUCCESS (1.667s)
[393.981023] [104/133] (653s left) kms_psr (psr2-cursor-plane-onoff)
[394.472473] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[394.773041] [105/133] (653s left) gem_spin_batch (engines)
[394.837718] Starting subtest: engines
[394.838747] Starting dynamic subtest: rcs0
[398.151764] Dynamic subtest rcs0: SUCCESS (3.310s)
[398.166178] Starting dynamic subtest: bcs0
[401.463959] Dynamic subtest bcs0: SUCCESS (3.310s)
[401.478206] Starting dynamic subtest: vcs0
[404.776461] Dynamic subtest vcs0: SUCCESS (3.310s)
[404.777533] Subtest engines: SUCCESS (9.935s)
[405.065827] [106/133] (642s left) gem_exec_whisper (basic-fds-priority-all)
[405.133391] Starting subtest: basic-fds-priority-all
[405.135697] Subtest basic-fds-priority-all: SKIP (0.001s)
[405.358453] [107/133] (642s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[405.849517] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[406.934955] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.086s)
[407.590316] [108/133] (640s left) prime_vgem (basic-fence-flip)
[407.656678] Starting subtest: basic-fence-flip
[408.554976] Subtest basic-fence-flip: SUCCESS (0.899s)
[409.322619] [109/133] (638s left) kms_vblank (query-forked-hang)
[409.806538] Starting subtest: query-forked-hang
[409.807797] Starting dynamic subtest: pipe-A-HDMI-A-1
[416.035572] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.226s)
[416.052125] Starting dynamic subtest: pipe-B-HDMI-A-1
[422.052622] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.012s)
[422.053693] Subtest query-forked-hang: SUCCESS (12.246s)
[422.776268] [110/133] (625s left) gem_eio (in-flight-1us)
[422.837399] Starting subtest: in-flight-1us
[424.239374] Subtest in-flight-1us: SUCCESS (1.401s)
[425.290460] [111/133] (622s left) vgem_basic (dmabuf-mmap)
[425.354773] Starting subtest: dmabuf-mmap
[425.368666] Subtest dmabuf-mmap: SUCCESS (0.016s)
[425.491653] [112/133] (622s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[425.979693] Starting subtest: addfb25-x-tiled-legacy
[425.980679] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[426.590637] [113/133] (621s left) perf (invalid-oa-format-id)
[426.739616] Subtest invalid-oa-format-id: SKIP (0.000s)
[426.798741] [114/133] (621s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[426.856307] Starting subtest: writes-after-reads-snoop
[431.693467] Subtest writes-after-reads-snoop: SUCCESS (4.836s)
[431.863659] [115/133] (616s left) gem_render_copy (y-tiled)
[431.934928] Starting subtest: y-tiled
[431.936046] Starting dynamic subtest: smem
[432.000161] Dynamic subtest smem: SUCCESS (0.064s)
[432.001490] Subtest y-tiled: SUCCESS (0.066s)
[432.246045] [116/133] (616s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[432.301169] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[432.302253] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[432.444316] [117/133] (616s left) gem_close (basic)
[432.501138] Starting subtest: basic
[432.502208] Subtest basic: SUCCESS (0.000s)
[432.643066] [118/133] (615s left) kms_color (ctm-red-to-blue)
[433.134253] Starting subtest: ctm-red-to-blue
[433.135614] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.603247] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.469s)
[433.618443] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.115857] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.512s)
[434.116954] Subtest ctm-red-to-blue: SUCCESS (0.984s)
[434.849509] [119/133] (613s left) gem_pxp (fail-invalid-protected-context)
[437.420761] Starting subtest: fail-invalid-protected-context
[437.423167] Subtest fail-invalid-protected-context: SKIP (0.000s)
[437.556379] [120/133] (611s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[437.616023] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[437.723379] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[437.860125] [121/133] (610s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[437.914253] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[437.985177] [122/133] (610s left) kms_atomic (plane-overlay-legacy)
[438.475127] Starting subtest: plane-overlay-legacy
[438.476205] Starting dynamic subtest: pipe-A-HDMI-A-1
[438.750022] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.274s)
[438.751165] Subtest plane-overlay-legacy: SUCCESS (0.277s)
[439.485377] [123/133] (609s left) gem_exec_params (invalid-ring)
[439.544692] Starting subtest: invalid-ring
[439.545769] Subtest invalid-ring: SUCCESS (0.000s)
[439.701343] [124/133] (609s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[439.756690] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[439.828344] [125/133] (609s left) kms_flip (2x-flip-vs-suspend)
[440.322147] Starting subtest: 2x-flip-vs-suspend
[440.323263] Starting dynamic subtest: AB-VGA1-HDMI-A1
[644.331383] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[656.246938] Closing watchdogs
[656.251195] Initializing watchdogs
[656.251269]   /dev/watchdog0
[656.277475] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[656.289440] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[656.291029] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[656.291804] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[656.295011] [126/133] (403s left) kms_hdr (static-swap)
[656.818766] Starting subtest: static-swap
[656.822214] Subtest static-swap: SKIP (0.000s)
[657.448719] [127/133] (402s left) gem_ctx_persistence (heartbeat-hostile)
[657.516142] Subtest heartbeat-hostile: SKIP (0.000s)
[657.590810] [128/133] (402s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[657.649793] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[657.723286] [129/133] (402s left) gem_workarounds (reset-context)
[657.790802] Starting subtest: reset-context
[657.797355] Subtest reset-context: SUCCESS (0.006s)
[657.964556] [130/133] (402s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[658.473500] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[658.475627] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[659.109002] [131/133] (401s left) kms_big_fb (linear-16bpp-rotate-180)
[659.621200] Starting subtest: linear-16bpp-rotate-180
[660.965665] Subtest linear-16bpp-rotate-180: SUCCESS (1.318s)
[661.616417] [132/133] (398s left) kms_chamelium_color (ctm-max)
[662.107308] Subtest ctm-max: SKIP (0.000s)
[662.416422] [133/133] (398s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[662.921252] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[662.923323] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[663.535189] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_edid
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: i915_query
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_plane_cursor
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: device_reset
results: parsing output: 16/ for test: gem_unfence_active_buffers
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gen3_render_tiledy_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_flink_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gen7_exec_parse
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_pm_lpsp
results: parsing output: 35/ for test: gem_exec_capture
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: gem_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: prime_udl
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_pm_freq_api
results: parsing output: 58/ for test: kms_dp_link_training
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_pxp
results: parsing output: 65/ for test: gem_render_copy_redux
results: parsing output: 66/ for test: api_intel_allocator
results: parsing output: 67/ for test: gem_busy
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: i915_pm_rc6_residency
results: parsing output: 78/ for test: gem_partial_pwrite_pread
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gen7_exec_parse
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_ctx_isolation
results: parsing output: 89/ for test: gem_exec_suspend
results: parsing output: 90/ for test: kms_chamelium_hpd
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: gem_exec_alignment
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_partial_pwrite_pread
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: gem_fence_thrash
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_close
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_atomic
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_hdr
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.