[110.704724] Initializing watchdogs
[110.704781]   /dev/watchdog0
[110.720772] [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]
[110.724807] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[110.726911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[110.730307] [001/130] (960s left) gem_wait (wait)
[110.881285] Starting subtest: wait
[110.883813] Starting dynamic subtest: all-engines
[112.939057] Dynamic subtest all-engines: SUCCESS (2.057s)
[112.948879] Starting dynamic subtest: rcs0
[113.987488] Dynamic subtest rcs0: SUCCESS (1.049s)
[113.999170] Starting dynamic subtest: bcs0
[115.031676] Dynamic subtest bcs0: SUCCESS (1.044s)
[115.039607] Starting dynamic subtest: vcs0
[116.075278] Dynamic subtest vcs0: SUCCESS (1.043s)
[116.082563] Starting dynamic subtest: vcs1
[117.120360] Dynamic subtest vcs1: SUCCESS (1.045s)
[117.129541] Starting dynamic subtest: vecs0
[118.164294] Dynamic subtest vecs0: SUCCESS (1.043s)
[118.172314] Starting dynamic subtest: ccs0
[119.211239] Dynamic subtest ccs0: SUCCESS (1.046s)
[119.213749] Subtest wait: SUCCESS (8.332s)
[119.402550] [002/130] (951s left) kms_chamelium_color (ctm-0-75)
[119.505471] Subtest ctm-0-75: SKIP (0.000s)
[119.543615] [003/130] (951s left) kms_cursor_crc (cursor-size-change)
[119.642108] Starting subtest: cursor-size-change
[119.644468] Starting dynamic subtest: pipe-A-eDP-1
[120.543641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[120.551598] Starting dynamic subtest: pipe-D-eDP-1
[122.085939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[122.088311] Subtest cursor-size-change: SUCCESS (2.442s)
[122.917966] [004/130] (948s left) syncobj_eventfd (timeline-wait)
[122.977061] Starting subtest: timeline-wait
[122.985894] Subtest timeline-wait: SUCCESS (0.010s)
[123.068854] [005/130] (948s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[123.132638] Starting subtest: multi-wait-all-for-submit-available-signaled
[123.134732] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[123.228508] [006/130] (948s left) perf_pmu (init-sema)
[123.268591] Starting subtest: init-sema
[123.270979] Starting dynamic subtest: rcs0
[123.273367] Dynamic subtest rcs0: SUCCESS (0.002s)
[123.281283] Starting dynamic subtest: bcs0
[123.283483] Dynamic subtest bcs0: SUCCESS (0.001s)
[123.289992] Starting dynamic subtest: vcs0
[123.292219] Dynamic subtest vcs0: SUCCESS (0.001s)
[123.298609] Starting dynamic subtest: vcs1
[123.300847] Dynamic subtest vcs1: SUCCESS (0.001s)
[123.307184] Starting dynamic subtest: vecs0
[123.309073] Dynamic subtest vecs0: SUCCESS (0.000s)
[123.315706] Starting dynamic subtest: ccs0
[123.317951] Dynamic subtest ccs0: SUCCESS (0.000s)
[123.320183] Subtest init-sema: SUCCESS (0.005s)
[123.360190] [007/130] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[123.458084] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[123.462404] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.561074] [008/130] (947s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[123.643648] Starting subtest: bad-rotation-90-y-tiled-ccs
[123.646016] Starting dynamic subtest: pipe-A-eDP-1
[123.668687] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.677057] Starting dynamic subtest: pipe-B-eDP-1
[123.698290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.704649] Starting dynamic subtest: pipe-C-eDP-1
[123.726306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.732591] Starting dynamic subtest: pipe-D-eDP-1
[123.754745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.759149] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[125.872638] [009/130] (945s left) sw_sync (sync_multi_consumer)
[125.908320] Starting subtest: sync_multi_consumer
[126.417199] Subtest sync_multi_consumer: SUCCESS (0.509s)
[126.470243] [010/130] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[126.575252] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[126.579592] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[126.680667] [011/130] (944s left) gem_ctx_sseu (invalid-sseu)
[126.747182] Subtest invalid-sseu: SKIP (0.000s)
[126.802895] [012/130] (944s left) api_intel_allocator (gem-pool)
[126.865789] Starting subtest: gem-pool
[126.872678] Subtest gem-pool: SUCCESS (0.008s)
[126.969549] [013/130] (944s left) prime_vgem (basic-gtt)
[127.073049] Starting subtest: basic-gtt
[127.077999] Subtest basic-gtt: SKIP (0.000s)
[127.184298] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[127.187393] [014/130] (944s left) gem_readwrite (write-bad-handle)
[127.257946] Subtest write-bad-handle: SKIP (0.000s)
[127.317802] [015/130] (944s left) gem_exec_schedule (preempt-self)
[127.388029] Starting subtest: preempt-self
[127.390829] Starting dynamic subtest: rcs0
[127.400944] Dynamic subtest rcs0: SUCCESS (0.020s)
[127.409767] Starting dynamic subtest: bcs0
[127.420820] Dynamic subtest bcs0: SUCCESS (0.020s)
[127.427451] Starting dynamic subtest: vcs0
[127.437967] Dynamic subtest vcs0: SUCCESS (0.017s)
[127.444257] Starting dynamic subtest: vcs1
[127.455993] Dynamic subtest vcs1: SUCCESS (0.017s)
[127.466035] Starting dynamic subtest: vecs0
[127.474242] Dynamic subtest vecs0: SUCCESS (0.018s)
[127.486085] Starting dynamic subtest: ccs0
[127.496516] Dynamic subtest ccs0: SUCCESS (0.022s)
[127.498521] Subtest preempt-self: SUCCESS (0.116s)
[129.029854] [016/130] (942s left) gem_madvise (dontneed-before-pwrite)
[129.066245] Starting subtest: dontneed-before-pwrite
[129.089947] Subtest dontneed-before-pwrite: SKIP (0.022s)
[129.152258] [017/130] (942s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[129.258804] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[129.262766] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.355940] [018/130] (942s left) kms_sequence (get-busy)
[129.449965] Starting subtest: get-busy
[129.452446] Starting dynamic subtest: pipe-A-eDP-1
[131.384363] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[131.392545] Starting dynamic subtest: pipe-B-eDP-1
[133.953845] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s)
[133.962325] Starting dynamic subtest: pipe-C-eDP-1
[136.580295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[136.586573] Starting dynamic subtest: pipe-D-eDP-1
[139.114262] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[139.116260] Subtest get-busy: SUCCESS (9.661s)
[139.893179] [019/130] (931s left) gem_pipe_control_store_loop (fresh-buffer)
[139.960638] Starting subtest: fresh-buffer
[142.114623] Subtest fresh-buffer: SUCCESS (2.152s)
[142.242757] [020/130] (929s left) kms_content_protection (mei-interface)
[142.416421] Starting subtest: mei-interface
[142.421351] Subtest mei-interface: SKIP (0.001s)
[142.568416] [021/130] (929s left) kms_busy (extended-pageflip-hang-newfb)
[142.677919] Starting subtest: extended-pageflip-hang-newfb
[142.680434] Starting dynamic subtest: pipe-A
[169.722289] Dynamic subtest pipe-A: SUCCESS (27.040s)
[169.730400] Starting dynamic subtest: pipe-D
[193.722731] Dynamic subtest pipe-D: SUCCESS (23.996s)
[193.725581] Subtest extended-pageflip-hang-newfb: SUCCESS (51.040s)
[194.540568] [022/130] (877s left) kms_plane_multiple (tiling-4)
[194.643957] Starting subtest: tiling-4
[194.646404] Starting dynamic subtest: pipe-A-eDP-1
[198.335791] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.689s)
[198.344068] Starting dynamic subtest: pipe-B-eDP-1
[202.741116] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.405s)
[202.748329] Starting dynamic subtest: pipe-C-eDP-1
[207.039124] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.295s)
[207.047687] Starting dynamic subtest: pipe-D-eDP-1
[211.370848] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[211.373742] Subtest tiling-4: SUCCESS (16.724s)
[212.168397] [023/130] (859s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[212.272353] Starting subtest: x-tiled-16bpp-rotate-0
[213.671092] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.400s)
[213.810426] [024/130] (858s left) syncobj_wait (reset-during-wait-for-submit)
[213.857162] Starting subtest: reset-during-wait-for-submit
[213.958787] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[214.029109] [025/130] (857s left) perf_pmu (busy)
[214.074825] Starting subtest: busy
[214.077272] Starting dynamic subtest: rcs0
[214.684557] Dynamic subtest rcs0: SUCCESS (0.612s)
[214.694580] Starting dynamic subtest: bcs0
[215.255914] Dynamic subtest bcs0: SUCCESS (0.570s)
[215.264840] Starting dynamic subtest: vcs0
[216.940402] Dynamic subtest vcs0: SUCCESS (1.682s)
[216.951037] Starting dynamic subtest: vcs1
[218.921934] Dynamic subtest vcs1: SUCCESS (1.981s)
[218.932511] Starting dynamic subtest: vecs0
[220.905506] Dynamic subtest vecs0: SUCCESS (1.982s)
[220.915686] Starting dynamic subtest: ccs0
[221.471461] Dynamic subtest ccs0: SUCCESS (0.566s)
[221.474542] Subtest busy: SUCCESS (7.398s)
[221.569120] [026/130] (850s left) gem_userptr_blits (coherency-sync)
[221.646583] Starting subtest: coherency-sync
[221.988281] Subtest coherency-sync: SKIP (0.304s)
[222.086662] [027/130] (850s left) kms_psr (psr-sprite-plane-move)
[222.228354] Starting subtest: psr-sprite-plane-move
[222.230669] Starting dynamic subtest: eDP-1
[224.006778] Dynamic subtest eDP-1: SUCCESS (1.776s)
[224.008673] Subtest psr-sprite-plane-move: SUCCESS (1.776s)
[224.818569] [028/130] (847s left) kms_psr (fbc-psr2-primary-page-flip)
[224.917213] Starting subtest: fbc-psr2-primary-page-flip
[224.919532] Starting dynamic subtest: eDP-1
[224.923702] Dynamic subtest eDP-1: SKIP (0.000s)
[224.927799] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[224.987495] [029/130] (847s left) gem_exec_schedule (submit-late-slice)
[225.068813] Starting subtest: submit-late-slice
[225.071060] Starting dynamic subtest: rcs0
[225.095531] Dynamic subtest rcs0: SUCCESS (0.032s)
[225.105276] Starting dynamic subtest: bcs0
[225.121390] Dynamic subtest bcs0: SUCCESS (0.026s)
[225.128960] Starting dynamic subtest: vcs0
[225.153196] Dynamic subtest vcs0: SUCCESS (0.032s)
[225.162679] Starting dynamic subtest: vcs1
[225.179484] Dynamic subtest vcs1: SUCCESS (0.026s)
[225.187424] Starting dynamic subtest: vecs0
[225.203622] Dynamic subtest vecs0: SUCCESS (0.024s)
[225.216837] Starting dynamic subtest: ccs0
[225.234631] Dynamic subtest ccs0: SUCCESS (0.031s)
[225.236937] Subtest submit-late-slice: SUCCESS (0.171s)
[227.018489] [030/130] (845s left) gem_ringfill (basic-all)
[232.940330] Starting subtest: basic-all
[234.123442] Subtest basic-all: SUCCESS (1.183s)
[234.253641] [031/130] (837s left) tools_test (tools_test)
[234.308109] Starting subtest: tools_test
[234.373071] Subtest tools_test: SUCCESS (0.083s)
[234.430886] [032/130] (837s left) syncobj_timeline (invalid-signal-bad-pad)
[234.494862] Starting subtest: invalid-signal-bad-pad
[234.497506] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[234.606253] [033/130] (837s left) kms_chamelium_audio (hdmi-audio-edid)
[234.991077] Subtest hdmi-audio-edid: SKIP (0.000s)
[235.821604] [034/130] (836s left) gem_render_copy_redux (flink)
[235.880450] Starting subtest: flink
[236.731643] Subtest flink: SUCCESS (0.852s)
[236.858067] [035/130] (835s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[236.963893] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[241.766773] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.804s)
[241.865146] [036/130] (830s left) gem_userptr_blits (stress-purge)
[241.933941] Starting subtest: stress-purge
[247.309213] Subtest stress-purge: SUCCESS (5.375s)
[247.463688] [037/130] (824s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[247.633090] Starting subtest: cursorB-vs-flipA-legacy
[247.636652] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[247.761307] [038/130] (824s left) kms_flip (2x-modeset-vs-vblank-race)
[247.870525] Starting subtest: 2x-modeset-vs-vblank-race
[247.882484] Subtest 2x-modeset-vs-vblank-race: SKIP (0.012s)
[247.975375] [039/130] (824s left) gem_exec_balancer (parallel-out-fence)
[248.228654] Starting subtest: parallel-out-fence
[249.300442] Subtest parallel-out-fence: SUCCESS (1.072s)
[249.442687] [040/130] (823s left) kms_big_fb (linear-16bpp-rotate-270)
[249.557338] Starting subtest: linear-16bpp-rotate-270
[249.576083] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[249.720077] [041/130] (822s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[249.828620] Starting subtest: plane-scaler-unity-scaling-with-rotation
[249.830921] Starting dynamic subtest: pipe-A
[250.166100] Dynamic subtest pipe-A: SUCCESS (0.337s)
[250.176568] Starting dynamic subtest: pipe-B
[251.570547] Dynamic subtest pipe-B: SUCCESS (1.404s)
[251.579505] Starting dynamic subtest: pipe-C
[252.992544] Dynamic subtest pipe-C: SUCCESS (1.422s)
[253.001940] Starting dynamic subtest: pipe-D
[254.423438] Dynamic subtest pipe-D: SUCCESS (1.430s)
[254.425850] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.595s)
[255.602971] [042/130] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[255.710703] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[255.715387] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[255.806318] [043/130] (816s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[255.869885] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[255.878082] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[256.045122] [044/130] (816s left) gem_ctx_persistence (legacy-engines-queued)
[256.112141] Starting subtest: legacy-engines-queued
[256.114601] Starting dynamic subtest: render
[256.218772] Dynamic subtest render: SUCCESS (0.106s)
[256.230172] Starting dynamic subtest: bsd1
[257.866373] Dynamic subtest bsd1: SUCCESS (1.644s)
[257.876901] Starting dynamic subtest: bsd2
[259.912476] Dynamic subtest bsd2: SUCCESS (2.043s)
[259.923526] Starting dynamic subtest: blt
[259.973026] Dynamic subtest blt: SUCCESS (0.059s)
[259.983275] Starting dynamic subtest: vebox
[261.896521] Dynamic subtest vebox: SUCCESS (1.920s)
[261.899608] Subtest legacy-engines-queued: SUCCESS (5.783s)
[261.971941] [045/130] (810s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[262.066025] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[262.068274] Starting dynamic subtest: pipe-A-default-mode
[262.360984] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[262.370133] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.287s)
[263.220451] [046/130] (809s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[263.327653] Starting subtest: 4-tiled-16bpp-rotate-90
[263.346452] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[263.474384] [047/130] (809s left) gem_userptr_blits (stress-mm-invalidate-close)
[263.551604] Starting subtest: stress-mm-invalidate-close
[265.701772] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[265.827206] [048/130] (807s left) gem_pipe_control_store_loop (reused-buffer)
[265.884154] Starting subtest: reused-buffer
[268.037643] Subtest reused-buffer: SUCCESS (2.152s)
[268.200977] [049/130] (804s left) kms_atomic (plane-invalid-params-fence)
[268.306075] Starting subtest: plane-invalid-params-fence
[268.308244] Starting dynamic subtest: pipe-A-eDP-1
[268.705762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[268.707723] Subtest plane-invalid-params-fence: SUCCESS (0.396s)
[269.554369] [050/130] (803s left) fbdev (eof)
[269.599817] Starting subtest: eof
[269.602097] Subtest eof: SUCCESS (0.000s)
[269.653710] [051/130] (803s left) api_intel_bb (simple-bb)
[269.716280] Starting subtest: simple-bb
[269.721350] Subtest simple-bb: SUCCESS (0.007s)
[269.826719] [052/130] (803s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[269.928194] Starting subtest: bo-too-small-due-to-tiling
[269.932775] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[270.033826] [053/130] (802s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[270.143496] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[270.147981] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[270.253276] [054/130] (802s left) gem_mmap_gtt (cpuset-big-copy)
[270.310587] Subtest cpuset-big-copy: SKIP (0.000s)
[270.363024] [055/130] (802s left) gem_pxp (create-valid-protected-context)
[270.486698] Starting subtest: create-valid-protected-context
[270.488884] Subtest create-valid-protected-context: SUCCESS (0.002s)
[270.606165] [056/130] (802s left) kms_tv_load_detect (load-detect)
[270.674504] Subtest load-detect: SKIP (0.000s)
[270.739344] [057/130] (802s left) gem_lmem_swapping (verify)
[270.781941] Subtest verify: SKIP (0.000s)
[270.820843] [058/130] (802s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[270.880530] Starting subtest: wait-all-for-submit-delayed-submit
[270.984884] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[271.059898] [059/130] (802s left) prime_mmap (test_dup)
[271.123799] Starting subtest: test_dup
[271.125752] Starting dynamic subtest: test_dup-smem
[271.157040] Dynamic subtest test_dup-smem: SUCCESS (0.035s)
[271.159547] Subtest test_dup: SUCCESS (0.036s)
[271.226874] [060/130] (802s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[271.360573] Starting subtest: cursor-rapid-movement-32x32
[271.412103] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[271.660015] [061/130] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[271.768592] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[271.772827] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[271.883888] [062/130] (801s left) kms_getfb (getfb-repeated-different-handles)
[271.932035] Starting subtest: getfb-repeated-different-handles
[271.934357] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[272.026779] [063/130] (801s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[272.129268] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[277.157917] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.030s)
[277.322506] [064/130] (796s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[277.722447] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[278.501075] [065/130] (794s left) gem_partial_pwrite_pread (reads)
[278.565524] Subtest reads: SKIP (0.000s)
[278.622807] [066/130] (794s left) gem_exec_schedule (manyslice)
[278.691569] Starting subtest: manyslice
[278.693783] Starting dynamic subtest: rcs0
[283.302159] Dynamic subtest rcs0: SUCCESS (4.620s)
[283.312025] Starting dynamic subtest: bcs0
[288.909605] Dynamic subtest bcs0: SUCCESS (5.606s)
[288.919571] Starting dynamic subtest: vcs0
[293.981214] Dynamic subtest vcs0: SUCCESS (5.070s)
[293.996766] Starting dynamic subtest: vcs1
[299.550129] Dynamic subtest vcs1: SUCCESS (5.568s)
[299.558920] Starting dynamic subtest: vecs0
[305.106246] Dynamic subtest vecs0: SUCCESS (5.556s)
[305.119959] Starting dynamic subtest: ccs0
[310.760322] Dynamic subtest ccs0: SUCCESS (5.652s)
[310.762722] Subtest manyslice: SUCCESS (32.077s)
[311.055932] [067/130] (762s left) kms_pm_rpm (modeset-lpsp)
[313.098608] Starting subtest: modeset-lpsp
[314.564419] Subtest modeset-lpsp: SUCCESS (1.466s)
[314.664925] [068/130] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[314.765082] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[314.769285] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.864364] [069/130] (758s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[314.971622] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[314.976072] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[315.059909] [070/130] (758s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[315.167692] Starting subtest: fbc-tiling-linear
[317.834605] Subtest fbc-tiling-linear: SUCCESS (2.670s)
[318.000181] [071/130] (755s left) syncobj_wait (invalid-wait-illegal-handle)
[318.062905] Starting subtest: invalid-wait-illegal-handle
[318.064969] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[318.170482] [072/130] (755s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[318.231775] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[318.234128] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[318.339014] [073/130] (755s left) kms_pm_rpm (pm-caching)
[320.078971] Starting subtest: pm-caching
[320.084939] Subtest pm-caching: SKIP (0.000s)
[320.572885] [074/130] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[320.672539] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[320.676558] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[320.774041] [075/130] (753s left) kms_cursor_legacy (torture-move)
[320.892573] Starting subtest: torture-move
[320.894523] Starting dynamic subtest: pipe-A
[326.693389] Dynamic subtest pipe-A: SUCCESS (5.798s)
[326.704929] Starting dynamic subtest: pipe-B
[333.606828] Dynamic subtest pipe-B: SUCCESS (6.912s)
[333.618668] Starting dynamic subtest: pipe-C
[340.115123] Dynamic subtest pipe-C: SUCCESS (6.506s)
[340.125438] Starting dynamic subtest: pipe-D
[346.279088] Dynamic subtest pipe-D: SUCCESS (6.163s)
[346.289108] Starting dynamic subtest: all-pipes
[353.159322] Dynamic subtest all-pipes: SUCCESS (6.878s)
[353.161731] Subtest torture-move: SUCCESS (32.264s)
[353.299156] [076/130] (720s left) gem_userptr_blits (dmabuf-unsync)
[353.365335] Subtest dmabuf-unsync: SKIP (0.000s)
[353.489430] [077/130] (720s left) gem_render_copy_redux (flink-interruptible)
[353.544570] Starting subtest: flink-interruptible
[354.405077] Subtest flink-interruptible: SUCCESS (0.861s)
[354.548543] [078/130] (719s left) kms_flip (flip-vs-absolute-wf_vblank)
[354.654219] Starting subtest: flip-vs-absolute-wf_vblank
[354.656122] Starting dynamic subtest: A-eDP1
[363.608802] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[363.617845] Starting dynamic subtest: B-eDP1
[372.536729] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[372.544725] Starting dynamic subtest: C-eDP1
[381.444544] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[381.455103] Starting dynamic subtest: D-eDP1
[390.363499] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[390.368405] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.712s)
[391.586084] [079/130] (682s left) gem_ctx_param (invalid-ctx-get)
[391.643912] Starting subtest: invalid-ctx-get
[391.646284] Subtest invalid-ctx-get: SUCCESS (0.000s)
[391.740931] [080/130] (682s left) gem_exec_fence (invalid-fence-array)
[392.178129] Starting subtest: invalid-fence-array
[392.180959] Subtest invalid-fence-array: SUCCESS (0.002s)
[394.009780] [081/130] (680s left) i915_power (sanity)
[394.067161] Starting subtest: sanity
[398.117582] Subtest sanity: SUCCESS (4.043s)
[400.013967] [082/130] (674s left) kms_feature_discovery (display-3x)
[400.140057] Starting subtest: display-3x
[400.144160] Subtest display-3x: SKIP (0.000s)
[400.208401] [083/130] (673s left) kms_writeback (writeback-invalid-parameters)
[400.311696] Subtest writeback-invalid-parameters: SKIP (0.000s)
[400.353792] [084/130] (673s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[405.338555] Starting subtest: psr2-cursor-plane-move-continuous-sf
[405.340961] Starting dynamic subtest: pipe-A-eDP-1
[416.412589] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.071s)
[416.421078] Starting dynamic subtest: pipe-B-eDP-1
[427.446133] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.031s)
[427.448531] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.107s)
[428.232255] [085/130] (645s left) kms_vblank (ts-continuation-modeset-hang)
[428.337343] Starting subtest: ts-continuation-modeset-hang
[428.339699] Starting dynamic subtest: pipe-A-eDP-1
[454.749118] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.408s)
[454.763974] Starting dynamic subtest: pipe-D-eDP-1
[469.671220] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.919s)
[469.673390] Subtest ts-continuation-modeset-hang: SUCCESS (41.331s)
[470.521074] [086/130] (603s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[470.622556] Starting subtest: fbc-rgb101010-draw-blt
[474.235248] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.616s)
[474.388858] [087/130] (599s left) i915_hangman (error-state-basic)
[474.457967] Starting subtest: error-state-basic
[474.570867] Subtest error-state-basic: SUCCESS (0.114s)
[474.640044] [088/130] (599s left) kms_psr (pr-primary-page-flip)
[474.748823] Starting subtest: pr-primary-page-flip
[474.752792] Subtest pr-primary-page-flip: SKIP (0.000s)
[474.814608] [089/130] (599s left) syncobj_wait (wait-zero-handles)
[474.876771] Starting subtest: wait-zero-handles
[474.879197] Subtest wait-zero-handles: SUCCESS (0.000s)
[474.988705] [090/130] (599s left) gem_exec_fence (syncobj-wait)
[475.401934] Starting subtest: syncobj-wait
[476.906956] Subtest syncobj-wait: SUCCESS (1.503s)
[477.265761] [091/130] (597s left) syncobj_wait (single-wait-signaled)
[477.327632] Starting subtest: single-wait-signaled
[477.330027] Subtest single-wait-signaled: SUCCESS (0.000s)
[477.417088] [092/130] (597s left) gem_exec_suspend (basic)
[477.482622] Starting subtest: basic
[477.485076] Starting dynamic subtest: smem
[478.954120] Dynamic subtest smem: SUCCESS (1.470s)
[478.957112] Subtest basic: SUCCESS (1.471s)
[479.134227] [093/130] (595s left) kms_lease (lease-get)
[479.228074] Starting subtest: lease-get
[479.230288] Starting dynamic subtest: pipe-A-eDP-1
[479.232758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[479.243328] Starting dynamic subtest: pipe-B-eDP-1
[479.245168] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[479.253218] Starting dynamic subtest: pipe-C-eDP-1
[479.255070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[479.262983] Starting dynamic subtest: pipe-D-eDP-1
[479.264820] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[479.266685] Subtest lease-get: SUCCESS (0.009s)
[479.345482] [094/130] (595s left) gem_exec_params (invalid-bsd2-flag-on-render)
[479.417489] Starting subtest: invalid-bsd2-flag-on-render
[479.419762] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[479.524935] [095/130] (595s left) i915_getparams_basic (basic-eu-total)
[479.578485] Starting subtest: basic-eu-total
[479.582272] Subtest basic-eu-total: SUCCESS (0.000s)
[479.666872] [096/130] (594s left) gem_ctx_isolation (nonpriv-switch)
[479.726813] Starting subtest: nonpriv-switch
[479.729153] Starting dynamic subtest: rcs0
[480.311725] Dynamic subtest rcs0: SUCCESS (0.585s)
[480.320922] Starting dynamic subtest: bcs0
[480.985308] Dynamic subtest bcs0: SUCCESS (0.673s)
[480.994139] Starting dynamic subtest: vcs0
[481.617076] Dynamic subtest vcs0: SUCCESS (0.631s)
[481.629079] Starting dynamic subtest: vcs1
[483.559513] Dynamic subtest vcs1: SUCCESS (1.941s)
[483.571964] Starting dynamic subtest: vecs0
[485.508387] Dynamic subtest vecs0: SUCCESS (1.948s)
[485.517338] Starting dynamic subtest: ccs0
[487.616319] Dynamic subtest ccs0: SUCCESS (2.107s)
[487.618577] Subtest nonpriv-switch: SUCCESS (7.890s)
[487.860350] [097/130] (586s left) kms_flip (absolute-wf_vblank-interruptible)
[487.959722] Starting subtest: absolute-wf_vblank-interruptible
[487.962109] Starting dynamic subtest: A-eDP1
[496.713417] Dynamic subtest A-eDP1: SUCCESS (8.751s)
[496.722085] Starting dynamic subtest: B-eDP1
[505.435293] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[505.443561] Starting dynamic subtest: C-eDP1
[514.150270] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[514.160635] Starting dynamic subtest: D-eDP1
[522.876927] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[522.882047] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.920s)
[524.080301] [098/130] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[524.189740] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[524.193929] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[524.264616] [099/130] (550s left) kms_cursor_crc (cursor-offscreen-64x21)
[524.446197] Starting subtest: cursor-offscreen-64x21
[524.482843] Subtest cursor-offscreen-64x21: SKIP (0.034s)
[524.718097] [100/130] (550s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[524.811143] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[524.813744] Starting dynamic subtest: pipe-A-eDP-1
[525.239824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[525.249549] Starting dynamic subtest: pipe-B-eDP-1
[526.668210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[526.678590] Starting dynamic subtest: pipe-C-eDP-1
[527.979999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[527.990429] Starting dynamic subtest: pipe-D-eDP-1
[529.315745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[529.317635] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.473s)
[530.490345] [101/130] (544s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[530.598399] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[530.603082] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[531.715347] [102/130] (543s left) kms_plane_lowres (tiling-4)
[531.817231] Starting subtest: tiling-4
[531.819596] Starting dynamic subtest: pipe-A-eDP-1
[531.824350] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[532.112859] Starting dynamic subtest: pipe-B-eDP-1
[532.117478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[532.128654] Starting dynamic subtest: pipe-C-eDP-1
[532.133376] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[532.141718] Starting dynamic subtest: pipe-D-eDP-1
[532.145874] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[532.150183] Subtest tiling-4: SKIP (0.290s)
[532.939242] [103/130] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[533.040829] Starting subtest: psr-1p-primscrn-cur-indfb-move
[538.124997] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.088s)
[538.267452] [104/130] (536s left) dmabuf_sync_file (import-multiple-read-write)
[538.313597] Starting subtest: import-multiple-read-write
[538.316061] Subtest import-multiple-read-write: SUCCESS (0.003s)
[538.368501] [105/130] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[538.470365] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[538.474658] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[538.575103] [106/130] (536s left) prime_vgem (coherency-gtt)
[538.647304] Starting subtest: coherency-gtt
[538.651750] Subtest coherency-gtt: SKIP (0.000s)
[538.741195] [107/130] (536s left) gem_exec_whisper (basic-queues-forked)
[538.800446] Starting subtest: basic-queues-forked
[562.825894] Subtest basic-queues-forked: SUCCESS (24.020s)
[563.006190] [108/130] (511s left) gem_ctx_param (vm)
[563.054994] Starting subtest: vm
[563.132323] Subtest vm: SUCCESS (0.077s)
[563.274014] [109/130] (511s left) gem_compute (compute-square)
[563.332483] Starting subtest: compute-square
[563.341514] Subtest compute-square: SUCCESS (0.012s)
[563.458182] [110/130] (511s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[563.572097] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[563.576964] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[563.678921] [111/130] (511s left) syncobj_wait (invalid-reset-illegal-handle)
[563.741459] Starting subtest: invalid-reset-illegal-handle
[563.743732] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[563.861973] [112/130] (511s left) i915_suspend (basic-s2idle-without-i915)
[563.900072] Starting subtest: basic-s2idle-without-i915
[585.059169] Subtest basic-s2idle-without-i915: SUCCESS (5.760s)
[585.180549] [113/130] (505s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[590.082887] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[590.085376] Starting dynamic subtest: pipe-A-eDP-1
[590.858014] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[590.868215] Starting dynamic subtest: pipe-B-eDP-1
[591.957704] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[591.962365] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.909s)
[593.109595] [114/130] (497s left) gem_mmap_gtt (coherency)
[593.166765] Subtest coherency: SKIP (0.000s)
[593.221101] [115/130] (497s left) gem_render_copy (y-tiled)
[593.279459] Starting subtest: y-tiled
[593.284119] Subtest y-tiled: SKIP (0.000s)
[593.460830] [116/130] (497s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[593.579341] Starting subtest: short-flip-before-cursor-atomic-transitions
[594.544951] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.976s)
[595.410818] [117/130] (495s left) kms_psr (fbc-pr-cursor-plane-onoff)
[595.514849] Starting subtest: fbc-pr-cursor-plane-onoff
[595.519016] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[595.579974] [118/130] (494s left) kms_draw_crc (draw-method-mmap-cpu)
[595.682969] Starting subtest: draw-method-mmap-cpu
[595.684827] Starting dynamic subtest: xrgb8888-untiled
[595.896763] Dynamic subtest xrgb8888-untiled: SUCCESS (0.218s)
[595.905206] Starting dynamic subtest: rgb565-untiled
[596.094488] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[596.103523] Starting dynamic subtest: xrgb2101010-untiled
[596.303707] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[596.312177] Starting dynamic subtest: xbgr16161616f-untiled
[596.523633] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[596.533963] Starting dynamic subtest: xrgb8888-xtiled
[596.644722] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[596.653017] Starting dynamic subtest: rgb565-xtiled
[596.765692] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[596.773875] Starting dynamic subtest: xrgb2101010-xtiled
[596.875633] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[596.883857] Starting dynamic subtest: xbgr16161616f-xtiled
[596.996643] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[597.004523] Starting dynamic subtest: xrgb8888-4tiled
[597.139948] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[597.149330] Starting dynamic subtest: rgb565-4tiled
[597.260815] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[597.269213] Starting dynamic subtest: xrgb2101010-4tiled
[597.382470] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[597.392521] Starting dynamic subtest: xbgr16161616f-4tiled
[597.515080] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[597.517397] Subtest draw-method-mmap-cpu: SUCCESS (1.853s)
[597.614111] [119/130] (492s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[597.746749] Starting subtest: flip-vs-cursor-busy-crc-legacy
[598.500928] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.758s)
[599.304508] [120/130] (491s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[599.401708] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[599.405784] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[599.519486] [121/130] (491s left) kms_pm_dc (dc5-dpms)
[600.628935] Starting subtest: dc5-dpms
[602.663442] Subtest dc5-dpms: SUCCESS (2.044s)
[602.739486] [122/130] (487s left) kms_invalid_mode (bad-vsync-end)
[602.843248] Starting subtest: bad-vsync-end
[602.845589] Starting dynamic subtest: pipe-A-eDP-1
[603.140784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[603.151978] Starting dynamic subtest: pipe-B-eDP-1
[603.154117] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[603.162763] Starting dynamic subtest: pipe-C-eDP-1
[603.165263] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[603.173881] Starting dynamic subtest: pipe-D-eDP-1
[603.176270] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[603.178585] Subtest bad-vsync-end: SUCCESS (0.303s)
[603.934473] [123/130] (486s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[603.996251] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[604.103136] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[604.178807] [124/130] (486s left) kms_concurrent (multi-plane-atomic-lowres)
[604.278937] Starting subtest: multi-plane-atomic-lowres
[604.280724] Starting dynamic subtest: pipe-A-eDP-1
[604.793990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[604.796448] Subtest multi-plane-atomic-lowres: SUCCESS (0.516s)
[605.650392] [125/130] (485s left) gem_mmap_wc (pf-nonblock)
[605.716076] Subtest pf-nonblock: SKIP (0.000s)
[605.779000] [126/130] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[605.895146] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[605.899043] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[606.005160] [127/130] (484s left) perf (enable-disable)
[606.127346] Starting subtest: enable-disable
[606.129572] Starting dynamic subtest: 0-rcs0
[608.418645] Dynamic subtest 0-rcs0: SUCCESS (2.295s)
[608.427697] Starting dynamic subtest: 1-vcs0
[612.946988] Dynamic subtest 1-vcs0: SUCCESS (4.536s)
[612.949766] Subtest enable-disable: SUCCESS (6.833s)
[612.987285] [128/130] (477s left) kms_big_fb (x-tiled-addfb)
[613.101096] Starting subtest: x-tiled-addfb
[613.103420] Subtest x-tiled-addfb: SUCCESS (0.000s)
[613.213276] [129/130] (477s left) kms_busy (extended-modeset-hang-newfb)
[613.327179] Starting subtest: extended-modeset-hang-newfb
[613.329516] Starting dynamic subtest: pipe-A
[648.263944] Dynamic subtest pipe-A: SUCCESS (34.931s)
[648.273782] Starting dynamic subtest: pipe-D
[671.148964] Dynamic subtest pipe-D: SUCCESS (22.893s)
[671.151413] Subtest extended-modeset-hang-newfb: SUCCESS (57.830s)
[671.931816] [130/130] (418s left) kms_psr (pr-suspend)
[672.033330] Starting subtest: pr-suspend
[672.037936] Subtest pr-suspend: SKIP (0.000s)
[672.104422] Closing watchdogs
results: parsing output: 0/ for test: gem_wait
results: parsing output: 1/ for test: kms_chamelium_color
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_ctx_sseu
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: gem_readwrite
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_madvise
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_sequence
results: parsing output: 18/ for test: gem_pipe_control_store_loop
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_plane_multiple
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_ringfill
results: parsing output: 30/ for test: tools_test
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: gem_render_copy_redux
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: gem_pipe_control_store_loop
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: fbdev
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_tv_load_detect
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_partial_pwrite_pread
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: gem_render_copy_redux
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: i915_power
results: parsing output: 81/ for test: kms_feature_discovery
results: parsing output: 82/ for test: kms_writeback
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_exec_suspend
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: i915_getparams_basic
results: parsing output: 95/ for test: gem_ctx_isolation
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_plane_lowres
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: dmabuf_sync_file
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: prime_vgem
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: gem_compute
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: i915_suspend
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_draw_crc
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pm_dc
results: parsing output: 121/ for test: kms_invalid_mode
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_concurrent
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_busy
results: parsing output: 129/ for test: kms_psr
Done.