[76.875381] Initializing watchdogs
[76.875496]   /dev/watchdog0
[76.895709] [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)
[76.903331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[76.908478] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[76.911512] [001/133] (960s left) kms_rotation_crc (sprite-rotation-180)
[77.441167] Starting subtest: sprite-rotation-180
[80.909807] Subtest sprite-rotation-180: SUCCESS (3.467s)
[81.706717] [002/133] (955s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[81.768341] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[81.769805] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[81.874970] [003/133] (955s left) kms_universal_plane (universal-plane-pageflip-windowed)
[82.371890] Starting subtest: universal-plane-pageflip-windowed
[82.374163] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[82.968506] [004/133] (954s left) kms_force_connector_basic (force-connector-state)
[83.040947] Starting subtest: force-connector-state
[83.622388] Subtest force-connector-state: SUCCESS (0.582s)
[84.412812] [005/133] (953s left) gen9_exec_parse (bb-chained)
[84.474998] Subtest bb-chained: SKIP (0.000s)
[84.531574] [006/133] (953s left) i915_pm_rps (thresholds-idle-park)
[84.609864] Starting subtest: thresholds-idle-park
[84.610710] Starting dynamic subtest: gt0
[99.945237] Dynamic subtest gt0: SUCCESS (15.332s)
[99.946811] Subtest thresholds-idle-park: SUCCESS (15.334s)
[100.060311] [007/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[100.558088] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[100.559464] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[101.158316] [008/133] (936s left) gem_ctx_shared (exec-shared-gtt)
[101.218119] Subtest exec-shared-gtt: SKIP (0.000s)
[101.339497] [009/133] (936s left) gem_ctx_param (set-priority-invalid-size)
[101.393110] Subtest set-priority-invalid-size: SKIP (0.000s)
[101.503580] [010/133] (936s left) syncobj_basic (bad-destroy)
[101.556272] Starting subtest: bad-destroy
[101.557254] Subtest bad-destroy: SUCCESS (0.000s)
[101.671430] [011/133] (936s left) kms_big_fb (yf-tiled-addfb)
[102.173730] Starting subtest: yf-tiled-addfb
[102.176642] Subtest yf-tiled-addfb: SKIP (0.000s)
[102.769891] [012/133] (935s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[103.272089] Starting subtest: x-tiled-64bpp-rotate-0
[105.124092] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.850s)
[105.734079] [013/133] (932s left) gem_close_race (multigpu-basic-process)
[105.803844] Starting subtest: multigpu-basic-process
[105.805485] Subtest multigpu-basic-process: SKIP (0.000s)
[106.046238] [014/133] (931s left) gem_sync (basic-store-each)
[106.111997] Starting subtest: basic-store-each
[108.376344] Subtest basic-store-each: SUCCESS (2.265s)
[108.593883] [015/133] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[109.093641] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[110.496245] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.402s)
[111.138920] [016/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[111.639829] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[111.641307] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.237843] [017/133] (925s left) api_intel_allocator (reloc-allocator)
[112.296911] Starting subtest: reloc-allocator
[112.297632] Starting dynamic subtest: basic
[112.300969] Dynamic subtest basic: SUCCESS (0.005s)
[112.311855] Starting dynamic subtest: parallel-one
[112.312673] Dynamic subtest parallel-one: SUCCESS (0.007s)
[112.321757] Starting dynamic subtest: print
[112.322652] Dynamic subtest print: SUCCESS (0.000s)
[112.332213] Starting dynamic subtest: reuse
[112.333268] Dynamic subtest reuse: SUCCESS (0.000s)
[112.346851] Starting dynamic subtest: fork-reopen-allocator
[112.348532] Dynamic subtest fork-reopen-allocator: SUCCESS (0.018s)
[112.349679] Subtest reloc-allocator: SUCCESS (0.033s)
[112.485299] [018/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[112.986096] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[112.987513] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[113.588029] [019/133] (924s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[113.647128] Starting subtest: multi-wait-for-submit-available-signaled
[113.648636] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[113.768753] [020/133] (924s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[113.824510] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[113.878044] [021/133] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[114.376046] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[114.377644] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[114.979207] [022/133] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[115.478027] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[115.479540] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[116.080408] [023/133] (922s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[116.151202] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[116.205196] [024/133] (922s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[116.703433] Starting subtest: fbcpsr-modesetfrombusy
[116.704953] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[117.310475] [025/133] (921s left) perf (gen12-oa-tlb-invalidate)
[117.452418] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s)
[117.504842] [026/133] (921s left) gem_eio (hibernate)
[117.567916] Starting subtest: hibernate
[131.436652] Subtest hibernate: SUCCESS (13.867s)
[142.464796] [027/133] (906s left) kms_frontbuffer_tracking (psr-2p-rte)
[142.980152] Starting subtest: psr-2p-rte
[142.981643] Subtest psr-2p-rte: SKIP (0.000s)
[143.581900] [028/133] (905s left) gem_sync (basic-store-all)
[143.654027] Starting subtest: basic-store-all
[145.887993] Subtest basic-store-all: SUCCESS (2.234s)
[146.122090] [029/133] (902s left) gem_exec_reloc (basic-wc-read-noreloc)
[146.176206] Starting subtest: basic-wc-read-noreloc
[146.178061] Subtest basic-wc-read-noreloc: SUCCESS (0.002s)
[147.225552] [030/133] (901s left) kms_flip (2x-absolute-wf_vblank)
[147.722811] Starting subtest: 2x-absolute-wf_vblank
[147.723677] Starting dynamic subtest: AB-VGA1-HDMI-A1
[178.147119] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.425s)
[178.149618] Subtest 2x-absolute-wf_vblank: SUCCESS (30.429s)
[178.969190] [031/133] (869s left) kms_psr (fbc-psr2-no-drrs)
[179.466731] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[179.759765] [032/133] (869s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[179.819980] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[179.876485] [033/133] (868s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[180.362548] Starting subtest: primary-y-tiled-reflect-x-90
[180.363976] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[180.963427] [034/133] (867s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[181.456448] Starting subtest: plane-downscale-factor-0-75-with-rotation
[181.457280] Starting dynamic subtest: pipe-A
[181.459955] Dynamic subtest pipe-A: SKIP (0.001s)
[181.472917] Starting dynamic subtest: pipe-B
[181.475071] Dynamic subtest pipe-B: SKIP (0.001s)
[181.476667] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.005s)
[182.060945] [035/133] (866s left) kms_psr (pr-primary-mmap-cpu)
[182.557954] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[182.868757] [036/133] (866s left) gem_flink_race (flink_name)
[182.924914] Starting subtest: flink_name
[188.299113] Subtest flink_name: SUCCESS (5.374s)
[188.431103] [037/133] (860s left) gem_exec_whisper (basic-sync)
[188.500088] Starting subtest: basic-sync
[189.845355] Subtest basic-sync: SUCCESS (1.344s)
[190.079130] [038/133] (859s left) gem_exec_whisper (basic-contexts-forked-all)
[190.150212] Starting subtest: basic-contexts-forked-all
[193.355306] Subtest basic-contexts-forked-all: SUCCESS (3.203s)
[193.590183] [039/133] (855s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[194.078811] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[194.080373] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[194.689189] [040/133] (854s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[195.180922] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[195.480371] [041/133] (853s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[195.541708] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[195.598424] [042/133] (853s left) kms_setmode (invalid-clone-single-crtc-stealing)
[195.650564] Starting subtest: invalid-clone-single-crtc-stealing
[195.652940] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[195.753411] [043/133] (853s left) gem_exec_schedule (preempt-user)
[195.822328] Subtest preempt-user: SKIP (0.000s)
[196.055931] [044/133] (853s left) gem_render_copy (y-tiled-to-vebox-linear)
[196.121295] Starting subtest: y-tiled-to-vebox-linear
[196.124238] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[196.352176] [045/133] (853s left) prime_vgem (coherency-gtt)
[196.475654] Starting subtest: coherency-gtt
[196.490607] Subtest coherency-gtt: SUCCESS (0.015s)
[196.639614] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[196.643545] [046/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[197.137437] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[197.138763] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[197.755362] [047/133] (851s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[198.241490] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[201.570733] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.329s)
[202.303459] [048/133] (847s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[202.378471] Starting subtest: etime-single-wait-for-submit-unsubmitted
[202.482120] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[202.614354] [049/133] (847s left) kms_psr (psr-no-drrs)
[203.100134] Subtest psr-no-drrs: SKIP (0.000s)
[203.421566] [050/133] (846s left) kms_cursor_crc (cursor-random-32x10)
[203.914177] Starting subtest: cursor-random-32x10
[203.970976] Subtest cursor-random-32x10: SKIP (0.055s)
[204.579678] [051/133] (845s left) kms_cursor_crc (cursor-onscreen-256x256)
[205.079718] Starting subtest: cursor-onscreen-256x256
[205.082059] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.303904] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.222s)
[207.346779] Starting dynamic subtest: pipe-B-HDMI-A-1
[209.558617] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.225s)
[209.560617] Subtest cursor-onscreen-256x256: SUCCESS (4.480s)
[210.302225] [052/133] (839s left) gem_softpin (reverse)
[210.364353] Starting subtest: reverse
[210.370369] Subtest reverse: SUCCESS (0.006s)
[210.512946] [053/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[211.001264] Starting subtest: 256x256-top-edge
[211.016047] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.420851] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.418s)
[214.434296] Starting dynamic subtest: pipe-B-HDMI-A-1
[217.750734] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.328s)
[217.752744] Subtest 256x256-top-edge: SUCCESS (6.751s)
[218.483277] [054/133] (831s left) gem_lmem_swapping (verify-ccs)
[218.549447] Subtest verify-ccs: SKIP (0.000s)
[218.612827] [055/133] (831s left) i915_drm_fdinfo (virtual-busy-idle-all)
[218.667855] Subtest virtual-busy-idle-all: SKIP (0.000s)
[218.725755] [056/133] (831s left) kms_debugfs (display-off-read-all)
[219.209892] Starting subtest: display-off-read-all
[219.298295] Subtest display-off-read-all: SUCCESS (0.089s)
[220.012598] [057/133] (830s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[220.076570] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[220.197886] [058/133] (829s left) kms_psr (psr2-primary-page-flip)
[220.684691] Subtest psr2-primary-page-flip: SKIP (0.000s)
[220.987952] [059/133] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[221.477842] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[221.479109] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[222.092944] [060/133] (828s left) gem_exec_schedule (fifo)
[222.161912] Starting subtest: fifo
[222.162729] Starting dynamic subtest: rcs0
[222.193499] Dynamic subtest rcs0: SUCCESS (0.031s)
[222.209320] Starting dynamic subtest: bcs0
[222.223538] Dynamic subtest bcs0: SUCCESS (0.028s)
[222.224259] Subtest fifo: SUCCESS (0.063s)
[222.489731] [061/133] (827s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[222.973745] Starting subtest: addfb25-x-tiled-legacy
[222.974711] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[223.572733] [062/133] (826s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[223.635554] Starting subtest: multi-wait-all-for-submit-unsubmitted
[223.738178] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[223.869761] [063/133] (826s left) kms_pm_lpsp (screens-disabled)
[235.401508] Starting subtest: screens-disabled
[235.549532] Subtest screens-disabled: SKIP (0.149s)
[236.258425] [064/133] (814s left) kms_setmode (invalid-clone-exclusive-crtc)
[236.318636] Starting subtest: invalid-clone-exclusive-crtc
[236.320644] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[236.444975] [065/133] (814s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[236.935656] Starting subtest: cursorB-vs-flipA-atomic-transitions
[236.940250] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[237.540248] [066/133] (813s left) kms_plane_scaling (planes-upscale-factor-0-25)
[238.021740] Starting subtest: planes-upscale-factor-0-25
[238.022457] Starting dynamic subtest: pipe-A
[238.024476] Dynamic subtest pipe-A: SKIP (0.001s)
[238.039438] Starting dynamic subtest: pipe-B
[238.041521] Dynamic subtest pipe-B: SKIP (0.001s)
[238.042899] Subtest planes-upscale-factor-0-25: SKIP (0.005s)
[238.602538] [067/133] (811s left) kms_atomic (test-only)
[239.095347] Starting subtest: test-only
[239.156740] Starting dynamic subtest: pipe-A-HDMI-A-1
[239.642724] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.487s)
[239.643483] Subtest test-only: SUCCESS (0.550s)
[240.356835] [068/133] (810s left) dmabuf_sync_file (export-before-signal)
[240.422948] Starting subtest: export-before-signal
[240.423927] Subtest export-before-signal: SUCCESS (0.002s)
[240.539753] [069/133] (810s left) kms_chamelium_color (ctm-0-50)
[241.026831] Subtest ctm-0-50: SKIP (0.000s)
[241.333802] [070/133] (809s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[241.824518] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[242.367952] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.542s)
[243.050044] [071/133] (807s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[243.549154] Starting subtest: fbc-tiling-linear
[251.417555] Subtest fbc-tiling-linear: SUCCESS (7.866s)
[252.051485] [072/133] (798s left) gem_tiled_blits (basic)
[252.674109] Starting subtest: basic
[252.688567] Subtest basic: SUCCESS (0.016s)
[252.862560] [073/133] (798s left) kms_addfb_basic (unused-modifier)
[253.041961] Starting subtest: unused-modifier
[253.042839] Subtest unused-modifier: SUCCESS (0.000s)
[254.077521] [074/133] (796s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[256.653641] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[256.655101] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[256.759882] [075/133] (794s left) gem_fence_thrash (bo-write-verify-threaded-y)
[256.813852] Starting subtest: bo-write-verify-threaded-y
[258.795170] Subtest bo-write-verify-threaded-y: SUCCESS (1.982s)
[258.924898] [076/133] (792s left) i915_drm_fdinfo (all-busy-check-all)
[258.985070] Subtest all-busy-check-all: SKIP (0.000s)
[259.046758] [077/133] (792s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[259.533807] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[260.616579] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.081s)
[261.339134] [078/133] (789s left) syncobj_eventfd (invalid-bad-flags)
[261.413941] Starting subtest: invalid-bad-flags
[261.414834] Subtest invalid-bad-flags: SUCCESS (0.000s)
[261.536645] [079/133] (789s left) kms_pm_rpm (legacy-planes)
[273.319238] Subtest legacy-planes: SKIP (0.000s)
[273.625753] [080/133] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[274.114704] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[274.115965] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[274.728897] [081/133] (776s left) kms_addfb_basic (too-wide)
[275.210759] Starting subtest: too-wide
[275.211476] Subtest too-wide: SUCCESS (0.000s)
[275.809967] [082/133] (775s left) gem_eio (in-flight-immediate)
[275.879826] Starting subtest: in-flight-immediate
[277.296860] Subtest in-flight-immediate: SUCCESS (1.417s)
[278.341324] [083/133] (773s left) gem_ctx_param (invalid-ctx-set)
[278.397269] Starting subtest: invalid-ctx-set
[278.397972] Subtest invalid-ctx-set: SUCCESS (0.000s)
[278.532338] [084/133] (772s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[279.026132] Starting subtest: cursor-vs-flip-atomic
[309.686866] Subtest cursor-vs-flip-atomic: SUCCESS (30.661s)
[310.407574] [085/133] (741s left) syncobj_wait (single-wait-all-submitted)
[310.475309] Starting subtest: single-wait-all-submitted
[310.578105] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[310.703800] [086/133] (740s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[310.761810] Starting subtest: writes-after-reads-snoop
[315.687993] Subtest writes-after-reads-snoop: SUCCESS (4.926s)
[315.863555] [087/133] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[316.353216] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[316.354924] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[316.959800] [088/133] (734s left) gem_exec_schedule (preemptive-hang)
[317.035427] Subtest preemptive-hang: SKIP (0.000s)
[317.276636] [089/133] (734s left) gem_readwrite (write-bad-handle)
[317.332267] Starting subtest: write-bad-handle
[317.333556] Subtest write-bad-handle: SUCCESS (0.000s)
[317.492681] [090/133] (734s left) kms_color (ctm-negative)
[317.976732] Starting subtest: ctm-negative
[317.977680] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.454294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.477s)
[318.469297] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.979513] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.523s)
[318.980300] Subtest ctm-negative: SUCCESS (1.005s)
[319.682380] [091/133] (732s left) gem_exec_params (invalid-bsd1-flag-on-render)
[319.745695] Starting subtest: invalid-bsd1-flag-on-render
[319.746449] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[319.881282] [092/133] (732s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[320.374987] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[320.377455] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[320.960500] [093/133] (731s left) kms_feature_discovery (psr2)
[321.449404] Starting subtest: psr2
[321.450817] Subtest psr2: SKIP (0.000s)
[322.058505] [094/133] (730s left) i915_query (query-topology-coherent-slice-mask)
[322.116164] Starting subtest: query-topology-coherent-slice-mask
[322.117381] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[322.242888] [095/133] (729s left) kms_lease (cursor-implicit-plane)
[322.727587] Starting subtest: cursor-implicit-plane
[322.728309] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.952570] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.224s)
[322.968125] Starting dynamic subtest: pipe-B-HDMI-A-1
[323.201641] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.246s)
[323.203862] Subtest cursor-implicit-plane: SUCCESS (0.477s)
[323.935844] [096/133] (728s left) gem_ctx_isolation (dirty-create)
[324.006621] Starting subtest: dirty-create
[324.007357] Starting dynamic subtest: rcs0
[324.576579] Dynamic subtest rcs0: SUCCESS (0.569s)
[324.577363] Subtest dirty-create: SUCCESS (0.570s)
[324.851748] [097/133] (727s left) gem_exec_balancer (busy)
[324.910708] Subtest busy: SKIP (0.000s)
[325.034251] [098/133] (727s left) gem_ctx_persistence (heartbeat-hostile)
[325.096534] Subtest heartbeat-hostile: SKIP (0.000s)
[325.162300] [099/133] (727s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[325.225540] Starting subtest: yf-tiled-ccs-to-yf-tiled
[325.226243] Starting dynamic subtest: smem
[325.227629] Dynamic subtest smem: SKIP (0.000s)
[325.228953] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.002s)
[325.464136] [100/133] (726s left) kms_invalid_mode (bad-vsync-end)
[325.949124] Starting subtest: bad-vsync-end
[325.949894] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.026739] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.077s)
[326.045701] Starting dynamic subtest: pipe-B-HDMI-A-1
[326.046521] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[326.047298] Subtest bad-vsync-end: SUCCESS (0.081s)
[326.509451] [101/133] (725s left) kms_psr2_su (frontbuffer-xrgb8888)
[326.570301] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[326.637828] [102/133] (725s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[326.696924] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[326.771621] [103/133] (725s left) gem_exec_fence (submit3)
[326.943396] Subtest submit3: SKIP (0.000s)
[327.323735] [104/133] (725s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[327.378957] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[327.451541] [105/133] (725s left) sysfs_heartbeat_interval (nopreempt)
[327.507663] Starting subtest: nopreempt
[327.509878] Starting dynamic subtest: vcs0
[327.511314] Dynamic subtest vcs0: SKIP (0.000s)
[327.526784] Starting dynamic subtest: bcs0
[327.528952] Dynamic subtest bcs0: SKIP (0.000s)
[327.546261] Starting dynamic subtest: rcs0
[327.548385] Dynamic subtest rcs0: SKIP (0.000s)
[327.550389] Subtest nopreempt: SKIP (0.006s)
[327.640707] [106/133] (725s left) perf_pmu (init-wait)
[327.697708] Starting subtest: init-wait
[327.698643] Starting dynamic subtest: rcs0
[327.700815] Dynamic subtest rcs0: SUCCESS (0.001s)
[327.716923] Starting dynamic subtest: bcs0
[327.718152] Dynamic subtest bcs0: SUCCESS (0.000s)
[327.741707] Starting dynamic subtest: vcs0
[327.743058] Dynamic subtest vcs0: SUCCESS (0.000s)
[327.744163] Subtest init-wait: SUCCESS (0.007s)
[327.838779] [107/133] (724s left) kms_big_fb (linear-32bpp-rotate-180)
[328.338610] Starting subtest: linear-32bpp-rotate-180
[329.832059] Subtest linear-32bpp-rotate-180: SUCCESS (1.494s)
[330.483520] [108/133] (722s left) kms_content_protection (uevent-hdcp14)
[330.986347] Starting subtest: uevent-hdcp14
[330.987886] Subtest uevent-hdcp14: SKIP (0.000s)
[331.600705] [109/133] (721s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[332.096626] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[332.389860] [110/133] (720s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[332.891576] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[332.893169] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[333.492560] [111/133] (719s left) kms_plane_lowres (tiling-x)
[333.983601] Starting subtest: tiling-x
[333.984654] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.546056] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.560s)
[336.645012] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.080272] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.448s)
[339.162419] Subtest tiling-x: SUCCESS (5.179s)
[339.910066] [112/133] (713s left) kms_vblank (wait-forked-hang)
[340.407332] Starting subtest: wait-forked-hang
[340.408450] Starting dynamic subtest: pipe-A-HDMI-A-1
[346.938687] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.531s)
[346.953970] Starting dynamic subtest: pipe-B-HDMI-A-1
[352.958101] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.016s)
[352.958894] Subtest wait-forked-hang: SUCCESS (12.553s)
[353.706133] [113/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[354.201630] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[354.202766] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.816531] [114/133] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[355.316080] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[355.318585] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[355.937310] [115/133] (697s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[356.427209] Starting subtest: basic-max-pipe-crc-check
[356.428615] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[356.727614] [116/133] (696s left) gem_blits (basic)
[356.787223] Starting subtest: basic
[358.739264] Subtest basic: SUCCESS (1.951s)
[358.877770] [117/133] (694s left) gem_wait (write-busy)
[358.950406] Starting subtest: write-busy
[358.951294] Starting dynamic subtest: all-engines
[359.463621] Dynamic subtest all-engines: SUCCESS (0.514s)
[359.479743] Starting dynamic subtest: rcs0
[359.991593] Dynamic subtest rcs0: SUCCESS (0.525s)
[360.008028] Starting dynamic subtest: bcs0
[360.513501] Dynamic subtest bcs0: SUCCESS (0.518s)
[360.530105] Starting dynamic subtest: vcs0
[361.037553] Dynamic subtest vcs0: SUCCESS (0.520s)
[361.040869] Subtest write-busy: SUCCESS (2.090s)
[361.309809] [118/133] (692s left) kms_chamelium_hpd (hdmi-hpd-storm)
[361.872990] Subtest hdmi-hpd-storm: SKIP (0.000s)
[362.281189] [119/133] (691s left) gem_mmap_offset (close-race)
[362.341508] Starting subtest: close-race
[383.303868] Subtest close-race: SUCCESS (20.962s)
[383.463282] [120/133] (670s left) sw_sync (timeline_closed_signaled)
[383.521840] Starting subtest: timeline_closed_signaled
[383.522647] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[383.643509] [121/133] (669s left) kms_chamelium_frames (hdmi-crc-fast)
[384.207533] Subtest hdmi-crc-fast: SKIP (0.000s)
[384.619513] [122/133] (668s left) perf (stress-open-close)
[384.810214] Subtest stress-open-close: SKIP (0.000s)
[384.865907] [123/133] (668s left) api_intel_bb (object-reloc-purge-cache)
[384.924523] Starting subtest: object-reloc-purge-cache
[384.926758] Subtest object-reloc-purge-cache: SUCCESS (0.003s)
[385.086278] [124/133] (668s left) gem_eio (reset-stress)
[385.145475] Starting subtest: reset-stress
[385.146232] Starting dynamic subtest: render
[386.836650] Dynamic subtest render: SUCCESS (1.690s)
[386.852924] Starting dynamic subtest: bsd
[388.661186] Dynamic subtest bsd: FAIL (1.792s)
[388.676271] Starting dynamic subtest: blt
[390.261928] Dynamic subtest blt: SUCCESS (1.630s)
[390.262871] Subtest reset-stress: FAIL (5.117s)
[391.315505] [125/133] (662s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[391.379203] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.000s)
[391.442942] [126/133] (662s left) gem_flink_race (flink_close)
[391.497376] Starting subtest: flink_close
[396.523807] Subtest flink_close: SUCCESS (5.026s)
[396.630341] [127/133] (657s left) syncobj_timeline (wait-any-snapshot)
[396.690682] Starting subtest: wait-any-snapshot
[396.773860] Subtest wait-any-snapshot: SUCCESS (0.082s)
[396.915578] [128/133] (657s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[397.404472] Starting subtest: 4-tiled-32bpp-rotate-180
[397.405812] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[398.012324] [129/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[398.508614] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[398.510016] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[399.110969] [130/133] (654s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[399.597336] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[399.901640] [131/133] (654s left) i915_pm_rpm (reg-read-ioctl)
[411.691435] Subtest reg-read-ioctl: SKIP (0.000s)
[411.997834] [132/133] (642s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[412.497023] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[413.946686] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.451s)
[414.582745] [133/133] (639s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[415.071061] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[415.074472] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[415.675571] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_universal_plane
results: parsing output: 3/ for test: kms_force_connector_basic
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_close_race
results: parsing output: 13/ for test: gem_sync
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: api_intel_allocator
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_sync
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_flink_race
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_cursor_edge_walk
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_debugfs
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_pm_lpsp
results: parsing output: 63/ for test: kms_setmode
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: dmabuf_sync_file
results: parsing output: 68/ for test: kms_chamelium_color
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_tiled_blits
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: syncobj_eventfd
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_readwrite
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_feature_discovery
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: gem_ctx_isolation
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_invalid_mode
results: parsing output: 100/ for test: kms_psr2_su
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_multipipe_modeset
results: parsing output: 115/ for test: gem_blits
results: parsing output: 116/ for test: gem_wait
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_chamelium_frames
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: gem_flink_race
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane
Done.