[59.264160] Initializing watchdogs [59.264278] /dev/watchdog0 [59.300855] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.313998] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.321324] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.328509] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [59.489595] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [60.512217] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.018s) [61.364242] [002/133] (958s left) kms_hdr (brightness-with-hdr) [61.469956] Starting subtest: brightness-with-hdr [61.476311] Subtest brightness-with-hdr: SKIP (0.000s) [61.539012] [003/133] (958s left) gem_sync (basic-store-all) [61.620185] Starting subtest: basic-store-all [64.386596] Subtest basic-store-all: SUCCESS (2.771s) [64.567942] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [64.631200] Starting subtest: heartbeat-stop [64.636103] Subtest heartbeat-stop: SKIP (0.000s) [64.750716] [005/133] (955s left) gem_ctx_shared (q-smoketest) [64.819059] Starting subtest: Q-smoketest [64.821530] Starting dynamic subtest: rcs0 [70.392543] Dynamic subtest rcs0: SUCCESS (5.519s) [70.400721] Starting dynamic subtest: bcs0 [75.895760] Dynamic subtest bcs0: SUCCESS (5.496s) [75.903968] Starting dynamic subtest: vcs0 [81.381555] Dynamic subtest vcs0: SUCCESS (5.491s) [81.393176] Starting dynamic subtest: vcs1 [86.860314] Dynamic subtest vcs1: SUCCESS (5.479s) [86.868504] Starting dynamic subtest: vecs0 [92.346097] Dynamic subtest vecs0: SUCCESS (5.484s) [92.356158] Starting dynamic subtest: ccs0 [97.841872] Dynamic subtest ccs0: SUCCESS (5.491s) [97.844096] Subtest Q-smoketest: SUCCESS (32.962s) [97.988318] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [98.391933] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [99.192556] [007/133] (920s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [99.313449] Starting subtest: cursorA-vs-flipA-atomic-transitions [110.475584] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.161s) [111.355857] [008/133] (908s left) gem_pread (display) [111.416900] Subtest display: SKIP (0.000s) [111.473721] [009/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [111.579630] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [112.581545] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.002s) [112.724584] [010/133] (907s left) gen3_render_tiledy_blits [112.842151] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [112.943505] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [112.945395] Starting dynamic subtest: pipe-A-default-mode [114.107854] Dynamic subtest pipe-A-default-mode: SKIP (1.160s) [114.112434] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s) [114.248146] [012/133] (906s left) gem_mmap_gtt (big-bo-tiledy) [114.307493] Subtest big-bo-tiledY: SKIP (0.000s) [114.366256] [013/133] (905s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [114.460439] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [114.462781] Starting dynamic subtest: A-eDP1 [123.335998] Dynamic subtest A-eDP1: SUCCESS (8.874s) [123.343466] Starting dynamic subtest: B-eDP1 [132.267646] Dynamic subtest B-eDP1: SUCCESS (8.929s) [132.276150] Starting dynamic subtest: C-eDP1 [141.187215] Dynamic subtest C-eDP1: SUCCESS (8.918s) [141.196267] Starting dynamic subtest: D-eDP1 [150.122675] Dynamic subtest D-eDP1: SUCCESS (8.932s) [150.125074] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.663s) [151.343690] [014/133] (869s left) kms_atomic_transition (plane-all-transition-nonblocking) [151.440553] Starting subtest: plane-all-transition-nonblocking [151.442854] Starting dynamic subtest: pipe-A-eDP-1 [153.935330] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [154.252376] Starting dynamic subtest: pipe-B-eDP-1 [157.475789] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s) [157.774759] Subtest plane-all-transition-nonblocking: SUCCESS (6.335s) [158.606415] [015/133] (861s left) gem_softpin (allocator-fork) [158.683522] Starting subtest: allocator-fork [160.894724] Subtest allocator-fork: SUCCESS (2.210s) [161.015087] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [161.118894] Starting subtest: x-tiled-8bpp-rotate-180 [162.391254] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.273s) [162.510194] [017/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [162.615078] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [162.618522] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [162.708413] [018/133] (857s left) gem_create (create-clear) [162.767546] Starting subtest: create-clear [162.769716] Starting dynamic subtest: smem0 [195.581076] Dynamic subtest smem0: SUCCESS (32.809s) [195.583221] Subtest create-clear: SUCCESS (32.811s) [195.787438] [019/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [195.908839] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [195.913391] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [196.013369] [020/133] (824s left) kms_chamelium_color (ctm-max) [196.110311] Subtest ctm-max: SKIP (0.000s) [196.154352] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [196.228927] Starting subtest: yf-tiled-ccs-to-linear [196.233261] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [196.407377] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [196.497057] Starting subtest: fbc-shrfb-scaledprimary [199.459366] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.965s) [200.619318] [023/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180) [200.737970] Starting subtest: y-tiled-64bpp-rotate-180 [200.742382] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [200.828919] [024/133] (819s left) gem_userptr_blits (unsync-overlap) [200.903593] Subtest unsync-overlap: SKIP (0.000s) [201.030687] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle) [201.083052] Starting subtest: invalid-signal-illegal-handle [201.085359] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [201.185028] [026/133] (819s left) gem_exec_schedule (timeslicing) [201.252623] Starting subtest: timeslicing [201.254782] Starting dynamic subtest: rcs0 [201.266091] Dynamic subtest rcs0: SUCCESS (0.021s) [201.276075] Starting dynamic subtest: bcs0 [201.287879] Dynamic subtest bcs0: SUCCESS (0.021s) [201.295314] Starting dynamic subtest: vcs0 [201.308377] Dynamic subtest vcs0: SUCCESS (0.020s) [201.315996] Starting dynamic subtest: vcs1 [201.328890] Dynamic subtest vcs1: SUCCESS (0.020s) [201.336598] Starting dynamic subtest: vecs0 [201.349165] Dynamic subtest vecs0: SUCCESS (0.020s) [201.356441] Starting dynamic subtest: ccs0 [201.370208] Dynamic subtest ccs0: SUCCESS (0.020s) [201.372551] Subtest timeslicing: SUCCESS (0.126s) [202.939047] [027/133] (817s left) kms_lease (lease-unleased-crtc) [203.029919] Starting subtest: lease-unleased-crtc [203.032207] Starting dynamic subtest: pipe-A-eDP-1 [203.328435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s) [203.337309] Starting dynamic subtest: pipe-B-eDP-1 [204.057734] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.727s) [204.067530] Starting dynamic subtest: pipe-C-eDP-1 [204.069813] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [204.078488] Starting dynamic subtest: pipe-D-eDP-1 [204.080377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [204.082685] Subtest lease-unleased-crtc: SUCCESS (1.039s) [204.425938] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [204.513272] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [211.323277] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.813s) [211.457580] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [211.561015] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [211.565200] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [211.661971] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21) [211.848653] Starting subtest: cursor-offscreen-64x21 [211.894558] Subtest cursor-offscreen-64x21: SKIP (0.044s) [212.117745] [031/133] (808s left) kms_vrr (negative-basic) [212.205243] Starting subtest: negative-basic [212.213568] Starting dynamic subtest: pipe-A-eDP-1 [217.632180] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.419s) [217.920439] Subtest negative-basic: SUCCESS (5.717s) [218.792808] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [218.899101] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [218.903654] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [218.991359] [033/133] (802s left) gem_wait (write-wait) [219.056092] Starting subtest: write-wait [219.058025] Starting dynamic subtest: all-engines [220.208967] Dynamic subtest all-engines: SUCCESS (1.155s) [220.224551] Starting dynamic subtest: rcs0 [221.263865] Dynamic subtest rcs0: SUCCESS (1.052s) [221.279803] Starting dynamic subtest: bcs0 [222.320506] Dynamic subtest bcs0: SUCCESS (1.055s) [222.339037] Starting dynamic subtest: vcs0 [223.377724] Dynamic subtest vcs0: SUCCESS (1.054s) [223.392873] Starting dynamic subtest: vcs1 [224.432170] Dynamic subtest vcs1: SUCCESS (1.053s) [224.447387] Starting dynamic subtest: vecs0 [225.485240] Dynamic subtest vecs0: SUCCESS (1.051s) [225.500714] Starting dynamic subtest: ccs0 [226.543083] Dynamic subtest ccs0: SUCCESS (1.055s) [226.545662] Subtest write-wait: SUCCESS (7.491s) [226.740077] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [226.743691] [034/133] (794s left) gem_exec_fence (basic-busy) [226.916061] Starting subtest: basic-busy [226.918738] Starting dynamic subtest: rcs0 [227.005260] Dynamic subtest rcs0: SUCCESS (0.089s) [227.015525] Starting dynamic subtest: bcs0 [227.062852] Dynamic subtest bcs0: SUCCESS (0.055s) [227.075675] Starting dynamic subtest: vcs0 [227.119908] Dynamic subtest vcs0: SUCCESS (0.054s) [227.132180] Starting dynamic subtest: vcs1 [227.184971] Dynamic subtest vcs1: SUCCESS (0.061s) [227.197507] Starting dynamic subtest: vecs0 [227.248294] Dynamic subtest vecs0: SUCCESS (0.060s) [227.258237] Starting dynamic subtest: ccs0 [227.307263] Dynamic subtest ccs0: SUCCESS (0.056s) [227.310307] Subtest basic-busy: SUCCESS (0.393s) [228.965418] [035/133] (792s left) gem_tiled_wc [229.081127] [036/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [229.179219] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [229.183608] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [229.249937] [037/133] (792s left) gem_exec_fence (submit) [229.428034] Starting subtest: submit [229.433139] Subtest submit: SKIP (0.000s) [231.007583] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [231.108185] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [231.110498] Starting dynamic subtest: pipe-A-eDP-1 [231.168328] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [231.176778] Starting dynamic subtest: pipe-B-eDP-1 [231.236117] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [231.246102] Starting dynamic subtest: pipe-C-eDP-1 [231.303838] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [231.312784] Starting dynamic subtest: pipe-D-eDP-1 [231.370633] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [231.374770] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [233.275693] [039/133] (788s left) vgem_basic (bad-handle) [233.324958] Starting subtest: bad-handle [233.327325] Subtest bad-handle: SUCCESS (0.000s) [233.385056] [040/133] (787s left) gem_exec_reloc (basic-cpu-wc-active) [233.436102] Subtest basic-cpu-wc-active: SKIP (0.000s) [233.513253] [041/133] (787s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [233.895120] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [234.677124] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [234.741839] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [234.812200] [043/133] (786s left) gem_readwrite (new-obj) [234.876525] Subtest new-obj: SKIP (0.000s) [234.937244] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active) [235.001823] Subtest basic-wc-cpu-active: SKIP (0.000s) [235.074202] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [235.180646] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [242.707970] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.530s) [242.843645] [046/133] (778s left) gem_pxp (fail-invalid-protected-context) [242.968669] Starting subtest: fail-invalid-protected-context [242.971191] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [243.072310] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip) [243.168134] Starting subtest: fbc-psr-primary-page-flip [243.170364] Starting dynamic subtest: eDP-1 [243.174399] Dynamic subtest eDP-1: SKIP (0.000s) [243.178531] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [243.239894] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [243.364545] Starting subtest: short-flip-before-cursor-atomic-transitions [244.327436] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.962s) [245.167455] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [245.272676] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [245.897663] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s) [246.056419] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [246.157535] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [246.161675] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [246.273964] [051/133] (775s left) gem_exec_schedule (noreorder-priority) [246.455470] Starting subtest: noreorder-priority [246.458075] Starting dynamic subtest: rcs0 [247.584389] Dynamic subtest rcs0: SUCCESS (1.129s) [247.595556] Starting dynamic subtest: vcs0 [248.922487] Dynamic subtest vcs0: SUCCESS (1.335s) [248.932858] Starting dynamic subtest: vcs1 [250.906481] Dynamic subtest vcs1: SUCCESS (1.981s) [250.917354] Starting dynamic subtest: vecs0 [252.882730] Dynamic subtest vecs0: SUCCESS (1.973s) [252.894061] Starting dynamic subtest: ccs0 [254.015780] Dynamic subtest ccs0: SUCCESS (1.132s) [254.018601] Subtest noreorder-priority: SUCCESS (7.562s) [254.198137] [052/133] (767s left) gem_lmem_swapping (verify-ccs) [254.255281] Subtest verify-ccs: SKIP (0.000s) [254.303457] [053/133] (767s left) gem_ctx_isolation (dirty-create) [254.365861] Starting subtest: dirty-create [254.368233] Starting dynamic subtest: rcs0 [254.609454] Dynamic subtest rcs0: SUCCESS (0.243s) [254.618079] Starting dynamic subtest: bcs0 [254.858041] Dynamic subtest bcs0: SUCCESS (0.247s) [254.869116] Starting dynamic subtest: vcs0 [255.098219] Dynamic subtest vcs0: SUCCESS (0.239s) [255.105905] Starting dynamic subtest: vcs1 [257.138231] Dynamic subtest vcs1: SUCCESS (2.039s) [257.147218] Starting dynamic subtest: vecs0 [259.103307] Dynamic subtest vecs0: SUCCESS (1.964s) [259.111502] Starting dynamic subtest: ccs0 [261.118387] Dynamic subtest ccs0: SUCCESS (2.014s) [261.120811] Subtest dirty-create: SUCCESS (6.753s) [261.350462] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [261.443931] Starting subtest: fbc-pr-plane-move-sf-dmg-area [261.448347] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [261.516807] [055/133] (760s left) dmabuf (all-tests) [261.553993] Starting subtest: all-tests [261.556394] Starting dynamic subtest: sanitycheck [261.658799] Dynamic subtest sanitycheck: SUCCESS (0.104s) [261.670605] Starting dynamic subtest: dma_fence [261.854917] Dynamic subtest dma_fence: SUCCESS (0.194s) [261.866166] Starting dynamic subtest: dma_fence_chain [271.367059] Dynamic subtest dma_fence_chain: SUCCESS (9.509s) [271.377822] Starting dynamic subtest: dma_fence_unwrap [271.460605] Dynamic subtest dma_fence_unwrap: SUCCESS (0.092s) [271.472221] Starting dynamic subtest: dma_resv [271.546530] Dynamic subtest dma_resv: SUCCESS (0.084s) [271.549054] Subtest all-tests: SUCCESS (9.993s) [271.621556] [056/133] (750s left) syncobj_timeline (reset-unsignaled) [271.680881] Starting subtest: reset-unsignaled [271.683254] Subtest reset-unsignaled: SUCCESS (0.000s) [271.768251] [057/133] (750s left) syncobj_wait (multi-wait-signaled) [271.820103] Starting subtest: multi-wait-signaled [271.822288] Subtest multi-wait-signaled: SUCCESS (0.000s) [271.912911] [058/133] (750s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [272.008121] Starting subtest: 2x-flip-vs-absolute-wf_vblank [272.018894] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [272.096506] [059/133] (750s left) kms_psr (pr-cursor-mmap-cpu) [272.196114] Starting subtest: pr-cursor-mmap-cpu [272.200314] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [272.287085] [060/133] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [272.340222] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [272.441609] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [272.521671] [061/133] (749s left) kms_atomic_transition (modeset-transition-fencing) [272.617573] Starting subtest: modeset-transition-fencing [272.619452] Starting dynamic subtest: 1x-outputs [283.423213] Dynamic subtest 1x-outputs: SUCCESS (10.803s) [283.425841] Subtest modeset-transition-fencing: SUCCESS (10.805s) [284.279135] [062/133] (738s left) kms_psr (fbc-psr2-cursor-plane-onoff) [284.380083] Starting subtest: fbc-psr2-cursor-plane-onoff [284.382229] Starting dynamic subtest: eDP-1 [284.386143] Dynamic subtest eDP-1: SKIP (0.000s) [284.390068] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [284.450785] [063/133] (737s left) i915_hangman (error-state-basic) [284.526403] Starting subtest: error-state-basic [284.663454] Subtest error-state-basic: SUCCESS (0.139s) [284.739610] [064/133] (737s left) gem_tiled_fence_blits (basic) [284.793420] Subtest basic: SKIP (0.000s) [284.861515] [065/133] (737s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [284.949541] Starting subtest: fbc-rgb565-draw-mmap-cpu [289.098078] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.151s) [290.291314] [066/133] (732s left) gem_gpgpu_fill (offset-16x16) [290.356609] Starting subtest: offset-16x16 [290.367478] Subtest offset-16x16: SUCCESS (0.011s) [290.496574] [067/133] (731s left) perf_pmu (all-busy-check-all) [290.546634] Starting subtest: all-busy-check-all [291.927844] Subtest all-busy-check-all: SUCCESS (1.380s) [292.029416] [068/133] (730s left) gen9_exec_parse (unaligned-jump) [292.097075] Subtest unaligned-jump: SKIP (0.000s) [292.182057] [069/133] (730s left) i915_pm_rpm (system-suspend-execbuf) [294.014218] Starting subtest: system-suspend-execbuf [353.144891] Subtest system-suspend-execbuf: SUCCESS (43.867s) [353.545679] [070/133] (669s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [353.638728] Starting subtest: fbc-farfromfence-mmap-gtt [353.643215] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [353.740149] [071/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [353.839920] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [353.844071] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [353.937375] [072/133] (668s left) kms_psr (psr2-sprite-render) [354.032313] Starting subtest: psr2-sprite-render [354.034596] Starting dynamic subtest: eDP-1 [355.727562] Dynamic subtest eDP-1: SUCCESS (1.695s) [355.729920] Subtest psr2-sprite-render: SUCCESS (1.696s) [356.587889] [073/133] (666s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [356.687309] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [356.689165] Starting dynamic subtest: pipe-A-eDP-1 [356.709865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [356.722567] Starting dynamic subtest: pipe-B-eDP-1 [356.742806] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [356.751807] Starting dynamic subtest: pipe-C-eDP-1 [356.771238] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [356.780250] Starting dynamic subtest: pipe-D-eDP-1 [356.799560] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [356.801815] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [358.951318] [074/133] (663s left) perf_pmu (idle-no-semaphores) [358.992719] Starting subtest: idle-no-semaphores [358.995110] Starting dynamic subtest: rcs0 [359.533554] Dynamic subtest rcs0: SUCCESS (0.541s) [359.545841] Starting dynamic subtest: bcs0 [360.061575] Dynamic subtest bcs0: SUCCESS (0.524s) [360.073656] Starting dynamic subtest: vcs0 [360.582500] Dynamic subtest vcs0: SUCCESS (0.517s) [360.594912] Starting dynamic subtest: vcs1 [361.102341] Dynamic subtest vcs1: SUCCESS (0.516s) [361.114305] Starting dynamic subtest: vecs0 [361.620367] Dynamic subtest vecs0: SUCCESS (0.514s) [361.632959] Starting dynamic subtest: ccs0 [362.145227] Dynamic subtest ccs0: SUCCESS (0.521s) [362.148198] Subtest idle-no-semaphores: SUCCESS (3.154s) [362.242908] [075/133] (660s left) gem_exec_fence (syncobj-timeline-signal) [362.790744] Starting subtest: syncobj-timeline-signal [362.803376] Subtest syncobj-timeline-signal: SUCCESS (0.014s) [364.103111] [076/133] (658s left) kms_plane_multiple (tiling-yf) [364.204031] Starting subtest: tiling-yf [364.208253] Subtest tiling-yf: SKIP (0.000s) [364.276368] [077/133] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [364.363277] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [364.365620] Starting dynamic subtest: pipe-A [365.410744] Dynamic subtest pipe-A: SUCCESS (1.050s) [365.419894] Starting dynamic subtest: pipe-B [367.556748] Dynamic subtest pipe-B: SUCCESS (2.144s) [367.567976] Starting dynamic subtest: pipe-C [368.745886] Dynamic subtest pipe-C: SUCCESS (1.186s) [368.756010] Starting dynamic subtest: pipe-D [369.968402] Dynamic subtest pipe-D: SUCCESS (1.222s) [369.970674] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.607s) [371.173492] [078/133] (651s left) kms_flip (flip-vs-expired-vblank) [371.271599] Starting subtest: flip-vs-expired-vblank [371.274257] Starting dynamic subtest: A-eDP1 [379.975668] Dynamic subtest A-eDP1: SUCCESS (8.704s) [379.985555] Starting dynamic subtest: B-eDP1 [388.628410] Dynamic subtest B-eDP1: SUCCESS (8.648s) [388.642673] Starting dynamic subtest: C-eDP1 [397.248977] Dynamic subtest C-eDP1: SUCCESS (8.614s) [397.261186] Starting dynamic subtest: D-eDP1 [405.874631] Dynamic subtest D-eDP1: SUCCESS (8.621s) [405.879706] Subtest flip-vs-expired-vblank: SUCCESS (34.600s) [407.036939] [079/133] (615s left) syncobj_timeline (single-wait-for-submit-available-signaled) [407.112112] Starting subtest: single-wait-for-submit-available-signaled [407.114370] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [407.228892] [080/133] (615s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [407.340385] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [408.119616] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s) [408.297705] [081/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [408.406618] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [417.968954] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.567s) [418.104911] [082/133] (605s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [418.198134] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [418.200281] Starting dynamic subtest: pipe-A-eDP-1 [418.220801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [418.232068] Starting dynamic subtest: pipe-B-eDP-1 [418.251726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [418.263130] Starting dynamic subtest: pipe-C-eDP-1 [418.281796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [418.290922] Starting dynamic subtest: pipe-D-eDP-1 [418.310408] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [418.312651] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [420.437057] [083/133] (602s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [420.543161] Starting subtest: fbc-2p-pri-indfb-multidraw [420.547524] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [420.647759] [084/133] (602s left) gem_render_tiled_blits (basic) [420.709161] Subtest basic: SKIP (0.000s) [420.791745] [085/133] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [420.877925] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [420.880185] Starting dynamic subtest: pipe-A-eDP-1 [420.902201] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [420.914194] Starting dynamic subtest: pipe-B-eDP-1 [420.934711] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [420.943669] Starting dynamic subtest: pipe-C-eDP-1 [420.964100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [420.973369] Starting dynamic subtest: pipe-D-eDP-1 [420.994224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [420.998084] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [423.216463] [086/133] (600s left) kms_vblank (ts-continuation-dpms-rpm) [423.309432] Starting subtest: ts-continuation-dpms-rpm [423.311421] Starting dynamic subtest: pipe-A-eDP-1 [425.806674] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [425.822339] Starting dynamic subtest: pipe-D-eDP-1 [428.043226] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s) [428.045672] Subtest ts-continuation-dpms-rpm: SUCCESS (4.737s) [428.925227] [087/133] (594s left) gem_exec_whisper (basic-fds-priority) [428.989106] Starting subtest: basic-fds-priority [452.207661] Subtest basic-fds-priority: SUCCESS (23.214s) [452.393449] [088/133] (570s left) kms_pm_rpm (legacy-planes-dpms) [454.243652] Starting subtest: legacy-planes-dpms [454.245792] Starting dynamic subtest: plane-64 [462.551328] Dynamic subtest plane-64: SUCCESS (8.308s) [462.564281] Starting dynamic subtest: plane-94 [470.864914] Dynamic subtest plane-94: SUCCESS (8.309s) [470.876766] Starting dynamic subtest: plane-124 [479.159748] Dynamic subtest plane-124: SUCCESS (8.290s) [479.171652] Starting dynamic subtest: plane-134 [487.471040] Dynamic subtest plane-134: SUCCESS (8.307s) [487.473560] Subtest legacy-planes-dpms: SUCCESS (33.226s) [487.839472] [089/133] (535s left) intel_hwmon (hwmon-write) [487.896114] Subtest hwmon-write: SKIP (0.000s) [487.957972] [090/133] (535s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [488.056171] Starting subtest: fbcpsr-rgb101010-draw-pwrite [495.050219] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.994s) [495.150298] [091/133] (528s left) syncobj_basic (bad-pad-fd-to-handle) [495.215052] Starting subtest: bad-pad-fd-to-handle [495.217058] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [495.321573] [092/133] (528s left) gen9_exec_parse (bb-chained) [495.374819] Subtest bb-chained: SKIP (0.000s) [495.453608] [093/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [495.539164] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [503.162240] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.623s) [503.288712] [094/133] (520s left) gem_exec_params (rel-constants-invalid-ring) [503.348200] Starting subtest: rel-constants-invalid-ring [503.350429] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [503.458932] [095/133] (520s left) gem_workarounds (suspend-resume-fd) [503.536452] Starting subtest: suspend-resume-fd [519.325319] Subtest suspend-resume-fd: SUCCESS (1.177s) [519.462306] [096/133] (504s left) kms_color (ctm-signed) [519.582292] Starting subtest: ctm-signed [519.585075] Starting dynamic subtest: pipe-A-eDP-1 [521.687429] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s) [521.697523] Starting dynamic subtest: pipe-B-eDP-1 [524.488604] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s) [524.499593] Starting dynamic subtest: pipe-C-eDP-1 [527.138530] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.629s) [527.148582] Starting dynamic subtest: pipe-D-eDP-1 [529.820607] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s) [529.823590] Subtest ctm-signed: SUCCESS (10.144s) [530.655903] [097/133] (493s left) kms_cursor_crc (cursor-random-256x256) [530.912335] Starting subtest: cursor-random-256x256 [530.915029] Starting dynamic subtest: pipe-A-eDP-1 [534.363582] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s) [534.392526] Starting dynamic subtest: pipe-D-eDP-1 [538.462945] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.066s) [538.464940] Subtest cursor-random-256x256: SUCCESS (7.529s) [539.354270] [098/133] (484s left) gem_mmap_gtt (ptrace) [539.414028] Subtest ptrace: SKIP (0.000s) [539.471708] [099/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [539.574515] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [543.120121] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.544s) [544.256373] [100/133] (479s left) gem_exec_balancer (parallel-balancer) [544.517355] Starting subtest: parallel-balancer [545.449902] Subtest parallel-balancer: SUCCESS (0.931s) [545.550938] [101/133] (478s left) syncobj_timeline (etime-single-wait-all-submitted) [545.603148] Starting subtest: etime-single-wait-all-submitted [545.704886] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s) [545.787176] [102/133] (478s left) api_intel_bb (crc32) [545.844377] Starting subtest: crc32 [545.846621] Starting dynamic subtest: rcs0-smem0 [546.144191] Dynamic subtest rcs0-smem0: SUCCESS (0.300s) [546.154925] Starting dynamic subtest: bcs0-smem0 [546.481345] Dynamic subtest bcs0-smem0: SUCCESS (0.333s) [546.494155] Starting dynamic subtest: vcs0-smem0 [546.895862] Dynamic subtest vcs0-smem0: SUCCESS (0.411s) [546.908409] Starting dynamic subtest: vcs1-smem0 [547.281983] Dynamic subtest vcs1-smem0: SUCCESS (0.383s) [547.295187] Starting dynamic subtest: vecs0-smem0 [547.623057] Dynamic subtest vecs0-smem0: SUCCESS (0.337s) [547.635338] Starting dynamic subtest: ccs0-smem0 [547.987499] Dynamic subtest ccs0-smem0: SUCCESS (0.362s) [547.990354] Subtest crc32: SUCCESS (2.144s) [548.131122] [103/133] (475s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [548.234329] Starting subtest: psr-rgb565-draw-mmap-gtt [548.239336] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [548.337766] [104/133] (475s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [548.396961] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [548.497249] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [548.578680] [105/133] (475s left) gem_exec_reloc (basic-cpu-wc) [548.632573] Subtest basic-cpu-wc: SKIP (0.000s) [548.702635] [106/133] (475s left) api_intel_bb (purge-bb) [548.750511] Starting subtest: purge-bb [548.753398] Subtest purge-bb: SUCCESS (0.004s) [548.875381] [107/133] (475s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [548.960618] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [548.962903] Starting dynamic subtest: pipe-A [549.324278] Dynamic subtest pipe-A: SUCCESS (0.364s) [549.333182] Starting dynamic subtest: pipe-B [550.753045] Dynamic subtest pipe-B: SUCCESS (1.426s) [550.762941] Starting dynamic subtest: pipe-C [552.215360] Dynamic subtest pipe-C: SUCCESS (1.461s) [552.225366] Starting dynamic subtest: pipe-D [553.652130] Dynamic subtest pipe-D: SUCCESS (1.435s) [553.654610] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.689s) [554.785690] [108/133] (469s left) gem_mmap_gtt (basic-write-read-distinct) [554.855031] Subtest basic-write-read-distinct: SKIP (0.000s) [554.921860] [109/133] (469s left) kms_feature_discovery (psr1) [555.015912] Starting subtest: psr1 [555.018263] Subtest psr1: SUCCESS (0.000s) [555.093783] [110/133] (469s left) kms_cursor_crc (cursor-tearing-position-change) [555.208591] Starting subtest: cursor-tearing-position-change [555.211846] Starting dynamic subtest: pipe-A-eDP-1 [555.808271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s) [555.817769] Starting dynamic subtest: pipe-D-eDP-1 [557.003589] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s) [557.006652] Subtest cursor-tearing-position-change: SUCCESS (1.794s) [557.852397] [111/133] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [557.955120] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [557.960194] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [558.059411] [112/133] (466s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [558.154054] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [558.159264] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [558.239666] [113/133] (466s left) gem_bad_reloc (negative-reloc) [558.305152] Subtest negative-reloc: SKIP (0.000s) [558.372883] [114/133] (466s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [558.470718] Starting subtest: primary-yf-tiled-reflect-x-180 [558.542599] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s) [558.645968] [115/133] (465s left) drm_read (empty-block) [558.784457] Starting subtest: empty-block [559.782142] Subtest empty-block: SUCCESS (1.000s) [559.906251] [116/133] (464s left) gem_render_copy (yf-tiled-to-vebox-linear) [559.968464] Starting subtest: yf-tiled-to-vebox-linear [559.973894] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [560.169165] [117/133] (464s left) kms_pm_rpm (dpms-lpsp) [561.793886] Starting subtest: dpms-lpsp [562.328403] Subtest dpms-lpsp: SUCCESS (0.536s) [562.419931] [118/133] (462s left) kms_cursor_legacy (forked-move) [562.539497] Starting subtest: forked-move [562.542217] Starting dynamic subtest: pipe-A [568.002752] Dynamic subtest pipe-A: SUCCESS (5.458s) [568.013496] Starting dynamic subtest: pipe-B [573.496170] Dynamic subtest pipe-B: SUCCESS (5.488s) [573.508158] Starting dynamic subtest: pipe-C [578.972570] Dynamic subtest pipe-C: SUCCESS (5.472s) [578.984204] Starting dynamic subtest: pipe-D [584.449851] Dynamic subtest pipe-D: SUCCESS (5.472s) [584.461582] Starting dynamic subtest: all-pipes [589.955613] Dynamic subtest all-pipes: SUCCESS (5.501s) [589.958451] Subtest forked-move: SUCCESS (27.403s) [590.110241] [119/133] (434s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [590.221375] Starting subtest: flip-primary-invalidate-overlay [601.858037] Subtest flip-primary-invalidate-overlay: SUCCESS (11.633s) [602.006953] [120/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [602.105555] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [602.110282] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [602.201858] [121/133] (422s left) kms_content_protection (srm) [602.351906] Starting subtest: srm [602.356871] Subtest srm: SKIP (0.002s) [602.466973] [122/133] (422s left) prime_busy (after-wait) [602.519300] Starting subtest: after-wait [602.524860] Starting dynamic subtest: rcs0 [602.548423] Dynamic subtest rcs0: SUCCESS (0.026s) [602.558658] Starting dynamic subtest: bcs0 [602.589422] Dynamic subtest bcs0: SUCCESS (0.040s) [602.599441] Starting dynamic subtest: vcs0 [602.631426] Dynamic subtest vcs0: SUCCESS (0.041s) [602.641668] Starting dynamic subtest: vcs1 [602.674605] Dynamic subtest vcs1: SUCCESS (0.042s) [602.684494] Starting dynamic subtest: vecs0 [602.716286] Dynamic subtest vecs0: SUCCESS (0.041s) [602.725503] Starting dynamic subtest: ccs0 [602.759683] Dynamic subtest ccs0: SUCCESS (0.042s) [602.868608] Subtest after-wait: SUCCESS (0.347s) [602.948944] [123/133] (421s left) kms_pipe_crc_basic (disable-crc-after-crtc) [603.040353] Starting subtest: disable-crc-after-crtc [603.042903] Starting dynamic subtest: pipe-A-eDP-1 [604.765054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.724s) [604.775156] Starting dynamic subtest: pipe-B-eDP-1 [607.118434] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.352s) [607.128998] Starting dynamic subtest: pipe-C-eDP-1 [609.358581] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s) [609.370300] Starting dynamic subtest: pipe-D-eDP-1 [611.624152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s) [611.626440] Subtest disable-crc-after-crtc: SUCCESS (8.581s) [612.451058] [124/133] (412s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [612.546994] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [612.549557] Starting dynamic subtest: pipe-A-eDP-1 [618.432216] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.888s) [618.442526] Starting dynamic subtest: pipe-B-eDP-1 [625.073637] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.641s) [625.076469] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.533s) [625.940637] [125/133] (399s left) kms_universal_plane (universal-plane-sanity) [626.029301] Starting subtest: universal-plane-sanity [626.032074] Starting dynamic subtest: pipe-A-eDP-1 [626.634506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s) [626.645887] Starting dynamic subtest: pipe-B-eDP-1 [627.865839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s) [627.877267] Starting dynamic subtest: pipe-C-eDP-1 [629.064878] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s) [629.075311] Starting dynamic subtest: pipe-D-eDP-1 [630.301483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [630.304411] Subtest universal-plane-sanity: SUCCESS (4.272s) [631.162387] [126/133] (393s left) kms_invalid_mode (clock-too-high) [631.261338] Starting subtest: clock-too-high [631.263727] Starting dynamic subtest: pipe-A-eDP-1 [631.269304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [631.279625] Starting dynamic subtest: pipe-B-eDP-1 [631.284432] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [631.294315] Starting dynamic subtest: pipe-C-eDP-1 [631.298906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [631.308243] Starting dynamic subtest: pipe-D-eDP-1 [631.312830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [631.318181] Subtest clock-too-high: SKIP (0.004s) [631.358950] [127/133] (393s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [631.458861] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [631.463450] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [631.527674] [128/133] (393s left) gem_eio (wait-immediate) [631.750601] Starting subtest: wait-immediate [632.129860] Subtest wait-immediate: SUCCESS (0.381s) [632.256172] [129/133] (392s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [632.355416] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [632.359999] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [632.460982] [130/133] (392s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [632.516012] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [632.615700] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [632.694267] [131/133] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [632.782034] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [640.106830] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.327s) [640.207778] [132/133] (385s left) i915_suspend (basic-s2idle-without-i915) [640.251198] Starting subtest: basic-s2idle-without-i915 [660.795197] Subtest basic-s2idle-without-i915: SUCCESS (5.644s) [660.947344] [133/133] (364s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [661.058876] Starting subtest: fbc-rgb565-draw-blt [665.252750] Subtest fbc-rgb565-draw-blt: SUCCESS (4.147s) [666.370064] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_legacy results: parsing output: 1/ for test: kms_hdr results: parsing output: 2/ for test: gem_sync results: parsing output: 3/ for test: gem_ctx_persistence results: parsing output: 4/ for test: gem_ctx_shared results: parsing output: 5/ for test: kms_chamelium_hpd results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: gem_pread results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: gen3_render_tiledy_blits results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_atomic_transition results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_create results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_chamelium_color results: parsing output: 20/ for test: gem_render_copy results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: gem_userptr_blits results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: gem_exec_schedule results: parsing output: 26/ for test: kms_lease results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: kms_vrr results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: gem_wait results: parsing output: 33/ for test: gem_exec_fence results: parsing output: 34/ for test: gem_tiled_wc results: parsing output: 35/ for test: kms_plane results: parsing output: 36/ for test: gem_exec_fence results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: vgem_basic results: parsing output: 39/ for test: gem_exec_reloc results: parsing output: 40/ for test: kms_chamelium_edid results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: gem_readwrite results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: gem_lmem_swapping results: parsing output: 52/ for test: gem_ctx_isolation results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: dmabuf results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: kms_atomic_transition results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: i915_hangman results: parsing output: 63/ for test: gem_tiled_fence_blits results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_gpgpu_fill results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: gen9_exec_parse results: parsing output: 68/ for test: i915_pm_rpm results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: kms_plane_multiple results: parsing output: 76/ for test: kms_plane_scaling results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_render_tiled_blits results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_vblank results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: kms_pm_rpm results: parsing output: 88/ for test: intel_hwmon results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_basic results: parsing output: 91/ for test: gen9_exec_parse results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_params results: parsing output: 94/ for test: gem_workarounds results: parsing output: 95/ for test: kms_color results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: api_intel_bb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: syncobj_wait results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: api_intel_bb results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_feature_discovery results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_flip_scaled_crc results: parsing output: 112/ for test: gem_bad_reloc results: parsing output: 113/ for test: kms_rotation_crc results: parsing output: 114/ for test: drm_read results: parsing output: 115/ for test: gem_render_copy results: parsing output: 116/ for test: kms_pm_rpm results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_psr_stress_test results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_content_protection results: parsing output: 121/ for test: prime_busy results: parsing output: 122/ for test: kms_pipe_crc_basic results: parsing output: 123/ for test: kms_psr2_sf results: parsing output: 124/ for test: kms_universal_plane results: parsing output: 125/ for test: kms_invalid_mode results: parsing output: 126/ for test: kms_psr2_sf results: parsing output: 127/ for test: gem_eio results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: i915_suspend results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.