[103.376423] Initializing watchdogs
[103.376469]   /dev/watchdog0
[103.390434] [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]
[103.394754] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[103.397074] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[103.400505] [001/133] (960s left) syncobj_wait (invalid-single-wait-unsubmitted)
[103.484134] Starting subtest: invalid-single-wait-unsubmitted
[103.486581] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[103.606648] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[103.713735] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[104.804159] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.091s)
[104.910563] [003/133] (959s left) kms_atomic_transition (plane-all-modeset-transition)
[104.996037] Starting subtest: plane-all-modeset-transition
[104.999747] Subtest plane-all-modeset-transition: SKIP (0.000s)
[105.064203] [004/133] (958s left) kms_psr (pr-primary-render)
[105.151403] Starting subtest: pr-primary-render
[105.154915] Subtest pr-primary-render: SKIP (0.000s)
[105.228545] [005/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[105.324820] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[105.328331] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[105.421274] [006/133] (958s left) gem_render_copy (y-tiled-ccs-to-linear)
[105.473717] Starting subtest: y-tiled-ccs-to-linear
[105.477506] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[105.654726] [007/133] (958s left) gem_gpgpu_fill (offset-16x16)
[105.715679] Starting subtest: offset-16x16
[105.722351] Subtest offset-16x16: SUCCESS (0.008s)
[105.861944] [008/133] (958s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[105.919908] Starting subtest: multi-wait-for-submit-available-signaled
[105.922638] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[106.033176] [009/133] (958s left) core_setmaster (master-drop-set-shared-fd)
[106.119639] Starting subtest: master-drop-set-shared-fd
[106.141796] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[106.173547] [010/133] (958s left) kms_plane (plane-position-hole)
[106.272205] Starting subtest: plane-position-hole
[106.779420] Starting dynamic subtest: pipe-A-plane-1
[108.075053] Dynamic subtest pipe-A-plane-1: SUCCESS (1.294s)
[108.083687] Starting dynamic subtest: pipe-A-plane-2
[109.339215] Dynamic subtest pipe-A-plane-2: SUCCESS (1.263s)
[109.347900] Starting dynamic subtest: pipe-A-plane-3
[110.671958] Dynamic subtest pipe-A-plane-3: SUCCESS (1.334s)
[110.680893] Starting dynamic subtest: pipe-A-plane-4
[111.990563] Dynamic subtest pipe-A-plane-4: SUCCESS (1.317s)
[111.998111] Starting dynamic subtest: pipe-A-plane-5
[112.017957] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[113.227246] Starting dynamic subtest: pipe-B-plane-1
[114.528610] Dynamic subtest pipe-B-plane-1: SUCCESS (1.308s)
[114.537910] Starting dynamic subtest: pipe-B-plane-2
[115.741779] Dynamic subtest pipe-B-plane-2: SUCCESS (1.214s)
[115.750927] Starting dynamic subtest: pipe-B-plane-3
[116.991144] Dynamic subtest pipe-B-plane-3: SUCCESS (1.248s)
[116.999634] Starting dynamic subtest: pipe-B-plane-4
[118.228797] Dynamic subtest pipe-B-plane-4: SUCCESS (1.238s)
[118.238256] Starting dynamic subtest: pipe-B-plane-5
[118.253613] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[118.255969] Subtest plane-position-hole: SUCCESS (11.981s)
[119.035856] [011/133] (945s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[119.142286] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[119.144471] Starting dynamic subtest: pipe-A-eDP-1
[119.200529] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[119.207132] Starting dynamic subtest: pipe-B-eDP-1
[119.262059] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[119.273488] Starting dynamic subtest: pipe-C-eDP-1
[119.330365] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[119.338841] Starting dynamic subtest: pipe-D-eDP-1
[119.396884] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[119.401257] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[121.310431] [012/133] (942s left) kms_psr (fbc-psr-basic)
[121.414400] Starting subtest: fbc-psr-basic
[121.416619] Starting dynamic subtest: eDP-1
[121.421214] Dynamic subtest eDP-1: SKIP (0.000s)
[121.425664] Subtest fbc-psr-basic: SKIP (0.000s)
[121.480519] [013/133] (942s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[121.613449] Starting subtest: cursorB-vs-flipA-toggle
[121.618173] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[121.753345] [014/133] (942s left) kms_psr (psr2-sprite-plane-move)
[121.840067] Starting subtest: psr2-sprite-plane-move
[121.842263] Starting dynamic subtest: eDP-1
[123.629969] Dynamic subtest eDP-1: SUCCESS (1.788s)
[123.632272] Subtest psr2-sprite-plane-move: SUCCESS (1.789s)
[124.464790] [015/133] (939s left) gem_ctx_shared (single-timeline)
[124.523042] Starting subtest: single-timeline
[124.541367] Subtest single-timeline: SUCCESS (0.012s)
[124.765366] [016/133] (939s left) i915_drm_fdinfo (memory-info-purgeable)
[124.804503] Starting subtest: memory-info-purgeable
[124.806775] Starting dynamic subtest: smem0
[127.305053] Dynamic subtest smem0: SUCCESS (2.502s)
[127.307099] Subtest memory-info-purgeable: SUCCESS (2.502s)
[127.374863] [017/133] (937s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[127.469996] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[127.473357] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[127.540707] [018/133] (936s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[127.639451] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[127.642833] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[127.706620] [019/133] (936s left) syncobj_eventfd (binary-wait)
[127.756888] Starting subtest: binary-wait
[127.766172] Subtest binary-wait: SUCCESS (0.010s)
[127.838242] [020/133] (936s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[127.933249] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[127.935162] Starting dynamic subtest: pipe-A-eDP-1
[128.029720] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[128.037120] Starting dynamic subtest: pipe-B-eDP-1
[129.140091] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[129.144722] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.209s)
[130.334435] [021/133] (934s left) kms_display_modes (extended-mode-basic)
[130.441307] Starting subtest: extended-mode-basic
[130.446447] Subtest extended-mode-basic: SKIP (0.000s)
[130.486423] [022/133] (934s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[130.590807] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[130.594888] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.686144] [023/133] (934s left) gem_flink_race (flink_name)
[130.719989] Starting subtest: flink_name
[136.115146] Subtest flink_name: SUCCESS (5.393s)
[136.244748] [024/133] (928s left) api_intel_bb (reset-flags)
[136.302807] Starting subtest: reset-flags
[136.315303] Subtest reset-flags: SUCCESS (0.014s)
[136.427445] [025/133] (928s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[136.550290] Starting subtest: flip-vs-cursor-crc-atomic
[137.197285] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.646s)
[138.056479] [026/133] (926s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[138.163235] Starting subtest: fbc-psr2-cursor-mmap-cpu
[138.165556] Starting dynamic subtest: eDP-1
[138.170033] Dynamic subtest eDP-1: SKIP (0.000s)
[138.174429] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[138.230383] [027/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[138.335435] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[138.339910] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[138.431796] [028/133] (926s left) gem_eio (in-flight-contexts-10ms)
[138.655126] Starting subtest: in-flight-contexts-10ms
[151.921586] Subtest in-flight-contexts-10ms: SUCCESS (13.266s)
[152.101087] [029/133] (912s left) gen9_exec_parse (batch-zero-length)
[152.168498] Subtest batch-zero-length: SKIP (0.000s)
[152.250452] [030/133] (912s left) gem_exec_reloc (basic-active)
[152.317753] Subtest basic-active: SKIP (0.000s)
[152.387279] [031/133] (912s left) kms_cursor_crc (cursor-size-hints)
[152.515142] Starting subtest: cursor-size-hints
[152.517275] Starting dynamic subtest: pipe-A-eDP-1
[153.137518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[153.147632] Starting dynamic subtest: pipe-D-eDP-1
[154.420447] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[154.422907] Subtest cursor-size-hints: SUCCESS (1.905s)
[155.207777] [032/133] (909s left) kms_cursor_edge_walk (128x128-top-bottom)
[155.313086] Starting subtest: 128x128-top-bottom
[155.315312] Starting dynamic subtest: pipe-A-eDP-1
[158.774920] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[158.788739] Starting dynamic subtest: pipe-D-eDP-1
[161.903339] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[161.905282] Subtest 128x128-top-bottom: SUCCESS (6.590s)
[162.701327] [033/133] (902s left) i915_drm_fdinfo (virtual-busy-idle)
[162.740818] Starting subtest: virtual-busy-idle
[162.745282] Subtest virtual-busy-idle: SKIP (0.000s)
[162.802791] [034/133] (902s left) gem_create (hog-create)
[162.847987] Starting subtest: hog-create
[162.850391] Starting dynamic subtest: smem0
[196.887533] Dynamic subtest smem0: SUCCESS (34.036s)
[196.890062] Subtest hog-create: SUCCESS (34.037s)
[197.066704] [035/133] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[197.185200] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[203.818329] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.636s)
[203.952243] [036/133] (861s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[204.037832] Starting subtest: nonblocking-crc-frame-sequence
[204.040090] Starting dynamic subtest: pipe-A-eDP-1
[204.771588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[204.779326] Starting dynamic subtest: pipe-B-eDP-1
[206.140672] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[206.149315] Starting dynamic subtest: pipe-C-eDP-1
[207.525114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[207.534468] Starting dynamic subtest: pipe-D-eDP-1
[208.856134] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[208.858432] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.820s)
[209.668980] [037/133] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[209.777540] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[213.330599] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.558s)
[214.480008] [038/133] (850s left) kms_vblank (query-idle-hang)
[214.581297] Starting subtest: query-idle-hang
[214.583515] Starting dynamic subtest: pipe-A-eDP-1
[240.661204] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.079s)
[240.674337] Starting dynamic subtest: pipe-D-eDP-1
[255.648056] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.984s)
[255.650614] Subtest query-idle-hang: SUCCESS (41.068s)
[256.528639] [039/133] (808s left) kms_frontbuffer_tracking (psr-1p-rte)
[256.629784] Starting subtest: psr-1p-rte
[262.070436] Subtest psr-1p-rte: SUCCESS (5.444s)
[262.206069] [040/133] (803s left) gem_exec_schedule (noreorder-priority)
[262.391595] Starting subtest: noreorder-priority
[262.393982] Starting dynamic subtest: rcs0
[263.513410] Dynamic subtest rcs0: SUCCESS (1.125s)
[263.521747] Starting dynamic subtest: vcs0
[264.919371] Dynamic subtest vcs0: SUCCESS (1.402s)
[264.927770] Starting dynamic subtest: vcs1
[266.896031] Dynamic subtest vcs1: SUCCESS (1.975s)
[266.905409] Starting dynamic subtest: vecs0
[268.879414] Dynamic subtest vecs0: SUCCESS (1.981s)
[268.889421] Starting dynamic subtest: ccs0
[270.026666] Dynamic subtest ccs0: SUCCESS (1.147s)
[270.029046] Subtest noreorder-priority: SUCCESS (7.639s)
[270.209768] [041/133] (795s left) kms_chamelium_frames (hdmi-frame-dump)
[270.605542] Subtest hdmi-frame-dump: SKIP (0.000s)
[271.382867] [042/133] (794s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[271.474282] Starting subtest: fbcpsr-rgb565-draw-pwrite
[278.580512] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.109s)
[278.699872] [043/133] (786s left) perf_pmu (enable-race)
[278.750677] Starting subtest: enable-race
[278.752883] Starting dynamic subtest: rcs0
[291.510216] Dynamic subtest rcs0: SUCCESS (12.759s)
[291.517712] Starting dynamic subtest: bcs0
[304.257908] Dynamic subtest bcs0: SUCCESS (12.746s)
[304.265855] Starting dynamic subtest: vcs0
[319.893715] Dynamic subtest vcs0: SUCCESS (15.631s)
[319.905050] Starting dynamic subtest: vcs1
[335.895210] Dynamic subtest vcs1: SUCCESS (15.998s)
[335.906407] Starting dynamic subtest: vecs0
[351.893999] Dynamic subtest vecs0: SUCCESS (15.995s)
[351.902973] Starting dynamic subtest: ccs0
[364.650684] Dynamic subtest ccs0: SUCCESS (12.755s)
[364.653192] Subtest enable-race: SUCCESS (85.898s)
[364.757189] [044/133] (700s left) kms_lease (setcrtc-implicit-plane)
[364.877104] Starting subtest: setcrtc-implicit-plane
[364.879379] Starting dynamic subtest: pipe-A-eDP-1
[365.365455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[365.373297] Starting dynamic subtest: pipe-B-eDP-1
[366.460201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[366.468644] Starting dynamic subtest: pipe-C-eDP-1
[367.567172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[367.578487] Starting dynamic subtest: pipe-D-eDP-1
[368.698483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[368.700457] Subtest setcrtc-implicit-plane: SUCCESS (3.822s)
[369.541682] [045/133] (695s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[369.636897] Starting subtest: yf-tiled-8bpp-rotate-180
[369.641122] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[369.717789] [046/133] (695s left) gem_mmap_wc (write-read-distinct)
[369.783680] Subtest write-read-distinct: SKIP (0.000s)
[369.842438] [047/133] (695s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[369.942202] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[376.760270] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.821s)
[376.857113] [048/133] (688s left) kms_cursor_crc (cursor-onscreen-256x85)
[377.134978] Starting subtest: cursor-onscreen-256x85
[377.180749] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[377.354530] [049/133] (688s left) vgem_basic (bad-handle)
[377.488700] Starting subtest: bad-handle
[377.490596] Subtest bad-handle: SUCCESS (0.000s)
[377.536587] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[377.539961] [050/133] (688s left) syncobj_timeline (invalid-signal-bad-pad)
[377.604080] Starting subtest: invalid-signal-bad-pad
[377.606358] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[377.699794] [051/133] (688s left) i915_pm_rpm (system-suspend-devices)
[379.212082] Starting subtest: system-suspend-devices
[387.004403] Subtest system-suspend-devices: SUCCESS (7.791s)
[387.398184] [052/133] (678s left) gem_eio (in-flight-external)
[387.638134] Starting subtest: in-flight-external
[388.952065] Subtest in-flight-external: SUCCESS (1.314s)
[389.067911] [053/133] (676s left) gem_wait (write-wait)
[389.129692] Starting subtest: write-wait
[389.131748] Starting dynamic subtest: all-engines
[390.221095] Dynamic subtest all-engines: SUCCESS (1.092s)
[390.237390] Starting dynamic subtest: rcs0
[391.274872] Dynamic subtest rcs0: SUCCESS (1.052s)
[391.291416] Starting dynamic subtest: bcs0
[392.332496] Dynamic subtest bcs0: SUCCESS (1.055s)
[392.348327] Starting dynamic subtest: vcs0
[393.385631] Dynamic subtest vcs0: SUCCESS (1.051s)
[393.401889] Starting dynamic subtest: vcs1
[394.439845] Dynamic subtest vcs1: SUCCESS (1.052s)
[394.455357] Starting dynamic subtest: vecs0
[395.493777] Dynamic subtest vecs0: SUCCESS (1.052s)
[395.509414] Starting dynamic subtest: ccs0
[396.549656] Dynamic subtest ccs0: SUCCESS (1.054s)
[396.552321] Subtest write-wait: SUCCESS (7.423s)
[396.751603] [054/133] (669s left) gem_mmap_gtt (big-copy)
[396.805464] Subtest big-copy: SKIP (0.000s)
[396.861341] [055/133] (669s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[396.961171] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[396.965634] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[397.056751] [056/133] (668s left) gem_exec_balancer (parallel-keep-submit-fence)
[397.325073] Starting subtest: parallel-keep-submit-fence
[398.454794] Subtest parallel-keep-submit-fence: SUCCESS (1.133s)
[398.550909] [057/133] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[398.647425] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[421.394375] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.751s)
[421.521340] [058/133] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[421.615468] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[421.618810] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[421.730273] [059/133] (644s left) kms_color (ctm-blue-to-red)
[421.825587] Starting subtest: ctm-blue-to-red
[421.827364] Starting dynamic subtest: pipe-A-eDP-1
[422.517674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[422.529606] Starting dynamic subtest: pipe-B-eDP-1
[423.915864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[423.925134] Starting dynamic subtest: pipe-C-eDP-1
[425.300203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[425.309729] Starting dynamic subtest: pipe-D-eDP-1
[426.589278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[426.591732] Subtest ctm-blue-to-red: SUCCESS (4.765s)
[427.438901] [060/133] (638s left) gem_spin_batch (user-each)
[427.493817] Starting subtest: user-each
[430.766691] Subtest user-each: SUCCESS (3.265s)
[430.961250] [061/133] (635s left) gem_mmap_wc (bad-object)
[431.027810] Subtest bad-object: SKIP (0.000s)
[431.087946] [062/133] (635s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[431.193406] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[431.197474] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[431.286440] [063/133] (634s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[431.383706] Starting subtest: y-tiled-8bpp-rotate-0
[431.388052] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[431.491630] [064/133] (634s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[431.587287] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[431.589588] Starting dynamic subtest: pipe-A-default-mode
[434.268462] Dynamic subtest pipe-A-default-mode: SUCCESS (2.682s)
[434.270838] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.683s)
[435.149045] [065/133] (631s left) gem_exec_params (invalid-bsd1-flag-on-render)
[435.214623] Starting subtest: invalid-bsd1-flag-on-render
[435.217066] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[435.318805] [066/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[435.455077] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[435.459692] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[435.560985] [067/133] (630s left) gem_exec_schedule (u-semaphore-codependency)
[435.634297] Starting subtest: u-semaphore-codependency
[435.651079] Subtest u-semaphore-codependency: SUCCESS (0.024s)
[436.025467] [068/133] (630s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[436.078697] Starting subtest: etime-multi-wait-all-for-submit-submitted
[436.185687] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[436.278227] [069/133] (630s left) kms_pm_dc (dc5-dpms)
[437.391068] Starting subtest: dc5-dpms
[439.426279] Subtest dc5-dpms: SUCCESS (2.034s)
[439.509536] [070/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[439.606954] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[439.611775] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[439.723999] [071/133] (626s left) sw_sync (sync_multi_consumer_producer)
[439.761043] Starting subtest: sync_multi_consumer_producer
[440.046462] Subtest sync_multi_consumer_producer: SUCCESS (0.287s)
[440.106162] [072/133] (626s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[440.202885] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[443.876144] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.678s)
[445.088404] [073/133] (621s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[445.173071] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[445.175184] Starting dynamic subtest: pipe-A
[445.195028] Dynamic subtest pipe-A: SKIP (0.018s)
[445.204230] Starting dynamic subtest: pipe-B
[445.225754] Dynamic subtest pipe-B: SKIP (0.031s)
[445.236407] Starting dynamic subtest: pipe-C
[445.258795] Dynamic subtest pipe-C: SKIP (0.031s)
[445.267566] Starting dynamic subtest: pipe-D
[445.289554] Dynamic subtest pipe-D: SKIP (0.031s)
[445.293136] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.113s)
[445.417066] [074/133] (621s left) syncobj_timeline (wait-all-for-submit-complex)
[445.478208] Starting subtest: wait-all-for-submit-complex
[445.691032] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[445.762528] [075/133] (621s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[445.866647] Starting subtest: fbc-rgb565-draw-mmap-wc
[449.893323] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.031s)
[451.091901] [076/133] (615s left) gem_exec_fence (submit3)
[451.279981] Starting subtest: submit3
[451.284400] Subtest submit3: SKIP (0.000s)
[452.955124] [077/133] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[453.046790] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[453.050934] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[453.147747] [078/133] (613s left) gem_exec_whisper (basic-contexts-forked-all)
[453.222036] Starting subtest: basic-contexts-forked-all
[476.050059] Subtest basic-contexts-forked-all: SUCCESS (22.824s)
[476.230704] [079/133] (590s left) kms_flip (plain-flip-ts-check-interruptible)
[476.334356] Starting subtest: plain-flip-ts-check-interruptible
[476.336858] Starting dynamic subtest: A-eDP1
[485.153186] Dynamic subtest A-eDP1: SUCCESS (8.818s)
[485.165142] Starting dynamic subtest: B-eDP1
[493.968064] Dynamic subtest B-eDP1: SUCCESS (8.812s)
[493.979954] Starting dynamic subtest: C-eDP1
[502.788212] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[502.800631] Starting dynamic subtest: D-eDP1
[511.613517] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[511.619627] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.283s)
[512.782110] [080/133] (554s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[512.842073] Starting subtest: multi-wait-for-submit-submitted-signaled
[512.844222] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[512.946982] [081/133] (554s left) api_intel_bb (blit-noreloc-purge-cache)
[512.993887] Starting subtest: blit-noreloc-purge-cache
[513.002084] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[513.098577] [082/133] (553s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[513.236498] Starting subtest: basic-flip-before-cursor-varying-size
[514.163218] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.923s)
[515.017939] [083/133] (552s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[515.125689] Starting subtest: psr-rgb101010-draw-render
[522.424214] Subtest psr-rgb101010-draw-render: SUCCESS (7.301s)
[522.553300] [084/133] (544s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[522.606593] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[522.608979] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[522.713664] [085/133] (544s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[522.813946] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[522.862088] [086/133] (544s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[522.973680] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[522.977801] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[523.040796] [087/133] (544s left) kms_vblank (crtc-id)
[523.130063] Starting subtest: crtc-id
[523.132710] Starting dynamic subtest: pipe-A-eDP-1
[523.584544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[523.599786] Starting dynamic subtest: pipe-D-eDP-1
[524.762592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.176s)
[524.764505] Subtest crtc-id: SUCCESS (1.632s)
[525.588482] [088/133] (541s left) perf (blocking-parameterized)
[525.728584] Starting subtest: blocking-parameterized
[545.752095] Subtest blocking-parameterized: SUCCESS (20.022s)
[545.802735] [089/133] (521s left) kms_hdr (static-toggle-dpms)
[545.909223] Starting subtest: static-toggle-dpms
[545.915640] Subtest static-toggle-dpms: SKIP (0.000s)
[546.006987] [090/133] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[546.113870] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[550.081257] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.971s)
[551.305592] [091/133] (516s left) kms_psr (psr-primary-blt)
[551.400242] Starting subtest: psr-primary-blt
[551.403846] Starting dynamic subtest: eDP-1
[553.190075] Dynamic subtest eDP-1: SUCCESS (1.788s)
[553.192775] Subtest psr-primary-blt: SUCCESS (1.789s)
[554.073654] [092/133] (513s left) gem_exec_balancer (invalid-balancer)
[554.131243] Starting subtest: invalid-balancer
[555.032863] Subtest invalid-balancer: SUCCESS (0.900s)
[555.338905] [093/133] (512s left) kms_fb_coherency (memset-crc)
[555.442303] Starting subtest: memset-crc
[555.444581] Starting dynamic subtest: mmap-offset-wc
[555.833040] Dynamic subtest mmap-offset-wc: SUCCESS (0.389s)
[556.133895] Starting dynamic subtest: mmap-offset-uc
[562.144938] Dynamic subtest mmap-offset-uc: SUCCESS (6.019s)
[562.438345] Subtest memset-crc: SUCCESS (6.994s)
[563.246916] [094/133] (504s left) kms_flip (2x-wf_vblank-ts-check)
[563.351743] Starting subtest: 2x-wf_vblank-ts-check
[563.371420] Subtest 2x-wf_vblank-ts-check: SKIP (0.019s)
[563.451388] [095/133] (504s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[563.541287] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[563.566818] Starting dynamic subtest: pipe-A-plane-0
[563.855715] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[563.865247] Starting dynamic subtest: pipe-A-plane-3
[564.089047] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[564.098184] Starting dynamic subtest: pipe-A-plane-5
[564.102370] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[565.211327] Starting dynamic subtest: pipe-B-plane-0
[565.505408] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[565.518822] Starting dynamic subtest: pipe-B-plane-3
[565.736223] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[565.746324] Starting dynamic subtest: pipe-B-plane-5
[565.750816] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[566.045399] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.506s)
[566.889800] [096/133] (500s left) gem_render_copy_redux (flink)
[566.946648] Starting subtest: flink
[567.814079] Subtest flink: SUCCESS (0.868s)
[567.937058] [097/133] (499s left) gem_busy (semaphore)
[568.123612] Subtest semaphore: SKIP (0.000s)
[568.356708] [098/133] (499s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[568.448177] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[568.450334] Starting dynamic subtest: pipe-A-eDP-1
[569.161740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[569.170779] Starting dynamic subtest: pipe-B-eDP-1
[570.900277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.736s)
[570.910899] Starting dynamic subtest: pipe-C-eDP-1
[572.638881] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.738s)
[572.649380] Starting dynamic subtest: pipe-D-eDP-1
[574.385780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.745s)
[574.388195] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.931s)
[575.521780] [099/133] (492s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[575.627763] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[576.440864] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s)
[576.636352] [100/133] (491s left) i915_query (query-regions-unallocated)
[576.697125] Starting subtest: query-regions-unallocated
[576.699210] Subtest query-regions-unallocated: SUCCESS (0.000s)
[576.798815] [101/133] (491s left) gem_ctx_persistence (legacy-engines-hostile)
[576.859270] Starting subtest: legacy-engines-hostile
[576.861532] Starting dynamic subtest: render
[576.947871] Dynamic subtest render: SUCCESS (0.088s)
[576.962913] Starting dynamic subtest: bsd1
[577.051061] Dynamic subtest bsd1: SUCCESS (0.100s)
[577.062857] Starting dynamic subtest: bsd2
[577.147922] Dynamic subtest bsd2: SUCCESS (0.094s)
[577.159958] Starting dynamic subtest: blt
[577.242750] Dynamic subtest blt: SUCCESS (0.092s)
[577.257727] Starting dynamic subtest: vebox
[577.332697] Dynamic subtest vebox: SUCCESS (0.087s)
[577.335230] Subtest legacy-engines-hostile: SUCCESS (0.475s)
[577.424578] [102/133] (490s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[577.538153] Starting subtest: 2x-cursor-vs-flip-atomic
[577.541964] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[577.686607] [103/133] (490s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[577.770244] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[577.772155] Starting dynamic subtest: pipe-A-eDP-1
[577.789482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[577.800417] Starting dynamic subtest: pipe-B-eDP-1
[577.816511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[577.825633] Starting dynamic subtest: pipe-C-eDP-1
[577.841972] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[577.850677] Starting dynamic subtest: pipe-D-eDP-1
[577.866587] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[577.868165] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[580.082850] [104/133] (487s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[580.188781] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[580.191246] Starting dynamic subtest: pipe-A-eDP-1
[612.377670] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.611s)
[612.392776] Starting dynamic subtest: pipe-B-eDP-1
[645.308218] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.696s)
[645.321678] Starting dynamic subtest: pipe-C-eDP-1
[678.314678] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.689s)
[678.326076] Starting dynamic subtest: pipe-D-eDP-1
[711.288663] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.670s)
[711.291048] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.671s)
[712.519579] [105/133] (355s left) kms_pm_rpm (universal-planes-dpms)
[714.753434] Starting subtest: universal-planes-dpms
[714.755818] Starting dynamic subtest: plane-34
[723.074860] Dynamic subtest plane-34: SUCCESS (8.390s)
[723.088743] Starting dynamic subtest: plane-64
[731.676231] Dynamic subtest plane-64: SUCCESS (8.623s)
[731.689212] Starting dynamic subtest: plane-94
[740.003478] Dynamic subtest plane-94: SUCCESS (8.334s)
[740.016471] Starting dynamic subtest: plane-124
[748.294758] Dynamic subtest plane-124: SUCCESS (8.285s)
[748.307165] Starting dynamic subtest: plane-134
[756.719950] Dynamic subtest plane-134: SUCCESS (8.419s)
[756.731848] Starting dynamic subtest: plane-144
[765.143558] Dynamic subtest plane-144: SUCCESS (8.419s)
[765.146396] Subtest universal-planes-dpms: SUCCESS (50.489s)
[765.517322] [106/133] (302s left) gem_ctx_param (vm)
[765.566787] Starting subtest: vm
[765.618273] Subtest vm: SUCCESS (0.050s)
[765.749564] [107/133] (302s left) gem_pxp (reject-modify-context-protection-on)
[765.880756] Starting subtest: reject-modify-context-protection-on
[765.883418] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[765.989065] [108/133] (302s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[766.046323] Starting subtest: etime-single-wait-available-unsubmitted
[766.149051] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[766.228802] [109/133] (301s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[766.279888] Starting subtest: wait-all-for-submit-delayed-submit
[766.383405] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[766.475125] [110/133] (301s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[766.864561] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[767.636073] [111/133] (300s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[767.738682] Starting subtest: bo-too-small-due-to-tiling
[767.743013] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[767.822946] [112/133] (300s left) kms_atomic (plane-primary-legacy)
[767.914107] Starting subtest: plane-primary-legacy
[767.916311] Starting dynamic subtest: pipe-A-eDP-1
[768.364453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[768.366644] Subtest plane-primary-legacy: SUCCESS (0.451s)
[769.189316] [113/133] (299s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[769.252538] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[769.324365] [114/133] (299s left) gem_mmap_offset (mmap-boundaries)
[769.381472] Starting subtest: mmap-boundaries
[769.383360] Starting dynamic subtest: smem0
[769.665241] Dynamic subtest smem0: SUCCESS (0.282s)
[769.668102] Subtest mmap-boundaries: SUCCESS (0.284s)
[769.781808] [115/133] (298s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[769.842236] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[769.846592] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[770.048352] [116/133] (298s left) kms_async_flips (crc)
[770.134118] Starting subtest: crc
[770.505319] Starting dynamic subtest: pipe-A-eDP-1
[773.418652] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[773.799437] Starting dynamic subtest: pipe-B-eDP-1
[776.731420] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.941s)
[777.106158] Starting dynamic subtest: pipe-C-eDP-1
[780.036509] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[780.401834] Starting dynamic subtest: pipe-D-eDP-1
[783.276778] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.887s)
[783.278984] Subtest crc: SUCCESS (13.148s)
[784.448758] [117/133] (284s left) gem_partial_pwrite_pread (write)
[784.516959] Subtest write: SKIP (0.000s)
[784.599335] [118/133] (283s left) kms_getfb (getfb2-accept-nv12)
[784.692953] Starting subtest: getfb2-accept-nv12
[784.695040] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[784.796184] [119/133] (283s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[784.861319] Starting subtest: basic-batch-kernel-default-cmd
[784.865569] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[785.055696] [120/133] (283s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[785.139964] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[785.142265] Starting dynamic subtest: pipe-A-eDP-1
[785.164460] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[785.176771] Starting dynamic subtest: pipe-B-eDP-1
[785.197231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[785.206090] Starting dynamic subtest: pipe-C-eDP-1
[785.226669] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[785.235552] Starting dynamic subtest: pipe-D-eDP-1
[785.256513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[785.260679] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[787.313381] [121/133] (281s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[787.417037] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[788.040721] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.625s)
[788.197737] [122/133] (280s left) gem_mmap_gtt (fault-concurrent-x)
[788.258294] Subtest fault-concurrent-X: SKIP (0.000s)
[788.318872] [123/133] (280s left) perf (non-sampling-read-error)
[788.409823] Starting subtest: non-sampling-read-error
[788.418048] Subtest non-sampling-read-error: SUCCESS (0.008s)
[788.500669] [124/133] (280s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[788.566419] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[788.631168] [125/133] (280s left) kms_flip (2x-flip-vs-dpms-on-nop)
[788.723671] Starting subtest: 2x-flip-vs-dpms-on-nop
[788.731688] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[788.810274] [126/133] (280s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[788.934146] Starting subtest: cursorB-vs-flipB-atomic
[788.938140] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[789.080242] [127/133] (279s left) gem_ctx_bad_destroy (invalid-ctx)
[789.129334] Starting subtest: invalid-ctx
[789.131437] Subtest invalid-ctx: SUCCESS (0.000s)
[789.218252] [128/133] (279s left) kms_psr (fbc-pr-dpms)
[789.315363] Starting subtest: fbc-pr-dpms
[789.318798] Subtest fbc-pr-dpms: SKIP (0.000s)
[789.387151] [129/133] (279s left) perf_pmu (all-busy-idle-check-all)
[789.429325] Starting subtest: all-busy-idle-check-all
[790.129242] Subtest all-busy-idle-check-all: FAIL (0.632s)
[790.659892] [130/133] (278s left) kms_fbcon_fbt (psr)
[790.725902] Starting subtest: psr
[798.074411] Subtest psr: SUCCESS (7.347s)
[798.155486] [131/133] (270s left) sw_sync (sync_expired_merge)
[798.194657] Starting subtest: sync_expired_merge
[799.266958] Subtest sync_expired_merge: SUCCESS (1.074s)
[799.327978] [132/133] (269s left) gem_eio (throttle)
[799.533614] Starting subtest: throttle
[799.829831] Subtest throttle: SUCCESS (0.295s)
[799.941146] [133/133] (269s left) kms_content_protection (uevent)
[800.087792] Starting subtest: uevent
[800.092379] Subtest uevent: SKIP (0.000s)
[800.191183] 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.