[57.832686] Initializing watchdogs
[57.832734]   /dev/watchdog0
[57.847339] [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]
[57.851596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.853937] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.857569] [001/133] (960s left) gem_mmap_offset (partial-unmap)
[57.940875] Starting subtest: partial-unmap
[57.943407] Starting dynamic subtest: smem0
[58.442736] Dynamic subtest smem0: SUCCESS (0.499s)
[58.445959] Subtest partial-unmap: SUCCESS (0.500s)
[58.570282] [002/133] (959s left) kms_cursor_crc (cursor-dpms)
[58.705319] Starting subtest: cursor-dpms
[58.707690] Starting dynamic subtest: pipe-A-eDP-1
[61.824452] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.111s)
[61.833238] Starting dynamic subtest: pipe-D-eDP-1
[65.444986] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.615s)
[65.447454] Subtest cursor-dpms: SUCCESS (6.728s)
[66.276881] [003/133] (952s left) dmabuf_sync_file (export-wait-after-attach)
[66.365716] Starting subtest: export-wait-after-attach
[66.367679] Subtest export-wait-after-attach: SUCCESS (0.001s)
[66.415776] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[66.418813] [004/133] (952s left) kms_color_pipeline (plane-lut1d-lut1d)
[66.517068] Starting subtest: plane-lut1d-lut1d
[66.640873] Starting dynamic subtest: pipe-A-plane-0
[66.984532] Dynamic subtest pipe-A-plane-0: FAIL (0.163s)
[66.992343] Starting dynamic subtest: pipe-A-plane-1
[67.224905] Dynamic subtest pipe-A-plane-1: FAIL (0.188s)
[67.232079] Starting dynamic subtest: pipe-A-plane-2
[67.453062] Dynamic subtest pipe-A-plane-2: FAIL (0.202s)
[68.365774] Starting dynamic subtest: pipe-B-plane-0
[68.772067] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[68.778819] Starting dynamic subtest: pipe-B-plane-1
[69.088389] Dynamic subtest pipe-B-plane-1: FAIL (0.167s)
[69.095235] Starting dynamic subtest: pipe-B-plane-2
[69.409033] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[69.997823] Starting dynamic subtest: pipe-C-plane-0
[70.497973] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[70.505762] Starting dynamic subtest: pipe-C-plane-1
[70.903924] Dynamic subtest pipe-C-plane-1: FAIL (0.610s)
[70.910318] Starting dynamic subtest: pipe-C-plane-2
[71.258165] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[72.134355] Starting dynamic subtest: pipe-D-plane-0
[72.753331] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[72.762074] Starting dynamic subtest: pipe-D-plane-1
[73.218493] Dynamic subtest pipe-D-plane-1: FAIL (0.606s)
[73.225890] Starting dynamic subtest: pipe-D-plane-2
[73.651026] Dynamic subtest pipe-D-plane-2: FAIL (0.558s)
[73.752454] Subtest plane-lut1d-lut1d: FAIL (7.234s)
[74.608797] [005/133] (943s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[74.708965] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[74.711306] Starting dynamic subtest: pipe-A
[74.774166] Dynamic subtest pipe-A: SUCCESS (0.065s)
[74.783258] Starting dynamic subtest: pipe-B
[75.939955] Dynamic subtest pipe-B: SUCCESS (1.165s)
[75.952727] Starting dynamic subtest: pipe-C
[77.048344] Dynamic subtest pipe-C: SUCCESS (1.107s)
[77.059743] Starting dynamic subtest: pipe-D
[78.183016] Dynamic subtest pipe-D: SUCCESS (1.134s)
[78.185348] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.475s)
[79.342111] [006/133] (939s left) syncobj_wait (wait-delayed-signal)
[79.408100] Starting subtest: wait-delayed-signal
[79.511431] Subtest wait-delayed-signal: SUCCESS (0.102s)
[79.598531] [007/133] (938s left) kms_chamelium_hpd (dp-hpd-storm)
[79.980539] Subtest dp-hpd-storm: SKIP (0.000s)
[80.762329] [008/133] (937s left) gem_exec_flush (basic-uc-set-default)
[80.820060] Starting subtest: basic-uc-set-default
[86.274393] Subtest basic-uc-set-default: SUCCESS (5.454s)
[86.458275] [009/133] (932s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[86.573429] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[90.539530] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.968s)
[91.668206] [010/133] (927s left) i915_pm_rc6_residency (rc6-fence)
[91.730882] Starting subtest: rc6-fence
[91.755784] Starting dynamic subtest: gt0
[104.073701] Dynamic subtest gt0: SUCCESS (12.317s)
[104.082833] Starting dynamic subtest: gt1
[117.907361] Dynamic subtest gt1: SUCCESS (13.831s)
[117.910068] Subtest rc6-fence: SUCCESS (26.176s)
[117.984720] [011/133] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[118.080846] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[118.085091] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.170289] [012/133] (900s left) kms_rotation_crc (bad-tiling)
[118.257450] Starting subtest: bad-tiling
[118.261576] Subtest bad-tiling: SKIP (0.001s)
[118.327738] [013/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[118.435206] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[126.236703] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.807s)
[126.348605] [014/133] (892s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[126.457366] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[126.461747] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[126.562094] [015/133] (892s left) gem_ctx_persistence (process)
[126.622679] Starting subtest: process
[126.801521] Subtest process: SUCCESS (0.178s)
[126.879120] [016/133] (892s left) perf (low-oa-exponent-permissions)
[127.020855] Starting subtest: low-oa-exponent-permissions
[127.056890] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[127.102525] [017/133] (891s left) gem_ctx_param (invalid-get-ringsize)
[127.159956] Starting subtest: invalid-get-ringsize
[127.162402] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[127.250667] [018/133] (891s left) kms_lease (page-flip-implicit-plane)
[127.337093] Starting subtest: page-flip-implicit-plane
[127.339103] Starting dynamic subtest: pipe-A-eDP-1
[127.828820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.490s)
[127.836668] Starting dynamic subtest: pipe-B-eDP-1
[128.994671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[129.004212] Starting dynamic subtest: pipe-C-eDP-1
[130.104786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[130.113534] Starting dynamic subtest: pipe-D-eDP-1
[131.233713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[131.236114] Subtest page-flip-implicit-plane: SUCCESS (3.897s)
[132.064672] [019/133] (886s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[132.162439] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[132.166700] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[132.255726] [020/133] (886s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[132.360514] Starting subtest: x-tiled-8bpp-rotate-90
[132.382139] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[132.507985] [021/133] (886s left) gem_exec_schedule (u-submit-late-slice)
[132.587129] Starting subtest: u-submit-late-slice
[132.589321] Starting dynamic subtest: rcs0
[132.618737] Dynamic subtest rcs0: SUCCESS (0.038s)
[132.626652] Starting dynamic subtest: bcs0
[132.645577] Dynamic subtest bcs0: SUCCESS (0.026s)
[132.653098] Starting dynamic subtest: vcs0
[132.678062] Dynamic subtest vcs0: SUCCESS (0.032s)
[132.686429] Starting dynamic subtest: vcs1
[132.707945] Dynamic subtest vcs1: SUCCESS (0.029s)
[132.716616] Starting dynamic subtest: vecs0
[132.741707] Dynamic subtest vecs0: SUCCESS (0.033s)
[132.749472] Starting dynamic subtest: ccs0
[132.769725] Dynamic subtest ccs0: SUCCESS (0.028s)
[132.771976] Subtest u-submit-late-slice: SUCCESS (0.190s)
[133.993775] [022/133] (885s left) gem_pxp (create-protected-buffer)
[134.123936] Starting subtest: create-protected-buffer
[134.126089] Subtest create-protected-buffer: SUCCESS (0.000s)
[134.228945] [023/133] (884s left) gem_exec_balancer (noheartbeat)
[134.486894] Starting subtest: noheartbeat
[134.491253] Subtest noheartbeat: SKIP (0.000s)
[134.586794] [024/133] (884s left) kms_plane_multiple (2x-tiling-yf)
[134.674840] Starting subtest: 2x-tiling-yf
[134.678798] Subtest 2x-tiling-yf: SKIP (0.000s)
[134.742292] [025/133] (884s left) kms_psr (fbc-psr-cursor-plane-onoff)
[134.840061] Starting subtest: fbc-psr-cursor-plane-onoff
[134.841956] Starting dynamic subtest: eDP-1
[134.846046] Dynamic subtest eDP-1: SKIP (0.000s)
[134.849822] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[134.907271] [026/133] (884s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[134.968273] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[134.972393] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[135.163350] [027/133] (884s left) kms_plane (pixel-format-x-tiled-modifier)
[135.243839] Starting subtest: pixel-format-x-tiled-modifier
[135.269952] Starting dynamic subtest: pipe-A-plane-0
[135.903297] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[135.912877] Starting dynamic subtest: pipe-A-plane-3
[136.335871] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[136.343127] Starting dynamic subtest: pipe-A-plane-5
[136.346422] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[137.461698] Starting dynamic subtest: pipe-B-plane-0
[138.131278] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s)
[138.140285] Starting dynamic subtest: pipe-B-plane-3
[138.542611] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[138.549968] Starting dynamic subtest: pipe-B-plane-5
[138.553462] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[138.854426] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.612s)
[139.731099] [028/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[139.837644] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[147.280345] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.448s)
[147.432547] [029/133] (871s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[147.528163] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[147.530347] Starting dynamic subtest: pipe-A-eDP-1
[147.552646] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[147.562753] Starting dynamic subtest: pipe-B-eDP-1
[147.584537] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.591879] Starting dynamic subtest: pipe-C-eDP-1
[147.613271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.620684] Starting dynamic subtest: pipe-D-eDP-1
[147.642505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.646604] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.007s)
[149.807683] [030/133] (869s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[149.911951] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[149.914241] Starting dynamic subtest: pipe-A-eDP-1
[150.000407] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[150.016889] Starting dynamic subtest: pipe-B-eDP-1
[151.180540] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[151.184773] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.269s)
[152.384484] [031/133] (867s left) perf (polling)
[152.476836] Starting subtest: polling
[152.479229] Starting dynamic subtest: 0-rcs0
[162.506824] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[162.515525] Starting dynamic subtest: 1-vcs0
[172.530160] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[172.532998] Subtest polling: SUCCESS (20.052s)
[172.579112] [032/133] (846s left) gem_softpin (allocator-fork)
[172.649468] Starting subtest: allocator-fork
[174.857068] Subtest allocator-fork: SUCCESS (2.209s)
[174.987095] [033/133] (844s left) kms_rotation_crc (primary-rotation-90)
[175.077244] Starting subtest: primary-rotation-90
[175.081863] Subtest primary-rotation-90: SKIP (0.001s)
[175.151368] [034/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[175.254786] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[175.258865] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[175.350265] [035/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[175.441298] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[175.445421] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[175.551289] [036/133] (844s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[175.652295] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[176.720770] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.068s)
[176.847132] [037/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[176.942762] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[176.946115] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[177.035059] [038/133] (842s left) prime_mmap_kms (buffer-sharing)
[177.128690] Starting subtest: buffer-sharing
[177.580240] Subtest buffer-sharing: SUCCESS (0.451s)
[178.427389] [039/133] (841s left) gem_exec_schedule (out-order)
[178.500621] Starting subtest: out-order
[178.502677] Starting dynamic subtest: rcs0
[178.589898] Dynamic subtest rcs0: SUCCESS (0.097s)
[178.597641] Starting dynamic subtest: vcs0
[178.678928] Dynamic subtest vcs0: SUCCESS (0.088s)
[178.691499] Starting dynamic subtest: vcs1
[178.754604] Dynamic subtest vcs1: SUCCESS (0.074s)
[178.765861] Starting dynamic subtest: vecs0
[178.831394] Dynamic subtest vecs0: SUCCESS (0.076s)
[178.846358] Starting dynamic subtest: ccs0
[178.911698] Dynamic subtest ccs0: SUCCESS (0.080s)
[178.914019] Subtest out-order: SUCCESS (0.420s)
[179.999614] [040/133] (839s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[180.102935] Starting subtest: fbc-psr2-cursor-plane-onoff
[180.105287] Starting dynamic subtest: eDP-1
[180.109630] Dynamic subtest eDP-1: SKIP (0.000s)
[180.114035] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[180.173697] [041/133] (839s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[180.265055] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[180.267267] Starting dynamic subtest: pipe-A-eDP-1
[180.292543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.301866] Starting dynamic subtest: pipe-B-eDP-1
[180.324763] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.332401] Starting dynamic subtest: pipe-C-eDP-1
[180.356265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.363817] Starting dynamic subtest: pipe-D-eDP-1
[180.388058] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.392434] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[182.575677] [042/133] (837s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[182.697640] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[182.702399] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[182.853733] [043/133] (837s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[182.958713] Starting subtest: cursorB-vs-flipA-toggle
[182.963040] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[183.102590] [044/133] (836s left) kms_chamelium_frames (dp-crc-fast)
[183.492288] Subtest dp-crc-fast: SKIP (0.000s)
[184.284440] [045/133] (835s left) gem_exec_params (invalid-ring2)
[184.340123] Starting subtest: invalid-ring2
[184.342460] Subtest invalid-ring2: SUCCESS (0.000s)
[184.450974] [046/133] (835s left) i915_suspend (basic-s3-without-i915)
[184.486180] Starting subtest: basic-s3-without-i915
[187.826302] Subtest basic-s3-without-i915: SKIP (3.337s)
[189.366983] [047/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[189.472819] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[189.477173] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[189.556453] [048/133] (830s left) i915_fb_tiling (basic-x-tiling)
[189.625873] Subtest basic-x-tiling: SKIP (0.000s)
[189.697327] [049/133] (830s left) gem_exec_schedule (deep)
[189.881296] Starting subtest: deep
[189.883744] Starting dynamic subtest: rcs0
[194.927631] Dynamic subtest rcs0: SKIP (5.045s)
[194.938251] Starting dynamic subtest: vcs0
[205.169119] Dynamic subtest vcs0: SUCCESS (10.242s)
[205.181344] Starting dynamic subtest: vcs1
[215.874443] Dynamic subtest vcs1: SUCCESS (10.705s)
[215.886211] Starting dynamic subtest: vecs0
[227.040126] Dynamic subtest vecs0: SUCCESS (11.164s)
[227.049373] Starting dynamic subtest: ccs0
[239.620547] Dynamic subtest ccs0: SUCCESS (12.578s)
[239.623525] Subtest deep: SUCCESS (49.739s)
[241.489403] [050/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[241.590555] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[241.594676] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[241.706232] [051/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[241.802081] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[241.806373] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[241.899100] [052/133] (778s left) gem_exec_parallel (contexts)
[241.957630] Starting subtest: contexts
[241.960102] Starting dynamic subtest: rcs0
[244.670098] Dynamic subtest rcs0: SUCCESS (2.710s)
[244.681825] Starting dynamic subtest: bcs0
[248.113843] Dynamic subtest bcs0: SUCCESS (3.443s)
[248.125094] Starting dynamic subtest: vcs0
[252.315050] Dynamic subtest vcs0: SUCCESS (4.198s)
[252.324514] Starting dynamic subtest: vcs1
[256.355848] Dynamic subtest vcs1: SUCCESS (4.038s)
[256.363969] Starting dynamic subtest: vecs0
[260.365667] Dynamic subtest vecs0: SUCCESS (4.008s)
[260.375956] Starting dynamic subtest: ccs0
[264.282247] Dynamic subtest ccs0: SUCCESS (3.916s)
[264.284698] Subtest contexts: SUCCESS (22.324s)
[264.469268] [053/133] (755s left) syncobj_wait (reset-during-wait-for-submit)
[264.516057] Starting subtest: reset-during-wait-for-submit
[264.619384] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[264.699431] [054/133] (755s left) syncobj_wait (single-wait-signaled)
[264.764579] Starting subtest: single-wait-signaled
[264.766912] Subtest single-wait-signaled: SUCCESS (0.000s)
[264.882766] [055/133] (755s left) gem_busy (parallel)
[265.079723] Starting subtest: parallel
[265.082188] Starting dynamic subtest: rcs0
[266.900833] Dynamic subtest rcs0: SUCCESS (1.819s)
[266.911809] Starting dynamic subtest: bcs0
[268.884058] Dynamic subtest bcs0: SUCCESS (1.981s)
[268.894091] Starting dynamic subtest: vcs0
[270.933230] Dynamic subtest vcs0: SUCCESS (2.046s)
[270.943868] Starting dynamic subtest: vcs1
[272.917583] Dynamic subtest vcs1: SUCCESS (1.982s)
[272.931583] Starting dynamic subtest: vecs0
[274.902035] Dynamic subtest vecs0: SUCCESS (1.981s)
[274.913810] Starting dynamic subtest: ccs0
[276.885980] Dynamic subtest ccs0: SUCCESS (1.981s)
[276.888910] Subtest parallel: SUCCESS (11.805s)
[277.137055] [056/133] (743s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[277.231726] Starting subtest: modeset-transition-nonblocking-fencing
[277.233920] Starting dynamic subtest: 1x-outputs
[288.097479] Dynamic subtest 1x-outputs: SUCCESS (10.866s)
[288.100269] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.867s)
[288.951225] [057/133] (731s left) gem_exec_fence (long-history)
[289.446410] Starting subtest: long-history
[296.615871] Subtest long-history: SUCCESS (7.170s)
[298.424056] [058/133] (722s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[298.527266] Starting subtest: yf-tiled-8bpp-rotate-90
[298.531182] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[298.622941] [059/133] (722s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[298.737765] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[299.716735] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[299.851146] [060/133] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[299.951275] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[299.955190] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[300.035673] [061/133] (720s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[300.119527] Starting subtest: plane-downscale-factor-0-5-with-rotation
[300.121437] Starting dynamic subtest: pipe-A
[300.137988] Dynamic subtest pipe-A: SKIP (0.016s)
[300.146288] Starting dynamic subtest: pipe-B
[300.167889] Dynamic subtest pipe-B: SKIP (0.030s)
[300.175957] Starting dynamic subtest: pipe-C
[300.199218] Dynamic subtest pipe-C: SKIP (0.031s)
[300.207123] Starting dynamic subtest: pipe-D
[300.233810] Dynamic subtest pipe-D: SKIP (0.034s)
[300.236909] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.113s)
[300.324771] [062/133] (720s left) kms_invalid_mode (bad-hsync-start)
[300.441190] Starting subtest: bad-hsync-start
[300.443064] Starting dynamic subtest: pipe-A-eDP-1
[300.726844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[300.735126] Starting dynamic subtest: pipe-B-eDP-1
[300.737269] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[300.744779] Starting dynamic subtest: pipe-C-eDP-1
[300.746894] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[300.754556] Starting dynamic subtest: pipe-D-eDP-1
[300.756418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[300.758257] Subtest bad-hsync-start: SUCCESS (0.291s)
[301.580287] [063/133] (719s left) kms_content_protection (suspend-resume)
[301.715796] Starting subtest: suspend-resume
[301.720314] Subtest suspend-resume: SKIP (0.000s)
[301.837554] [064/133] (718s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[301.947437] Starting subtest: flip-vs-cursor-atomic
[308.998736] Subtest flip-vs-cursor-atomic: SUCCESS (7.051s)
[309.817759] [065/133] (711s left) kms_feature_discovery (psr2)
[309.921046] Starting subtest: psr2
[309.923193] Subtest psr2: SUCCESS (0.000s)
[309.994922] [066/133] (710s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[310.074270] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[310.076340] Starting dynamic subtest: pipe-A-default-mode
[312.770698] Dynamic subtest pipe-A-default-mode: SUCCESS (2.697s)
[312.773105] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.698s)
[313.618335] [067/133] (707s left) syncobj_wait (single-wait-all-signaled)
[313.675661] Starting subtest: single-wait-all-signaled
[313.678057] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[313.779777] [068/133] (707s left) gem_exec_schedule (promotion)
[313.845595] Starting subtest: promotion
[313.847948] Starting dynamic subtest: rcs0
[313.942647] Dynamic subtest rcs0: SUCCESS (0.107s)
[313.953168] Starting dynamic subtest: vcs0
[314.034449] Dynamic subtest vcs0: SUCCESS (0.090s)
[314.046793] Starting dynamic subtest: vcs1
[314.114824] Dynamic subtest vcs1: SUCCESS (0.079s)
[314.125914] Starting dynamic subtest: vecs0
[314.204407] Dynamic subtest vecs0: SUCCESS (0.089s)
[314.215785] Starting dynamic subtest: ccs0
[314.288046] Dynamic subtest ccs0: SUCCESS (0.082s)
[314.290627] Subtest promotion: SUCCESS (0.452s)
[315.952577] [069/133] (705s left) kms_flip (basic-flip-vs-modeset)
[316.055640] Starting subtest: basic-flip-vs-modeset
[316.057646] Starting dynamic subtest: A-eDP1
[318.613102] Dynamic subtest A-eDP1: SUCCESS (2.559s)
[318.622856] Starting dynamic subtest: B-eDP1
[320.769866] Dynamic subtest B-eDP1: SUCCESS (2.155s)
[320.778190] Starting dynamic subtest: C-eDP1
[322.938487] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[322.947425] Starting dynamic subtest: D-eDP1
[325.096387] Dynamic subtest D-eDP1: SUCCESS (2.158s)
[325.101023] Subtest basic-flip-vs-modeset: SUCCESS (9.049s)
[325.894763] [070/133] (695s left) kms_addfb_basic (unused-offsets)
[325.955925] Starting subtest: unused-offsets
[325.958070] Subtest unused-offsets: SUCCESS (0.000s)
[326.077893] [071/133] (695s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[326.185760] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[326.190282] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[326.262818] [072/133] (694s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[326.328662] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[326.403568] [073/133] (694s left) gem_wait (busy)
[326.462246] Starting subtest: busy
[326.464463] Starting dynamic subtest: all-engines
[327.892346] Dynamic subtest all-engines: SUCCESS (1.428s)
[327.903218] Starting dynamic subtest: rcs0
[328.434216] Dynamic subtest rcs0: SUCCESS (0.540s)
[328.444587] Starting dynamic subtest: bcs0
[328.973935] Dynamic subtest bcs0: SUCCESS (0.539s)
[328.983142] Starting dynamic subtest: vcs0
[330.899879] Dynamic subtest vcs0: SUCCESS (1.923s)
[330.914055] Starting dynamic subtest: vcs1
[332.884530] Dynamic subtest vcs1: SUCCESS (1.981s)
[332.896145] Starting dynamic subtest: vecs0
[334.933076] Dynamic subtest vecs0: SUCCESS (2.044s)
[334.945038] Starting dynamic subtest: ccs0
[335.475268] Dynamic subtest ccs0: SUCCESS (0.541s)
[335.477743] Subtest busy: SUCCESS (9.013s)
[335.670416] [074/133] (685s left) gen9_exec_parse (bb-large)
[335.729955] Subtest bb-large: SKIP (0.000s)
[335.794422] [075/133] (685s left) syncobj_timeline (single-wait-for-submit-signaled)
[335.852428] Starting subtest: single-wait-for-submit-signaled
[335.854764] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[335.956270] [076/133] (685s left) gem_pxp (protected-raw-src-copy-not-readible)
[336.089143] Starting subtest: protected-raw-src-copy-not-readible
[336.149095] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[336.262721] [077/133] (685s left) perf (whitelisted-registers-userspace-config)
[336.383575] Starting subtest: whitelisted-registers-userspace-config
[336.385706] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[336.431662] [078/133] (684s left) kms_flip (dpms-vs-vblank-race-interruptible)
[336.537096] Starting subtest: dpms-vs-vblank-race-interruptible
[336.541773] Starting dynamic subtest: A-eDP1
[340.428305] Dynamic subtest A-eDP1: SUCCESS (3.888s)
[340.437327] Starting dynamic subtest: B-eDP1
[345.059419] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[345.068682] Starting dynamic subtest: C-eDP1
[349.695056] Dynamic subtest C-eDP1: SUCCESS (4.631s)
[349.704832] Starting dynamic subtest: D-eDP1
[354.317964] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[354.320771] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.784s)
[355.198544] [079/133] (666s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[355.292637] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[355.294968] Starting dynamic subtest: pipe-A-eDP-1
[355.354696] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[355.364475] Starting dynamic subtest: pipe-B-eDP-1
[355.422280] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[355.431989] Starting dynamic subtest: pipe-C-eDP-1
[355.490760] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[355.500667] Starting dynamic subtest: pipe-D-eDP-1
[355.566071] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[355.570476] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[357.461662] [080/133] (664s left) kms_flip (flip-vs-fences)
[357.554538] Starting subtest: flip-vs-fences
[357.558913] Subtest flip-vs-fences: SKIP (0.000s)
[357.652544] [081/133] (663s left) kms_flip (2x-nonexisting-fb-interruptible)
[357.746056] Starting subtest: 2x-nonexisting-fb-interruptible
[357.756876] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[357.843899] [082/133] (663s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[357.934718] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[357.938839] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[358.007699] [083/133] (663s left) gem_exec_balancer (parallel-keep-submit-fence)
[358.264965] Starting subtest: parallel-keep-submit-fence
[359.425773] Subtest parallel-keep-submit-fence: SUCCESS (1.160s)
[359.520309] [084/133] (662s left) kms_pm_rpm (modeset-stress-extra-wait)
[361.047700] Starting subtest: modeset-stress-extra-wait
[415.342586] Subtest modeset-stress-extra-wait: SUCCESS (54.291s)
[415.433477] [085/133] (606s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[415.550089] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[415.554654] Starting dynamic subtest: pipe-A-eDP-1
[416.389393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[416.398080] Starting dynamic subtest: pipe-B-eDP-1
[417.900609] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.511s)
[417.909472] Starting dynamic subtest: pipe-C-eDP-1
[419.427354] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s)
[419.445755] Starting dynamic subtest: pipe-D-eDP-1
[420.945183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[420.947353] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.393s)
[422.121878] [086/133] (599s left) syncobj_wait (wait-all-interrupted)
[422.185101] Starting subtest: wait-all-interrupted
[422.285906] Subtest wait-all-interrupted: SUCCESS (0.102s)
[422.364878] [087/133] (599s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[422.451930] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[422.454076] Starting dynamic subtest: pipe-A-eDP-1
[422.629854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.169s)
[422.642224] Starting dynamic subtest: pipe-B-eDP-1
[422.661935] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[422.670325] Starting dynamic subtest: pipe-C-eDP-1
[422.689926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[422.697441] Starting dynamic subtest: pipe-D-eDP-1
[422.716949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[422.718900] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.206s)
[424.915266] [088/133] (596s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[424.967854] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[425.030188] [089/133] (596s left) vgem_basic (bad-flag)
[425.076259] Starting subtest: bad-flag
[425.078428] Subtest bad-flag: SUCCESS (0.000s)
[425.142517] [090/133] (596s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[425.203350] Starting subtest: etime-single-wait-for-submit-unsubmitted
[425.303929] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[425.391520] [091/133] (596s left) syncobj_timeline (multi-wait-all-available-submitted)
[425.448263] Starting subtest: multi-wait-all-available-submitted
[425.450186] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[425.531860] [092/133] (596s left) kms_universal_plane (disable-primary-vs-flip)
[425.619179] Starting subtest: disable-primary-vs-flip
[425.621361] Starting dynamic subtest: pipe-A-eDP-1
[427.188081] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.568s)
[427.197166] Starting dynamic subtest: pipe-B-eDP-1
[429.455720] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.268s)
[429.466758] Starting dynamic subtest: pipe-C-eDP-1
[431.692815] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.231s)
[431.701775] Starting dynamic subtest: pipe-D-eDP-1
[433.867765] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.174s)
[433.870046] Subtest disable-primary-vs-flip: SUCCESS (8.248s)
[434.660361] [093/133] (587s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[434.763181] Starting subtest: invalidate-primary-flip-overlay
[445.497451] Subtest invalidate-primary-flip-overlay: SUCCESS (10.736s)
[445.620387] [094/133] (576s left) kms_cursor_crc (cursor-random-512x512)
[445.901639] Starting subtest: cursor-random-512x512
[445.906614] Subtest cursor-random-512x512: SKIP (0.001s)
[446.073786] [095/133] (575s left) i915_drm_fdinfo (virtual-busy-all)
[446.119616] Starting subtest: virtual-busy-all
[446.123555] Subtest virtual-busy-all: SKIP (0.000s)
[446.178690] [096/133] (575s left) gem_create (create-massive)
[446.234230] Starting subtest: create-massive
[446.236223] Subtest create-massive: SUCCESS (0.000s)
[446.423211] [097/133] (575s left) kms_pm_dc (dc6-psr)
[447.514161] Starting subtest: dc6-psr
[450.497078] Subtest dc6-psr: SUCCESS (2.981s)
[451.314341] [098/133] (570s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[451.450477] Starting subtest: basic-busy-flip-before-cursor-varying-size
[451.454919] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[451.595050] [099/133] (570s left) kms_vblank (query-forked-busy-hang)
[451.681370] Starting subtest: query-forked-busy-hang
[451.683527] Starting dynamic subtest: pipe-A-eDP-1
[477.651072] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.969s)
[477.667951] Starting dynamic subtest: pipe-D-eDP-1
[492.704394] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.048s)
[492.706761] Subtest query-forked-busy-hang: SUCCESS (41.022s)
[493.561020] [100/133] (528s left) kms_addfb_basic (master-rmfb)
[493.614127] Starting subtest: master-rmfb
[493.616019] Subtest master-rmfb: SUCCESS (0.001s)
[493.750777] [101/133] (528s left) perf_pmu (render-node-busy-idle)
[493.821063] Starting subtest: render-node-busy-idle
[493.823363] Starting dynamic subtest: rcs0
[494.484113] Dynamic subtest rcs0: SUCCESS (0.662s)
[494.495844] Starting dynamic subtest: bcs0
[495.154748] Dynamic subtest bcs0: SUCCESS (0.669s)
[495.166526] Starting dynamic subtest: vcs0
[496.917350] Dynamic subtest vcs0: SUCCESS (1.759s)
[496.929446] Starting dynamic subtest: vcs1
[498.900293] Dynamic subtest vcs1: SUCCESS (1.980s)
[498.912425] Starting dynamic subtest: vecs0
[500.885410] Dynamic subtest vecs0: SUCCESS (1.982s)
[500.897619] Starting dynamic subtest: ccs0
[501.556498] Dynamic subtest ccs0: SUCCESS (0.670s)
[501.559244] Subtest render-node-busy-idle: SUCCESS (7.736s)
[501.636257] [102/133] (520s left) kms_atomic_transition (plane-all-transition-fencing)
[501.742131] Starting subtest: plane-all-transition-fencing
[501.744425] Starting dynamic subtest: pipe-A-eDP-1
[504.236155] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[504.545442] Starting dynamic subtest: pipe-B-eDP-1
[507.793113] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.256s)
[508.095679] Subtest plane-all-transition-fencing: SUCCESS (6.354s)
[508.919673] [103/133] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[509.034616] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[509.038667] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[509.131608] [104/133] (513s left) gem_mmap_gtt (basic-write-gtt)
[509.198105] Subtest basic-write-gtt: SKIP (0.000s)
[509.273401] [105/133] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[509.361794] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[509.365944] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[509.467555] [106/133] (513s left) gem_gtt_cpu_tlb
[509.602747] [107/133] (512s left) kms_properties (plane-properties-legacy)
[509.691285] Starting subtest: plane-properties-legacy
[509.693603] Starting dynamic subtest: pipe-A-eDP-1
[510.246364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[510.256120] Starting dynamic subtest: pipe-B-eDP-1
[511.512068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[511.520427] Starting dynamic subtest: pipe-C-eDP-1
[512.826895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[512.836665] Starting dynamic subtest: pipe-D-eDP-1
[514.049650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[514.051872] Subtest plane-properties-legacy: SUCCESS (4.359s)
[514.835713] [108/133] (507s left) gem_exec_whisper (basic-queues-forked-all)
[514.895801] Starting subtest: basic-queues-forked-all
[533.257443] Subtest basic-queues-forked-all: SUCCESS (18.358s)
[533.441819] [109/133] (489s left) gem_exec_alignment (many)
[533.494589] Starting subtest: many
[557.079482] Subtest many: SUCCESS (23.582s)
[559.479253] [110/133] (463s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[559.653193] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[559.657660] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[559.801996] [111/133] (462s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[559.894382] Starting subtest: read-crc-frame-sequence
[559.896697] Starting dynamic subtest: pipe-A-eDP-1
[560.610629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[560.622099] Starting dynamic subtest: pipe-B-eDP-1
[562.004383] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[562.014100] Starting dynamic subtest: pipe-C-eDP-1
[563.308148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[563.317469] Starting dynamic subtest: pipe-D-eDP-1
[564.618203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[564.620379] Subtest read-crc-frame-sequence: SUCCESS (4.722s)
[565.457262] [112/133] (457s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[565.558283] Starting subtest: psr-rgb565-draw-pwrite
[572.566868] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.015s)
[572.666902] [113/133] (450s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[572.737952] Starting subtest: single-wait-for-submit-unsubmitted
[572.840766] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[572.919823] [114/133] (449s left) api_intel_bb (object-noreloc-keep-cache-simple)
[572.984222] Starting subtest: object-noreloc-keep-cache-simple
[572.987053] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[573.104888] [115/133] (449s left) kms_psr (pr-sprite-blt)
[573.189036] Starting subtest: pr-sprite-blt
[573.193419] Subtest pr-sprite-blt: SKIP (0.000s)
[573.267513] [116/133] (449s left) gem_lmem_swapping (verify-random)
[573.315276] Subtest verify-random: SKIP (0.000s)
[573.361637] [117/133] (449s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[573.465107] Starting subtest: y-tiled-addfb-size-offset-overflow
[573.469578] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[573.594795] [118/133] (449s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[573.699926] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[580.293678] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.596s)
[580.412515] [119/133] (442s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[580.516942] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[581.174706] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[581.346317] [120/133] (441s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[581.392864] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[581.395170] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[581.510200] [121/133] (441s left) api_intel_allocator (execbuf-with-allocator)
[581.573705] Starting subtest: execbuf-with-allocator
[581.577891] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[581.695312] [122/133] (441s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[581.758519] Starting subtest: multi-wait-for-submit-submitted-signaled
[581.760939] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[581.872575] [123/133] (441s left) syncobj_timeline (reset-unsignaled)
[581.927555] Starting subtest: reset-unsignaled
[581.929973] Subtest reset-unsignaled: SUCCESS (0.000s)
[582.037120] [124/133] (441s left) prime_self_import (export-vs-gem_close-race)
[582.082268] Starting subtest: export-vs-gem_close-race
[587.173652] Subtest export-vs-gem_close-race: SUCCESS (5.094s)
[587.252735] [125/133] (436s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[587.384774] Starting subtest: cursorA-vs-flipA-legacy
[598.562636] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.177s)
[599.430823] [126/133] (423s left) prime_vgem (basic-fence-mmap)
[599.502882] Starting subtest: basic-fence-mmap
[599.507645] Subtest basic-fence-mmap: SKIP (0.000s)
[599.598257] [127/133] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[599.695048] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[606.281335] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.588s)
[606.395177] [128/133] (417s left) kms_psr (psr-cursor-plane-onoff)
[606.488088] Starting subtest: psr-cursor-plane-onoff
[606.490291] Starting dynamic subtest: eDP-1
[608.242850] Dynamic subtest eDP-1: SUCCESS (1.754s)
[608.244913] Subtest psr-cursor-plane-onoff: SUCCESS (1.755s)
[609.110955] [129/133] (414s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[609.212046] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[609.216868] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[609.310606] [130/133] (414s left) perf (stress-open-close)
[609.427157] Starting subtest: stress-open-close
[609.429543] Starting dynamic subtest: 0-rcs0
[611.592061] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[611.600631] Starting dynamic subtest: 1-vcs1
[613.752789] Dynamic subtest 1-vcs1: SUCCESS (2.160s)
[613.754849] Subtest stress-open-close: SUCCESS (4.326s)
[613.800300] [131/133] (409s left) perf_pmu (busy-accuracy-98)
[613.842854] Starting subtest: busy-accuracy-98
[613.844979] Starting dynamic subtest: rcs0
[616.886883] Dynamic subtest rcs0: SUCCESS (3.039s)
[616.896619] Starting dynamic subtest: bcs0
[619.935064] Dynamic subtest bcs0: SUCCESS (3.047s)
[619.946257] Starting dynamic subtest: vcs0
[622.982606] Dynamic subtest vcs0: SUCCESS (3.044s)
[622.993387] Starting dynamic subtest: vcs1
[626.028537] Dynamic subtest vcs1: SUCCESS (3.043s)
[626.038851] Starting dynamic subtest: vecs0
[629.071507] Dynamic subtest vecs0: SUCCESS (3.040s)
[629.080571] Starting dynamic subtest: ccs0
[632.120578] Dynamic subtest ccs0: SUCCESS (3.046s)
[632.122801] Subtest busy-accuracy-98: SUCCESS (18.276s)
[632.240697] [132/133] (391s left) syncobj_eventfd (binary-wait-before-signal)
[632.299760] Starting subtest: binary-wait-before-signal
[632.328395] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[632.421938] [133/133] (391s left) kms_psr (fbc-pr-cursor-blt)
[632.523578] Starting subtest: fbc-pr-cursor-blt
[632.527894] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[632.591522] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_offset
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_pxp
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: prime_mmap_kms
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_fb_tiling
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_invalid_mode
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: gem_wait
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_psr_stress_test
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_gtt_cpu_tlb
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: gem_exec_alignment
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_pipe_crc_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: kms_psr
Done.