[59.566185] Initializing watchdogs [59.566282] /dev/watchdog0 [59.581338] [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.585881] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.588123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.591234] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [59.734767] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [60.750069] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.009s) [61.591393] [002/133] (958s left) kms_hdr (brightness-with-hdr) [61.684093] Starting subtest: brightness-with-hdr [61.690670] Subtest brightness-with-hdr: SKIP (0.000s) [61.752861] [003/133] (958s left) gem_sync (basic-store-all) [61.824551] Starting subtest: basic-store-all [64.670591] Subtest basic-store-all: SUCCESS (2.843s) [64.853905] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [64.909905] Starting subtest: heartbeat-stop [64.914587] Subtest heartbeat-stop: SKIP (0.000s) [64.999061] [005/133] (955s left) gem_ctx_shared (q-smoketest) [65.063964] Starting subtest: Q-smoketest [65.066443] Starting dynamic subtest: rcs0 [70.611670] Dynamic subtest rcs0: SUCCESS (5.488s) [70.620629] Starting dynamic subtest: bcs0 [76.140779] Dynamic subtest bcs0: SUCCESS (5.520s) [76.152285] Starting dynamic subtest: vcs0 [81.619413] Dynamic subtest vcs0: SUCCESS (5.469s) [81.627224] Starting dynamic subtest: vcs1 [87.102057] Dynamic subtest vcs1: SUCCESS (5.480s) [87.109962] Starting dynamic subtest: vecs0 [92.585274] Dynamic subtest vecs0: SUCCESS (5.484s) [92.592915] Starting dynamic subtest: ccs0 [98.079148] Dynamic subtest ccs0: SUCCESS (5.488s) [98.081312] Subtest Q-smoketest: SUCCESS (32.935s) [98.220287] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [98.609274] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [99.433721] [007/133] (920s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [99.547290] Starting subtest: cursorA-vs-flipA-atomic-transitions [110.733684] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.184s) [111.592867] [008/133] (908s left) gem_pread (display) [111.654266] Subtest display: SKIP (0.000s) [111.707557] [009/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [111.809520] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [112.809561] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s) [112.931966] [010/133] (907s left) gen3_render_tiledy_blits [113.048487] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [113.144030] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [113.145899] Starting dynamic subtest: pipe-A-default-mode [114.257658] Dynamic subtest pipe-A-default-mode: SKIP (1.111s) [114.262471] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.112s) [114.393031] [012/133] (906s left) gem_mmap_gtt (big-bo-tiledy) [114.446657] Subtest big-bo-tiledY: SKIP (0.000s) [114.507975] [013/133] (906s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [114.610819] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [114.613201] Starting dynamic subtest: A-eDP1 [123.476065] Dynamic subtest A-eDP1: SUCCESS (8.863s) [123.484734] Starting dynamic subtest: B-eDP1 [132.413246] Dynamic subtest B-eDP1: SUCCESS (8.934s) [132.424623] Starting dynamic subtest: C-eDP1 [141.336651] Dynamic subtest C-eDP1: SUCCESS (8.920s) [141.344068] Starting dynamic subtest: D-eDP1 [150.268977] Dynamic subtest D-eDP1: SUCCESS (8.930s) [150.274190] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.658s) [151.495169] [014/133] (869s left) kms_atomic_transition (plane-all-transition-nonblocking) [151.587425] Starting subtest: plane-all-transition-nonblocking [151.589845] Starting dynamic subtest: pipe-A-eDP-1 [154.080206] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [154.403413] Starting dynamic subtest: pipe-B-eDP-1 [157.635235] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.239s) [157.935564] Subtest plane-all-transition-nonblocking: SUCCESS (6.350s) [158.766530] [015/133] (861s left) gem_softpin (allocator-fork) [158.838341] Starting subtest: allocator-fork [161.046210] Subtest allocator-fork: SUCCESS (2.207s) [161.170206] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [161.263503] Starting subtest: x-tiled-8bpp-rotate-180 [162.454583] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.191s) [162.564208] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [162.679482] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [162.683520] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [162.781477] [018/133] (857s left) gem_create (create-clear) [162.844408] Starting subtest: create-clear [162.846485] Starting dynamic subtest: smem0 [195.687735] Dynamic subtest smem0: SUCCESS (32.838s) [195.689918] Subtest create-clear: SUCCESS (32.839s) [195.878579] [019/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [195.996275] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [196.000437] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [196.087812] [020/133] (824s left) kms_chamelium_color (ctm-max) [196.186252] Subtest ctm-max: SKIP (0.000s) [196.230640] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [196.284692] Starting subtest: yf-tiled-ccs-to-linear [196.289397] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [196.459676] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [196.562533] Starting subtest: fbc-shrfb-scaledprimary [199.555983] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.995s) [200.759396] [023/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180) [200.865888] Starting subtest: y-tiled-64bpp-rotate-180 [200.870621] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [200.956121] [024/133] (820s left) gem_userptr_blits (unsync-overlap) [201.029617] Subtest unsync-overlap: SKIP (0.000s) [201.154946] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle) [201.213077] Starting subtest: invalid-signal-illegal-handle [201.215349] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [201.317175] [026/133] (819s left) gem_exec_schedule (timeslicing) [201.396178] Starting subtest: timeslicing [201.398435] Starting dynamic subtest: rcs0 [201.412979] Dynamic subtest rcs0: SUCCESS (0.021s) [201.420973] Starting dynamic subtest: bcs0 [201.433404] Dynamic subtest bcs0: SUCCESS (0.020s) [201.440574] Starting dynamic subtest: vcs0 [201.454974] Dynamic subtest vcs0: SUCCESS (0.021s) [201.461971] Starting dynamic subtest: vcs1 [201.475762] Dynamic subtest vcs1: SUCCESS (0.020s) [201.482784] Starting dynamic subtest: vecs0 [201.496304] Dynamic subtest vecs0: SUCCESS (0.020s) [201.503298] Starting dynamic subtest: ccs0 [201.516424] Dynamic subtest ccs0: SUCCESS (0.019s) [201.518769] Subtest timeslicing: SUCCESS (0.126s) [202.939138] [027/133] (818s left) kms_lease (lease-unleased-crtc) [203.033868] Starting subtest: lease-unleased-crtc [203.036251] Starting dynamic subtest: pipe-A-eDP-1 [203.332731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s) [203.340631] Starting dynamic subtest: pipe-B-eDP-1 [204.104307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s) [204.114224] Starting dynamic subtest: pipe-C-eDP-1 [204.116413] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [204.123118] Starting dynamic subtest: pipe-D-eDP-1 [204.124938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [204.126778] Subtest lease-unleased-crtc: SUCCESS (1.081s) [204.464740] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [204.573126] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [211.328140] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.757s) [211.448579] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [211.551415] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [211.555860] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [211.644563] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21) [211.830394] Starting subtest: cursor-offscreen-64x21 [211.878302] Subtest cursor-offscreen-64x21: SKIP (0.043s) [212.093797] [031/133] (809s left) kms_vrr (negative-basic) [212.183375] Starting subtest: negative-basic [212.190237] Starting dynamic subtest: pipe-A-eDP-1 [217.618878] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.425s) [217.898244] Subtest negative-basic: SUCCESS (5.714s) [218.730153] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [218.836058] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [218.840670] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [218.935236] [033/133] (802s left) gem_wait (write-wait) [219.001620] Starting subtest: write-wait [219.004079] Starting dynamic subtest: all-engines [220.192035] Dynamic subtest all-engines: SUCCESS (1.190s) [220.209256] Starting dynamic subtest: rcs0 [221.245597] Dynamic subtest rcs0: SUCCESS (1.052s) [221.260334] Starting dynamic subtest: bcs0 [222.301359] Dynamic subtest bcs0: SUCCESS (1.053s) [222.316646] Starting dynamic subtest: vcs0 [223.356052] Dynamic subtest vcs0: SUCCESS (1.053s) [223.371326] Starting dynamic subtest: vcs1 [224.408636] Dynamic subtest vcs1: SUCCESS (1.050s) [224.422661] Starting dynamic subtest: vecs0 [225.470242] Dynamic subtest vecs0: SUCCESS (1.059s) [225.487595] Starting dynamic subtest: ccs0 [226.528561] Dynamic subtest ccs0: SUCCESS (1.055s) [226.531149] Subtest write-wait: SUCCESS (7.527s) [226.739405] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [226.743138] [034/133] (794s left) gem_exec_fence (basic-busy) [226.922034] Starting subtest: basic-busy [226.924177] Starting dynamic subtest: rcs0 [227.007280] Dynamic subtest rcs0: SUCCESS (0.085s) [227.016861] Starting dynamic subtest: bcs0 [227.061315] Dynamic subtest bcs0: SUCCESS (0.052s) [227.070164] Starting dynamic subtest: vcs0 [227.115230] Dynamic subtest vcs0: SUCCESS (0.052s) [227.124519] Starting dynamic subtest: vcs1 [227.171436] Dynamic subtest vcs1: SUCCESS (0.054s) [227.181020] Starting dynamic subtest: vecs0 [227.236703] Dynamic subtest vecs0: SUCCESS (0.063s) [227.246474] Starting dynamic subtest: ccs0 [227.299687] Dynamic subtest ccs0: SUCCESS (0.061s) [227.302065] Subtest basic-busy: SUCCESS (0.379s) [228.974282] [035/133] (792s left) gem_tiled_wc [229.094197] [036/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [229.180070] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [229.184178] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [229.250489] [037/133] (792s left) gem_exec_fence (submit) [229.428650] Starting subtest: submit [229.433161] Subtest submit: SKIP (0.000s) [231.003705] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [231.103720] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [231.105977] Starting dynamic subtest: pipe-A-eDP-1 [231.165235] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [231.174525] Starting dynamic subtest: pipe-B-eDP-1 [231.232292] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [231.241298] Starting dynamic subtest: pipe-C-eDP-1 [231.297678] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [231.305807] Starting dynamic subtest: pipe-D-eDP-1 [231.359844] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [231.364116] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [233.308949] [039/133] (788s left) vgem_basic (bad-handle) [233.358924] Starting subtest: bad-handle [233.360955] Subtest bad-handle: SUCCESS (0.000s) [233.412796] [040/133] (788s left) gem_exec_reloc (basic-cpu-wc-active) [233.477753] Subtest basic-cpu-wc-active: SKIP (0.000s) [233.553450] [041/133] (788s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [233.939400] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [234.712835] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [234.780686] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [234.850181] [043/133] (786s left) gem_readwrite (new-obj) [234.921980] Subtest new-obj: SKIP (0.000s) [234.989633] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active) [235.049628] Subtest basic-wc-cpu-active: SKIP (0.000s) [235.116623] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [235.205795] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [242.531109] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.328s) [242.642929] [046/133] (779s left) gem_pxp (fail-invalid-protected-context) [242.773083] Starting subtest: fail-invalid-protected-context [242.775869] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [242.886809] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip) [242.977086] Starting subtest: fbc-psr-primary-page-flip [242.979370] Starting dynamic subtest: eDP-1 [242.983689] Dynamic subtest eDP-1: SKIP (0.000s) [242.988041] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [243.048861] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [243.160412] Starting subtest: short-flip-before-cursor-atomic-transitions [244.127757] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.968s) [244.995263] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [245.087457] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [245.733529] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s) [245.901183] [050/133] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [245.993381] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [245.997668] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [246.096707] [051/133] (775s left) gem_exec_schedule (noreorder-priority) [246.273729] Starting subtest: noreorder-priority [246.276287] Starting dynamic subtest: rcs0 [247.411684] Dynamic subtest rcs0: SUCCESS (1.139s) [247.422374] Starting dynamic subtest: vcs0 [248.912468] Dynamic subtest vcs0: SUCCESS (1.497s) [248.921345] Starting dynamic subtest: vcs1 [250.898593] Dynamic subtest vcs1: SUCCESS (1.983s) [250.910045] Starting dynamic subtest: vecs0 [252.880849] Dynamic subtest vecs0: SUCCESS (1.980s) [252.893564] Starting dynamic subtest: ccs0 [254.029954] Dynamic subtest ccs0: SUCCESS (1.148s) [254.032645] Subtest noreorder-priority: SUCCESS (7.758s) [254.232210] [052/133] (767s left) gem_lmem_swapping (verify-ccs) [254.283067] Subtest verify-ccs: SKIP (0.000s) [254.331579] [053/133] (767s left) gem_ctx_isolation (dirty-create) [254.403470] Starting subtest: dirty-create [254.405961] Starting dynamic subtest: rcs0 [254.617170] Dynamic subtest rcs0: SUCCESS (0.214s) [254.628100] Starting dynamic subtest: bcs0 [254.862575] Dynamic subtest bcs0: SUCCESS (0.244s) [254.873068] Starting dynamic subtest: vcs0 [255.107680] Dynamic subtest vcs0: SUCCESS (0.244s) [255.121877] Starting dynamic subtest: vcs1 [257.111589] Dynamic subtest vcs1: SUCCESS (2.003s) [257.121453] Starting dynamic subtest: vecs0 [259.111039] Dynamic subtest vecs0: SUCCESS (1.998s) [259.121256] Starting dynamic subtest: ccs0 [261.104411] Dynamic subtest ccs0: SUCCESS (1.992s) [261.106857] Subtest dirty-create: SUCCESS (6.701s) [261.335600] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [261.434893] Starting subtest: fbc-pr-plane-move-sf-dmg-area [261.439188] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [261.499112] [055/133] (760s left) dmabuf (all-tests) [261.535158] Starting subtest: all-tests [261.537179] Starting dynamic subtest: sanitycheck [261.634844] Dynamic subtest sanitycheck: SUCCESS (0.104s) [261.645902] Starting dynamic subtest: dma_fence [261.826900] Dynamic subtest dma_fence: SUCCESS (0.189s) [261.841626] Starting dynamic subtest: dma_fence_chain [270.742706] Dynamic subtest dma_fence_chain: SUCCESS (8.912s) [270.752270] Starting dynamic subtest: dma_fence_unwrap [270.830675] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s) [270.841324] Starting dynamic subtest: dma_resv [270.914714] Dynamic subtest dma_resv: SUCCESS (0.082s) [270.917280] Subtest all-tests: SUCCESS (9.385s) [270.992334] [056/133] (751s left) syncobj_timeline (reset-unsignaled) [271.035031] Starting subtest: reset-unsignaled [271.037409] Subtest reset-unsignaled: SUCCESS (0.000s) [271.146504] [057/133] (751s left) syncobj_wait (multi-wait-signaled) [271.215143] Starting subtest: multi-wait-signaled [271.217416] Subtest multi-wait-signaled: SUCCESS (0.000s) [271.331133] [058/133] (750s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [271.428271] Starting subtest: 2x-flip-vs-absolute-wf_vblank [271.438852] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [271.516132] [059/133] (750s left) kms_psr (pr-cursor-mmap-cpu) [271.602653] Starting subtest: pr-cursor-mmap-cpu [271.607076] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [271.672434] [060/133] (750s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [271.729581] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [271.835474] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [271.913069] [061/133] (750s left) kms_atomic_transition (modeset-transition-fencing) [272.002284] Starting subtest: modeset-transition-fencing [272.004184] Starting dynamic subtest: 1x-outputs [282.837759] Dynamic subtest 1x-outputs: SUCCESS (10.836s) [282.840634] Subtest modeset-transition-fencing: SUCCESS (10.839s) [283.693249] [062/133] (738s left) kms_psr (fbc-psr2-cursor-plane-onoff) [283.811299] Starting subtest: fbc-psr2-cursor-plane-onoff [283.813686] Starting dynamic subtest: eDP-1 [283.818219] Dynamic subtest eDP-1: SKIP (0.000s) [283.822532] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.003s) [283.923210] [063/133] (738s left) i915_hangman (error-state-basic) [283.994224] Starting subtest: error-state-basic [284.125946] Subtest error-state-basic: SUCCESS (0.132s) [284.199889] [064/133] (738s left) gem_tiled_fence_blits (basic) [284.268279] Subtest basic: SKIP (0.000s) [284.345918] [065/133] (738s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [284.453593] Starting subtest: fbc-rgb565-draw-mmap-cpu [288.399866] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.949s) [289.520740] [066/133] (733s left) gem_gpgpu_fill (offset-16x16) [289.570319] Starting subtest: offset-16x16 [289.577832] Subtest offset-16x16: SUCCESS (0.009s) [289.708946] [067/133] (732s left) perf_pmu (all-busy-check-all) [289.751510] Starting subtest: all-busy-check-all [290.903844] Subtest all-busy-check-all: SUCCESS (1.153s) [291.000206] [068/133] (731s left) gen9_exec_parse (unaligned-jump) [291.074519] Subtest unaligned-jump: SKIP (0.000s) [291.140339] [069/133] (731s left) i915_pm_rpm (system-suspend-execbuf) [293.073716] Starting subtest: system-suspend-execbuf [351.306814] Subtest system-suspend-execbuf: SUCCESS (42.656s) [351.696302] [070/133] (671s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [351.806468] Starting subtest: fbc-farfromfence-mmap-gtt [351.810608] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [351.911215] [071/133] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [352.007155] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [352.011281] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [352.118807] [072/133] (670s left) kms_psr (psr2-sprite-render) [352.224128] Starting subtest: psr2-sprite-render [352.226310] Starting dynamic subtest: eDP-1 [353.991132] Dynamic subtest eDP-1: SUCCESS (1.766s) [353.993286] Subtest psr2-sprite-render: SUCCESS (1.767s) [354.841835] [073/133] (668s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [354.936615] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [354.938947] Starting dynamic subtest: pipe-A-eDP-1 [354.959264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [354.973925] Starting dynamic subtest: pipe-B-eDP-1 [354.994320] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [355.005052] Starting dynamic subtest: pipe-C-eDP-1 [355.024162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [355.032816] Starting dynamic subtest: pipe-D-eDP-1 [355.051909] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [355.054112] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [357.223645] [074/133] (665s left) perf_pmu (idle-no-semaphores) [357.265516] Starting subtest: idle-no-semaphores [357.267763] Starting dynamic subtest: rcs0 [357.800431] Dynamic subtest rcs0: SUCCESS (0.534s) [357.812602] Starting dynamic subtest: bcs0 [358.320709] Dynamic subtest bcs0: SUCCESS (0.516s) [358.332463] Starting dynamic subtest: vcs0 [358.841613] Dynamic subtest vcs0: SUCCESS (0.517s) [358.853581] Starting dynamic subtest: vcs1 [359.359445] Dynamic subtest vcs1: SUCCESS (0.514s) [359.371299] Starting dynamic subtest: vecs0 [359.879770] Dynamic subtest vecs0: SUCCESS (0.516s) [359.889830] Starting dynamic subtest: ccs0 [360.397152] Dynamic subtest ccs0: SUCCESS (0.514s) [360.400555] Subtest idle-no-semaphores: SUCCESS (3.132s) [360.505321] [075/133] (662s left) gem_exec_fence (syncobj-timeline-signal) [361.041541] Starting subtest: syncobj-timeline-signal [361.049793] Subtest syncobj-timeline-signal: SUCCESS (0.014s) [362.236237] [076/133] (660s left) kms_plane_multiple (tiling-yf) [362.342878] Starting subtest: tiling-yf [362.347007] Subtest tiling-yf: SKIP (0.000s) [362.428015] [077/133] (660s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [362.512196] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [362.514487] Starting dynamic subtest: pipe-A [363.583136] Dynamic subtest pipe-A: SUCCESS (1.072s) [363.594441] Starting dynamic subtest: pipe-B [365.729478] Dynamic subtest pipe-B: SUCCESS (2.143s) [365.738360] Starting dynamic subtest: pipe-C [366.931152] Dynamic subtest pipe-C: SUCCESS (1.199s) [366.941080] Starting dynamic subtest: pipe-D [368.153175] Dynamic subtest pipe-D: SUCCESS (1.220s) [368.155456] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.641s) [369.352786] [078/133] (653s left) kms_flip (flip-vs-expired-vblank) [369.448537] Starting subtest: flip-vs-expired-vblank [369.450865] Starting dynamic subtest: A-eDP1 [378.169034] Dynamic subtest A-eDP1: SUCCESS (8.715s) [378.182938] Starting dynamic subtest: B-eDP1 [386.806443] Dynamic subtest B-eDP1: SUCCESS (8.630s) [386.819459] Starting dynamic subtest: C-eDP1 [395.444461] Dynamic subtest C-eDP1: SUCCESS (8.629s) [395.454137] Starting dynamic subtest: D-eDP1 [404.074913] Dynamic subtest D-eDP1: SUCCESS (8.625s) [404.077138] Subtest flip-vs-expired-vblank: SUCCESS (34.612s) [405.245195] [079/133] (617s left) syncobj_timeline (single-wait-for-submit-available-signaled) [405.312032] Starting subtest: single-wait-for-submit-available-signaled [405.314511] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [405.439334] [080/133] (617s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [405.548739] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [406.507495] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.959s) [406.735544] [081/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [406.825650] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [415.964853] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.144s) [416.095586] [082/133] (607s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [416.189219] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [416.191613] Starting dynamic subtest: pipe-A-eDP-1 [416.212344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [416.223043] Starting dynamic subtest: pipe-B-eDP-1 [416.242166] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [416.251005] Starting dynamic subtest: pipe-C-eDP-1 [416.270225] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [416.278940] Starting dynamic subtest: pipe-D-eDP-1 [416.298165] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [416.300360] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [418.418886] [083/133] (604s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [418.516655] Starting subtest: fbc-2p-pri-indfb-multidraw [418.521025] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [418.647913] [084/133] (604s left) gem_render_tiled_blits (basic) [418.704463] Subtest basic: SKIP (0.000s) [418.792657] [085/133] (604s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [418.880781] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [418.883148] Starting dynamic subtest: pipe-A-eDP-1 [418.905607] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [418.916622] Starting dynamic subtest: pipe-B-eDP-1 [418.938778] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [418.948546] Starting dynamic subtest: pipe-C-eDP-1 [418.969110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [418.977964] Starting dynamic subtest: pipe-D-eDP-1 [418.998853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [419.002693] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [421.153999] [086/133] (602s left) kms_vblank (ts-continuation-dpms-rpm) [421.245450] Starting subtest: ts-continuation-dpms-rpm [421.247658] Starting dynamic subtest: pipe-A-eDP-1 [423.754429] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.508s) [423.769805] Starting dynamic subtest: pipe-D-eDP-1 [426.001036] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s) [426.002934] Subtest ts-continuation-dpms-rpm: SUCCESS (4.756s) [426.803296] [087/133] (596s left) gem_exec_whisper (basic-fds-priority) [426.876345] Starting subtest: basic-fds-priority [450.791375] Subtest basic-fds-priority: SUCCESS (23.909s) [450.978796] [088/133] (572s left) kms_pm_rpm (legacy-planes-dpms) [452.502864] Starting subtest: legacy-planes-dpms [452.505901] Starting dynamic subtest: plane-64 [460.828588] Dynamic subtest plane-64: SUCCESS (8.324s) [460.840016] Starting dynamic subtest: plane-94 [469.147828] Dynamic subtest plane-94: SUCCESS (8.315s) [469.158858] Starting dynamic subtest: plane-124 [477.772360] Dynamic subtest plane-124: SUCCESS (8.618s) [477.784445] Starting dynamic subtest: plane-134 [486.501795] Dynamic subtest plane-134: SUCCESS (8.727s) [486.504365] Subtest legacy-planes-dpms: SUCCESS (33.993s) [486.888971] [089/133] (536s left) intel_hwmon (hwmon-write) [486.946469] Subtest hwmon-write: SKIP (0.000s) [487.008766] [090/133] (536s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [487.102120] Starting subtest: fbcpsr-rgb101010-draw-pwrite [494.067719] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.967s) [494.192357] [091/133] (529s left) syncobj_basic (bad-pad-fd-to-handle) [494.244947] Starting subtest: bad-pad-fd-to-handle [494.247360] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [494.352734] [092/133] (529s left) gen9_exec_parse (bb-chained) [494.404151] Subtest bb-chained: SKIP (0.000s) [494.467198] [093/133] (529s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [494.574004] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [501.844938] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.269s) [501.980474] [094/133] (521s left) gem_exec_params (rel-constants-invalid-ring) [502.037300] Starting subtest: rel-constants-invalid-ring [502.039537] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [502.138229] [095/133] (521s left) gem_workarounds (suspend-resume-fd) [502.199770] Starting subtest: suspend-resume-fd [517.493414] Subtest suspend-resume-fd: SUCCESS (1.952s) [517.645234] [096/133] (506s left) kms_color (ctm-signed) [517.752012] Starting subtest: ctm-signed [517.754392] Starting dynamic subtest: pipe-A-eDP-1 [519.918088] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s) [519.928004] Starting dynamic subtest: pipe-B-eDP-1 [522.776368] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s) [522.786756] Starting dynamic subtest: pipe-C-eDP-1 [525.519168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.684s) [525.529722] Starting dynamic subtest: pipe-D-eDP-1 [528.232401] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.677s) [528.235031] Subtest ctm-signed: SUCCESS (10.233s) [529.069421] [097/133] (494s left) kms_cursor_crc (cursor-random-256x256) [529.320569] Starting subtest: cursor-random-256x256 [529.323230] Starting dynamic subtest: pipe-A-eDP-1 [532.717081] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.364s) [532.750512] Starting dynamic subtest: pipe-D-eDP-1 [536.735724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.974s) [536.738639] Subtest cursor-random-256x256: SUCCESS (7.364s) [537.574578] [098/133] (486s left) gem_mmap_gtt (ptrace) [537.641883] Subtest ptrace: SKIP (0.000s) [537.700405] [099/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [537.800134] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [541.352136] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.546s) [542.496371] [100/133] (481s left) gem_exec_balancer (parallel-balancer) [542.755895] Starting subtest: parallel-balancer [543.651476] Subtest parallel-balancer: SUCCESS (0.894s) [543.749285] [101/133] (480s left) syncobj_timeline (etime-single-wait-all-submitted) [543.809835] Starting subtest: etime-single-wait-all-submitted [543.915594] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [543.990129] [102/133] (480s left) api_intel_bb (crc32) [544.049327] Starting subtest: crc32 [544.051334] Starting dynamic subtest: rcs0-smem0 [544.341304] Dynamic subtest rcs0-smem0: SUCCESS (0.292s) [544.354113] Starting dynamic subtest: bcs0-smem0 [544.681843] Dynamic subtest bcs0-smem0: SUCCESS (0.337s) [544.694869] Starting dynamic subtest: vcs0-smem0 [545.049032] Dynamic subtest vcs0-smem0: SUCCESS (0.365s) [545.061483] Starting dynamic subtest: vcs1-smem0 [545.447042] Dynamic subtest vcs1-smem0: SUCCESS (0.393s) [545.457828] Starting dynamic subtest: vecs0-smem0 [545.807008] Dynamic subtest vecs0-smem0: SUCCESS (0.357s) [545.822553] Starting dynamic subtest: ccs0-smem0 [546.163164] Dynamic subtest ccs0-smem0: SUCCESS (0.352s) [546.166237] Subtest crc32: SUCCESS (2.113s) [546.313062] [103/133] (477s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [546.416520] Starting subtest: psr-rgb565-draw-mmap-gtt [546.421611] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [546.514597] [104/133] (477s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [546.570645] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [546.676646] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [546.796955] [105/133] (477s left) gem_exec_reloc (basic-cpu-wc) [546.861759] Subtest basic-cpu-wc: SKIP (0.000s) [546.928180] [106/133] (477s left) api_intel_bb (purge-bb) [546.976411] Starting subtest: purge-bb [546.978739] Subtest purge-bb: SUCCESS (0.004s) [547.103524] [107/133] (477s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [547.194487] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [547.197120] Starting dynamic subtest: pipe-A [547.543876] Dynamic subtest pipe-A: SUCCESS (0.351s) [547.553312] Starting dynamic subtest: pipe-B [549.000553] Dynamic subtest pipe-B: SUCCESS (1.454s) [549.009998] Starting dynamic subtest: pipe-C [550.466641] Dynamic subtest pipe-C: SUCCESS (1.462s) [550.486913] Starting dynamic subtest: pipe-D [551.847437] Dynamic subtest pipe-D: SUCCESS (1.379s) [551.849853] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.652s) [553.014377] [108/133] (471s left) gem_mmap_gtt (basic-write-read-distinct) [553.068694] Subtest basic-write-read-distinct: SKIP (0.000s) [553.129418] [109/133] (471s left) kms_feature_discovery (psr1) [553.217910] Starting subtest: psr1 [553.220300] Subtest psr1: SUCCESS (0.000s) [553.290468] [110/133] (471s left) kms_cursor_crc (cursor-tearing-position-change) [553.405370] Starting subtest: cursor-tearing-position-change [553.407892] Starting dynamic subtest: pipe-A-eDP-1 [553.971653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [553.981410] Starting dynamic subtest: pipe-D-eDP-1 [555.253367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s) [555.255439] Subtest cursor-tearing-position-change: SUCCESS (1.846s) [556.078746] [111/133] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [556.184598] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [556.189838] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [556.286407] [112/133] (468s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [556.389836] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [556.394825] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [556.459965] [113/133] (468s left) gem_bad_reloc (negative-reloc) [556.522140] Subtest negative-reloc: SKIP (0.000s) [556.589539] [114/133] (468s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [556.686198] Starting subtest: primary-yf-tiled-reflect-x-180 [556.751365] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [556.856153] [115/133] (467s left) drm_read (empty-block) [557.001855] Starting subtest: empty-block [558.002240] Subtest empty-block: SUCCESS (1.000s) [558.137354] [116/133] (466s left) gem_render_copy (yf-tiled-to-vebox-linear) [558.193857] Starting subtest: yf-tiled-to-vebox-linear [558.199777] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [558.392044] [117/133] (466s left) kms_pm_rpm (dpms-lpsp) [560.630457] Starting subtest: dpms-lpsp [560.935108] Subtest dpms-lpsp: SUCCESS (0.307s) [561.021719] [118/133] (463s left) kms_cursor_legacy (forked-move) [561.142856] Starting subtest: forked-move [561.145557] Starting dynamic subtest: pipe-A [566.628013] Dynamic subtest pipe-A: SUCCESS (5.481s) [566.639478] Starting dynamic subtest: pipe-B [572.110460] Dynamic subtest pipe-B: SUCCESS (5.477s) [572.122516] Starting dynamic subtest: pipe-C [577.611259] Dynamic subtest pipe-C: SUCCESS (5.496s) [577.626727] Starting dynamic subtest: pipe-D [583.112216] Dynamic subtest pipe-D: SUCCESS (5.495s) [583.133058] Starting dynamic subtest: all-pipes [588.588048] Dynamic subtest all-pipes: SUCCESS (5.472s) [588.590662] Subtest forked-move: SUCCESS (27.433s) [588.738147] [119/133] (436s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [588.825707] Starting subtest: flip-primary-invalidate-overlay [600.467691] Subtest flip-primary-invalidate-overlay: SUCCESS (11.639s) [600.632017] [120/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [600.731399] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [600.735508] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [600.837498] [121/133] (424s left) kms_content_protection (srm) [600.970858] Starting subtest: srm [600.975590] Subtest srm: SKIP (0.002s) [601.085031] [122/133] (423s left) prime_busy (after-wait) [601.150427] Starting subtest: after-wait [601.156076] Starting dynamic subtest: rcs0 [601.184188] Dynamic subtest rcs0: SUCCESS (0.030s) [601.194178] Starting dynamic subtest: bcs0 [601.224469] Dynamic subtest bcs0: SUCCESS (0.040s) [601.233914] Starting dynamic subtest: vcs0 [601.266222] Dynamic subtest vcs0: SUCCESS (0.041s) [601.275608] Starting dynamic subtest: vcs1 [601.306452] Dynamic subtest vcs1: SUCCESS (0.039s) [601.316132] Starting dynamic subtest: vecs0 [601.349194] Dynamic subtest vecs0: SUCCESS (0.042s) [601.358318] Starting dynamic subtest: ccs0 [601.390059] Dynamic subtest ccs0: SUCCESS (0.040s) [601.498838] Subtest after-wait: SUCCESS (0.346s) [601.578568] [123/133] (423s left) kms_pipe_crc_basic (disable-crc-after-crtc) [601.681025] Starting subtest: disable-crc-after-crtc [601.684060] Starting dynamic subtest: pipe-A-eDP-1 [603.365380] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.683s) [603.375252] Starting dynamic subtest: pipe-B-eDP-1 [605.634233] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.269s) [605.643728] Starting dynamic subtest: pipe-C-eDP-1 [607.879356] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s) [607.890551] Starting dynamic subtest: pipe-D-eDP-1 [610.152103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s) [610.154631] Subtest disable-crc-after-crtc: SUCCESS (8.469s) [610.990204] [124/133] (414s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [611.100837] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [611.103485] Starting dynamic subtest: pipe-A-eDP-1 [617.089548] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.992s) [617.099842] Starting dynamic subtest: pipe-B-eDP-1 [623.733467] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s) [623.736212] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.640s) [624.606733] [125/133] (400s left) kms_universal_plane (universal-plane-sanity) [624.696544] Starting subtest: universal-plane-sanity [624.699066] Starting dynamic subtest: pipe-A-eDP-1 [625.289137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s) [625.302847] Starting dynamic subtest: pipe-B-eDP-1 [626.523722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s) [626.535156] Starting dynamic subtest: pipe-C-eDP-1 [627.746307] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s) [627.756671] Starting dynamic subtest: pipe-D-eDP-1 [628.968771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s) [628.971841] Subtest universal-plane-sanity: SUCCESS (4.275s) [629.836285] [126/133] (395s left) kms_invalid_mode (clock-too-high) [629.941720] Starting subtest: clock-too-high [629.944745] Starting dynamic subtest: pipe-A-eDP-1 [629.949698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [629.960548] Starting dynamic subtest: pipe-B-eDP-1 [629.965852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [629.975838] Starting dynamic subtest: pipe-C-eDP-1 [629.981101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [629.989911] Starting dynamic subtest: pipe-D-eDP-1 [629.994868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [629.999749] Subtest clock-too-high: SKIP (0.005s) [630.039329] [127/133] (395s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [630.136444] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [630.141547] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [630.206167] [128/133] (395s left) gem_eio (wait-immediate) [630.436005] Starting subtest: wait-immediate [630.790878] Subtest wait-immediate: SUCCESS (0.355s) [630.964897] [129/133] (394s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [631.062302] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [631.065572] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [631.156270] [130/133] (394s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [631.202760] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [631.307981] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [631.385733] [131/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [631.484333] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [638.644477] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.166s) [638.767050] [132/133] (386s left) i915_suspend (basic-s2idle-without-i915) [638.812457] Starting subtest: basic-s2idle-without-i915 [658.962279] Subtest basic-s2idle-without-i915: SUCCESS (4.854s) [659.086819] [133/133] (366s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [659.202793] Starting subtest: fbc-rgb565-draw-blt [663.465366] Subtest fbc-rgb565-draw-blt: SUCCESS (4.128s) [664.642684] 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.