[60.401595] Initializing watchdogs [60.401645] /dev/watchdog0 [60.415901] [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] [60.420383] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.422581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.425905] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [60.571077] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [61.596869] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.022s) [62.483998] [002/133] (958s left) kms_hdr (brightness-with-hdr) [62.585129] Starting subtest: brightness-with-hdr [62.591822] Subtest brightness-with-hdr: SKIP (0.000s) [62.659871] [003/133] (958s left) gem_sync (basic-store-all) [62.735377] Starting subtest: basic-store-all [65.741694] Subtest basic-store-all: SUCCESS (3.017s) [65.929571] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [65.991620] Starting subtest: heartbeat-stop [65.996257] Subtest heartbeat-stop: SKIP (0.000s) [66.088348] [005/133] (954s left) gem_ctx_shared (q-smoketest) [66.149887] Starting subtest: Q-smoketest [66.152329] Starting dynamic subtest: rcs0 [71.736039] Dynamic subtest rcs0: SUCCESS (5.484s) [71.744398] Starting dynamic subtest: bcs0 [77.245292] Dynamic subtest bcs0: SUCCESS (5.507s) [77.257856] Starting dynamic subtest: vcs0 [82.720134] Dynamic subtest vcs0: SUCCESS (5.479s) [82.727354] Starting dynamic subtest: vcs1 [88.193805] Dynamic subtest vcs1: SUCCESS (5.467s) [88.205484] Starting dynamic subtest: vecs0 [93.671416] Dynamic subtest vecs0: SUCCESS (5.480s) [93.680014] Starting dynamic subtest: ccs0 [99.143493] Dynamic subtest ccs0: SUCCESS (5.471s) [99.146319] Subtest Q-smoketest: SUCCESS (32.890s) [99.229682] [006/133] (921s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [99.619602] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [100.476352] [007/133] (920s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [100.607135] Starting subtest: cursorA-vs-flipA-atomic-transitions [111.759211] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.152s) [112.636871] [008/133] (908s left) gem_pread (display) [112.705435] Subtest display: SKIP (0.000s) [112.762845] [009/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [112.874721] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [113.898492] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s) [114.055497] [010/133] (907s left) gen3_render_tiledy_blits [114.172338] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [114.270563] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [114.272507] Starting dynamic subtest: pipe-A-default-mode [115.400959] Dynamic subtest pipe-A-default-mode: SKIP (1.126s) [115.405119] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.128s) [115.539887] [012/133] (905s left) gem_mmap_gtt (big-bo-tiledy) [115.605194] Subtest big-bo-tiledY: SKIP (0.000s) [115.659778] [013/133] (905s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [115.757392] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [115.759761] Starting dynamic subtest: A-eDP1 [124.626685] Dynamic subtest A-eDP1: SUCCESS (8.869s) [124.635981] Starting dynamic subtest: B-eDP1 [133.554343] Dynamic subtest B-eDP1: SUCCESS (8.926s) [133.562974] Starting dynamic subtest: C-eDP1 [142.524682] Dynamic subtest C-eDP1: SUCCESS (8.924s) [142.533149] Starting dynamic subtest: D-eDP1 [151.452432] Dynamic subtest D-eDP1: SUCCESS (8.923s) [151.454397] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.655s) [152.635860] [014/133] (868s left) kms_atomic_transition (plane-all-transition-nonblocking) [152.732717] Starting subtest: plane-all-transition-nonblocking [152.735658] Starting dynamic subtest: pipe-A-eDP-1 [155.224070] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [155.541477] Starting dynamic subtest: pipe-B-eDP-1 [158.769932] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.236s) [159.068577] Subtest plane-all-transition-nonblocking: SUCCESS (6.338s) [159.906699] [015/133] (861s left) gem_softpin (allocator-fork) [159.972483] Starting subtest: allocator-fork [162.238448] Subtest allocator-fork: SUCCESS (2.211s) [162.302809] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [162.406802] Starting subtest: x-tiled-8bpp-rotate-180 [163.642644] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.236s) [163.752517] [017/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [163.846346] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [163.849744] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [163.942187] [018/133] (857s left) gem_create (create-clear) [164.002261] Starting subtest: create-clear [164.004482] Starting dynamic subtest: smem0 [196.818891] Dynamic subtest smem0: SUCCESS (32.811s) [196.821089] Subtest create-clear: SUCCESS (32.812s) [197.005874] [019/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [197.122668] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [197.126838] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [197.223114] [020/133] (824s left) kms_chamelium_color (ctm-max) [197.310311] Subtest ctm-max: SKIP (0.000s) [197.350973] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [197.410150] Starting subtest: yf-tiled-ccs-to-linear [197.414721] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [197.592978] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [197.685936] Starting subtest: fbc-shrfb-scaledprimary [200.700326] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.018s) [201.889280] [023/133] (819s left) kms_big_fb (y-tiled-64bpp-rotate-180) [201.984021] Starting subtest: y-tiled-64bpp-rotate-180 [201.988561] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [202.074281] [024/133] (819s left) gem_userptr_blits (unsync-overlap) [202.139986] Subtest unsync-overlap: SKIP (0.000s) [202.267827] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle) [202.323997] Starting subtest: invalid-signal-illegal-handle [202.326320] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [202.424369] [026/133] (819s left) gem_exec_schedule (timeslicing) [202.507754] Starting subtest: timeslicing [202.509849] Starting dynamic subtest: rcs0 [202.519594] Dynamic subtest rcs0: SUCCESS (0.021s) [202.529208] Starting dynamic subtest: bcs0 [202.540762] Dynamic subtest bcs0: SUCCESS (0.020s) [202.547850] Starting dynamic subtest: vcs0 [202.563374] Dynamic subtest vcs0: SUCCESS (0.022s) [202.572149] Starting dynamic subtest: vcs1 [202.586354] Dynamic subtest vcs1: SUCCESS (0.021s) [202.594389] Starting dynamic subtest: vecs0 [202.607123] Dynamic subtest vecs0: SUCCESS (0.020s) [202.614271] Starting dynamic subtest: ccs0 [202.626967] Dynamic subtest ccs0: SUCCESS (0.019s) [202.629174] Subtest timeslicing: SUCCESS (0.130s) [203.968217] [027/133] (817s left) kms_lease (lease-unleased-crtc) [204.062300] Starting subtest: lease-unleased-crtc [204.064603] Starting dynamic subtest: pipe-A-eDP-1 [204.356525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [204.364568] Starting dynamic subtest: pipe-B-eDP-1 [205.135315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.777s) [205.145515] Starting dynamic subtest: pipe-C-eDP-1 [205.147840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [205.155146] Starting dynamic subtest: pipe-D-eDP-1 [205.156999] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [205.158870] Subtest lease-unleased-crtc: SUCCESS (1.087s) [205.505722] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [205.593137] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [212.389312] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.799s) [212.524949] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [212.625743] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [212.630118] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [212.719031] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21) [212.900882] Starting subtest: cursor-offscreen-64x21 [212.953970] Subtest cursor-offscreen-64x21: SKIP (0.048s) [213.169666] [031/133] (808s left) kms_vrr (negative-basic) [213.249185] Starting subtest: negative-basic [213.255409] Starting dynamic subtest: pipe-A-eDP-1 [218.725376] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s) [218.972801] Subtest negative-basic: SUCCESS (5.723s) [219.776580] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [219.894792] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [219.898951] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [220.002294] [033/133] (802s left) gem_wait (write-wait) [220.061536] Starting subtest: write-wait [220.063753] Starting dynamic subtest: all-engines [221.206951] Dynamic subtest all-engines: SUCCESS (1.145s) [221.222349] Starting dynamic subtest: rcs0 [222.262705] Dynamic subtest rcs0: SUCCESS (1.053s) [222.278543] Starting dynamic subtest: bcs0 [223.320468] Dynamic subtest bcs0: SUCCESS (1.056s) [223.337242] Starting dynamic subtest: vcs0 [224.375025] Dynamic subtest vcs0: SUCCESS (1.052s) [224.390982] Starting dynamic subtest: vcs1 [225.428994] Dynamic subtest vcs1: SUCCESS (1.052s) [225.445374] Starting dynamic subtest: vecs0 [226.482082] Dynamic subtest vecs0: SUCCESS (1.051s) [226.498020] Starting dynamic subtest: ccs0 [227.538755] Dynamic subtest ccs0: SUCCESS (1.055s) [227.541164] Subtest write-wait: SUCCESS (7.478s) [227.733092] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [227.736369] [034/133] (794s left) gem_exec_fence (basic-busy) [227.922216] Starting subtest: basic-busy [227.924700] Starting dynamic subtest: rcs0 [227.985155] Dynamic subtest rcs0: SUCCESS (0.063s) [227.994090] Starting dynamic subtest: bcs0 [228.040924] Dynamic subtest bcs0: SUCCESS (0.054s) [228.051197] Starting dynamic subtest: vcs0 [228.104030] Dynamic subtest vcs0: SUCCESS (0.061s) [228.113827] Starting dynamic subtest: vcs1 [228.160609] Dynamic subtest vcs1: SUCCESS (0.055s) [228.170396] Starting dynamic subtest: vecs0 [228.215473] Dynamic subtest vecs0: SUCCESS (0.053s) [228.224879] Starting dynamic subtest: ccs0 [228.271975] Dynamic subtest ccs0: SUCCESS (0.055s) [228.274391] Subtest basic-busy: SUCCESS (0.352s) [230.002647] [035/133] (792s left) gem_tiled_wc [230.115736] [036/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [230.204829] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [230.208713] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [230.288855] [037/133] (792s left) gem_exec_fence (submit) [230.464293] Starting subtest: submit [230.468690] Subtest submit: SKIP (0.000s) [231.971898] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [232.060326] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [232.062636] Starting dynamic subtest: pipe-A-eDP-1 [232.121473] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [232.130789] Starting dynamic subtest: pipe-B-eDP-1 [232.187482] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [232.198219] Starting dynamic subtest: pipe-C-eDP-1 [232.255424] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [232.264514] Starting dynamic subtest: pipe-D-eDP-1 [232.321272] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [232.325681] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [234.316159] [039/133] (788s left) vgem_basic (bad-handle) [234.359258] Starting subtest: bad-handle [234.361212] Subtest bad-handle: SUCCESS (0.000s) [234.416589] [040/133] (788s left) gem_exec_reloc (basic-cpu-wc-active) [234.487152] Subtest basic-cpu-wc-active: SKIP (0.000s) [234.554870] [041/133] (787s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [234.942604] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [235.734079] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [235.796125] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [235.859917] [043/133] (786s left) gem_readwrite (new-obj) [235.926192] Subtest new-obj: SKIP (0.000s) [235.987981] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active) [236.042628] Subtest basic-wc-cpu-active: SKIP (0.000s) [236.117433] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [236.214052] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [243.758681] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.548s) [243.882154] [046/133] (778s left) gem_pxp (fail-invalid-protected-context) [244.008634] Starting subtest: fail-invalid-protected-context [244.011067] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [244.113276] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip) [244.205969] Starting subtest: fbc-psr-primary-page-flip [244.208122] Starting dynamic subtest: eDP-1 [244.212058] Dynamic subtest eDP-1: SKIP (0.000s) [244.215919] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [244.277252] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [244.401348] Starting subtest: short-flip-before-cursor-atomic-transitions [245.347528] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s) [246.225018] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [246.328655] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [246.986113] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s) [247.156800] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [247.291948] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [247.295934] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [247.403464] [051/133] (775s left) gem_exec_schedule (noreorder-priority) [247.575288] Starting subtest: noreorder-priority [247.577866] Starting dynamic subtest: rcs0 [248.709822] Dynamic subtest rcs0: SUCCESS (1.136s) [248.720816] Starting dynamic subtest: vcs0 [249.875373] Dynamic subtest vcs0: SUCCESS (1.163s) [249.886461] Starting dynamic subtest: vcs1 [251.902072] Dynamic subtest vcs1: SUCCESS (2.023s) [251.912972] Starting dynamic subtest: vecs0 [253.886793] Dynamic subtest vecs0: SUCCESS (1.982s) [253.897593] Starting dynamic subtest: ccs0 [255.019979] Dynamic subtest ccs0: SUCCESS (1.132s) [255.022733] Subtest noreorder-priority: SUCCESS (7.448s) [255.208225] [052/133] (767s left) gem_lmem_swapping (verify-ccs) [255.257925] Subtest verify-ccs: SKIP (0.000s) [255.305230] [053/133] (767s left) gem_ctx_isolation (dirty-create) [255.377010] Starting subtest: dirty-create [255.379291] Starting dynamic subtest: rcs0 [255.612107] Dynamic subtest rcs0: SUCCESS (0.237s) [255.623065] Starting dynamic subtest: bcs0 [255.857668] Dynamic subtest bcs0: SUCCESS (0.245s) [255.867825] Starting dynamic subtest: vcs0 [256.086296] Dynamic subtest vcs0: SUCCESS (0.227s) [256.096301] Starting dynamic subtest: vcs1 [258.082490] Dynamic subtest vcs1: SUCCESS (1.995s) [258.092190] Starting dynamic subtest: vecs0 [260.121655] Dynamic subtest vecs0: SUCCESS (2.038s) [260.131384] Starting dynamic subtest: ccs0 [262.119474] Dynamic subtest ccs0: SUCCESS (1.997s) [262.121988] Subtest dirty-create: SUCCESS (6.745s) [262.347509] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [262.449150] Starting subtest: fbc-pr-plane-move-sf-dmg-area [262.453398] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [262.529897] [055/133] (760s left) dmabuf (all-tests) [262.567796] Starting subtest: all-tests [262.570078] Starting dynamic subtest: sanitycheck [262.664441] Dynamic subtest sanitycheck: SUCCESS (0.099s) [262.675234] Starting dynamic subtest: dma_fence [262.866576] Dynamic subtest dma_fence: SUCCESS (0.200s) [262.877841] Starting dynamic subtest: dma_fence_chain [272.430314] Dynamic subtest dma_fence_chain: SUCCESS (9.561s) [272.441074] Starting dynamic subtest: dma_fence_unwrap [272.515665] Dynamic subtest dma_fence_unwrap: SUCCESS (0.083s) [272.527064] Starting dynamic subtest: dma_resv [272.606360] Dynamic subtest dma_resv: SUCCESS (0.088s) [272.609221] Subtest all-tests: SUCCESS (10.043s) [272.671462] [056/133] (750s left) syncobj_timeline (reset-unsignaled) [272.722316] Starting subtest: reset-unsignaled [272.724207] Subtest reset-unsignaled: SUCCESS (0.000s) [272.808617] [057/133] (750s left) syncobj_wait (multi-wait-signaled) [272.866684] Starting subtest: multi-wait-signaled [272.868929] Subtest multi-wait-signaled: SUCCESS (0.000s) [272.965099] [058/133] (750s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [273.063373] Starting subtest: 2x-flip-vs-absolute-wf_vblank [273.071862] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [273.149715] [059/133] (750s left) kms_psr (pr-cursor-mmap-cpu) [273.240903] Starting subtest: pr-cursor-mmap-cpu [273.245345] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [273.314504] [060/133] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [273.368989] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [273.473510] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [273.561279] [061/133] (749s left) kms_atomic_transition (modeset-transition-fencing) [273.656355] Starting subtest: modeset-transition-fencing [273.658376] Starting dynamic subtest: 1x-outputs [284.591714] Dynamic subtest 1x-outputs: SUCCESS (10.936s) [284.594212] Subtest modeset-transition-fencing: SUCCESS (10.937s) [285.451506] [062/133] (737s left) kms_psr (fbc-psr2-cursor-plane-onoff) [285.543442] Starting subtest: fbc-psr2-cursor-plane-onoff [285.545411] Starting dynamic subtest: eDP-1 [285.549542] Dynamic subtest eDP-1: SKIP (0.000s) [285.553640] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [285.627910] [063/133] (737s left) i915_hangman (error-state-basic) [285.701029] Starting subtest: error-state-basic [285.839880] Subtest error-state-basic: SUCCESS (0.139s) [285.913419] [064/133] (737s left) gem_tiled_fence_blits (basic) [285.971327] Subtest basic: SKIP (0.000s) [286.044744] [065/133] (737s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [286.158872] Starting subtest: fbc-rgb565-draw-mmap-cpu [290.173167] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.018s) [291.344888] [066/133] (732s left) gem_gpgpu_fill (offset-16x16) [291.404503] Starting subtest: offset-16x16 [291.409926] Subtest offset-16x16: SUCCESS (0.008s) [291.558868] [067/133] (731s left) perf_pmu (all-busy-check-all) [291.597425] Starting subtest: all-busy-check-all [292.885909] Subtest all-busy-check-all: SUCCESS (1.287s) [292.971295] [068/133] (730s left) gen9_exec_parse (unaligned-jump) [293.037524] Subtest unaligned-jump: SKIP (0.000s) [293.116765] [069/133] (730s left) i915_pm_rpm (system-suspend-execbuf) [295.037433] Starting subtest: system-suspend-execbuf [352.872541] Subtest system-suspend-execbuf: SUCCESS (43.113s) [353.267009] [070/133] (670s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [353.396075] Starting subtest: fbc-farfromfence-mmap-gtt [353.400499] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [353.494234] [071/133] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [353.591757] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [353.595825] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [353.697636] [072/133] (670s left) kms_psr (psr2-sprite-render) [353.788439] Starting subtest: psr2-sprite-render [353.790728] Starting dynamic subtest: eDP-1 [355.543973] Dynamic subtest eDP-1: SUCCESS (1.756s) [355.546120] Subtest psr2-sprite-render: SUCCESS (1.757s) [356.410128] [073/133] (667s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [356.494525] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [356.496664] Starting dynamic subtest: pipe-A-eDP-1 [356.516015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [356.526731] Starting dynamic subtest: pipe-B-eDP-1 [356.544930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [356.553438] Starting dynamic subtest: pipe-C-eDP-1 [356.572139] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [356.580640] Starting dynamic subtest: pipe-D-eDP-1 [356.599431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [356.601223] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [358.805733] [074/133] (665s left) perf_pmu (idle-no-semaphores) [358.852139] Starting subtest: idle-no-semaphores [358.854509] Starting dynamic subtest: rcs0 [359.384709] Dynamic subtest rcs0: SUCCESS (0.532s) [359.396457] Starting dynamic subtest: bcs0 [359.904937] Dynamic subtest bcs0: SUCCESS (0.517s) [359.916800] Starting dynamic subtest: vcs0 [360.422895] Dynamic subtest vcs0: SUCCESS (0.514s) [360.434463] Starting dynamic subtest: vcs1 [360.940643] Dynamic subtest vcs1: SUCCESS (0.515s) [360.951824] Starting dynamic subtest: vecs0 [361.460819] Dynamic subtest vecs0: SUCCESS (0.517s) [361.473055] Starting dynamic subtest: ccs0 [361.979332] Dynamic subtest ccs0: SUCCESS (0.515s) [361.982577] Subtest idle-no-semaphores: SUCCESS (3.129s) [362.075398] [075/133] (661s left) gem_exec_fence (syncobj-timeline-signal) [362.639921] Starting subtest: syncobj-timeline-signal [362.648511] Subtest syncobj-timeline-signal: SUCCESS (0.014s) [363.695483] [076/133] (660s left) kms_plane_multiple (tiling-yf) [363.790406] Starting subtest: tiling-yf [363.794561] Subtest tiling-yf: SKIP (0.000s) [363.865715] [077/133] (660s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [363.950373] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [363.952605] Starting dynamic subtest: pipe-A [364.997740] Dynamic subtest pipe-A: SUCCESS (1.050s) [365.006465] Starting dynamic subtest: pipe-B [367.101986] Dynamic subtest pipe-B: SUCCESS (2.103s) [367.110668] Starting dynamic subtest: pipe-C [368.307354] Dynamic subtest pipe-C: SUCCESS (1.203s) [368.316733] Starting dynamic subtest: pipe-D [369.452870] Dynamic subtest pipe-D: SUCCESS (1.145s) [369.455243] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.505s) [370.640972] [078/133] (653s left) kms_flip (flip-vs-expired-vblank) [370.734500] Starting subtest: flip-vs-expired-vblank [370.736685] Starting dynamic subtest: A-eDP1 [379.482194] Dynamic subtest A-eDP1: SUCCESS (8.711s) [379.491009] Starting dynamic subtest: B-eDP1 [388.123445] Dynamic subtest B-eDP1: SUCCESS (8.636s) [388.139719] Starting dynamic subtest: C-eDP1 [396.754346] Dynamic subtest C-eDP1: SUCCESS (8.616s) [396.769118] Starting dynamic subtest: D-eDP1 [405.342179] Dynamic subtest D-eDP1: SUCCESS (8.631s) [405.348138] Subtest flip-vs-expired-vblank: SUCCESS (34.609s) [406.516572] [079/133] (617s left) syncobj_timeline (single-wait-for-submit-available-signaled) [406.579087] Starting subtest: single-wait-for-submit-available-signaled [406.581912] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [406.695599] [080/133] (617s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [406.793344] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [407.573917] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s) [407.738170] [081/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [407.826001] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [417.208350] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.384s) [417.349765] [082/133] (606s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [417.438776] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [417.441122] Starting dynamic subtest: pipe-A-eDP-1 [417.462162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [417.473285] Starting dynamic subtest: pipe-B-eDP-1 [417.492721] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [417.501577] Starting dynamic subtest: pipe-C-eDP-1 [417.521409] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [417.531920] Starting dynamic subtest: pipe-D-eDP-1 [417.551063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [417.553030] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [419.615608] [083/133] (604s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [419.717283] Starting subtest: fbc-2p-pri-indfb-multidraw [419.721478] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [419.813746] [084/133] (604s left) gem_render_tiled_blits (basic) [419.874507] Subtest basic: SKIP (0.000s) [419.949433] [085/133] (604s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [420.036341] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [420.038573] Starting dynamic subtest: pipe-A-eDP-1 [420.061274] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [420.071025] Starting dynamic subtest: pipe-B-eDP-1 [420.092041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [420.100497] Starting dynamic subtest: pipe-C-eDP-1 [420.121475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [420.129851] Starting dynamic subtest: pipe-D-eDP-1 [420.151446] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [420.155771] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [422.280891] [086/133] (602s left) kms_vblank (ts-continuation-dpms-rpm) [422.374005] Starting subtest: ts-continuation-dpms-rpm [422.376253] Starting dynamic subtest: pipe-A-eDP-1 [424.875323] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s) [424.890384] Starting dynamic subtest: pipe-D-eDP-1 [427.123633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s) [427.126090] Subtest ts-continuation-dpms-rpm: SUCCESS (4.751s) [428.011699] [087/133] (596s left) gem_exec_whisper (basic-fds-priority) [428.069944] Starting subtest: basic-fds-priority [452.039099] Subtest basic-fds-priority: SUCCESS (23.912s) [452.173701] [088/133] (572s left) kms_pm_rpm (legacy-planes-dpms) [453.705549] Starting subtest: legacy-planes-dpms [453.708099] Starting dynamic subtest: plane-64 [462.089129] Dynamic subtest plane-64: SUCCESS (8.386s) [462.101079] Starting dynamic subtest: plane-94 [470.680343] Dynamic subtest plane-94: SUCCESS (8.588s) [470.691436] Starting dynamic subtest: plane-124 [479.257811] Dynamic subtest plane-124: SUCCESS (8.574s) [479.269625] Starting dynamic subtest: plane-134 [487.897152] Dynamic subtest plane-134: SUCCESS (8.636s) [487.899914] Subtest legacy-planes-dpms: SUCCESS (34.194s) [488.270996] [089/133] (536s left) intel_hwmon (hwmon-write) [488.334994] Subtest hwmon-write: SKIP (0.000s) [488.392091] [090/133] (536s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [488.479821] Starting subtest: fbcpsr-rgb101010-draw-pwrite [495.522152] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.045s) [495.637399] [091/133] (528s left) syncobj_basic (bad-pad-fd-to-handle) [495.694242] Starting subtest: bad-pad-fd-to-handle [495.696130] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [495.783060] [092/133] (528s left) gen9_exec_parse (bb-chained) [495.844268] Subtest bb-chained: SKIP (0.000s) [495.909536] [093/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [496.017768] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [503.425374] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.410s) [503.553339] [094/133] (521s left) gem_exec_params (rel-constants-invalid-ring) [503.619906] Starting subtest: rel-constants-invalid-ring [503.622110] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [503.723852] [095/133] (521s left) gem_workarounds (suspend-resume-fd) [503.795355] Starting subtest: suspend-resume-fd [520.348318] Subtest suspend-resume-fd: SUCCESS (1.568s) [526.563938] [096/133] (504s left) kms_color (ctm-signed) [526.701332] Starting subtest: ctm-signed [526.703613] Starting dynamic subtest: pipe-A-eDP-1 [528.794861] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s) [528.804463] Starting dynamic subtest: pipe-B-eDP-1 [531.676207] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.876s) [531.685570] Starting dynamic subtest: pipe-C-eDP-1 [534.360603] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.683s) [534.370775] Starting dynamic subtest: pipe-D-eDP-1 [537.025206] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.662s) [537.027375] Subtest ctm-signed: SUCCESS (10.315s) [537.853964] [097/133] (493s left) kms_cursor_crc (cursor-random-256x256) [538.102136] Starting subtest: cursor-random-256x256 [538.107353] Starting dynamic subtest: pipe-A-eDP-1 [541.426380] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s) [541.456805] Starting dynamic subtest: pipe-D-eDP-1 [545.444275] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s) [545.446605] Subtest cursor-random-256x256: SUCCESS (7.340s) [546.337373] [098/133] (484s left) gem_mmap_gtt (ptrace) [546.398436] Subtest ptrace: SKIP (0.000s) [546.456579] [099/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [546.556689] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [550.115588] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.563s) [551.234482] [100/133] (479s left) gem_exec_balancer (parallel-balancer) [551.488749] Starting subtest: parallel-balancer [552.383444] Subtest parallel-balancer: SUCCESS (0.895s) [552.493986] [101/133] (478s left) syncobj_timeline (etime-single-wait-all-submitted) [552.543695] Starting subtest: etime-single-wait-all-submitted [552.651641] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [552.729700] [102/133] (478s left) api_intel_bb (crc32) [552.785237] Starting subtest: crc32 [552.787190] Starting dynamic subtest: rcs0-smem0 [553.091197] Dynamic subtest rcs0-smem0: SUCCESS (0.306s) [553.103094] Starting dynamic subtest: bcs0-smem0 [553.431120] Dynamic subtest bcs0-smem0: SUCCESS (0.337s) [553.443075] Starting dynamic subtest: vcs0-smem0 [553.844349] Dynamic subtest vcs0-smem0: SUCCESS (0.411s) [553.856617] Starting dynamic subtest: vcs1-smem0 [554.224228] Dynamic subtest vcs1-smem0: SUCCESS (0.376s) [554.236480] Starting dynamic subtest: vecs0-smem0 [554.590890] Dynamic subtest vecs0-smem0: SUCCESS (0.364s) [554.603298] Starting dynamic subtest: ccs0-smem0 [554.981187] Dynamic subtest ccs0-smem0: SUCCESS (0.387s) [554.984007] Subtest crc32: SUCCESS (2.198s) [555.120223] [103/133] (476s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [555.224143] Starting subtest: psr-rgb565-draw-mmap-gtt [555.228723] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [555.314199] [104/133] (475s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [555.371208] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [555.476948] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [555.558884] [105/133] (475s left) gem_exec_reloc (basic-cpu-wc) [555.629379] Subtest basic-cpu-wc: SKIP (0.000s) [555.700207] [106/133] (475s left) api_intel_bb (purge-bb) [555.752810] Starting subtest: purge-bb [555.754720] Subtest purge-bb: SUCCESS (0.004s) [555.881884] [107/133] (475s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [555.980749] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [555.982981] Starting dynamic subtest: pipe-A [556.321195] Dynamic subtest pipe-A: SUCCESS (0.342s) [556.330882] Starting dynamic subtest: pipe-B [557.734602] Dynamic subtest pipe-B: SUCCESS (1.412s) [557.744073] Starting dynamic subtest: pipe-C [559.160903] Dynamic subtest pipe-C: SUCCESS (1.425s) [559.171522] Starting dynamic subtest: pipe-D [560.600297] Dynamic subtest pipe-D: SUCCESS (1.438s) [560.602681] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.622s) [561.749939] [108/133] (469s left) gem_mmap_gtt (basic-write-read-distinct) [561.822806] Subtest basic-write-read-distinct: SKIP (0.000s) [561.886771] [109/133] (469s left) kms_feature_discovery (psr1) [561.973778] Starting subtest: psr1 [561.975753] Subtest psr1: SUCCESS (0.000s) [562.048823] [110/133] (469s left) kms_cursor_crc (cursor-tearing-position-change) [562.167982] Starting subtest: cursor-tearing-position-change [562.170292] Starting dynamic subtest: pipe-A-eDP-1 [562.734910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [562.744725] Starting dynamic subtest: pipe-D-eDP-1 [563.988587] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [563.991066] Subtest cursor-tearing-position-change: SUCCESS (1.820s) [564.821207] [111/133] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [564.910312] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [564.914351] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [565.001964] [112/133] (466s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [565.093473] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [565.097825] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [565.182829] [113/133] (466s left) gem_bad_reloc (negative-reloc) [565.239891] Subtest negative-reloc: SKIP (0.000s) [565.306160] [114/133] (466s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [565.398584] Starting subtest: primary-yf-tiled-reflect-x-180 [565.458494] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [565.562869] [115/133] (466s left) drm_read (empty-block) [565.707391] Starting subtest: empty-block [566.709587] Subtest empty-block: SUCCESS (1.000s) [566.858868] [116/133] (464s left) gem_render_copy (yf-tiled-to-vebox-linear) [566.922803] Starting subtest: yf-tiled-to-vebox-linear [566.927611] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [567.107987] [117/133] (464s left) kms_pm_rpm (dpms-lpsp) [568.734587] Starting subtest: dpms-lpsp [569.291654] Subtest dpms-lpsp: SUCCESS (0.557s) [569.379427] [118/133] (462s left) kms_cursor_legacy (forked-move) [569.520387] Starting subtest: forked-move [569.522671] Starting dynamic subtest: pipe-A [575.032867] Dynamic subtest pipe-A: SUCCESS (5.455s) [575.043835] Starting dynamic subtest: pipe-B [580.504905] Dynamic subtest pipe-B: SUCCESS (5.471s) [580.516272] Starting dynamic subtest: pipe-C [585.997614] Dynamic subtest pipe-C: SUCCESS (5.490s) [586.008422] Starting dynamic subtest: pipe-D [591.479256] Dynamic subtest pipe-D: SUCCESS (5.477s) [591.494999] Starting dynamic subtest: all-pipes [596.970597] Dynamic subtest all-pipes: SUCCESS (5.489s) [596.973275] Subtest forked-move: SUCCESS (27.394s) [597.061713] [119/133] (434s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [597.153856] Starting subtest: flip-primary-invalidate-overlay [608.860969] Subtest flip-primary-invalidate-overlay: SUCCESS (11.707s) [609.011445] [120/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [609.113741] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [609.117150] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [609.217535] [121/133] (422s left) kms_content_protection (srm) [609.385618] Starting subtest: srm [609.389436] Subtest srm: SKIP (0.003s) [609.543685] [122/133] (422s left) prime_busy (after-wait) [609.593907] Starting subtest: after-wait [609.598189] Starting dynamic subtest: rcs0 [609.625736] Dynamic subtest rcs0: SUCCESS (0.028s) [609.636300] Starting dynamic subtest: bcs0 [609.665156] Dynamic subtest bcs0: SUCCESS (0.039s) [609.673921] Starting dynamic subtest: vcs0 [609.705541] Dynamic subtest vcs0: SUCCESS (0.040s) [609.714478] Starting dynamic subtest: vcs1 [609.747037] Dynamic subtest vcs1: SUCCESS (0.041s) [609.756322] Starting dynamic subtest: vecs0 [609.788305] Dynamic subtest vecs0: SUCCESS (0.040s) [609.797506] Starting dynamic subtest: ccs0 [609.830045] Dynamic subtest ccs0: SUCCESS (0.041s) [609.937903] Subtest after-wait: SUCCESS (0.341s) [610.015711] [123/133] (422s left) kms_pipe_crc_basic (disable-crc-after-crtc) [610.108576] Starting subtest: disable-crc-after-crtc [610.110874] Starting dynamic subtest: pipe-A-eDP-1 [611.816518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.708s) [611.830439] Starting dynamic subtest: pipe-B-eDP-1 [614.177783] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.358s) [614.187507] Starting dynamic subtest: pipe-C-eDP-1 [616.426442] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s) [616.436127] Starting dynamic subtest: pipe-D-eDP-1 [618.691474] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s) [618.693685] Subtest disable-crc-after-crtc: SUCCESS (8.580s) [619.514458] [124/133] (412s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [619.618135] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [619.620310] Starting dynamic subtest: pipe-A-eDP-1 [625.606333] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.993s) [625.615895] Starting dynamic subtest: pipe-B-eDP-1 [632.241297] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s) [632.244043] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.629s) [633.144056] [125/133] (398s left) kms_universal_plane (universal-plane-sanity) [633.244892] Starting subtest: universal-plane-sanity [633.246848] Starting dynamic subtest: pipe-A-eDP-1 [633.846755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s) [633.856920] Starting dynamic subtest: pipe-B-eDP-1 [635.033923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s) [635.044098] Starting dynamic subtest: pipe-C-eDP-1 [636.238623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s) [636.249307] Starting dynamic subtest: pipe-D-eDP-1 [637.462954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [637.465396] Subtest universal-plane-sanity: SUCCESS (4.220s) [638.331217] [126/133] (393s left) kms_invalid_mode (clock-too-high) [638.428741] Starting subtest: clock-too-high [638.430908] Starting dynamic subtest: pipe-A-eDP-1 [638.434888] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [638.445219] Starting dynamic subtest: pipe-B-eDP-1 [638.449326] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [638.458670] Starting dynamic subtest: pipe-C-eDP-1 [638.462695] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [638.472886] Starting dynamic subtest: pipe-D-eDP-1 [638.476776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [638.480663] Subtest clock-too-high: SKIP (0.004s) [638.517906] [127/133] (393s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [638.620284] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [638.624273] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [638.687255] [128/133] (393s left) gem_eio (wait-immediate) [638.928003] Starting subtest: wait-immediate [639.291928] Subtest wait-immediate: SUCCESS (0.366s) [639.437935] [129/133] (392s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [639.534081] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [639.537469] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [639.630946] [130/133] (392s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [639.683597] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [639.788258] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [639.877624] [131/133] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [639.980597] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [647.275603] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.298s) [647.412892] [132/133] (385s left) i915_suspend (basic-s2idle-without-i915) [647.450208] Starting subtest: basic-s2idle-without-i915 [667.833730] Subtest basic-s2idle-without-i915: SUCCESS (5.238s) [673.948285] [133/133] (364s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [674.058113] Starting subtest: fbc-rgb565-draw-blt [678.260253] Subtest fbc-rgb565-draw-blt: SUCCESS (4.199s) [679.397815] 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.