[58.542108] Initializing watchdogs
[58.542155]   /dev/watchdog0
[58.556099] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.560388] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.562634] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.565899] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[58.695370] Starting subtest: x-tiled-8bpp-rotate-270
[58.731330] Subtest x-tiled-8bpp-rotate-270: SKIP (0.035s)
[58.861933] [002/133] (960s left) kms_prop_blob (basic)
[58.912099] Starting subtest: basic
[58.914487] Subtest basic: SUCCESS (0.000s)
[59.007845] [003/133] (960s left) gen9_exec_parse (bb-large)
[59.072789] Subtest bb-large: SKIP (0.000s)
[59.149382] [004/133] (960s left) prime_vgem (fence-read-hang)
[59.253103] Subtest fence-read-hang: SKIP (0.000s)
[59.338557] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[59.341676] [005/133] (959s left) gem_userptr_blits (readonly-unsync)
[59.398075] Subtest readonly-unsync: SKIP (0.000s)
[59.522699] [006/133] (959s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[59.602867] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[59.604647] Starting dynamic subtest: pipe-A
[60.753779] Dynamic subtest pipe-A: SUCCESS (1.151s)
[60.761405] Starting dynamic subtest: pipe-B
[62.920450] Dynamic subtest pipe-B: SUCCESS (2.166s)
[62.932888] Starting dynamic subtest: pipe-C
[64.140591] Dynamic subtest pipe-C: SUCCESS (1.219s)
[64.149700] Starting dynamic subtest: pipe-D
[65.371080] Dynamic subtest pipe-D: SUCCESS (1.230s)
[65.373343] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.768s)
[66.561711] [007/133] (952s left) kms_psr (fbc-pr-sprite-blt)
[66.659272] Starting subtest: fbc-pr-sprite-blt
[66.663563] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[66.730963] [008/133] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[66.900722] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[66.902983] Starting dynamic subtest: pipe-A-eDP-1
[66.991713] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[67.001601] Starting dynamic subtest: pipe-B-eDP-1
[68.147070] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[68.151738] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.248s)
[69.436978] [009/133] (949s left) kms_flip (2x-plain-flip-ts-check)
[69.530235] Starting subtest: 2x-plain-flip-ts-check
[69.541817] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[69.619392] [010/133] (949s left) gem_spin_batch (engines)
[69.678606] Starting subtest: engines
[69.680794] Starting dynamic subtest: rcs0
[72.916499] Dynamic subtest rcs0: SUCCESS (3.235s)
[72.925777] Starting dynamic subtest: bcs0
[76.151868] Dynamic subtest bcs0: SUCCESS (3.235s)
[76.161034] Starting dynamic subtest: vcs0
[79.389216] Dynamic subtest vcs0: SUCCESS (3.235s)
[79.396479] Starting dynamic subtest: vcs1
[82.622676] Dynamic subtest vcs1: SUCCESS (3.233s)
[82.631678] Starting dynamic subtest: vecs0
[85.860355] Dynamic subtest vecs0: SUCCESS (3.236s)
[85.870079] Starting dynamic subtest: ccs0
[89.096323] Dynamic subtest ccs0: SUCCESS (3.236s)
[89.098420] Subtest engines: SUCCESS (19.415s)
[89.313610] [011/133] (930s left) syncobj_timeline (wait-zero-handles)
[89.381855] Starting subtest: wait-zero-handles
[89.384306] Subtest wait-zero-handles: SUCCESS (0.000s)
[89.481806] [012/133] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[89.578079] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[93.139859] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.564s)
[94.333462] [013/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[94.444988] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[95.501204] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.057s)
[95.620994] [014/133] (923s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[95.719075] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[102.665658] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.945s)
[102.802469] [015/133] (916s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[102.864180] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[102.866295] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[102.972684] [016/133] (916s left) kms_big_fb (linear-16bpp-rotate-90)
[103.082204] Starting subtest: linear-16bpp-rotate-90
[103.100985] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[103.205321] [017/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[103.299632] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[110.972343] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.676s)
[111.100279] [018/133] (908s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[111.210838] Starting subtest: yf-tiled-64bpp-rotate-270
[111.215191] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[111.315236] [019/133] (908s left) perf (stress-open-close)
[111.439323] Starting subtest: stress-open-close
[111.441762] Starting dynamic subtest: 0-rcs0
[113.605736] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[113.612804] Starting dynamic subtest: 1-vcs1
[115.770475] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[115.772445] Subtest stress-open-close: SUCCESS (4.332s)
[115.814378] [020/133] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.909970] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.913477] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[116.012752] [021/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[116.109075] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[116.112485] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[116.193482] [022/133] (903s left) kms_psr (psr2-cursor-mmap-gtt)
[116.289280] Starting subtest: psr2-cursor-mmap-gtt
[116.291210] Starting dynamic subtest: eDP-1
[117.984546] Dynamic subtest eDP-1: SUCCESS (1.693s)
[117.986752] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.694s)
[118.782090] [023/133] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.889499] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.893627] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.994436] [024/133] (900s left) kms_addfb_basic (bo-too-small)
[119.087401] Starting subtest: bo-too-small
[119.089680] Subtest bo-too-small: SUCCESS (0.000s)
[119.193533] [025/133] (900s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[119.297025] Starting subtest: bad-aux-stride-y-tiled-ccs
[119.301554] Starting dynamic subtest: pipe-A-eDP-1
[119.323593] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.333535] Starting dynamic subtest: pipe-B-eDP-1
[119.354176] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.361282] Starting dynamic subtest: pipe-C-eDP-1
[119.382102] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.389093] Starting dynamic subtest: pipe-D-eDP-1
[119.411152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.415603] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[121.542299] [026/133] (898s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[121.642829] Starting subtest: pr-primary-plane-update-sf-dmg-area
[121.647031] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[121.721468] [027/133] (898s left) gem_exec_whisper (basic-contexts-priority-all)
[121.795252] Starting subtest: basic-contexts-priority-all
[144.000824] Subtest basic-contexts-priority-all: SUCCESS (22.202s)
[144.185808] [028/133] (875s left) kms_cursor_crc (cursor-random-64x64)
[144.361557] Starting subtest: cursor-random-64x64
[144.366275] Starting dynamic subtest: pipe-A-eDP-1
[147.725280] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.359s)
[147.755851] Starting dynamic subtest: pipe-D-eDP-1
[151.772761] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.022s)
[151.774686] Subtest cursor-random-64x64: SUCCESS (7.408s)
[152.621070] [029/133] (867s left) kms_flip (2x-plain-flip-interruptible)
[152.719000] Starting subtest: 2x-plain-flip-interruptible
[152.731075] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[152.806600] [030/133] (867s left) kms_busy (extended-modeset-hang-oldfb)
[152.907082] Starting subtest: extended-modeset-hang-oldfb
[152.909350] Starting dynamic subtest: pipe-A
[164.793443] Dynamic subtest pipe-A: SUCCESS (11.885s)
[164.804665] Starting dynamic subtest: pipe-D
[177.791039] Dynamic subtest pipe-D: SUCCESS (12.988s)
[177.793474] Subtest extended-modeset-hang-oldfb: SUCCESS (24.882s)
[178.186704] [031/133] (842s left) gem_exec_flush (basic-wb-rw-default)
[178.248086] Starting subtest: basic-wb-rw-default
[183.697310] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[183.882525] [032/133] (836s left) gem_exec_reloc (basic-scanout)
[183.946766] Subtest basic-scanout: SKIP (0.000s)
[184.022285] [033/133] (836s left) gem_partial_pwrite_pread (reads-uncached)
[184.096802] Subtest reads-uncached: SKIP (0.000s)
[184.162088] [034/133] (836s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[184.259826] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[184.263776] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[184.341493] [035/133] (836s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[185.978531] Starting subtest: gem-execbuf-stress-pc8
[186.014933] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[186.618573] [036/133] (833s left) syncobj_wait (reset-during-wait-for-submit)
[186.675302] Starting subtest: reset-during-wait-for-submit
[186.778074] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[186.855935] [037/133] (833s left) syncobj_wait (invalid-signal-zero-handles)
[186.921824] Starting subtest: invalid-signal-zero-handles
[186.924165] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[187.034993] [038/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[187.138976] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[187.143160] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[187.264360] [039/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[187.383992] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[194.241120] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.861s)
[194.388678] [040/133] (826s left) kms_feature_discovery (dp-mst)
[194.488272] Starting subtest: dp-mst
[194.492527] Subtest dp-mst: SKIP (0.000s)
[194.575373] [041/133] (826s left) syncobj_timeline (reset-unsignaled)
[194.635775] Starting subtest: reset-unsignaled
[194.637947] Subtest reset-unsignaled: SUCCESS (0.000s)
[194.755183] [042/133] (825s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[194.850133] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[194.852447] Starting dynamic subtest: pipe-A-eDP-1
[194.875755] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.888060] Starting dynamic subtest: pipe-B-eDP-1
[194.909768] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.917700] Starting dynamic subtest: pipe-C-eDP-1
[194.939018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.947070] Starting dynamic subtest: pipe-D-eDP-1
[194.969132] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.973503] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[197.097936] [043/133] (823s left) kms_hdmi_inject (inject-4k)
[197.435408] Starting subtest: inject-4k
[197.751804] Subtest inject-4k: SUCCESS (0.318s)
[198.256680] [044/133] (822s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[198.351523] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[198.356041] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[198.438093] [045/133] (822s left) gem_mmap_gtt (fault-concurrent-y)
[198.492179] Subtest fault-concurrent-Y: SKIP (0.000s)
[198.547409] [046/133] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[198.644817] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[198.649317] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[198.756319] [047/133] (822s left) gem_exec_balancer (parallel-contexts)
[199.021828] Starting subtest: parallel-contexts
[201.798548] Subtest parallel-contexts: SUCCESS (2.776s)
[201.904974] [048/133] (819s left) gem_exec_schedule (semaphore-resolve)
[201.974954] Starting subtest: semaphore-resolve
[202.032372] Subtest semaphore-resolve: SUCCESS (0.061s)
[202.382858] [049/133] (818s left) gem_ctx_engines (independent)
[202.446549] Starting subtest: independent
[202.448947] Starting dynamic subtest: rcs0
[202.663114] Dynamic subtest rcs0: SUCCESS (0.214s)
[202.674400] Starting dynamic subtest: bcs0
[202.883750] Dynamic subtest bcs0: SUCCESS (0.220s)
[202.894780] Starting dynamic subtest: vcs0
[203.089831] Dynamic subtest vcs0: SUCCESS (0.206s)
[203.101322] Starting dynamic subtest: vcs1
[203.322763] Dynamic subtest vcs1: SUCCESS (0.232s)
[203.333327] Starting dynamic subtest: vecs0
[203.514961] Dynamic subtest vecs0: SUCCESS (0.191s)
[203.525420] Starting dynamic subtest: ccs0
[203.771570] Dynamic subtest ccs0: SUCCESS (0.256s)
[203.782706] Starting dynamic subtest: all-engines
[204.686294] Dynamic subtest all-engines: SUCCESS (0.913s)
[204.689019] Subtest independent: SUCCESS (2.238s)
[205.086270] [050/133] (816s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[205.193331] Starting subtest: y-tiled-32bpp-rotate-0
[205.197730] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[205.302971] [051/133] (815s left) kms_async_flips (test-time-stamp)
[205.386987] Starting subtest: test-time-stamp
[205.759091] Starting dynamic subtest: pipe-A-eDP-1
[206.602616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[206.981937] Starting dynamic subtest: pipe-B-eDP-1
[207.800054] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.823s)
[208.181307] Starting dynamic subtest: pipe-C-eDP-1
[209.000887] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.827s)
[209.369680] Starting dynamic subtest: pipe-D-eDP-1
[210.194440] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.830s)
[210.196781] Subtest test-time-stamp: SUCCESS (4.808s)
[211.439205] [052/133] (809s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[211.526389] Starting subtest: plane-upscale-20x20-with-modifiers
[211.528709] Starting dynamic subtest: pipe-A
[211.862548] Dynamic subtest pipe-A: SUCCESS (0.339s)
[211.873325] Starting dynamic subtest: pipe-B
[213.287617] Dynamic subtest pipe-B: SUCCESS (1.424s)
[213.296310] Starting dynamic subtest: pipe-C
[214.685462] Dynamic subtest pipe-C: SUCCESS (1.396s)
[214.696472] Starting dynamic subtest: pipe-D
[216.085106] Dynamic subtest pipe-D: SUCCESS (1.399s)
[216.087249] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.563s)
[217.240736] [053/133] (803s left) gem_mmap (bad-object)
[217.297624] Subtest bad-object: SKIP (0.000s)
[217.372176] [054/133] (803s left) gem_exec_params (no-vebox)
[217.424589] Starting subtest: no-vebox
[217.429853] Subtest no-vebox: SUCCESS (0.003s)
[218.954131] [055/133] (802s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[219.044152] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[219.046814] Starting dynamic subtest: pipe-A-eDP-1
[219.072189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.083347] Starting dynamic subtest: pipe-B-eDP-1
[219.106615] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.115094] Starting dynamic subtest: pipe-C-eDP-1
[219.138127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.145885] Starting dynamic subtest: pipe-D-eDP-1
[219.168732] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.172603] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[221.325712] [056/133] (800s left) gem_workarounds (reset)
[221.392715] Starting subtest: reset
[221.589157] Subtest reset: SUCCESS (0.196s)
[221.715421] [057/133] (799s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[221.815196] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[221.819574] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[221.887536] [058/133] (799s left) kms_lease (page-flip-implicit-plane)
[221.983451] Starting subtest: page-flip-implicit-plane
[221.985357] Starting dynamic subtest: pipe-A-eDP-1
[222.467761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[222.477278] Starting dynamic subtest: pipe-B-eDP-1
[223.636930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[223.646699] Starting dynamic subtest: pipe-C-eDP-1
[224.731052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[224.742428] Starting dynamic subtest: pipe-D-eDP-1
[225.817674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s)
[225.819955] Subtest page-flip-implicit-plane: SUCCESS (3.836s)
[226.622415] [059/133] (794s left) gem_exec_fence (syncobj-signal)
[227.088193] Starting subtest: syncobj-signal
[227.094238] Subtest syncobj-signal: SUCCESS (0.005s)
[228.976843] [060/133] (792s left) kms_async_flips (alternate-sync-async-flip)
[229.074169] Starting subtest: alternate-sync-async-flip
[229.450533] Starting dynamic subtest: pipe-A-eDP-1
[232.197881] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[232.584438] Starting dynamic subtest: pipe-B-eDP-1
[235.385021] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.809s)
[235.764874] Starting dynamic subtest: pipe-C-eDP-1
[238.581337] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.824s)
[238.949137] Starting dynamic subtest: pipe-D-eDP-1
[241.695147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s)
[241.697103] Subtest alternate-sync-async-flip: SUCCESS (12.624s)
[242.933547] [061/133] (778s left) gem_exec_params (invalid-ring2)
[243.006255] Starting subtest: invalid-ring2
[243.008493] Subtest invalid-ring2: SUCCESS (0.000s)
[243.104649] [062/133] (778s left) kms_plane_alpha_blend (coverage-7efc)
[243.210640] Starting subtest: coverage-7efc
[243.498042] Starting dynamic subtest: pipe-A-eDP-1
[244.081842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[244.128810] Starting dynamic subtest: pipe-D-eDP-1
[245.428794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[245.431105] Subtest coverage-7efc: SUCCESS (2.219s)
[246.242494] [063/133] (775s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[246.341674] Starting subtest: psr-rgb101010-draw-mmap-gtt
[246.346233] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[246.452233] [064/133] (775s left) kms_flip (flip-vs-rmfb-interruptible)
[246.559844] Starting subtest: flip-vs-rmfb-interruptible
[246.562149] Starting dynamic subtest: A-eDP1
[255.175910] Dynamic subtest A-eDP1: SUCCESS (8.615s)
[255.188294] Starting dynamic subtest: B-eDP1
[263.794573] Dynamic subtest B-eDP1: SUCCESS (8.616s)
[263.805751] Starting dynamic subtest: C-eDP1
[272.467485] Dynamic subtest C-eDP1: SUCCESS (8.670s)
[272.479507] Starting dynamic subtest: D-eDP1
[281.075764] Dynamic subtest D-eDP1: SUCCESS (8.606s)
[281.080295] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.519s)
[282.226505] [065/133] (739s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[282.327030] Starting subtest: primary-4-tiled-reflect-x-0
[289.348489] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.023s)
[290.512497] [066/133] (731s left) i915_hangman (engine-error-state-capture)
[290.570650] Starting subtest: engine-error-state-capture
[290.572588] Starting dynamic subtest: rcs0
[293.875605] Dynamic subtest rcs0: SUCCESS (3.304s)
[293.887953] Starting dynamic subtest: bcs0
[299.890867] Dynamic subtest bcs0: SUCCESS (6.013s)
[299.902931] Starting dynamic subtest: vcs0
[305.843343] Dynamic subtest vcs0: SUCCESS (5.950s)
[305.855406] Starting dynamic subtest: vcs1
[311.795406] Dynamic subtest vcs1: SUCCESS (5.949s)
[311.807518] Starting dynamic subtest: vecs0
[316.850396] Dynamic subtest vecs0: SUCCESS (5.052s)
[316.862417] Starting dynamic subtest: ccs0
[322.867954] Dynamic subtest ccs0: SUCCESS (6.014s)
[322.870977] Subtest engine-error-state-capture: SUCCESS (32.298s)
[322.994721] [067/133] (698s left) kms_color (gamma)
[323.100187] Starting subtest: gamma
[323.102082] Starting dynamic subtest: pipe-A-eDP-1
[323.846094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[323.855557] Starting dynamic subtest: pipe-B-eDP-1
[325.308155] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[325.317870] Starting dynamic subtest: pipe-C-eDP-1
[326.641098] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[326.650297] Starting dynamic subtest: pipe-D-eDP-1
[328.043282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[328.045167] Subtest gamma: SUCCESS (4.944s)
[328.915943] [068/133] (692s left) template (b)
[328.975781] Starting subtest: B
[328.977780] Subtest B: SUCCESS (0.000s)
[329.071699] [069/133] (692s left) gem_ctx_isolation (nonpriv-switch)
[329.134142] Starting subtest: nonpriv-switch
[329.136057] Starting dynamic subtest: rcs0
[329.414126] Dynamic subtest rcs0: SUCCESS (0.282s)
[329.423604] Starting dynamic subtest: bcs0
[329.705106] Dynamic subtest bcs0: SUCCESS (0.290s)
[329.714323] Starting dynamic subtest: vcs0
[330.003916] Dynamic subtest vcs0: SUCCESS (0.298s)
[330.012556] Starting dynamic subtest: vcs1
[331.153098] Dynamic subtest vcs1: SUCCESS (1.148s)
[331.162341] Starting dynamic subtest: vecs0
[333.202429] Dynamic subtest vecs0: SUCCESS (2.048s)
[333.211839] Starting dynamic subtest: ccs0
[335.271463] Dynamic subtest ccs0: SUCCESS (2.068s)
[335.273726] Subtest nonpriv-switch: SUCCESS (6.141s)
[335.508200] [070/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[335.608773] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[335.613118] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.710990] [071/133] (686s left) gem_lmem_swapping (massive)
[335.753553] Subtest massive: SKIP (0.000s)
[335.804420] [072/133] (686s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[336.190861] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[336.993465] [073/133] (685s left) kms_content_protection (content-type-change)
[337.140899] Starting subtest: content-type-change
[337.145566] Subtest content-type-change: SKIP (0.000s)
[337.269162] [074/133] (684s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[337.326585] Subtest untiled-to-tiled: SKIP (0.000s)
[337.396697] [075/133] (684s left) kms_rotation_crc (primary-rotation-90)
[337.483342] Starting subtest: primary-rotation-90
[337.487402] Subtest primary-rotation-90: SKIP (0.001s)
[337.573690] [076/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[337.669126] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[344.406368] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.740s)
[344.522586] [077/133] (677s left) kms_vblank (query-forked-hang)
[344.618273] Starting subtest: query-forked-hang
[344.620569] Starting dynamic subtest: pipe-A-eDP-1
[370.641361] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.021s)
[370.656347] Starting dynamic subtest: pipe-D-eDP-1
[395.670260] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[395.672621] Subtest query-forked-hang: SUCCESS (51.053s)
[396.510487] [078/133] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[396.613685] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[396.617859] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.700410] [079/133] (625s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[396.758433] Starting subtest: y-tiled-to-vebox-yf-tiled
[396.763043] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[396.941983] [080/133] (625s left) gem_ctx_shared (exec-shared-gtt)
[397.023219] Starting subtest: exec-shared-gtt
[397.025818] Starting dynamic subtest: rcs0
[397.031474] Dynamic subtest rcs0: SUCCESS (0.006s)
[397.042305] Starting dynamic subtest: bcs0
[397.044188] Dynamic subtest bcs0: SUCCESS (0.005s)
[397.053458] Starting dynamic subtest: vcs0
[397.055709] Dynamic subtest vcs0: SUCCESS (0.006s)
[397.064954] Starting dynamic subtest: vcs1
[397.066907] Dynamic subtest vcs1: SUCCESS (0.007s)
[397.076117] Starting dynamic subtest: vecs0
[397.077997] Dynamic subtest vecs0: SUCCESS (0.006s)
[397.086756] Starting dynamic subtest: ccs0
[397.088660] Dynamic subtest ccs0: SUCCESS (0.006s)
[397.090574] Subtest exec-shared-gtt: SUCCESS (0.041s)
[397.247532] [081/133] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[397.350143] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[397.354111] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[397.443914] [082/133] (624s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[397.556294] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[398.225271] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[398.390022] [083/133] (624s left) gem_exec_flush (basic-wb-prw-default)
[398.458784] Starting subtest: basic-wb-prw-default
[403.926677] Subtest basic-wb-prw-default: SUCCESS (5.470s)
[404.126971] [084/133] (618s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[404.243099] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[404.247722] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[404.390306] [085/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[404.486629] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[404.491036] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.582737] [086/133] (618s left) kms_atomic_interruptible (legacy-pageflip)
[404.670377] Starting subtest: legacy-pageflip
[404.672642] Starting dynamic subtest: pipe-A-eDP-1
[412.100547] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[412.102811] Subtest legacy-pageflip: SUCCESS (7.429s)
[412.908403] [087/133] (609s left) kms_pipe_crc_basic (bad-source)
[413.004019] Starting subtest: bad-source
[413.006396] Subtest bad-source: SUCCESS (0.000s)
[413.076610] [088/133] (609s left) kms_pm_rpm (cursor)
[415.101627] Starting subtest: cursor
[415.106479] Subtest cursor: SKIP (0.000s)
[415.476188] [089/133] (607s left) perf_pmu (init-busy)
[415.511335] Starting subtest: init-busy
[415.513687] Starting dynamic subtest: rcs0
[415.516026] Dynamic subtest rcs0: SUCCESS (0.001s)
[415.528646] Starting dynamic subtest: bcs0
[415.530774] Dynamic subtest bcs0: SUCCESS (0.000s)
[415.539738] Starting dynamic subtest: vcs0
[415.541644] Dynamic subtest vcs0: SUCCESS (0.001s)
[415.550742] Starting dynamic subtest: vcs1
[415.552637] Dynamic subtest vcs1: SUCCESS (0.000s)
[415.561225] Starting dynamic subtest: vecs0
[415.563075] Dynamic subtest vecs0: SUCCESS (0.000s)
[415.571405] Starting dynamic subtest: ccs0
[415.573304] Dynamic subtest ccs0: SUCCESS (0.000s)
[415.575098] Subtest init-busy: SUCCESS (0.007s)
[415.636189] [090/133] (607s left) kms_cursor_edge_walk (128x128-right-edge)
[415.725861] Starting subtest: 128x128-right-edge
[415.728016] Starting dynamic subtest: pipe-A-eDP-1
[419.155058] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[419.166706] Starting dynamic subtest: pipe-D-eDP-1
[422.322078] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.167s)
[422.324376] Subtest 128x128-right-edge: SUCCESS (6.598s)
[423.208720] [091/133] (599s left) gem_ctx_param (non-root-set)
[423.264768] Starting subtest: non-root-set
[423.285076] Subtest non-root-set: SUCCESS (0.020s)
[423.382187] [092/133] (599s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[423.440564] Starting subtest: etime-single-wait-for-submit-unsubmitted
[423.545054] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[423.622288] [093/133] (599s left) gem_pxp (create-protected-buffer)
[423.750432] Starting subtest: create-protected-buffer
[423.752655] Subtest create-protected-buffer: SUCCESS (0.000s)
[423.855624] [094/133] (599s left) kms_psr (fbc-pr-no-drrs)
[423.945810] Starting subtest: fbc-pr-no-drrs
[423.950126] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[424.017997] [095/133] (598s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[424.070342] Starting subtest: invalid-single-wait-all-unsubmitted
[424.072523] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[424.170608] [096/133] (598s left) kms_psr (fbc-psr-sprite-plane-onoff)
[424.260418] Starting subtest: fbc-psr-sprite-plane-onoff
[424.262601] Starting dynamic subtest: eDP-1
[424.267093] Dynamic subtest eDP-1: SKIP (0.000s)
[424.271377] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[424.336872] [097/133] (598s left) kms_addfb_basic (no-handle)
[424.389710] Starting subtest: no-handle
[424.391817] Subtest no-handle: SUCCESS (0.000s)
[424.532427] [098/133] (598s left) kms_sequence (get-idle)
[424.615513] Starting subtest: get-idle
[424.617291] Starting dynamic subtest: pipe-A-eDP-1
[426.428180] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[426.437417] Starting dynamic subtest: pipe-B-eDP-1
[428.929489] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.502s)
[428.939683] Starting dynamic subtest: pipe-C-eDP-1
[431.430578] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.500s)
[431.441286] Starting dynamic subtest: pipe-D-eDP-1
[433.910313] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s)
[433.912199] Subtest get-idle: SUCCESS (9.294s)
[434.707743] [099/133] (588s left) gem_exec_schedule (preempt-hang)
[434.895209] Starting subtest: preempt-hang
[434.897434] Starting dynamic subtest: rcs0
[435.130576] Dynamic subtest rcs0: SUCCESS (0.236s)
[435.150824] Starting dynamic subtest: bcs0
[435.362190] Dynamic subtest bcs0: SUCCESS (0.230s)
[435.378031] Starting dynamic subtest: vcs0
[435.590410] Dynamic subtest vcs0: SUCCESS (0.229s)
[435.601172] Starting dynamic subtest: vcs1
[435.820584] Dynamic subtest vcs1: SUCCESS (0.228s)
[435.831295] Starting dynamic subtest: vecs0
[436.049110] Dynamic subtest vecs0: SUCCESS (0.227s)
[436.059107] Starting dynamic subtest: ccs0
[436.280087] Dynamic subtest ccs0: SUCCESS (0.231s)
[436.282068] Subtest preempt-hang: SUCCESS (1.389s)
[436.986406] [100/133] (586s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[437.375967] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[438.191146] [101/133] (585s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[438.253178] Starting subtest: multi-wait-all-for-submit-submitted
[438.360598] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[438.438526] [102/133] (584s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[438.530223] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[445.288371] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.760s)
[445.411087] [103/133] (577s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[445.479633] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[445.585077] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[445.680738] [104/133] (577s left) i915_suspend (basic-s2idle-without-i915)
[445.720944] Starting subtest: basic-s2idle-without-i915
[466.398214] Subtest basic-s2idle-without-i915: SUCCESS (5.720s)
[466.535917] [105/133] (556s left) gem_lmem_swapping (random-engines)
[466.604100] Subtest random-engines: SKIP (0.000s)
[466.651374] [106/133] (556s left) syncobj_timeline (signal-array)
[466.709568] Starting subtest: signal-array
[466.711867] Subtest signal-array: SUCCESS (0.000s)
[466.809010] [107/133] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[466.914788] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[466.919105] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[467.026772] [108/133] (556s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[467.123180] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[467.127457] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[467.205229] [109/133] (556s left) gem_userptr_blits (sync-unmap)
[467.262102] Starting subtest: sync-unmap
[467.278584] Subtest sync-unmap: SUCCESS (0.020s)
[467.405848] [110/133] (556s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[467.487650] Starting subtest: blocking-absolute-wf_vblank-interruptible
[467.489267] Starting dynamic subtest: A-eDP1
[476.266999] Dynamic subtest A-eDP1: SUCCESS (8.768s)
[476.277213] Starting dynamic subtest: B-eDP1
[485.004240] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[485.014073] Starting dynamic subtest: C-eDP1
[493.730116] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[493.742340] Starting dynamic subtest: D-eDP1
[502.449037] Dynamic subtest D-eDP1: SUCCESS (8.718s)
[502.454188] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.951s)
[503.661134] [111/133] (519s left) gem_exec_balancer (parallel-balancer)
[503.925391] Starting subtest: parallel-balancer
[504.817279] Subtest parallel-balancer: SUCCESS (0.892s)
[504.932483] [112/133] (518s left) gem_mmap_gtt (basic-read)
[504.995276] Subtest basic-read: SKIP (0.000s)
[505.055974] [113/133] (518s left) gem_userptr_blits (stress-mm-invalidate-close)
[505.137710] Starting subtest: stress-mm-invalidate-close
[507.286455] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[507.408116] [114/133] (516s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[507.473466] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[507.477760] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[507.675760] [115/133] (516s left) kms_dirtyfb (default-dirtyfb-ioctl)
[507.778030] Starting subtest: default-dirtyfb-ioctl
[507.779902] Starting dynamic subtest: A-eDP-1
[509.395464] Dynamic subtest A-eDP-1: SUCCESS (1.618s)
[509.397998] Subtest default-dirtyfb-ioctl: SUCCESS (1.619s)
[510.196263] [116/133] (513s left) core_getclient (basic)
[510.251446] Starting subtest: basic
[510.253610] Subtest basic: SUCCESS (0.000s)
[510.338127] [117/133] (513s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[510.434993] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[510.437257] Starting dynamic subtest: pipe-A-eDP-1
[510.457685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[510.468468] Starting dynamic subtest: pipe-B-eDP-1
[510.487496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[510.495747] Starting dynamic subtest: pipe-C-eDP-1
[510.514485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[510.522257] Starting dynamic subtest: pipe-D-eDP-1
[510.541494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[510.543397] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[512.749685] [118/133] (511s left) gem_userptr_blits (map-fixed-invalidate)
[512.812447] Starting subtest: map-fixed-invalidate
[512.816770] Subtest map-fixed-invalidate: SKIP (0.000s)
[512.946540] [119/133] (511s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[513.029836] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[513.040763] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[513.136874] [120/133] (510s left) syncobj_timeline (invalid-signal-illegal-handle)
[513.184209] Starting subtest: invalid-signal-illegal-handle
[513.186391] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[513.273285] [121/133] (510s left) kms_joiner (basic-big-joiner)
[513.373024] Starting subtest: basic-big-joiner
[513.376924] Subtest basic-big-joiner: SKIP (0.000s)
[513.449882] [122/133] (510s left) gem_tiled_pread_basic (basic)
[513.502948] Subtest basic: SKIP (0.000s)
[513.571611] [123/133] (510s left) kms_cursor_crc (cursor-offscreen-512x512)
[513.832101] Starting subtest: cursor-offscreen-512x512
[513.835890] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[513.996612] [124/133] (510s left) perf (global-sseu-config-invalid)
[514.126253] Starting subtest: global-sseu-config-invalid
[514.129840] Subtest global-sseu-config-invalid: SKIP (0.000s)
[514.169569] [125/133] (510s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[514.261314] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[521.572121] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.313s)
[521.699650] [126/133] (502s left) gem_ctx_persistence (smoketest)
[521.759017] Starting subtest: smoketest
[561.757313] Subtest smoketest: SUCCESS (39.991s)
[561.870083] [127/133] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[561.974381] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[561.978850] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[562.076988] [128/133] (462s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[562.167635] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[562.169720] Starting dynamic subtest: pipe-A-eDP-1
[578.158106] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.436s)
[578.167224] Starting dynamic subtest: pipe-B-eDP-1
[595.140180] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.428s)
[595.149183] Starting dynamic subtest: pipe-C-eDP-1
[612.101136] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.419s)
[612.111349] Starting dynamic subtest: pipe-D-eDP-1
[629.086732] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.359s)
[629.089682] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.648s)
[630.236388] [129/133] (394s left) gem_busy (busy)
[630.320315] Starting subtest: busy
[630.322942] Starting dynamic subtest: all-engines
[630.372779] Dynamic subtest all-engines: SUCCESS (0.056s)
[630.383029] Starting dynamic subtest: rcs0
[632.087908] Dynamic subtest rcs0: SUCCESS (1.711s)
[632.098902] Starting dynamic subtest: bcs0
[632.131507] Dynamic subtest bcs0: SUCCESS (0.039s)
[632.140905] Starting dynamic subtest: vcs0
[632.173272] Dynamic subtest vcs0: SUCCESS (0.040s)
[632.182793] Starting dynamic subtest: vcs1
[634.068554] Dynamic subtest vcs1: SUCCESS (1.888s)
[634.083474] Starting dynamic subtest: vecs0
[636.115947] Dynamic subtest vecs0: SUCCESS (2.043s)
[636.126742] Starting dynamic subtest: ccs0
[638.165205] Dynamic subtest ccs0: SUCCESS (2.043s)
[638.167756] Subtest busy: SUCCESS (7.835s)
[638.496032] [130/133] (385s left) kms_psr (pr-primary-mmap-gtt)
[638.590669] Starting subtest: pr-primary-mmap-gtt
[638.595640] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[638.662107] [131/133] (385s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[638.763033] Starting subtest: psr-shrfb-scaledprimary
[644.525172] Subtest psr-shrfb-scaledprimary: SUCCESS (5.761s)
[644.639188] [132/133] (379s left) dmabuf_sync_file (export-multiwait)
[644.703821] Starting subtest: export-multiwait
[644.706675] Subtest export-multiwait: SUCCESS (0.000s)
[644.761370] [133/133] (379s left) i915_drm_fdinfo (basics)
[644.808580] Starting subtest: basics
[644.811051] Subtest basics: SUCCESS (0.000s)
[644.869288] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_prop_blob
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_busy
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_hdmi_inject
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_ctx_engines
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_plane_alpha_blend
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: template
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_chamelium_edid
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_atomic_interruptible
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_dirtyfb
results: parsing output: 115/ for test: core_getclient
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: gem_tiled_pread_basic
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_busy
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.