[59.265854] Initializing watchdogs [59.265900] /dev/watchdog0 [59.280978] [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.285758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.288124] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.291573] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [59.434904] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [60.443561] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.007s) [61.239874] [002/133] (958s left) kms_hdr (brightness-with-hdr) [61.341423] Starting subtest: brightness-with-hdr [61.347304] Subtest brightness-with-hdr: SKIP (0.000s) [61.411497] [003/133] (958s left) gem_sync (basic-store-all) [61.478565] Starting subtest: basic-store-all [64.174056] Subtest basic-store-all: SUCCESS (2.707s) [64.357946] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [64.428409] Starting subtest: heartbeat-stop [64.433094] Subtest heartbeat-stop: SKIP (0.000s) [64.527124] [005/133] (955s left) gem_ctx_shared (q-smoketest) [64.596783] Starting subtest: Q-smoketest [64.599255] Starting dynamic subtest: rcs0 [70.141326] Dynamic subtest rcs0: SUCCESS (5.498s) [70.150064] Starting dynamic subtest: bcs0 [75.652033] Dynamic subtest bcs0: SUCCESS (5.513s) [75.659567] Starting dynamic subtest: vcs0 [81.139734] Dynamic subtest vcs0: SUCCESS (5.480s) [81.147812] Starting dynamic subtest: vcs1 [86.610538] Dynamic subtest vcs1: SUCCESS (5.477s) [86.618073] Starting dynamic subtest: vecs0 [92.093605] Dynamic subtest vecs0: SUCCESS (5.481s) [92.101925] Starting dynamic subtest: ccs0 [97.593237] Dynamic subtest ccs0: SUCCESS (5.495s) [97.595095] Subtest Q-smoketest: SUCCESS (32.947s) [97.725690] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [98.889975] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [99.201362] [007/133] (920s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [99.318838] Starting subtest: cursorA-vs-flipA-atomic-transitions [110.491541] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.171s) [111.345753] [008/133] (908s left) gem_pread (display) [111.410050] Subtest display: SKIP (0.000s) [111.468541] [009/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [111.569301] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [112.634890] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.049s) [112.764238] [010/133] (907s left) gen3_render_tiledy_blits [112.930399] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [113.046802] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [113.056267] Starting dynamic subtest: pipe-A-default-mode [114.234905] Dynamic subtest pipe-A-default-mode: SKIP (1.174s) [114.256641] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.176s) [114.402647] [012/133] (905s left) gem_mmap_gtt (big-bo-tiledy) [114.510415] Subtest big-bo-tiledY: SKIP (0.000s) [114.606133] [013/133] (905s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [114.744478] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [114.754509] Starting dynamic subtest: A-eDP1 [123.636495] Dynamic subtest A-eDP1: SUCCESS (8.905s) [123.645593] Starting dynamic subtest: B-eDP1 [132.564165] Dynamic subtest B-eDP1: SUCCESS (8.925s) [132.576490] Starting dynamic subtest: C-eDP1 [141.486750] Dynamic subtest C-eDP1: SUCCESS (8.920s) [141.496690] Starting dynamic subtest: D-eDP1 [150.418324] Dynamic subtest D-eDP1: SUCCESS (8.930s) [150.423619] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.693s) [151.651307] [014/133] (868s left) kms_atomic_transition (plane-all-transition-nonblocking) [151.755146] Starting subtest: plane-all-transition-nonblocking [151.757329] Starting dynamic subtest: pipe-A-eDP-1 [154.248739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [154.566659] Starting dynamic subtest: pipe-B-eDP-1 [157.784678] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.225s) [158.092038] Subtest plane-all-transition-nonblocking: SUCCESS (6.338s) [158.914611] [015/133] (861s left) gem_softpin (allocator-fork) [158.972927] Starting subtest: allocator-fork [161.179661] Subtest allocator-fork: SUCCESS (2.208s) [161.317909] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [161.430300] Starting subtest: x-tiled-8bpp-rotate-180 [162.654988] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.225s) [162.784586] [017/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [162.882346] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [162.885967] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [162.982737] [018/133] (857s left) gem_create (create-clear) [163.042331] Starting subtest: create-clear [163.043960] Starting dynamic subtest: smem0 [195.854328] Dynamic subtest smem0: SUCCESS (32.807s) [195.856370] Subtest create-clear: SUCCESS (32.808s) [196.042687] [019/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [196.142227] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [196.146911] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [196.245153] [020/133] (824s left) kms_chamelium_color (ctm-max) [196.331566] Subtest ctm-max: SKIP (0.000s) [196.373791] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [196.432954] Starting subtest: yf-tiled-ccs-to-linear [196.437630] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [196.626222] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [196.719954] Starting subtest: fbc-shrfb-scaledprimary [199.719728] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.002s) [200.922223] [023/133] (819s left) kms_big_fb (y-tiled-64bpp-rotate-180) [201.030117] Starting subtest: y-tiled-64bpp-rotate-180 [201.034660] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [201.140047] [024/133] (819s left) gem_userptr_blits (unsync-overlap) [201.215769] Subtest unsync-overlap: SKIP (0.000s) [201.350337] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle) [201.402884] Starting subtest: invalid-signal-illegal-handle [201.405233] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [201.499901] [026/133] (819s left) gem_exec_schedule (timeslicing) [201.570236] Starting subtest: timeslicing [201.572217] Starting dynamic subtest: rcs0 [201.580360] Dynamic subtest rcs0: SUCCESS (0.021s) [201.590286] Starting dynamic subtest: bcs0 [201.600376] Dynamic subtest bcs0: SUCCESS (0.019s) [201.608098] Starting dynamic subtest: vcs0 [201.621280] Dynamic subtest vcs0: SUCCESS (0.020s) [201.628623] Starting dynamic subtest: vcs1 [201.641665] Dynamic subtest vcs1: SUCCESS (0.020s) [201.651480] Starting dynamic subtest: vecs0 [201.661669] Dynamic subtest vecs0: SUCCESS (0.019s) [201.668862] Starting dynamic subtest: ccs0 [201.684683] Dynamic subtest ccs0: SUCCESS (0.022s) [201.686784] Subtest timeslicing: SUCCESS (0.127s) [202.940255] [027/133] (818s left) kms_lease (lease-unleased-crtc) [203.027260] Starting subtest: lease-unleased-crtc [203.029552] Starting dynamic subtest: pipe-A-eDP-1 [203.323196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [203.332527] Starting dynamic subtest: pipe-B-eDP-1 [204.065745] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.738s) [204.074467] Starting dynamic subtest: pipe-C-eDP-1 [204.076652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [204.084197] Starting dynamic subtest: pipe-D-eDP-1 [204.086424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [204.088665] Subtest lease-unleased-crtc: SUCCESS (1.052s) [204.442822] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [204.531190] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [211.339651] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.810s) [211.471547] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [211.564631] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [211.568996] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [211.663614] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21) [211.857588] Starting subtest: cursor-offscreen-64x21 [211.905645] Subtest cursor-offscreen-64x21: SKIP (0.044s) [212.147573] [031/133] (808s left) kms_vrr (negative-basic) [212.250436] Starting subtest: negative-basic [212.256958] Starting dynamic subtest: pipe-A-eDP-1 [217.669436] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s) [217.965591] Subtest negative-basic: SUCCESS (5.717s) [218.806456] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [218.930274] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [218.934814] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [219.028786] [033/133] (802s left) gem_wait (write-wait) [219.088327] Starting subtest: write-wait [219.090770] Starting dynamic subtest: all-engines [220.262041] Dynamic subtest all-engines: SUCCESS (1.173s) [220.278290] Starting dynamic subtest: rcs0 [221.316555] Dynamic subtest rcs0: SUCCESS (1.052s) [221.331578] Starting dynamic subtest: bcs0 [222.372942] Dynamic subtest bcs0: SUCCESS (1.053s) [222.388513] Starting dynamic subtest: vcs0 [223.425212] Dynamic subtest vcs0: SUCCESS (1.051s) [223.440713] Starting dynamic subtest: vcs1 [224.481237] Dynamic subtest vcs1: SUCCESS (1.053s) [224.496262] Starting dynamic subtest: vecs0 [225.535266] Dynamic subtest vecs0: SUCCESS (1.052s) [225.550268] Starting dynamic subtest: ccs0 [226.592072] Dynamic subtest ccs0: SUCCESS (1.054s) [226.594864] Subtest write-wait: SUCCESS (7.505s) [226.786787] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [226.790215] [034/133] (794s left) gem_exec_fence (basic-busy) [226.985868] Starting subtest: basic-busy [226.987813] Starting dynamic subtest: rcs0 [227.080645] Dynamic subtest rcs0: SUCCESS (0.097s) [227.090780] Starting dynamic subtest: bcs0 [227.151227] Dynamic subtest bcs0: SUCCESS (0.068s) [227.161890] Starting dynamic subtest: vcs0 [227.214577] Dynamic subtest vcs0: SUCCESS (0.061s) [227.224801] Starting dynamic subtest: vcs1 [227.272248] Dynamic subtest vcs1: SUCCESS (0.056s) [227.283597] Starting dynamic subtest: vecs0 [227.325542] Dynamic subtest vecs0: SUCCESS (0.051s) [227.336471] Starting dynamic subtest: ccs0 [227.385986] Dynamic subtest ccs0: SUCCESS (0.059s) [227.388347] Subtest basic-busy: SUCCESS (0.405s) [228.953590] [035/133] (792s left) gem_tiled_wc [229.070116] [036/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [229.163283] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [229.167246] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [229.233246] [037/133] (792s left) gem_exec_fence (submit) [229.407464] Starting subtest: submit [229.412755] Subtest submit: SKIP (0.000s) [231.012235] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [231.098098] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [231.100367] Starting dynamic subtest: pipe-A-eDP-1 [231.159282] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [231.168781] Starting dynamic subtest: pipe-B-eDP-1 [231.225508] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [231.235697] Starting dynamic subtest: pipe-C-eDP-1 [231.293764] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [231.302061] Starting dynamic subtest: pipe-D-eDP-1 [231.359069] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [231.363589] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [233.379139] [039/133] (788s left) vgem_basic (bad-handle) [233.429648] Starting subtest: bad-handle [233.431801] Subtest bad-handle: SUCCESS (0.000s) [233.485419] [040/133] (787s left) gem_exec_reloc (basic-cpu-wc-active) [233.542072] Subtest basic-cpu-wc-active: SKIP (0.000s) [233.608981] [041/133] (787s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [233.997070] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [234.783190] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [234.848140] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [234.907245] [043/133] (786s left) gem_readwrite (new-obj) [234.972070] Subtest new-obj: SKIP (0.000s) [235.032638] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active) [235.089598] Subtest basic-wc-cpu-active: SKIP (0.000s) [235.159196] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [235.262759] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [242.740421] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.481s) [242.868145] [046/133] (778s left) gem_pxp (fail-invalid-protected-context) [242.995584] Starting subtest: fail-invalid-protected-context [242.998226] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [243.111093] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip) [243.200044] Starting subtest: fbc-psr-primary-page-flip [243.202321] Starting dynamic subtest: eDP-1 [243.206683] Dynamic subtest eDP-1: SKIP (0.000s) [243.211067] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [243.276829] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [243.403470] Starting subtest: short-flip-before-cursor-atomic-transitions [244.352681] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s) [245.194301] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [245.287160] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [245.888962] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s) [246.076307] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [246.163472] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [246.167749] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [246.280380] [051/133] (775s left) gem_exec_schedule (noreorder-priority) [246.463841] Starting subtest: noreorder-priority [246.466277] Starting dynamic subtest: rcs0 [247.599900] Dynamic subtest rcs0: SUCCESS (1.136s) [247.611185] Starting dynamic subtest: vcs0 [248.915430] Dynamic subtest vcs0: SUCCESS (1.312s) [248.926504] Starting dynamic subtest: vcs1 [250.897115] Dynamic subtest vcs1: SUCCESS (1.979s) [250.905550] Starting dynamic subtest: vecs0 [252.889304] Dynamic subtest vecs0: SUCCESS (1.989s) [252.899897] Starting dynamic subtest: ccs0 [254.048371] Dynamic subtest ccs0: SUCCESS (1.157s) [254.051277] Subtest noreorder-priority: SUCCESS (7.586s) [254.231136] [052/133] (767s left) gem_lmem_swapping (verify-ccs) [254.281671] Subtest verify-ccs: SKIP (0.000s) [254.327857] [053/133] (767s left) gem_ctx_isolation (dirty-create) [254.384097] Starting subtest: dirty-create [254.386471] Starting dynamic subtest: rcs0 [254.688950] Dynamic subtest rcs0: SUCCESS (0.304s) [254.700080] Starting dynamic subtest: bcs0 [254.968969] Dynamic subtest bcs0: SUCCESS (0.279s) [254.977322] Starting dynamic subtest: vcs0 [255.226081] Dynamic subtest vcs0: SUCCESS (0.256s) [255.236645] Starting dynamic subtest: vcs1 [257.120184] Dynamic subtest vcs1: SUCCESS (1.893s) [257.128084] Starting dynamic subtest: vecs0 [259.100074] Dynamic subtest vecs0: SUCCESS (1.978s) [259.109956] Starting dynamic subtest: ccs0 [261.100664] Dynamic subtest ccs0: SUCCESS (1.999s) [261.103141] Subtest dirty-create: SUCCESS (6.717s) [261.326932] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [261.427870] Starting subtest: fbc-pr-plane-move-sf-dmg-area [261.432383] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [261.508977] [055/133] (760s left) dmabuf (all-tests) [261.544898] Starting subtest: all-tests [261.546999] Starting dynamic subtest: sanitycheck [261.650997] Dynamic subtest sanitycheck: SUCCESS (0.107s) [261.661876] Starting dynamic subtest: dma_fence [261.868539] Dynamic subtest dma_fence: SUCCESS (0.215s) [261.883647] Starting dynamic subtest: dma_fence_chain [271.349679] Dynamic subtest dma_fence_chain: SUCCESS (9.479s) [271.360513] Starting dynamic subtest: dma_fence_unwrap [271.436202] Dynamic subtest dma_fence_unwrap: SUCCESS (0.085s) [271.446766] Starting dynamic subtest: dma_resv [271.520671] Dynamic subtest dma_resv: SUCCESS (0.082s) [271.523480] Subtest all-tests: SUCCESS (9.979s) [271.604540] [056/133] (750s left) syncobj_timeline (reset-unsignaled) [271.655148] Starting subtest: reset-unsignaled [271.657399] Subtest reset-unsignaled: SUCCESS (0.000s) [271.757238] [057/133] (750s left) syncobj_wait (multi-wait-signaled) [271.805445] Starting subtest: multi-wait-signaled [271.807365] Subtest multi-wait-signaled: SUCCESS (0.000s) [271.898183] [058/133] (750s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [271.990241] Starting subtest: 2x-flip-vs-absolute-wf_vblank [272.001642] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [272.080820] [059/133] (750s left) kms_psr (pr-cursor-mmap-cpu) [272.182055] Starting subtest: pr-cursor-mmap-cpu [272.186687] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [272.287044] [060/133] (750s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [272.347401] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [272.449298] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [272.524917] [061/133] (749s left) kms_atomic_transition (modeset-transition-fencing) [272.614498] Starting subtest: modeset-transition-fencing [272.616329] Starting dynamic subtest: 1x-outputs [283.469568] Dynamic subtest 1x-outputs: SUCCESS (10.852s) [283.472133] Subtest modeset-transition-fencing: SUCCESS (10.854s) [284.325407] [062/133] (738s left) kms_psr (fbc-psr2-cursor-plane-onoff) [284.421179] Starting subtest: fbc-psr2-cursor-plane-onoff [284.423373] Starting dynamic subtest: eDP-1 [284.427329] Dynamic subtest eDP-1: SKIP (0.000s) [284.431299] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [284.495330] [063/133] (737s left) i915_hangman (error-state-basic) [284.563953] Starting subtest: error-state-basic [284.712249] Subtest error-state-basic: SUCCESS (0.147s) [284.828319] [064/133] (737s left) gem_tiled_fence_blits (basic) [284.912580] Subtest basic: SKIP (0.000s) [284.969300] [065/133] (737s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [285.064494] Starting subtest: fbc-rgb565-draw-mmap-cpu [289.012266] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.950s) [290.144850] [066/133] (732s left) gem_gpgpu_fill (offset-16x16) [290.207211] Starting subtest: offset-16x16 [290.213882] Subtest offset-16x16: SUCCESS (0.008s) [290.348390] [067/133] (732s left) perf_pmu (all-busy-check-all) [290.403734] Starting subtest: all-busy-check-all [291.863442] Subtest all-busy-check-all: SUCCESS (1.458s) [291.954895] [068/133] (730s left) gen9_exec_parse (unaligned-jump) [292.029779] Subtest unaligned-jump: SKIP (0.000s) [292.085521] [069/133] (730s left) i915_pm_rpm (system-suspend-execbuf) [294.020768] Starting subtest: system-suspend-execbuf [352.498129] Subtest system-suspend-execbuf: SUCCESS (43.059s) [352.882290] [070/133] (669s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [352.980945] Starting subtest: fbc-farfromfence-mmap-gtt [352.984996] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [353.073821] [071/133] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [353.176874] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [353.181212] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [353.275916] [072/133] (669s left) kms_psr (psr2-sprite-render) [353.367714] Starting subtest: psr2-sprite-render [353.369917] Starting dynamic subtest: eDP-1 [355.077313] Dynamic subtest eDP-1: SUCCESS (1.709s) [355.079687] Subtest psr2-sprite-render: SUCCESS (1.710s) [355.937935] [073/133] (666s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [356.032651] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [356.034923] Starting dynamic subtest: pipe-A-eDP-1 [356.054996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [356.067398] Starting dynamic subtest: pipe-B-eDP-1 [356.086687] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [356.095419] Starting dynamic subtest: pipe-C-eDP-1 [356.114621] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [356.123298] Starting dynamic subtest: pipe-D-eDP-1 [356.142657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [356.144859] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [358.305116] [074/133] (664s left) perf_pmu (idle-no-semaphores) [358.350557] Starting subtest: idle-no-semaphores [358.352636] Starting dynamic subtest: rcs0 [358.897379] Dynamic subtest rcs0: SUCCESS (0.544s) [358.908140] Starting dynamic subtest: bcs0 [359.419032] Dynamic subtest bcs0: SUCCESS (0.518s) [359.429561] Starting dynamic subtest: vcs0 [359.941858] Dynamic subtest vcs0: SUCCESS (0.519s) [359.954793] Starting dynamic subtest: vcs1 [360.455719] Dynamic subtest vcs1: SUCCESS (0.511s) [360.467526] Starting dynamic subtest: vecs0 [360.977917] Dynamic subtest vecs0: SUCCESS (0.519s) [360.990508] Starting dynamic subtest: ccs0 [361.494866] Dynamic subtest ccs0: SUCCESS (0.514s) [361.497699] Subtest idle-no-semaphores: SUCCESS (3.145s) [361.615028] [075/133] (661s left) gem_exec_fence (syncobj-timeline-signal) [362.172076] Starting subtest: syncobj-timeline-signal [362.178568] Subtest syncobj-timeline-signal: SUCCESS (0.012s) [363.436902] [076/133] (659s left) kms_plane_multiple (tiling-yf) [363.527700] Starting subtest: tiling-yf [363.531819] Subtest tiling-yf: SKIP (0.000s) [363.600102] [077/133] (659s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [363.694441] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [363.696786] Starting dynamic subtest: pipe-A [364.764086] Dynamic subtest pipe-A: SUCCESS (1.072s) [364.778148] Starting dynamic subtest: pipe-B [366.916052] Dynamic subtest pipe-B: SUCCESS (2.150s) [366.925206] Starting dynamic subtest: pipe-C [368.089452] Dynamic subtest pipe-C: SUCCESS (1.171s) [368.100238] Starting dynamic subtest: pipe-D [369.322089] Dynamic subtest pipe-D: SUCCESS (1.230s) [369.324659] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.631s) [370.507901] [078/133] (652s left) kms_flip (flip-vs-expired-vblank) [370.602805] Starting subtest: flip-vs-expired-vblank [370.605083] Starting dynamic subtest: A-eDP1 [379.304615] Dynamic subtest A-eDP1: SUCCESS (8.700s) [379.315588] Starting dynamic subtest: B-eDP1 [387.945030] Dynamic subtest B-eDP1: SUCCESS (8.638s) [387.955675] Starting dynamic subtest: C-eDP1 [396.576415] Dynamic subtest C-eDP1: SUCCESS (8.629s) [396.587785] Starting dynamic subtest: D-eDP1 [405.209274] Dynamic subtest D-eDP1: SUCCESS (8.629s) [405.214341] Subtest flip-vs-expired-vblank: SUCCESS (34.607s) [406.392403] [079/133] (616s left) syncobj_timeline (single-wait-for-submit-available-signaled) [406.466268] Starting subtest: single-wait-for-submit-available-signaled [406.468781] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [406.587005] [080/133] (616s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [406.685041] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [407.487287] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s) [407.647854] [081/133] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [407.755657] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [417.163815] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.409s) [417.304494] [082/133] (605s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [417.403911] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [417.406257] Starting dynamic subtest: pipe-A-eDP-1 [417.427158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [417.441614] Starting dynamic subtest: pipe-B-eDP-1 [417.461238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [417.470421] Starting dynamic subtest: pipe-C-eDP-1 [417.490071] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [417.499124] Starting dynamic subtest: pipe-D-eDP-1 [417.518702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [417.520911] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [419.649137] [083/133] (603s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [419.757336] Starting subtest: fbc-2p-pri-indfb-multidraw [419.761720] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [419.870965] [084/133] (603s left) gem_render_tiled_blits (basic) [419.928388] Subtest basic: SKIP (0.000s) [419.994109] [085/133] (603s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [420.094438] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [420.096728] Starting dynamic subtest: pipe-A-eDP-1 [420.121667] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [420.133082] Starting dynamic subtest: pipe-B-eDP-1 [420.153933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [420.162695] Starting dynamic subtest: pipe-C-eDP-1 [420.183452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [420.194900] Starting dynamic subtest: pipe-D-eDP-1 [420.216771] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [420.221104] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [422.411894] [086/133] (601s left) kms_vblank (ts-continuation-dpms-rpm) [422.498857] Starting subtest: ts-continuation-dpms-rpm [422.501397] Starting dynamic subtest: pipe-A-eDP-1 [425.007232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.509s) [425.022452] Starting dynamic subtest: pipe-D-eDP-1 [427.249109] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s) [427.251498] Subtest ts-continuation-dpms-rpm: SUCCESS (4.753s) [428.040858] [087/133] (595s left) gem_exec_whisper (basic-fds-priority) [428.117093] Starting subtest: basic-fds-priority [451.804698] Subtest basic-fds-priority: SUCCESS (23.684s) [451.999592] [088/133] (571s left) kms_pm_rpm (legacy-planes-dpms) [453.533549] Starting subtest: legacy-planes-dpms [453.536073] Starting dynamic subtest: plane-64 [461.813469] Dynamic subtest plane-64: SUCCESS (8.282s) [461.825612] Starting dynamic subtest: plane-94 [470.103342] Dynamic subtest plane-94: SUCCESS (8.284s) [470.115571] Starting dynamic subtest: plane-124 [478.407540] Dynamic subtest plane-124: SUCCESS (8.303s) [478.419261] Starting dynamic subtest: plane-134 [486.710384] Dynamic subtest plane-134: SUCCESS (8.299s) [486.713377] Subtest legacy-planes-dpms: SUCCESS (33.179s) [487.081228] [089/133] (536s left) intel_hwmon (hwmon-write) [487.143761] Subtest hwmon-write: SKIP (0.000s) [487.197248] [090/133] (536s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [487.298991] Starting subtest: fbcpsr-rgb101010-draw-pwrite [494.309185] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.012s) [494.422134] [091/133] (529s left) syncobj_basic (bad-pad-fd-to-handle) [494.475309] Starting subtest: bad-pad-fd-to-handle [494.477488] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [494.560718] [092/133] (529s left) gen9_exec_parse (bb-chained) [494.614222] Subtest bb-chained: SKIP (0.000s) [494.700274] [093/133] (529s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [494.798583] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [502.140461] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.344s) [502.272682] [094/133] (521s left) gem_exec_params (rel-constants-invalid-ring) [502.335853] Starting subtest: rel-constants-invalid-ring [502.338108] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [502.441819] [095/133] (521s left) gem_workarounds (suspend-resume-fd) [502.505156] Starting subtest: suspend-resume-fd [518.648680] Subtest suspend-resume-fd: SUCCESS (1.158s) [519.790817] [096/133] (505s left) kms_color (ctm-signed) [519.905703] Starting subtest: ctm-signed [519.908179] Starting dynamic subtest: pipe-A-eDP-1 [522.016926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s) [522.026811] Starting dynamic subtest: pipe-B-eDP-1 [524.878946] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.857s) [524.888913] Starting dynamic subtest: pipe-C-eDP-1 [527.586952] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.703s) [527.596992] Starting dynamic subtest: pipe-D-eDP-1 [530.243507] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s) [530.246253] Subtest ctm-signed: SUCCESS (10.328s) [531.070563] [097/133] (493s left) kms_cursor_crc (cursor-random-256x256) [531.324936] Starting subtest: cursor-random-256x256 [531.327409] Starting dynamic subtest: pipe-A-eDP-1 [534.666198] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.336s) [534.694317] Starting dynamic subtest: pipe-D-eDP-1 [538.695169] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.007s) [538.697972] Subtest cursor-random-256x256: SUCCESS (7.370s) [539.539500] [098/133] (485s left) gem_mmap_gtt (ptrace) [539.603209] Subtest ptrace: SKIP (0.000s) [539.656827] [099/133] (485s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [539.753922] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [543.290488] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.540s) [544.439075] [100/133] (480s left) gem_exec_balancer (parallel-balancer) [544.687120] Starting subtest: parallel-balancer [545.614191] Subtest parallel-balancer: SUCCESS (0.926s) [545.722167] [101/133] (479s left) syncobj_timeline (etime-single-wait-all-submitted) [545.776207] Starting subtest: etime-single-wait-all-submitted [545.881828] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s) [545.962109] [102/133] (479s left) api_intel_bb (crc32) [546.025443] Starting subtest: crc32 [546.027965] Starting dynamic subtest: rcs0-smem0 [546.303658] Dynamic subtest rcs0-smem0: SUCCESS (0.280s) [546.315863] Starting dynamic subtest: bcs0-smem0 [546.608177] Dynamic subtest bcs0-smem0: SUCCESS (0.301s) [546.621172] Starting dynamic subtest: vcs0-smem0 [546.992639] Dynamic subtest vcs0-smem0: SUCCESS (0.383s) [547.008642] Starting dynamic subtest: vcs1-smem0 [547.392626] Dynamic subtest vcs1-smem0: SUCCESS (0.396s) [547.405350] Starting dynamic subtest: vecs0-smem0 [547.735791] Dynamic subtest vecs0-smem0: SUCCESS (0.339s) [547.747467] Starting dynamic subtest: ccs0-smem0 [548.085686] Dynamic subtest ccs0-smem0: SUCCESS (0.347s) [548.088783] Subtest crc32: SUCCESS (2.064s) [548.213364] [103/133] (476s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [548.319012] Starting subtest: psr-rgb565-draw-mmap-gtt [548.324226] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [548.429045] [104/133] (476s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [548.489853] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [548.592894] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [548.672229] [105/133] (476s left) gem_exec_reloc (basic-cpu-wc) [548.729081] Subtest basic-cpu-wc: SKIP (0.000s) [548.801221] [106/133] (476s left) api_intel_bb (purge-bb) [548.864425] Starting subtest: purge-bb [548.867105] Subtest purge-bb: SUCCESS (0.004s) [548.989567] [107/133] (476s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [549.083961] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [549.086617] Starting dynamic subtest: pipe-A [549.456079] Dynamic subtest pipe-A: SUCCESS (0.374s) [549.466217] Starting dynamic subtest: pipe-B [550.839017] Dynamic subtest pipe-B: SUCCESS (1.381s) [550.848664] Starting dynamic subtest: pipe-C [552.265801] Dynamic subtest pipe-C: SUCCESS (1.426s) [552.275985] Starting dynamic subtest: pipe-D [553.709649] Dynamic subtest pipe-D: SUCCESS (1.443s) [553.712184] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.627s) [554.854006] [108/133] (470s left) gem_mmap_gtt (basic-write-read-distinct) [554.910919] Subtest basic-write-read-distinct: SKIP (0.000s) [554.975722] [109/133] (470s left) kms_feature_discovery (psr1) [555.066055] Starting subtest: psr1 [555.068489] Subtest psr1: SUCCESS (0.000s) [555.139547] [110/133] (470s left) kms_cursor_crc (cursor-tearing-position-change) [555.245496] Starting subtest: cursor-tearing-position-change [555.248067] Starting dynamic subtest: pipe-A-eDP-1 [555.810432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [555.822799] Starting dynamic subtest: pipe-D-eDP-1 [557.092441] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s) [557.095107] Subtest cursor-tearing-position-change: SUCCESS (1.848s) [557.931582] [111/133] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [558.027753] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [558.032821] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [558.134955] [112/133] (467s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [558.226750] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [558.231411] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [558.298314] [113/133] (467s left) gem_bad_reloc (negative-reloc) [558.350052] Subtest negative-reloc: SKIP (0.000s) [558.422914] [114/133] (467s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [558.512062] Starting subtest: primary-yf-tiled-reflect-x-180 [558.573111] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s) [558.676749] [115/133] (467s left) drm_read (empty-block) [558.814443] Starting subtest: empty-block [559.815029] Subtest empty-block: SUCCESS (1.000s) [559.951074] [116/133] (465s left) gem_render_copy (yf-tiled-to-vebox-linear) [560.019418] Starting subtest: yf-tiled-to-vebox-linear [560.025008] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [560.227783] [117/133] (465s left) kms_pm_rpm (dpms-lpsp) [562.460716] Starting subtest: dpms-lpsp [562.766912] Subtest dpms-lpsp: SUCCESS (0.308s) [562.858391] [118/133] (462s left) kms_cursor_legacy (forked-move) [562.978076] Starting subtest: forked-move [562.980814] Starting dynamic subtest: pipe-A [568.437957] Dynamic subtest pipe-A: SUCCESS (5.457s) [568.456168] Starting dynamic subtest: pipe-B [573.906212] Dynamic subtest pipe-B: SUCCESS (5.465s) [573.917106] Starting dynamic subtest: pipe-C [579.377867] Dynamic subtest pipe-C: SUCCESS (5.469s) [579.389566] Starting dynamic subtest: pipe-D [584.854626] Dynamic subtest pipe-D: SUCCESS (5.471s) [584.867050] Starting dynamic subtest: all-pipes [590.333172] Dynamic subtest all-pipes: SUCCESS (5.477s) [590.335866] Subtest forked-move: SUCCESS (27.351s) [590.478068] [119/133] (435s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [590.568415] Starting subtest: flip-primary-invalidate-overlay [602.239674] Subtest flip-primary-invalidate-overlay: SUCCESS (11.672s) [602.377542] [120/133] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [602.473669] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [602.477314] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [602.582147] [121/133] (423s left) kms_content_protection (srm) [602.726948] Starting subtest: srm [602.731330] Subtest srm: SKIP (0.002s) [602.851645] [122/133] (423s left) prime_busy (after-wait) [602.909668] Starting subtest: after-wait [602.914857] Starting dynamic subtest: rcs0 [602.945447] Dynamic subtest rcs0: SUCCESS (0.032s) [602.956425] Starting dynamic subtest: bcs0 [602.986922] Dynamic subtest bcs0: SUCCESS (0.041s) [602.996742] Starting dynamic subtest: vcs0 [603.028629] Dynamic subtest vcs0: SUCCESS (0.041s) [603.038334] Starting dynamic subtest: vcs1 [603.072455] Dynamic subtest vcs1: SUCCESS (0.043s) [603.084400] Starting dynamic subtest: vecs0 [603.113845] Dynamic subtest vecs0: SUCCESS (0.041s) [603.123349] Starting dynamic subtest: ccs0 [603.156198] Dynamic subtest ccs0: SUCCESS (0.042s) [603.264851] Subtest after-wait: SUCCESS (0.353s) [603.347643] [123/133] (422s left) kms_pipe_crc_basic (disable-crc-after-crtc) [603.460317] Starting subtest: disable-crc-after-crtc [603.463187] Starting dynamic subtest: pipe-A-eDP-1 [605.083967] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.624s) [605.093964] Starting dynamic subtest: pipe-B-eDP-1 [607.364106] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.275s) [607.374719] Starting dynamic subtest: pipe-C-eDP-1 [609.615516] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s) [609.625568] Starting dynamic subtest: pipe-D-eDP-1 [611.892471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.281s) [611.895007] Subtest disable-crc-after-crtc: SUCCESS (8.433s) [612.722237] [124/133] (413s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [612.814874] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [612.817662] Starting dynamic subtest: pipe-A-eDP-1 [618.710692] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.900s) [618.720678] Starting dynamic subtest: pipe-B-eDP-1 [625.369973] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.658s) [625.373048] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.562s) [626.242726] [125/133] (399s left) kms_universal_plane (universal-plane-sanity) [626.338659] Starting subtest: universal-plane-sanity [626.340887] Starting dynamic subtest: pipe-A-eDP-1 [626.932940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s) [626.947960] Starting dynamic subtest: pipe-B-eDP-1 [628.162665] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.228s) [628.174463] Starting dynamic subtest: pipe-C-eDP-1 [629.370189] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s) [629.381042] Starting dynamic subtest: pipe-D-eDP-1 [630.604536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [630.607157] Subtest universal-plane-sanity: SUCCESS (4.268s) [631.471460] [126/133] (394s left) kms_invalid_mode (clock-too-high) [631.569420] Starting subtest: clock-too-high [631.572029] Starting dynamic subtest: pipe-A-eDP-1 [631.576829] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [631.587688] Starting dynamic subtest: pipe-B-eDP-1 [631.592937] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [631.602743] Starting dynamic subtest: pipe-C-eDP-1 [631.607589] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [631.616873] Starting dynamic subtest: pipe-D-eDP-1 [631.622069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [631.627186] Subtest clock-too-high: SKIP (0.004s) [631.666414] [127/133] (394s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [631.762694] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [631.767822] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [631.833944] [128/133] (394s left) gem_eio (wait-immediate) [632.066919] Starting subtest: wait-immediate [632.434906] Subtest wait-immediate: SUCCESS (0.370s) [632.567544] [129/133] (393s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [632.662292] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [632.666690] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [632.756588] [130/133] (393s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [632.808084] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [632.914467] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [632.992538] [131/133] (393s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [633.088670] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [640.385757] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.301s) [640.503508] [132/133] (385s left) i915_suspend (basic-s2idle-without-i915) [640.540429] Starting subtest: basic-s2idle-without-i915 [662.086386] Subtest basic-s2idle-without-i915: SUCCESS (6.785s) [662.189735] [133/133] (364s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [662.301173] Starting subtest: fbc-rgb565-draw-blt [666.487187] Subtest fbc-rgb565-draw-blt: SUCCESS (4.181s) [667.623278] 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.