[59.714339] Initializing watchdogs
[59.714385]   /dev/watchdog0
[59.727528] [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]
[59.732575] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.734730] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.736648] [001/134] (960s left) kms_setmode (invalid-clone-single-crtc-stealing)
[59.799973] Starting subtest: invalid-clone-single-crtc-stealing
[59.804180] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[59.922317] [002/134] (960s left) gem_lmem_swapping (parallel-random)
[59.966547] Subtest parallel-random: SKIP (0.000s)
[60.004923] [003/134] (960s left) kms_sequence (get-idle)
[60.099790] Starting subtest: get-idle
[60.100703] Starting dynamic subtest: pipe-A-eDP-1
[61.942164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.830s)
[61.951878] Starting dynamic subtest: pipe-B-eDP-1
[64.472815] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.516s)
[64.479587] Starting dynamic subtest: pipe-C-eDP-1
[66.907990] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[66.914074] Starting dynamic subtest: pipe-D-eDP-1
[69.330235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[69.331164] Subtest get-idle: SUCCESS (9.194s)
[70.151296] [004/134] (950s left) gem_exec_gttfill (all-engines)
[70.210079] Starting subtest: all-engines
[93.172386] Subtest all-engines: SUCCESS (22.940s)
[93.365798] [005/134] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[93.494807] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[93.496690] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[93.616340] [006/134] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[93.716442] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[93.718448] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[93.833255] [007/134] (926s left) i915_pm_rpm (gem-mmap-type)
[96.074104] Starting subtest: gem-mmap-type
[96.075763] Starting dynamic subtest: wb-smem0
[99.528377] Dynamic subtest wb-smem0: SUCCESS (3.454s)
[99.538434] Starting dynamic subtest: wc-smem0
[102.703588] Dynamic subtest wc-smem0: SUCCESS (3.174s)
[102.711665] Starting dynamic subtest: uc-smem0
[105.594169] Dynamic subtest uc-smem0: SUCCESS (2.889s)
[105.595142] Subtest gem-mmap-type: SUCCESS (9.519s)
[105.685797] [008/134] (914s left) gem_ctx_isolation (nonpriv-switch)
[105.743161] Starting subtest: nonpriv-switch
[105.744110] Starting dynamic subtest: rcs0
[106.011796] Dynamic subtest rcs0: SUCCESS (0.268s)
[106.020946] Starting dynamic subtest: bcs0
[106.312849] Dynamic subtest bcs0: SUCCESS (0.301s)
[106.321560] Starting dynamic subtest: vcs0
[106.620746] Dynamic subtest vcs0: SUCCESS (0.308s)
[106.628999] Starting dynamic subtest: vcs1
[108.213121] Dynamic subtest vcs1: SUCCESS (1.592s)
[108.221373] Starting dynamic subtest: vecs0
[110.234705] Dynamic subtest vecs0: SUCCESS (2.021s)
[110.243358] Starting dynamic subtest: ccs0
[112.235901] Dynamic subtest ccs0: SUCCESS (2.000s)
[112.237393] Subtest nonpriv-switch: SUCCESS (6.491s)
[112.502611] [009/134] (907s left) kms_cursor_edge_walk (64x64-top-edge)
[112.590807] Starting subtest: 64x64-top-edge
[112.591859] Starting dynamic subtest: pipe-A-eDP-1
[116.029164] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[116.035992] Starting dynamic subtest: pipe-D-eDP-1
[119.160204] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[119.161135] Subtest 64x64-top-edge: SUCCESS (6.568s)
[119.965551] [010/134] (900s left) kms_cursor_crc (cursor-random-128x128)
[120.181905] Starting subtest: cursor-random-128x128
[120.183928] Starting dynamic subtest: pipe-A-eDP-1
[123.546246] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.361s)
[123.571856] Starting dynamic subtest: pipe-D-eDP-1
[127.549668] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.982s)
[127.550573] Subtest cursor-random-128x128: SUCCESS (7.367s)
[128.432937] [011/134] (892s left) gem_ctx_shared (detached-shared-gtt)
[128.489757] Starting subtest: detached-shared-gtt
[130.643434] Subtest detached-shared-gtt: SUCCESS (2.151s)
[131.060974] [012/134] (889s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[131.147189] Starting subtest: read-crc-frame-sequence
[131.148162] Starting dynamic subtest: pipe-A-eDP-1
[131.843169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[131.850047] Starting dynamic subtest: pipe-B-eDP-1
[133.186429] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[133.193029] Starting dynamic subtest: pipe-C-eDP-1
[134.468410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[134.476805] Starting dynamic subtest: pipe-D-eDP-1
[135.795352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[135.796270] Subtest read-crc-frame-sequence: SUCCESS (4.648s)
[136.640231] [013/134] (883s left) gen3_mixed_blits
[136.755831] [014/134] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[136.851532] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[136.853252] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[136.959748] [015/134] (883s left) kms_draw_crc (draw-method-render)
[137.046496] Starting subtest: draw-method-render
[137.047465] Starting dynamic subtest: xrgb8888-untiled
[137.267153] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[137.273926] Starting dynamic subtest: rgb565-untiled
[137.489101] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[137.495586] Starting dynamic subtest: xrgb2101010-untiled
[137.711494] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[137.717847] Starting dynamic subtest: xbgr16161616f-untiled
[137.956070] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[137.962998] Starting dynamic subtest: xrgb8888-xtiled
[138.089315] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[138.096354] Starting dynamic subtest: rgb565-xtiled
[138.200560] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[138.207427] Starting dynamic subtest: xrgb2101010-xtiled
[138.311739] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[138.323390] Starting dynamic subtest: xbgr16161616f-xtiled
[138.433806] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[138.443145] Starting dynamic subtest: xrgb8888-4tiled
[138.567220] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[138.576869] Starting dynamic subtest: rgb565-4tiled
[138.689995] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[138.725302] Starting dynamic subtest: xrgb2101010-4tiled
[138.800493] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[138.807398] Starting dynamic subtest: xbgr16161616f-4tiled
[138.933792] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[138.934657] Subtest draw-method-render: SUCCESS (1.889s)
[139.030143] [016/134] (881s left) gem_exec_params (cliprects_ptr-dirt)
[139.090258] Starting subtest: cliprects_ptr-dirt
[139.091193] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[139.207764] [017/134] (881s left) gem_pxp (reject-modify-context-protection-off-1)
[139.332453] Starting subtest: reject-modify-context-protection-off-1
[139.333588] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[139.448143] [018/134] (881s left) gem_fence_thrash (bo-write-verify-threaded-x)
[139.477481] Starting subtest: bo-write-verify-threaded-x
[139.506532] Subtest bo-write-verify-threaded-x: SKIP (0.027s)
[139.568696] [019/134] (881s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[139.635685] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[139.637594] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[139.822690] [020/134] (880s left) gem_softpin (evict-prime)
[139.880285] Starting subtest: evict-prime
[139.881291] Starting dynamic subtest: rcs0
[141.085861] Dynamic subtest rcs0: SUCCESS (1.206s)
[141.094925] Starting dynamic subtest: bcs0
[142.239596] Dynamic subtest bcs0: SUCCESS (1.153s)
[142.248668] Starting dynamic subtest: vcs0
[143.924923] Dynamic subtest vcs0: SUCCESS (1.682s)
[143.931997] Starting dynamic subtest: vcs1
[145.909243] Dynamic subtest vcs1: SUCCESS (1.982s)
[145.917341] Starting dynamic subtest: vecs0
[147.884074] Dynamic subtest vecs0: SUCCESS (1.973s)
[147.892934] Starting dynamic subtest: ccs0
[148.998319] Dynamic subtest ccs0: SUCCESS (1.115s)
[149.005394] Starting dynamic subtest: all
[150.900619] Dynamic subtest all: SUCCESS (1.901s)
[150.902064] Subtest evict-prime: SUCCESS (11.021s)
[150.985155] [021/134] (869s left) kms_psr (fbc-psr-suspend)
[151.083087] Starting subtest: fbc-psr-suspend
[151.083983] Starting dynamic subtest: eDP-1
[151.085727] Dynamic subtest eDP-1: SKIP (0.000s)
[151.087404] Subtest fbc-psr-suspend: SKIP (0.001s)
[151.160946] [022/134] (869s left) syncobj_timeline (invalid-signal-illegal-point)
[151.227968] Starting subtest: invalid-signal-illegal-point
[151.229096] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[151.320671] [023/134] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[151.415999] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[155.921755] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.505s)
[157.060179] [024/134] (863s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[157.153146] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[157.525977] Starting dynamic subtest: pipe-A-eDP-1
[160.300760] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.772s)
[160.658456] Starting dynamic subtest: pipe-B-eDP-1
[163.432558] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[163.789020] Starting dynamic subtest: pipe-C-eDP-1
[166.564211] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[166.935785] Starting dynamic subtest: pipe-D-eDP-1
[169.691368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[169.693330] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.538s)
[170.884163] [025/134] (850s left) kms_async_flips (test-time-stamp)
[170.978252] Starting subtest: test-time-stamp
[171.351419] Starting dynamic subtest: pipe-A-eDP-1
[172.185682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[172.562441] Starting dynamic subtest: pipe-B-eDP-1
[173.315407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[173.687432] Starting dynamic subtest: pipe-C-eDP-1
[174.444574] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[174.805817] Starting dynamic subtest: pipe-D-eDP-1
[175.574274] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[175.575379] Subtest test-time-stamp: SUCCESS (4.595s)
[176.730010] [026/134] (844s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[176.830386] Starting subtest: fbc-psr2-sprite-mmap-cpu
[176.831241] Starting dynamic subtest: eDP-1
[176.832829] Dynamic subtest eDP-1: SKIP (0.000s)
[176.834536] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[176.909108] [027/134] (844s left) gem_linear_blits (basic)
[177.176230] Starting subtest: basic
[177.193817] Subtest basic: SUCCESS (0.018s)
[177.371848] [028/134] (843s left) core_getversion (basic)
[177.425628] Starting subtest: basic
[177.427487] Subtest basic: SUCCESS (0.000s)
[177.514295] [029/134] (843s left) gem_exec_schedule (preempt-engines)
[177.580480] Starting subtest: preempt-engines
[177.581545] Starting dynamic subtest: rcs0
[179.902834] Dynamic subtest rcs0: SUCCESS (2.320s)
[179.909435] Starting dynamic subtest: bcs0
[182.211667] Dynamic subtest bcs0: SUCCESS (2.306s)
[182.218513] Starting dynamic subtest: vcs0
[184.475568] Dynamic subtest vcs0: SUCCESS (2.264s)
[184.484751] Starting dynamic subtest: vcs1
[186.745844] Dynamic subtest vcs1: SUCCESS (2.267s)
[186.755078] Starting dynamic subtest: vecs0
[189.006587] Dynamic subtest vecs0: SUCCESS (2.260s)
[189.013584] Starting dynamic subtest: ccs0
[191.329939] Dynamic subtest ccs0: SUCCESS (2.320s)
[191.331405] Subtest preempt-engines: SUCCESS (13.747s)
[191.636359] [030/134] (829s left) kms_chamelium_color (ctm-0-75)
[191.737054] Subtest ctm-0-75: SKIP (0.000s)
[191.775164] [031/134] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[191.881465] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[191.883298] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[191.998600] [032/134] (829s left) kms_plane_multiple (tiling-yf)
[192.102277] Starting subtest: tiling-yf
[192.104076] Subtest tiling-yf: SKIP (0.000s)
[192.183911] [033/134] (829s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[192.283549] Starting subtest: fbcpsr-stridechange
[198.558859] Subtest fbcpsr-stridechange: SUCCESS (6.276s)
[198.715043] [034/134] (822s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[198.815371] Starting subtest: crc-primary-basic-y-tiled-ccs
[198.816315] Starting dynamic subtest: pipe-A-eDP-1
[198.824836] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.831326] Starting dynamic subtest: pipe-B-eDP-1
[198.839800] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.846453] Starting dynamic subtest: pipe-C-eDP-1
[198.854760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.861230] Starting dynamic subtest: pipe-D-eDP-1
[198.869552] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.871210] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[201.025721] [035/134] (820s left) kms_content_protection (srm)
[201.168255] Starting subtest: srm
[201.171393] Subtest srm: SKIP (0.004s)
[201.308938] [036/134] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[201.406852] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[208.760668] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.355s)
[208.908376] [037/134] (812s left) kms_big_fb (linear-32bpp-rotate-0)
[209.011800] Starting subtest: linear-32bpp-rotate-0
[210.593745] Subtest linear-32bpp-rotate-0: SUCCESS (1.583s)
[210.742373] [038/134] (810s left) gem_vm_create (execbuf)
[210.813958] Starting subtest: execbuf
[210.821360] Subtest execbuf: SUCCESS (0.007s)
[210.970293] [039/134] (810s left) gem_eio (wait-immediate)
[211.211800] Starting subtest: wait-immediate
[211.598079] Subtest wait-immediate: SUCCESS (0.386s)
[211.771451] [040/134] (809s left) gem_userptr_blits (unsync-unmap)
[211.840813] Subtest unsync-unmap: SKIP (0.000s)
[211.995056] [041/134] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[212.095751] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[212.097534] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[212.205734] [042/134] (809s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[212.300292] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[212.301190] Starting dynamic subtest: pipe-A-default-mode
[213.492372] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[213.494065] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (1.192s)
[213.680681] [043/134] (807s left) kms_atomic_interruptible (legacy-setmode)
[213.797309] Starting subtest: legacy-setmode
[213.798158] Starting dynamic subtest: pipe-A-eDP-1
[220.713273] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s)
[220.714211] Subtest legacy-setmode: SUCCESS (6.915s)
[221.586975] [044/134] (799s left) perf_pmu (render-node-busy-idle)
[221.672054] Starting subtest: render-node-busy-idle
[221.672975] Starting dynamic subtest: rcs0
[222.373784] Dynamic subtest rcs0: SUCCESS (0.703s)
[222.384471] Starting dynamic subtest: bcs0
[223.047936] Dynamic subtest bcs0: SUCCESS (0.671s)
[223.059242] Starting dynamic subtest: vcs0
[224.918974] Dynamic subtest vcs0: SUCCESS (1.867s)
[224.928940] Starting dynamic subtest: vcs1
[226.903776] Dynamic subtest vcs1: SUCCESS (1.982s)
[226.913922] Starting dynamic subtest: vecs0
[228.885341] Dynamic subtest vecs0: SUCCESS (1.980s)
[228.894396] Starting dynamic subtest: ccs0
[229.555967] Dynamic subtest ccs0: SUCCESS (0.668s)
[229.557581] Subtest render-node-busy-idle: SUCCESS (7.886s)
[229.644568] [045/134] (791s left) gem_lmem_swapping (parallel-random-verify-ccs)
[229.688180] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[229.718129] [046/134] (791s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[229.810984] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[229.815609] Starting dynamic subtest: A-eDP1
[233.402908] Dynamic subtest A-eDP1: SUCCESS (3.586s)
[233.409977] Starting dynamic subtest: B-eDP1
[236.627886] Dynamic subtest B-eDP1: SUCCESS (3.224s)
[236.635067] Starting dynamic subtest: C-eDP1
[239.746839] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[239.754890] Starting dynamic subtest: D-eDP1
[242.862152] Dynamic subtest D-eDP1: SUCCESS (3.114s)
[242.864202] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.052s)
[243.665336] [047/134] (778s left) syncobj_timeline (multi-wait-signaled)
[243.739840] Starting subtest: multi-wait-signaled
[243.761232] Subtest multi-wait-signaled: SUCCESS (0.002s)
[243.839583] [048/134] (777s left) kms_panel_fitting (legacy)
[243.931391] Starting subtest: legacy
[243.932366] Starting dynamic subtest: pipe-A-eDP-1
[244.460937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[244.488413] Starting dynamic subtest: pipe-B-eDP-1
[246.009150] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.528s)
[246.036426] Starting dynamic subtest: pipe-C-eDP-1
[247.503931] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.475s)
[247.529703] Starting dynamic subtest: pipe-D-eDP-1
[249.028602] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[249.029493] Subtest legacy: SUCCESS (5.098s)
[250.277475] [049/134] (771s left) kms_cursor_legacy (torture-move)
[250.394334] Starting subtest: torture-move
[250.395228] Starting dynamic subtest: pipe-A
[256.598749] Dynamic subtest pipe-A: SUCCESS (6.200s)
[256.612216] Starting dynamic subtest: pipe-B
[263.482329] Dynamic subtest pipe-B: SUCCESS (6.883s)
[263.490801] Starting dynamic subtest: pipe-C
[269.999874] Dynamic subtest pipe-C: SUCCESS (6.515s)
[270.015368] Starting dynamic subtest: pipe-D
[277.478484] Dynamic subtest pipe-D: SUCCESS (7.476s)
[277.489023] Starting dynamic subtest: all-pipes
[284.472530] Dynamic subtest all-pipes: SUCCESS (6.991s)
[284.473764] Subtest torture-move: SUCCESS (34.075s)
[284.641382] [050/134] (737s left) kms_joiner (basic-ultra-joiner)
[284.735687] Starting subtest: basic-ultra-joiner
[284.737455] Subtest basic-ultra-joiner: SKIP (0.000s)
[284.810401] [051/134] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[284.914558] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[291.744898] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.827s)
[291.923973] [052/134] (729s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[292.020346] Starting subtest: bad-aux-stride-y-tiled-ccs
[292.021274] Starting dynamic subtest: pipe-A-eDP-1
[292.029697] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.036967] Starting dynamic subtest: pipe-B-eDP-1
[292.045656] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.053373] Starting dynamic subtest: pipe-C-eDP-1
[292.061693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.068430] Starting dynamic subtest: pipe-D-eDP-1
[292.076774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.078502] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[294.171131] [053/134] (727s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[294.259279] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[294.286450] Starting dynamic subtest: pipe-A-plane-0
[294.575112] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[294.582403] Starting dynamic subtest: pipe-A-plane-3
[294.830791] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[294.838489] Starting dynamic subtest: pipe-A-plane-5
[294.840281] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[295.949475] Starting dynamic subtest: pipe-B-plane-0
[296.230226] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[296.237569] Starting dynamic subtest: pipe-B-plane-3
[296.463633] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[296.471310] Starting dynamic subtest: pipe-B-plane-5
[296.472921] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[296.772209] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.513s)
[297.620773] [054/134] (724s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[297.715344] Starting subtest: y-tiled-64bpp-rotate-90
[297.717030] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[297.837611] [055/134] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[297.922547] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[297.924175] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.019292] [056/134] (723s left) gem_partial_pwrite_pread (reads-display)
[298.076458] Subtest reads-display: SKIP (0.000s)
[298.154675] [057/134] (723s left) kms_getfb (getfb-handle-valid)
[298.246381] Starting subtest: getfb-handle-valid
[298.247293] Subtest getfb-handle-valid: SUCCESS (0.000s)
[298.366037] [058/134] (723s left) kms_addfb_basic (basic)
[298.426148] Starting subtest: basic
[298.427059] Subtest basic: SUCCESS (0.000s)
[298.564978] [059/134] (723s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[298.659547] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[298.660474] Starting dynamic subtest: pipe-A-default-mode
[298.948993] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[298.950671] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.290s)
[299.760091] [060/134] (722s left) kms_psr (psr-suspend)
[299.858436] Starting subtest: psr-suspend
[299.859398] Starting dynamic subtest: eDP-1
[317.983166] Dynamic subtest eDP-1: SUCCESS (3.403s)
[317.984053] Subtest psr-suspend: SUCCESS (3.404s)
[327.908222] [061/134] (703s left) gem_userptr_blits (process-exit-busy)
[327.985013] Starting subtest: process-exit-busy
[328.000883] Subtest process-exit-busy: SUCCESS (0.015s)
[328.136814] [062/134] (703s left) kms_psr (fbc-pr-dpms)
[328.245174] Starting subtest: fbc-pr-dpms
[328.246941] Subtest fbc-pr-dpms: SKIP (0.000s)
[328.331358] [063/134] (702s left) kms_vblank (ts-continuation-suspend)
[328.428144] Starting subtest: ts-continuation-suspend
[328.429090] Starting dynamic subtest: pipe-A-eDP-1
[344.862353] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[344.872240] Starting dynamic subtest: pipe-D-eDP-1
[362.853833] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[362.854833] Subtest ts-continuation-suspend: SUCCESS (4.438s)
[370.769871] [064/134] (667s left) sriov_basic (bind-unbind-vf)
[370.828403] Starting subtest: bind-unbind-vf
[370.829461] Starting dynamic subtest: vf-1
[370.865000] Dynamic subtest vf-1: FAIL (0.016s)
[370.874235] Starting dynamic subtest: vf-2
[370.903607] Dynamic subtest vf-2: FAIL (0.004s)
[370.912519] Starting dynamic subtest: vf-3
[370.945405] Dynamic subtest vf-3: FAIL (0.003s)
[370.953592] Starting dynamic subtest: vf-4
[370.980449] Dynamic subtest vf-4: FAIL (0.003s)
[370.988095] Starting dynamic subtest: vf-5
[371.015692] Dynamic subtest vf-5: FAIL (0.004s)
[371.023346] Starting dynamic subtest: vf-6
[371.052780] Dynamic subtest vf-6: FAIL (0.004s)
[371.061457] Starting dynamic subtest: vf-7
[371.088918] Dynamic subtest vf-7: FAIL (0.004s)
[371.096570] Starting dynamic subtest: vf-random
[371.122900] Dynamic subtest vf-random: FAIL (0.003s)
[371.130379] Starting dynamic subtest: vf-last
[371.156880] Dynamic subtest vf-last: FAIL (0.004s)
[371.157759] Subtest bind-unbind-vf: FAIL (0.051s)
[371.184073] [065/134] (667s left) kms_chamelium_color (degamma)
[371.279935] Subtest degamma: SKIP (0.000s)
[371.319122] [066/134] (667s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[371.412359] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[378.193660] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.677s)
[378.309815] [067/134] (660s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[383.382985] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[383.387318] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[384.232376] [068/134] (654s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[384.326715] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[384.932379] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[385.074705] [069/134] (653s left) gem_exec_endless (dispatch)
[385.148448] Starting subtest: dispatch
[385.149537] Starting dynamic subtest: rcs0
[385.154158] Dynamic subtest rcs0: SUCCESS (0.005s)
[385.163212] Starting dynamic subtest: bcs0
[385.165014] Dynamic subtest bcs0: SUCCESS (0.005s)
[385.172855] Starting dynamic subtest: vcs0
[385.174489] Dynamic subtest vcs0: SUCCESS (0.004s)
[385.183288] Starting dynamic subtest: vcs1
[385.185436] Dynamic subtest vcs1: SUCCESS (0.007s)
[385.204153] Starting dynamic subtest: vecs0
[385.205985] Dynamic subtest vecs0: SUCCESS (0.004s)
[385.224730] Starting dynamic subtest: ccs0
[385.226857] Dynamic subtest ccs0: SUCCESS (0.004s)
[385.227878] Subtest dispatch: SUCCESS (0.035s)
[386.538040] [070/134] (651s left) sw_sync (sync_multi_producer_single_consumer)
[386.574837] Starting subtest: sync_multi_producer_single_consumer
[387.655911] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[387.723723] [071/134] (650s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[387.781399] Starting subtest: etime-single-wait-available-unsubmitted
[387.882984] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[387.965554] [072/134] (650s left) gem_tiled_blits (normal)
[388.029181] Subtest normal: SKIP (0.000s)
[388.125664] [073/134] (650s left) syncobj_basic (bad-destroy-pad)
[388.181134] Starting subtest: bad-destroy-pad
[388.182149] Subtest bad-destroy-pad: SUCCESS (0.000s)
[388.314367] [074/134] (650s left) gem_flink_basic (bad-open)
[388.371528] Starting subtest: bad-open
[388.372511] Subtest bad-open: SUCCESS (0.000s)
[388.485333] [075/134] (650s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[388.592048] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[389.596306] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.002s)
[389.750088] [076/134] (648s left) gem_mmap_wc (pf-nonblock)
[389.802130] Subtest pf-nonblock: SKIP (0.000s)
[389.857275] [077/134] (648s left) syncobj_wait (signal)
[389.918689] Starting subtest: signal
[389.919710] Subtest signal: SUCCESS (0.000s)
[390.024171] [078/134] (648s left) prime_self_import (basic-llseek-size)
[390.058336] Starting subtest: basic-llseek-size
[390.083683] Subtest basic-llseek-size: SUCCESS (0.024s)
[390.233989] [079/134] (648s left) kms_pm_dc (dc3co-vpb-simulation)
[391.325126] Starting subtest: dc3co-vpb-simulation
[399.885503] Subtest dc3co-vpb-simulation: SKIP (8.543s)
[400.053296] [080/134] (638s left) gem_ctx_persistence (processes)
[400.123965] Starting subtest: processes
[401.466530] Subtest processes: SUCCESS (1.341s)
[401.553584] [081/134] (637s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[401.663244] Starting subtest: cursorA-vs-flipB-legacy
[401.665158] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[401.830735] [082/134] (637s left) gem_workarounds (reset-fd)
[401.905003] Starting subtest: reset-fd
[402.081337] Subtest reset-fd: SUCCESS (0.176s)
[402.223673] [083/134] (636s left) syncobj_wait (wait-for-submit-complex)
[402.290819] Starting subtest: wait-for-submit-complex
[402.353043] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[402.435619] [084/134] (636s left) kms_hdr (static-toggle)
[402.537580] Starting subtest: static-toggle
[402.540199] Subtest static-toggle: SKIP (0.000s)
[402.631290] [085/134] (636s left) gem_exec_whisper (basic-fds-forked-all)
[402.707476] Starting subtest: basic-fds-forked-all
[422.472116] Subtest basic-fds-forked-all: SUCCESS (19.764s)
[422.658474] [086/134] (616s left) i915_suspend (basic-s2idle-without-i915)
[422.687559] Starting subtest: basic-s2idle-without-i915
[443.967910] Subtest basic-s2idle-without-i915: SUCCESS (6.245s)
[450.099342] [087/134] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[450.194208] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[450.195920] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[450.319684] [088/134] (594s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[450.419413] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[450.421489] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[450.549934] [089/134] (594s left) gen9_exec_parse (batch-zero-length)
[450.623214] Subtest batch-zero-length: SKIP (0.000s)
[450.696435] [090/134] (594s left) gem_ctx_param (get-priority-new-ctx)
[450.752754] Starting subtest: get-priority-new-ctx
[450.756487] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[450.897305] [091/134] (594s left) syncobj_wait (wait-all-snapshot)
[450.951945] Starting subtest: wait-all-snapshot
[451.034575] Subtest wait-all-snapshot: SUCCESS (0.079s)
[451.118243] [092/134] (594s left) gem_exec_fence (syncobj-signal)
[451.561010] Starting subtest: syncobj-signal
[451.566900] Subtest syncobj-signal: SUCCESS (0.006s)
[453.573724] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[453.575800] [093/134] (591s left) gem_exec_schedule (u-semaphore-resolve)
[453.659348] Starting subtest: u-semaphore-resolve
[453.726907] Subtest u-semaphore-resolve: SUCCESS (0.065s)
[454.088010] [094/134] (591s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[454.488603] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[455.337303] [095/134] (590s left) kms_color (ctm-0-50)
[455.432320] Starting subtest: ctm-0-50
[455.433481] Starting dynamic subtest: pipe-A-eDP-1
[459.042839] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.544s)
[459.051284] Starting dynamic subtest: pipe-B-eDP-1
[463.207992] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.115s)
[463.217188] Starting dynamic subtest: pipe-C-eDP-1
[467.212078] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.974s)
[467.219216] Starting dynamic subtest: pipe-D-eDP-1
[471.223562] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[471.224485] Subtest ctm-0-50: SUCCESS (15.630s)
[472.086111] [096/134] (573s left) gem_create (create-massive)
[472.140239] Starting subtest: create-massive
[472.141195] Subtest create-massive: SUCCESS (0.000s)
[472.333822] [097/134] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[472.424871] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[477.714459] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.279s)
[478.884157] [098/134] (566s left) kms_busy (extended-pageflip-hang-oldfb)
[478.972178] Starting subtest: extended-pageflip-hang-oldfb
[478.973090] Starting dynamic subtest: pipe-A
[479.396387] Dynamic subtest pipe-A: SUCCESS (0.422s)
[479.405675] Starting dynamic subtest: pipe-D
[480.493187] Dynamic subtest pipe-D: SUCCESS (1.093s)
[480.494210] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.520s)
[481.356758] [099/134] (564s left) kms_flip (2x-flip-vs-rmfb)
[481.448056] Starting subtest: 2x-flip-vs-rmfb
[481.459440] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[481.580596] [100/134] (563s left) kms_plane (plane-position-hole)
[481.672946] Starting subtest: plane-position-hole
[482.176156] Starting dynamic subtest: pipe-A-plane-1
[483.429465] Dynamic subtest pipe-A-plane-1: SUCCESS (1.251s)
[483.438042] Starting dynamic subtest: pipe-A-plane-2
[484.729137] Dynamic subtest pipe-A-plane-2: SUCCESS (1.299s)
[484.737205] Starting dynamic subtest: pipe-A-plane-3
[485.969551] Dynamic subtest pipe-A-plane-3: SUCCESS (1.238s)
[485.977708] Starting dynamic subtest: pipe-A-plane-4
[487.204620] Dynamic subtest pipe-A-plane-4: SUCCESS (1.233s)
[487.212556] Starting dynamic subtest: pipe-A-plane-5
[487.230028] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[488.359569] Starting dynamic subtest: pipe-B-plane-1
[489.595042] Dynamic subtest pipe-B-plane-1: SUCCESS (1.241s)
[489.602634] Starting dynamic subtest: pipe-B-plane-2
[490.820689] Dynamic subtest pipe-B-plane-2: SUCCESS (1.224s)
[490.830796] Starting dynamic subtest: pipe-B-plane-3
[492.054468] Dynamic subtest pipe-B-plane-3: SUCCESS (1.232s)
[492.064773] Starting dynamic subtest: pipe-B-plane-4
[493.328043] Dynamic subtest pipe-B-plane-4: SUCCESS (1.270s)
[493.345787] Starting dynamic subtest: pipe-B-plane-5
[493.351868] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[493.353195] Subtest plane-position-hole: SUCCESS (11.670s)
[494.209566] [101/134] (551s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[494.311542] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[494.313441] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[494.429684] [102/134] (551s left) core_debugfs (read-all-entries)
[494.490181] Starting subtest: read-all-entries
[494.571380] Subtest read-all-entries: SUCCESS (0.082s)
[494.643557] [103/134] (550s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[494.703990] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[494.764846] [104/134] (550s left) perf_pmu (busy-accuracy-50)
[494.806897] Starting subtest: busy-accuracy-50
[494.807789] Starting dynamic subtest: rcs0
[496.342162] Dynamic subtest rcs0: SUCCESS (1.533s)
[496.352136] Starting dynamic subtest: bcs0
[497.886477] Dynamic subtest bcs0: SUCCESS (1.541s)
[497.897643] Starting dynamic subtest: vcs0
[499.431511] Dynamic subtest vcs0: SUCCESS (1.541s)
[499.441049] Starting dynamic subtest: vcs1
[500.974423] Dynamic subtest vcs1: SUCCESS (1.539s)
[500.984129] Starting dynamic subtest: vecs0
[502.516832] Dynamic subtest vecs0: SUCCESS (1.539s)
[502.526581] Starting dynamic subtest: ccs0
[504.062830] Dynamic subtest ccs0: SUCCESS (1.543s)
[504.063801] Subtest busy-accuracy-50: SUCCESS (9.251s)
[504.204626] [105/134] (541s left) kms_flip (nonexisting-fb-interruptible)
[504.299661] Starting subtest: nonexisting-fb-interruptible
[504.301914] Starting dynamic subtest: A-eDP1
[505.429246] Dynamic subtest A-eDP1: SUCCESS (1.127s)
[505.437560] Starting dynamic subtest: B-eDP1
[506.563633] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[506.572937] Starting dynamic subtest: C-eDP1
[507.706995] Dynamic subtest C-eDP1: SUCCESS (1.142s)
[507.716495] Starting dynamic subtest: D-eDP1
[508.826392] Dynamic subtest D-eDP1: SUCCESS (1.117s)
[508.828720] Subtest nonexisting-fb-interruptible: SUCCESS (4.526s)
[510.011481] [106/134] (535s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[510.065087] Starting subtest: etime-multi-wait-all-for-submit-submitted
[510.176082] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[510.265656] [107/134] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[510.364242] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[510.365959] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[510.496405] [108/134] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[510.606318] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[510.608098] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[510.742975] [109/134] (535s left) gem_close (basic)
[510.808649] Starting subtest: basic
[510.809597] Subtest basic: SUCCESS (0.000s)
[510.933048] [110/134] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[511.031313] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[511.033058] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[511.156943] [111/134] (534s left) kms_lease (page-flip-implicit-plane)
[511.248139] Starting subtest: page-flip-implicit-plane
[511.248992] Starting dynamic subtest: pipe-A-eDP-1
[511.727136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[511.735936] Starting dynamic subtest: pipe-B-eDP-1
[512.830245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.101s)
[512.839836] Starting dynamic subtest: pipe-C-eDP-1
[513.947091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[513.955902] Starting dynamic subtest: pipe-D-eDP-1
[515.079775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[515.080646] Subtest page-flip-implicit-plane: SUCCESS (3.831s)
[515.925536] [112/134] (530s left) gem_partial_pwrite_pread (writes-after-reads)
[515.976512] Subtest writes-after-reads: SKIP (0.000s)
[516.047220] [113/134] (529s left) gem_partial_pwrite_pread (write)
[516.095709] Subtest write: SKIP (0.000s)
[516.151245] [114/134] (529s left) i915_getparams_basic (basic-subslice-total)
[516.201075] Starting subtest: basic-subslice-total
[516.202694] Subtest basic-subslice-total: SUCCESS (0.000s)
[516.302012] [115/134] (529s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[516.399904] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[516.400708] Starting dynamic subtest: pipe-A-eDP-1
[516.421756] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[516.432415] Starting dynamic subtest: pipe-B-eDP-1
[516.453590] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[516.461001] Starting dynamic subtest: pipe-C-eDP-1
[516.482293] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[516.489328] Starting dynamic subtest: pipe-D-eDP-1
[516.509777] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[516.511392] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[518.593113] [116/134] (527s left) sysfs_heartbeat_interval (precise)
[518.659506] Starting subtest: precise
[518.660448] Starting dynamic subtest: vecs0
[526.526234] Dynamic subtest vecs0: SUCCESS (7.860s)
[526.536234] Starting dynamic subtest: ccs0
[527.784321] Dynamic subtest ccs0: SUCCESS (1.256s)
[527.795682] Starting dynamic subtest: vcs0
[535.530513] Dynamic subtest vcs0: SUCCESS (7.740s)
[535.542301] Starting dynamic subtest: bcs0
[536.742304] Dynamic subtest bcs0: SUCCESS (1.207s)
[536.752534] Starting dynamic subtest: rcs0
[538.040074] Dynamic subtest rcs0: SUCCESS (1.294s)
[538.049051] Starting dynamic subtest: vcs1
[545.508486] Dynamic subtest vcs1: SUCCESS (7.470s)
[545.511608] Subtest precise: SUCCESS (26.842s)
[545.606401] [117/134] (500s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[545.698915] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[545.699763] Starting dynamic subtest: pipe-A
[545.718341] Dynamic subtest pipe-A: SKIP (0.017s)
[545.726383] Starting dynamic subtest: pipe-B
[545.747341] Dynamic subtest pipe-B: SKIP (0.029s)
[545.755226] Starting dynamic subtest: pipe-C
[545.777581] Dynamic subtest pipe-C: SKIP (0.029s)
[545.785093] Starting dynamic subtest: pipe-D
[545.806498] Dynamic subtest pipe-D: SKIP (0.029s)
[545.808252] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[545.945677] [118/134] (500s left) kms_psr (pr-cursor-plane-move)
[546.040776] Starting subtest: pr-cursor-plane-move
[546.042559] Subtest pr-cursor-plane-move: SKIP (0.000s)
[546.117683] [119/134] (500s left) kms_flip (wf_vblank-ts-check)
[546.209437] Starting subtest: wf_vblank-ts-check
[546.211650] Starting dynamic subtest: A-eDP1
[555.141972] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[555.152381] Starting dynamic subtest: B-eDP1
[564.278016] Dynamic subtest B-eDP1: SUCCESS (9.136s)
[564.287177] Starting dynamic subtest: C-eDP1
[573.196451] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[573.204828] Starting dynamic subtest: D-eDP1
[582.331898] Dynamic subtest D-eDP1: SUCCESS (9.133s)
[582.336257] Subtest wf_vblank-ts-check: SUCCESS (36.129s)
[583.556864] [120/134] (462s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[583.651704] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[583.653556] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[583.801683] [121/134] (462s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[583.897841] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[583.899414] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[584.988079] [122/134] (461s left) kms_flip (2x-nonexisting-fb-interruptible)
[585.085271] Starting subtest: 2x-nonexisting-fb-interruptible
[585.097268] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[585.225840] [123/134] (461s left) perf (short-reads)
[585.350481] Starting subtest: short-reads
[585.364175] Subtest short-reads: SUCCESS (0.014s)
[585.403685] [124/134] (460s left) kms_cursor_crc (cursor-offscreen-512x512)
[585.652332] Starting subtest: cursor-offscreen-512x512
[585.654076] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[585.807368] [125/134] (460s left) gem_mmap_gtt (flink-race)
[585.870304] Subtest flink-race: SKIP (0.000s)
[585.932521] [126/134] (460s left) kms_pm_rpm (modeset-pc8-residency-stress)
[587.670482] Starting subtest: modeset-pc8-residency-stress
[587.672933] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[588.247343] [127/134] (458s left) syncobj_timeline (single-wait-for-submit-signaled)
[588.304117] Starting subtest: single-wait-for-submit-signaled
[588.305012] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[588.424220] [128/134] (458s left) gem_exec_balancer (busy)
[588.479951] Starting subtest: busy
[590.517014] Subtest busy: SUCCESS (2.035s)
[590.855514] [129/134] (455s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[590.945981] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[590.946798] Starting dynamic subtest: pipe-A-default-mode
[593.644828] Dynamic subtest pipe-A-default-mode: SUCCESS (2.697s)
[593.645774] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.699s)
[594.527319] [130/134] (452s left) kms_psr (psr-no-drrs)
[594.625037] Starting subtest: psr-no-drrs
[594.625939] Starting dynamic subtest: eDP-1
[596.223102] Dynamic subtest eDP-1: SUCCESS (1.597s)
[596.223989] Subtest psr-no-drrs: SUCCESS (1.598s)
[597.105762] [131/134] (449s left) api_intel_allocator (two-level-inception)
[597.167844] Starting subtest: two-level-inception
[602.568721] Subtest two-level-inception: SUCCESS (5.399s)
[602.696023] [132/134] (443s left) fbdev (pan)
[602.737885] Starting subtest: pan
[602.767009] Subtest pan: SUCCESS (0.030s)
[602.856794] [133/134] (443s left) i915_drm_fdinfo (virtual-busy)
[602.905659] Starting subtest: virtual-busy
[602.907523] Subtest virtual-busy: SKIP (0.000s)
[602.989150] [134/134] (443s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[607.998536] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[608.001021] Starting dynamic subtest: pipe-A-eDP-1
[608.779273] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[608.788684] Starting dynamic subtest: pipe-B-eDP-1
[609.929956] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[609.931911] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.931s)
[611.218471] Closing watchdogs
results: parsing output: 0/ for test: kms_setmode
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: kms_sequence
results: parsing output: 3/ for test: gem_exec_gttfill
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: kms_cursor_edge_walk
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: gen3_mixed_blits
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: gem_fence_thrash
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: gem_softpin
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_linear_blits
results: parsing output: 27/ for test: core_getversion
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_multiple
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_vm_create
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_atomic_interruptible
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_panel_fitting
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_joiner
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_partial_pwrite_pread
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: sriov_basic
results: parsing output: 64/ for test: kms_chamelium_color
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_endless
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_tiled_blits
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: gem_flink_basic
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: prime_self_import
results: parsing output: 78/ for test: kms_pm_dc
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_workarounds
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gen9_exec_parse
results: parsing output: 89/ for test: gem_ctx_param
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_busy
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: core_debugfs
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_close
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: gem_partial_pwrite_pread
results: parsing output: 113/ for test: i915_getparams_basic
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: sysfs_heartbeat_interval
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: fbdev
results: parsing output: 132/ for test: i915_drm_fdinfo
results: parsing output: 133/ for test: kms_psr2_sf
Done.