[58.263413] Initializing watchdogs
[58.263467]   /dev/watchdog0
[58.277984] [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]
[58.282496] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.284814] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.288671] [001/133] (960s left) syncobj_wait (invalid-single-wait-unsubmitted)
[58.366791] Starting subtest: invalid-single-wait-unsubmitted
[58.369614] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[58.462215] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[58.590234] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[59.677644] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.090s)
[59.809429] [003/133] (959s left) kms_atomic_transition (plane-all-modeset-transition)
[59.898450] Starting subtest: plane-all-modeset-transition
[59.901895] Subtest plane-all-modeset-transition: SKIP (0.000s)
[59.997303] [004/133] (958s left) kms_psr (pr-primary-render)
[60.093359] Starting subtest: pr-primary-render
[60.096910] Subtest pr-primary-render: SKIP (0.000s)
[60.180671] [005/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[60.277061] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[60.280530] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[60.378800] [006/133] (958s left) gem_render_copy (y-tiled-ccs-to-linear)
[60.430061] Starting subtest: y-tiled-ccs-to-linear
[60.433825] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[60.607754] [007/133] (958s left) gem_gpgpu_fill (offset-16x16)
[60.661840] Starting subtest: offset-16x16
[60.668369] Subtest offset-16x16: SUCCESS (0.008s)
[60.794956] [008/133] (958s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[60.845259] Starting subtest: multi-wait-for-submit-available-signaled
[60.848067] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[60.943663] [009/133] (958s left) core_setmaster (master-drop-set-shared-fd)
[61.028958] Starting subtest: master-drop-set-shared-fd
[61.048651] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[61.084243] [010/133] (958s left) kms_plane (plane-position-hole)
[61.171989] Starting subtest: plane-position-hole
[61.715957] Starting dynamic subtest: pipe-A-plane-1
[63.044422] Dynamic subtest pipe-A-plane-1: SUCCESS (1.331s)
[63.056672] Starting dynamic subtest: pipe-A-plane-2
[64.391128] Dynamic subtest pipe-A-plane-2: SUCCESS (1.348s)
[64.400368] Starting dynamic subtest: pipe-A-plane-3
[65.668476] Dynamic subtest pipe-A-plane-3: SUCCESS (1.279s)
[65.678396] Starting dynamic subtest: pipe-A-plane-4
[66.909930] Dynamic subtest pipe-A-plane-4: SUCCESS (1.241s)
[66.920262] Starting dynamic subtest: pipe-A-plane-5
[66.941738] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[68.167197] Starting dynamic subtest: pipe-B-plane-1
[69.466503] Dynamic subtest pipe-B-plane-1: SUCCESS (1.309s)
[69.476304] Starting dynamic subtest: pipe-B-plane-2
[70.723828] Dynamic subtest pipe-B-plane-2: SUCCESS (1.258s)
[70.731906] Starting dynamic subtest: pipe-B-plane-3
[72.078708] Dynamic subtest pipe-B-plane-3: SUCCESS (1.355s)
[72.087216] Starting dynamic subtest: pipe-B-plane-4
[73.379806] Dynamic subtest pipe-B-plane-4: SUCCESS (1.300s)
[73.389058] Starting dynamic subtest: pipe-B-plane-5
[73.407955] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[73.409942] Subtest plane-position-hole: SUCCESS (12.246s)
[74.289374] [011/133] (944s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[74.384913] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[74.387259] Starting dynamic subtest: pipe-A-eDP-1
[74.444573] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[74.453330] Starting dynamic subtest: pipe-B-eDP-1
[74.509611] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[74.518091] Starting dynamic subtest: pipe-C-eDP-1
[74.574630] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[74.583081] Starting dynamic subtest: pipe-D-eDP-1
[74.639416] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[74.643901] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[76.711428] [012/133] (942s left) kms_psr (fbc-psr-basic)
[76.812217] Starting subtest: fbc-psr-basic
[76.814104] Starting dynamic subtest: eDP-1
[76.818162] Dynamic subtest eDP-1: SKIP (0.000s)
[76.822177] Subtest fbc-psr-basic: SKIP (0.001s)
[76.887773] [013/133] (942s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[77.015201] Starting subtest: cursorB-vs-flipA-toggle
[77.019792] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[77.156816] [014/133] (942s left) kms_psr (psr2-sprite-plane-move)
[77.251877] Starting subtest: psr2-sprite-plane-move
[77.254236] Starting dynamic subtest: eDP-1
[79.030047] Dynamic subtest eDP-1: SUCCESS (1.779s)
[79.032355] Subtest psr2-sprite-plane-move: SUCCESS (1.780s)
[79.872843] [015/133] (939s left) gem_ctx_shared (single-timeline)
[79.943742] Starting subtest: single-timeline
[79.965668] Subtest single-timeline: SUCCESS (0.017s)
[80.196297] [016/133] (939s left) i915_drm_fdinfo (memory-info-purgeable)
[80.240843] Starting subtest: memory-info-purgeable
[80.242741] Starting dynamic subtest: smem0
[83.060555] Dynamic subtest smem0: SUCCESS (2.821s)
[83.062794] Subtest memory-info-purgeable: SUCCESS (2.822s)
[83.143609] [017/133] (936s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[83.242104] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[83.245797] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[83.317743] [018/133] (936s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[83.411971] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[83.415579] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[83.491840] [019/133] (936s left) syncobj_eventfd (binary-wait)
[83.551656] Starting subtest: binary-wait
[83.560140] Subtest binary-wait: SUCCESS (0.010s)
[83.650881] [020/133] (935s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[83.747986] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[83.750070] Starting dynamic subtest: pipe-A-eDP-1
[83.844970] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[83.854918] Starting dynamic subtest: pipe-B-eDP-1
[84.963823] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[84.968328] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.219s)
[86.150404] [021/133] (933s left) kms_display_modes (extended-mode-basic)
[86.240225] Starting subtest: extended-mode-basic
[86.244334] Subtest extended-mode-basic: SKIP (0.000s)
[86.286494] [022/133] (933s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[86.386081] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[86.390581] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.473212] [023/133] (933s left) gem_flink_race (flink_name)
[86.509176] Starting subtest: flink_name
[91.927508] Subtest flink_name: SUCCESS (5.416s)
[92.049911] [024/133] (927s left) api_intel_bb (reset-flags)
[92.101076] Starting subtest: reset-flags
[92.113600] Subtest reset-flags: SUCCESS (0.015s)
[92.223771] [025/133] (927s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[92.354488] Starting subtest: flip-vs-cursor-crc-atomic
[93.065451] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.710s)
[93.881211] [026/133] (925s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[93.983790] Starting subtest: fbc-psr2-cursor-mmap-cpu
[93.986141] Starting dynamic subtest: eDP-1
[93.990276] Dynamic subtest eDP-1: SKIP (0.000s)
[93.994523] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[94.080862] [027/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[94.183374] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[94.187466] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[94.275352] [028/133] (925s left) gem_eio (in-flight-contexts-10ms)
[94.479590] Starting subtest: in-flight-contexts-10ms
[107.942263] Subtest in-flight-contexts-10ms: SUCCESS (13.461s)
[108.112376] [029/133] (911s left) gen9_exec_parse (batch-zero-length)
[108.179672] Subtest batch-zero-length: SKIP (0.000s)
[108.248648] [030/133] (911s left) gem_exec_reloc (basic-active)
[108.312536] Subtest basic-active: SKIP (0.000s)
[108.382651] [031/133] (911s left) kms_cursor_crc (cursor-size-hints)
[108.509390] Starting subtest: cursor-size-hints
[108.511769] Starting dynamic subtest: pipe-A-eDP-1
[109.137145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[109.146057] Starting dynamic subtest: pipe-D-eDP-1
[110.442098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[110.444512] Subtest cursor-size-hints: SUCCESS (1.932s)
[111.233567] [032/133] (908s left) kms_cursor_edge_walk (128x128-top-bottom)
[111.339139] Starting subtest: 128x128-top-bottom
[111.341393] Starting dynamic subtest: pipe-A-eDP-1
[114.803440] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[114.812232] Starting dynamic subtest: pipe-D-eDP-1
[117.925781] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[117.928089] Subtest 128x128-top-bottom: SUCCESS (6.588s)
[118.717691] [033/133] (901s left) i915_drm_fdinfo (virtual-busy-idle)
[118.762674] Starting subtest: virtual-busy-idle
[118.766855] Subtest virtual-busy-idle: SKIP (0.000s)
[118.828336] [034/133] (901s left) gem_create (hog-create)
[118.884688] Starting subtest: hog-create
[118.887103] Starting dynamic subtest: smem0
[152.916255] Dynamic subtest smem0: SUCCESS (34.029s)
[152.918722] Subtest hog-create: SUCCESS (34.031s)
[153.112518] [035/133] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[153.226424] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[159.917916] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.693s)
[160.043972] [036/133] (860s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[160.137709] Starting subtest: nonblocking-crc-frame-sequence
[160.140119] Starting dynamic subtest: pipe-A-eDP-1
[160.888341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[160.897273] Starting dynamic subtest: pipe-B-eDP-1
[162.341180] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[162.350208] Starting dynamic subtest: pipe-C-eDP-1
[163.728535] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[163.737942] Starting dynamic subtest: pipe-D-eDP-1
[165.049074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[165.051352] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.911s)
[165.858804] [037/133] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[165.954908] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[169.544450] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.591s)
[170.674422] [038/133] (849s left) kms_vblank (query-idle-hang)
[170.768414] Starting subtest: query-idle-hang
[170.770633] Starting dynamic subtest: pipe-A-eDP-1
[197.654250] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.885s)
[197.668322] Starting dynamic subtest: pipe-D-eDP-1
[212.695815] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[212.698077] Subtest query-idle-hang: SUCCESS (41.928s)
[213.515385] [039/133] (806s left) kms_frontbuffer_tracking (psr-1p-rte)
[213.625142] Starting subtest: psr-1p-rte
[219.049187] Subtest psr-1p-rte: SUCCESS (5.428s)
[219.194604] [040/133] (801s left) gem_exec_schedule (noreorder-priority)
[219.383493] Starting subtest: noreorder-priority
[219.385874] Starting dynamic subtest: rcs0
[220.504973] Dynamic subtest rcs0: SUCCESS (1.121s)
[220.515749] Starting dynamic subtest: vcs0
[221.902698] Dynamic subtest vcs0: SUCCESS (1.395s)
[221.913805] Starting dynamic subtest: vcs1
[223.890697] Dynamic subtest vcs1: SUCCESS (1.986s)
[223.901755] Starting dynamic subtest: vecs0
[225.875902] Dynamic subtest vecs0: SUCCESS (1.983s)
[225.887061] Starting dynamic subtest: ccs0
[227.010065] Dynamic subtest ccs0: SUCCESS (1.134s)
[227.012576] Subtest noreorder-priority: SUCCESS (7.628s)
[227.199461] [041/133] (793s left) kms_chamelium_frames (hdmi-frame-dump)
[227.599128] Subtest hdmi-frame-dump: SKIP (0.000s)
[228.373449] [042/133] (792s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[228.483360] Starting subtest: fbcpsr-rgb565-draw-pwrite
[235.628529] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.147s)
[235.741241] [043/133] (784s left) perf_pmu (enable-race)
[235.787812] Starting subtest: enable-race
[235.790352] Starting dynamic subtest: rcs0
[248.557135] Dynamic subtest rcs0: SUCCESS (12.770s)
[248.565680] Starting dynamic subtest: bcs0
[261.307648] Dynamic subtest bcs0: SUCCESS (12.748s)
[261.317797] Starting dynamic subtest: vcs0
[276.887091] Dynamic subtest vcs0: SUCCESS (15.577s)
[276.904087] Starting dynamic subtest: vcs1
[292.888053] Dynamic subtest vcs1: SUCCESS (15.998s)
[292.898969] Starting dynamic subtest: vecs0
[308.887489] Dynamic subtest vecs0: SUCCESS (15.997s)
[308.898679] Starting dynamic subtest: ccs0
[321.626836] Dynamic subtest ccs0: SUCCESS (12.739s)
[321.629750] Subtest enable-race: SUCCESS (85.841s)
[321.739970] [044/133] (698s left) kms_lease (setcrtc-implicit-plane)
[321.843141] Starting subtest: setcrtc-implicit-plane
[321.845442] Starting dynamic subtest: pipe-A-eDP-1
[322.326355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[322.334682] Starting dynamic subtest: pipe-B-eDP-1
[323.458314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[323.466781] Starting dynamic subtest: pipe-C-eDP-1
[324.581535] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[324.591027] Starting dynamic subtest: pipe-D-eDP-1
[325.708450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[325.710853] Subtest setcrtc-implicit-plane: SUCCESS (3.866s)
[326.545268] [045/133] (694s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[326.651950] Starting subtest: yf-tiled-8bpp-rotate-180
[326.656251] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[326.762352] [046/133] (693s left) gem_mmap_wc (write-read-distinct)
[326.822582] Subtest write-read-distinct: SKIP (0.000s)
[326.875464] [047/133] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[326.980049] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[333.831138] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.855s)
[333.934502] [048/133] (686s left) kms_cursor_crc (cursor-onscreen-256x85)
[334.216596] Starting subtest: cursor-onscreen-256x85
[334.268204] Subtest cursor-onscreen-256x85: SKIP (0.045s)
[334.463154] [049/133] (686s left) vgem_basic (bad-handle)
[334.567951] Starting subtest: bad-handle
[334.570277] Subtest bad-handle: SUCCESS (0.000s)
[334.633821] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[334.637873] [050/133] (686s left) syncobj_timeline (invalid-signal-bad-pad)
[334.694463] Starting subtest: invalid-signal-bad-pad
[334.696730] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[334.799347] [051/133] (686s left) i915_pm_rpm (system-suspend-devices)
[337.133638] Starting subtest: system-suspend-devices
[344.895332] Subtest system-suspend-devices: SUCCESS (7.766s)
[345.281489] [052/133] (675s left) gem_eio (in-flight-external)
[345.531943] Starting subtest: in-flight-external
[346.977494] Subtest in-flight-external: SUCCESS (1.445s)
[347.131401] [053/133] (673s left) gem_wait (write-wait)
[347.192840] Starting subtest: write-wait
[347.195206] Starting dynamic subtest: all-engines
[348.290871] Dynamic subtest all-engines: SUCCESS (1.097s)
[348.307623] Starting dynamic subtest: rcs0
[349.344519] Dynamic subtest rcs0: SUCCESS (1.051s)
[349.360774] Starting dynamic subtest: bcs0
[350.400580] Dynamic subtest bcs0: SUCCESS (1.053s)
[350.415984] Starting dynamic subtest: vcs0
[351.451852] Dynamic subtest vcs0: SUCCESS (1.049s)
[351.468330] Starting dynamic subtest: vcs1
[352.505975] Dynamic subtest vcs1: SUCCESS (1.051s)
[352.521990] Starting dynamic subtest: vecs0
[353.558599] Dynamic subtest vecs0: SUCCESS (1.051s)
[353.574657] Starting dynamic subtest: ccs0
[354.614595] Dynamic subtest ccs0: SUCCESS (1.053s)
[354.619592] Subtest write-wait: SUCCESS (7.422s)
[354.819897] [054/133] (666s left) gem_mmap_gtt (big-copy)
[354.890506] Subtest big-copy: SKIP (0.000s)
[354.961903] [055/133] (666s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[355.075145] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[355.079657] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[355.169544] [056/133] (665s left) gem_exec_balancer (parallel-keep-submit-fence)
[355.441368] Starting subtest: parallel-keep-submit-fence
[356.576221] Subtest parallel-keep-submit-fence: SUCCESS (1.136s)
[356.686147] [057/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[356.778602] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[379.727606] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.950s)
[379.843244] [058/133] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[379.950228] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[379.953724] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[380.048904] [059/133] (641s left) kms_color (ctm-blue-to-red)
[380.140298] Starting subtest: ctm-blue-to-red
[380.141992] Starting dynamic subtest: pipe-A-eDP-1
[380.830240] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[380.839762] Starting dynamic subtest: pipe-B-eDP-1
[382.214108] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[382.223109] Starting dynamic subtest: pipe-C-eDP-1
[383.583650] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[383.593465] Starting dynamic subtest: pipe-D-eDP-1
[384.926755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[384.928942] Subtest ctm-blue-to-red: SUCCESS (4.786s)
[385.728470] [060/133] (635s left) gem_spin_batch (user-each)
[385.789389] Starting subtest: user-each
[389.062551] Subtest user-each: SUCCESS (3.266s)
[390.962305] [061/133] (630s left) gem_mmap_wc (bad-object)
[391.021159] Subtest bad-object: SKIP (0.000s)
[391.087208] [062/133] (630s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[391.206088] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[391.210663] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[391.307727] [063/133] (630s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[391.410953] Starting subtest: y-tiled-8bpp-rotate-0
[391.415246] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[391.523129] [064/133] (629s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[391.620052] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[391.622162] Starting dynamic subtest: pipe-A-default-mode
[394.382801] Dynamic subtest pipe-A-default-mode: SUCCESS (2.762s)
[394.385129] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.764s)
[395.242879] [065/133] (626s left) gem_exec_params (invalid-bsd1-flag-on-render)
[395.332254] Starting subtest: invalid-bsd1-flag-on-render
[395.334127] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[395.442038] [066/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[395.535251] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[395.539644] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[395.630300] [067/133] (625s left) gem_exec_schedule (u-semaphore-codependency)
[395.696217] Starting subtest: u-semaphore-codependency
[395.703084] Subtest u-semaphore-codependency: SUCCESS (0.014s)
[396.041355] [068/133] (625s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[396.092459] Starting subtest: etime-multi-wait-all-for-submit-submitted
[396.193672] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[396.273142] [069/133] (625s left) kms_pm_dc (dc5-dpms)
[397.378048] Starting subtest: dc5-dpms
[399.490533] Subtest dc5-dpms: SUCCESS (2.112s)
[399.569811] [070/133] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[399.680194] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[399.684622] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[399.782036] [071/133] (621s left) sw_sync (sync_multi_consumer_producer)
[399.822868] Starting subtest: sync_multi_consumer_producer
[400.107539] Subtest sync_multi_consumer_producer: SUCCESS (0.287s)
[400.181435] [072/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[400.287076] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[403.950955] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.667s)
[405.146986] [073/133] (616s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[405.247079] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[405.249341] Starting dynamic subtest: pipe-A
[405.269438] Dynamic subtest pipe-A: SKIP (0.019s)
[405.278974] Starting dynamic subtest: pipe-B
[405.302367] Dynamic subtest pipe-B: SKIP (0.033s)
[405.311584] Starting dynamic subtest: pipe-C
[405.337507] Dynamic subtest pipe-C: SKIP (0.033s)
[405.346538] Starting dynamic subtest: pipe-D
[405.370269] Dynamic subtest pipe-D: SKIP (0.033s)
[405.373976] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.122s)
[405.474055] [074/133] (616s left) syncobj_timeline (wait-all-for-submit-complex)
[405.525291] Starting subtest: wait-all-for-submit-complex
[405.739058] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[405.817844] [075/133] (616s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[405.925940] Starting subtest: fbc-rgb565-draw-mmap-wc
[409.970061] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.047s)
[411.150759] [076/133] (610s left) gem_exec_fence (submit3)
[411.330082] Starting subtest: submit3
[411.334387] Subtest submit3: SKIP (0.000s)
[412.964194] [077/133] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[413.075442] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[413.079829] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[413.166553] [078/133] (608s left) gem_exec_whisper (basic-contexts-forked-all)
[413.245019] Starting subtest: basic-contexts-forked-all
[435.951675] Subtest basic-contexts-forked-all: SUCCESS (22.701s)
[436.147347] [079/133] (585s left) kms_flip (plain-flip-ts-check-interruptible)
[436.253487] Starting subtest: plain-flip-ts-check-interruptible
[436.255878] Starting dynamic subtest: A-eDP1
[445.115845] Dynamic subtest A-eDP1: SUCCESS (8.860s)
[445.130757] Starting dynamic subtest: B-eDP1
[453.956437] Dynamic subtest B-eDP1: SUCCESS (8.839s)
[453.969765] Starting dynamic subtest: C-eDP1
[462.781495] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[462.792907] Starting dynamic subtest: D-eDP1
[471.600997] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[471.603777] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.349s)
[472.782780] [080/133] (549s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[472.847421] Starting subtest: multi-wait-for-submit-submitted-signaled
[472.849388] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[472.967890] [081/133] (549s left) api_intel_bb (blit-noreloc-purge-cache)
[473.026469] Starting subtest: blit-noreloc-purge-cache
[473.034513] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[473.173832] [082/133] (548s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[473.287544] Starting subtest: basic-flip-before-cursor-varying-size
[474.223758] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.935s)
[475.039818] [083/133] (547s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[475.137633] Starting subtest: psr-rgb101010-draw-render
[482.559872] Subtest psr-rgb101010-draw-render: SUCCESS (7.424s)
[482.676329] [084/133] (539s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[482.727881] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[482.730122] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[482.844296] [085/133] (539s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[482.944178] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[482.990452] [086/133] (539s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[483.087252] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[483.091534] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[483.156135] [087/133] (539s left) kms_vblank (crtc-id)
[483.250902] Starting subtest: crtc-id
[483.252790] Starting dynamic subtest: pipe-A-eDP-1
[483.699776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[483.714016] Starting dynamic subtest: pipe-D-eDP-1
[484.797223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[484.799510] Subtest crtc-id: SUCCESS (1.547s)
[485.648626] [088/133] (536s left) perf (blocking-parameterized)
[485.768869] Starting subtest: blocking-parameterized
[505.792372] Subtest blocking-parameterized: SUCCESS (20.021s)
[505.842575] [089/133] (516s left) kms_hdr (static-toggle-dpms)
[505.938833] Starting subtest: static-toggle-dpms
[505.945116] Subtest static-toggle-dpms: SKIP (0.000s)
[506.014063] [090/133] (516s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[506.101777] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[510.134668] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.037s)
[511.340452] [091/133] (511s left) kms_psr (psr-primary-blt)
[511.440902] Starting subtest: psr-primary-blt
[511.443162] Starting dynamic subtest: eDP-1
[513.136175] Dynamic subtest eDP-1: SUCCESS (1.695s)
[513.138277] Subtest psr-primary-blt: SUCCESS (1.696s)
[514.013067] [092/133] (508s left) gem_exec_balancer (invalid-balancer)
[514.066284] Starting subtest: invalid-balancer
[514.977066] Subtest invalid-balancer: SUCCESS (0.909s)
[515.282550] [093/133] (507s left) kms_fb_coherency (memset-crc)
[515.371214] Starting subtest: memset-crc
[515.373515] Starting dynamic subtest: mmap-offset-wc
[515.768333] Dynamic subtest mmap-offset-wc: SUCCESS (0.400s)
[516.071764] Starting dynamic subtest: mmap-offset-uc
[522.280260] Dynamic subtest mmap-offset-uc: SUCCESS (6.218s)
[522.568335] Subtest memset-crc: SUCCESS (7.200s)
[523.374411] [094/133] (499s left) kms_flip (2x-wf_vblank-ts-check)
[523.476468] Starting subtest: 2x-wf_vblank-ts-check
[523.485411] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[523.595364] [095/133] (499s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[523.680182] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[523.705792] Starting dynamic subtest: pipe-A-plane-0
[523.994404] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[524.006511] Starting dynamic subtest: pipe-A-plane-3
[524.228574] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[524.239072] Starting dynamic subtest: pipe-A-plane-5
[524.243538] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.358531] Starting dynamic subtest: pipe-B-plane-0
[525.650165] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[525.660515] Starting dynamic subtest: pipe-B-plane-3
[525.883488] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[525.893873] Starting dynamic subtest: pipe-B-plane-5
[525.899575] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[526.194609] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.515s)
[527.037755] [096/133] (495s left) gem_render_copy_redux (flink)
[527.105441] Starting subtest: flink
[527.971977] Subtest flink: SUCCESS (0.868s)
[528.091091] [097/133] (494s left) gem_busy (semaphore)
[528.272177] Subtest semaphore: SKIP (0.000s)
[528.498109] [098/133] (494s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[528.593194] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[528.595078] Starting dynamic subtest: pipe-A-eDP-1
[529.339553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[529.349074] Starting dynamic subtest: pipe-B-eDP-1
[531.172868] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.831s)
[531.183312] Starting dynamic subtest: pipe-C-eDP-1
[533.019699] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.845s)
[533.029461] Starting dynamic subtest: pipe-D-eDP-1
[534.839574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.819s)
[534.841422] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.241s)
[535.968856] [099/133] (486s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[536.072559] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[536.896964] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[537.061431] [100/133] (485s left) i915_query (query-regions-unallocated)
[537.118270] Starting subtest: query-regions-unallocated
[537.120427] Subtest query-regions-unallocated: SUCCESS (0.000s)
[537.206128] [101/133] (485s left) gem_ctx_persistence (legacy-engines-hostile)
[537.277841] Starting subtest: legacy-engines-hostile
[537.280561] Starting dynamic subtest: render
[537.397851] Dynamic subtest render: SUCCESS (0.119s)
[537.412744] Starting dynamic subtest: bsd1
[537.487679] Dynamic subtest bsd1: SUCCESS (0.087s)
[537.501974] Starting dynamic subtest: bsd2
[537.576728] Dynamic subtest bsd2: SUCCESS (0.086s)
[537.588865] Starting dynamic subtest: blt
[537.645668] Dynamic subtest blt: SUCCESS (0.066s)
[537.656174] Starting dynamic subtest: vebox
[537.764860] Dynamic subtest vebox: SUCCESS (0.117s)
[537.767607] Subtest legacy-engines-hostile: SUCCESS (0.488s)
[537.859189] [102/133] (485s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[537.972956] Starting subtest: 2x-cursor-vs-flip-atomic
[537.976398] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[538.121308] [103/133] (484s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[538.214704] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[538.216677] Starting dynamic subtest: pipe-A-eDP-1
[538.234109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[538.243978] Starting dynamic subtest: pipe-B-eDP-1
[538.261539] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[538.270454] Starting dynamic subtest: pipe-C-eDP-1
[538.286442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[538.295954] Starting dynamic subtest: pipe-D-eDP-1
[538.311945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[538.313822] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.012s)
[540.520559] [104/133] (482s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[540.613480] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[540.615356] Starting dynamic subtest: pipe-A-eDP-1
[573.326352] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.933s)
[573.336789] Starting dynamic subtest: pipe-B-eDP-1
[606.256993] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.704s)
[606.274040] Starting dynamic subtest: pipe-C-eDP-1
[639.243511] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.648s)
[639.256817] Starting dynamic subtest: pipe-D-eDP-1
[672.237210] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.653s)
[672.239634] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.942s)
[673.468778] [105/133] (349s left) kms_pm_rpm (universal-planes-dpms)
[675.026220] Starting subtest: universal-planes-dpms
[675.028684] Starting dynamic subtest: plane-34
[685.513992] Dynamic subtest plane-34: SUCCESS (10.530s)
[685.526989] Starting dynamic subtest: plane-64
[693.832256] Dynamic subtest plane-64: SUCCESS (8.328s)
[693.845443] Starting dynamic subtest: plane-94
[702.149358] Dynamic subtest plane-94: SUCCESS (8.321s)
[702.163963] Starting dynamic subtest: plane-124
[710.423321] Dynamic subtest plane-124: SUCCESS (8.270s)
[710.436591] Starting dynamic subtest: plane-134
[718.759882] Dynamic subtest plane-134: SUCCESS (8.335s)
[718.772451] Starting dynamic subtest: plane-144
[727.050347] Dynamic subtest plane-144: SUCCESS (8.289s)
[727.053381] Subtest universal-planes-dpms: SUCCESS (52.089s)
[727.431274] [106/133] (295s left) gem_ctx_param (vm)
[727.500087] Starting subtest: vm
[727.546506] Subtest vm: SUCCESS (0.046s)
[727.678915] [107/133] (295s left) gem_pxp (reject-modify-context-protection-on)
[727.807817] Starting subtest: reject-modify-context-protection-on
[727.810543] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[727.925311] [108/133] (295s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[727.984897] Starting subtest: etime-single-wait-available-unsubmitted
[728.093177] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[728.172119] [109/133] (295s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[728.236474] Starting subtest: wait-all-for-submit-delayed-submit
[728.338401] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[728.430965] [110/133] (294s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[728.823020] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[729.624028] [111/133] (293s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[729.718336] Starting subtest: bo-too-small-due-to-tiling
[729.722942] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[729.835259] [112/133] (293s left) kms_atomic (plane-primary-legacy)
[729.946280] Starting subtest: plane-primary-legacy
[729.948563] Starting dynamic subtest: pipe-A-eDP-1
[730.431237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[730.433682] Subtest plane-primary-legacy: SUCCESS (0.487s)
[731.285428] [113/133] (292s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[731.342942] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[731.424263] [114/133] (292s left) gem_mmap_offset (mmap-boundaries)
[731.486866] Starting subtest: mmap-boundaries
[731.489079] Starting dynamic subtest: smem0
[731.772035] Dynamic subtest smem0: SUCCESS (0.284s)
[731.774918] Subtest mmap-boundaries: SUCCESS (0.285s)
[731.911794] [115/133] (291s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[731.978649] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[731.983127] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[732.162507] [116/133] (291s left) kms_async_flips (crc)
[732.251383] Starting subtest: crc
[732.622282] Starting dynamic subtest: pipe-A-eDP-1
[735.486971] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.863s)
[735.882794] Starting dynamic subtest: pipe-B-eDP-1
[738.748092] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[739.123135] Starting dynamic subtest: pipe-C-eDP-1
[742.056977] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.946s)
[742.421465] Starting dynamic subtest: pipe-D-eDP-1
[745.275048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s)
[745.277387] Subtest crc: SUCCESS (13.030s)
[746.447066] [117/133] (277s left) gem_partial_pwrite_pread (write)
[746.509203] Subtest write: SKIP (0.000s)
[746.576798] [118/133] (277s left) kms_getfb (getfb2-accept-nv12)
[746.659402] Starting subtest: getfb2-accept-nv12
[746.661709] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[746.764807] [119/133] (276s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[746.833944] Starting subtest: basic-batch-kernel-default-cmd
[746.838598] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[747.020391] [120/133] (276s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[747.112273] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[747.114700] Starting dynamic subtest: pipe-A-eDP-1
[747.138095] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[747.151173] Starting dynamic subtest: pipe-B-eDP-1
[747.169977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[747.180473] Starting dynamic subtest: pipe-C-eDP-1
[747.201352] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[747.211001] Starting dynamic subtest: pipe-D-eDP-1
[747.232059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[747.236342] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[749.419358] [121/133] (274s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[749.530221] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[750.154056] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[750.308245] [122/133] (273s left) gem_mmap_gtt (fault-concurrent-x)
[750.365439] Subtest fault-concurrent-X: SKIP (0.000s)
[750.423673] [123/133] (273s left) perf (non-sampling-read-error)
[750.516523] Starting subtest: non-sampling-read-error
[750.523562] Subtest non-sampling-read-error: SUCCESS (0.008s)
[750.569577] [124/133] (273s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[750.626630] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[750.685138] [125/133] (273s left) kms_flip (2x-flip-vs-dpms-on-nop)
[750.774055] Starting subtest: 2x-flip-vs-dpms-on-nop
[750.785429] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[750.874480] [126/133] (273s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[750.995920] Starting subtest: cursorB-vs-flipB-atomic
[751.000261] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[751.140354] [127/133] (272s left) gem_ctx_bad_destroy (invalid-ctx)
[751.192117] Starting subtest: invalid-ctx
[751.194060] Subtest invalid-ctx: SUCCESS (0.000s)
[751.269366] [128/133] (272s left) kms_psr (fbc-pr-dpms)
[751.360877] Starting subtest: fbc-pr-dpms
[751.364443] Subtest fbc-pr-dpms: SKIP (0.000s)
[751.448579] [129/133] (272s left) perf_pmu (all-busy-idle-check-all)
[751.494420] Starting subtest: all-busy-idle-check-all
[752.196242] Subtest all-busy-idle-check-all: FAIL (0.643s)
[752.758335] [130/133] (271s left) kms_fbcon_fbt (psr)
[752.822882] Starting subtest: psr
[760.117106] Subtest psr: SUCCESS (7.293s)
[760.195043] [131/133] (264s left) sw_sync (sync_expired_merge)
[760.238730] Starting subtest: sync_expired_merge
[761.311247] Subtest sync_expired_merge: SUCCESS (1.074s)
[761.388524] [132/133] (262s left) gem_eio (throttle)
[761.599004] Starting subtest: throttle
[761.893855] Subtest throttle: SUCCESS (0.295s)
[762.038359] [133/133] (262s left) kms_content_protection (uevent)
[762.177971] Starting subtest: uevent
[762.182463] Subtest uevent: SKIP (0.000s)
[762.297636] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_atomic_transition
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: gem_gpgpu_fill
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: core_setmaster
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_ctx_shared
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_eventfd
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_display_modes
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_flink_race
results: parsing output: 23/ for test: api_intel_bb
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_cursor_edge_walk
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: gem_create
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_chamelium_frames
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: i915_pm_rpm
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: gem_wait
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: gem_spin_batch
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_pm_dc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_tiled_display
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_fb_coherency
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: gem_render_copy_redux
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: gem_partial_pwrite_pread
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_ctx_bad_destroy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_fbcon_fbt
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_content_protection
Done.