[61.386422] Initializing watchdogs
[61.386470]   /dev/watchdog0
[61.401207] [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]
[61.405801] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.408102] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.411554] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[61.541662] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[61.546133] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.649788] [002/131] (960s left) prime_mmap (test_correct_cpu_write)
[61.704019] Starting subtest: test_correct_cpu_write
[61.705942] Starting dynamic subtest: test_correct_cpu_write-smem
[61.707890] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[61.709845] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[61.813044] [003/131] (960s left) gem_softpin (noreloc)
[61.894890] Starting subtest: noreloc
[67.372783] Subtest noreloc: SUCCESS (5.489s)
[67.891938] [004/131] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[68.051497] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[68.056166] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[68.368108] [005/131] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[68.460562] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[68.464820] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.556426] [006/131] (953s left) api_intel_bb (delta-check)
[68.615873] Starting subtest: delta-check
[68.620433] Subtest delta-check: SUCCESS (0.006s)
[68.740901] [007/131] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[68.839970] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[73.366698] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.534s)
[74.532870] [008/131] (947s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[74.645987] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[75.735417] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[75.832896] [009/131] (946s left) gem_ccs (suspend-resume)
[75.888430] Starting subtest: suspend-resume
[75.892359] Subtest suspend-resume: SKIP (0.000s)
[75.977098] [010/131] (946s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[76.080435] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[76.083938] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[76.174940] [011/131] (946s left) kms_hdr (static-toggle-suspend)
[76.280262] Starting subtest: static-toggle-suspend
[76.285315] Subtest static-toggle-suspend: SKIP (0.000s)
[76.374448] [012/131] (945s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[76.428047] Starting subtest: invalid-multi-wait-unsubmitted
[76.430083] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[76.521986] [013/131] (945s left) kms_psr (psr2-sprite-render)
[76.607078] Starting subtest: psr2-sprite-render
[76.609075] Starting dynamic subtest: eDP-1
[78.327622] Dynamic subtest eDP-1: SUCCESS (1.722s)
[78.330075] Subtest psr2-sprite-render: SUCCESS (1.722s)
[79.193079] [014/131] (943s left) gem_ctx_isolation (nonpriv-switch)
[79.251952] Starting subtest: nonpriv-switch
[79.254456] Starting dynamic subtest: rcs0
[79.545442] Dynamic subtest rcs0: SUCCESS (0.293s)
[79.556827] Starting dynamic subtest: bcs0
[79.846858] Dynamic subtest bcs0: SUCCESS (0.301s)
[79.857382] Starting dynamic subtest: vcs0
[80.110734] Dynamic subtest vcs0: SUCCESS (0.263s)
[80.120525] Starting dynamic subtest: vcs1
[82.181666] Dynamic subtest vcs1: SUCCESS (2.070s)
[82.192066] Starting dynamic subtest: vecs0
[84.248766] Dynamic subtest vecs0: SUCCESS (2.067s)
[84.261402] Starting dynamic subtest: ccs0
[86.243095] Dynamic subtest ccs0: SUCCESS (1.994s)
[86.245597] Subtest nonpriv-switch: SUCCESS (6.991s)
[86.498694] [015/131] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[86.606489] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[86.610678] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[86.699431] [016/131] (935s left) syncobj_wait (single-wait-all-for-submit-signaled)
[86.758885] Starting subtest: single-wait-all-for-submit-signaled
[86.760925] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[86.845237] [017/131] (935s left) gem_exec_reloc (basic-cpu-noreloc)
[86.895100] Subtest basic-cpu-noreloc: SKIP (0.000s)
[86.961801] [018/131] (935s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[87.060794] Starting subtest: x-tiled-64bpp-rotate-270
[87.084471] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[87.181838] [019/131] (935s left) kms_big_fb (linear-64bpp-rotate-180)
[87.287760] Starting subtest: linear-64bpp-rotate-180
[88.832317] Subtest linear-64bpp-rotate-180: SUCCESS (1.545s)
[88.997011] [020/131] (933s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[89.094275] Starting subtest: bad-rotation-90-y-tiled-ccs
[89.096626] Starting dynamic subtest: pipe-A-eDP-1
[89.120414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.131949] Starting dynamic subtest: pipe-B-eDP-1
[89.153842] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.161289] Starting dynamic subtest: pipe-C-eDP-1
[89.183046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.190073] Starting dynamic subtest: pipe-D-eDP-1
[89.208251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[89.211776] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[91.363981] [021/131] (931s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[91.423762] Starting subtest: etime-multi-wait-for-submit-submitted
[91.532043] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[91.617511] [022/131] (931s left) gem_mmap_wc (write-prefaulted)
[91.682026] Subtest write-prefaulted: SKIP (0.000s)
[91.742998] [023/131] (931s left) kms_cursor_edge_walk (64x64-right-edge)
[91.837142] Starting subtest: 64x64-right-edge
[91.839519] Starting dynamic subtest: pipe-A-eDP-1
[95.311633] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[95.324095] Starting dynamic subtest: pipe-D-eDP-1
[98.436729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[98.438990] Subtest 64x64-right-edge: SUCCESS (6.601s)
[99.255574] [024/131] (923s left) kms_pm_dc (dc6-dpms)
[100.369653] Starting subtest: dc6-dpms
[102.413095] Subtest dc6-dpms: SUCCESS (2.042s)
[102.486944] [025/131] (920s left) gem_spin_batch (resubmit-all)
[102.550944] Starting subtest: resubmit-all
[102.553260] Starting dynamic subtest: rcs0
[102.562314] Dynamic subtest rcs0: SUCCESS (0.011s)
[102.570906] Starting dynamic subtest: bcs0
[102.573385] Dynamic subtest bcs0: SUCCESS (0.002s)
[102.580978] Starting dynamic subtest: vcs0
[102.582945] Dynamic subtest vcs0: SUCCESS (0.002s)
[102.589995] Starting dynamic subtest: vcs1
[102.591894] Dynamic subtest vcs1: SUCCESS (0.002s)
[102.599055] Starting dynamic subtest: vecs0
[102.600929] Dynamic subtest vecs0: SUCCESS (0.002s)
[102.608219] Starting dynamic subtest: ccs0
[102.610089] Dynamic subtest ccs0: SUCCESS (0.003s)
[102.611959] Subtest resubmit-all: SUCCESS (0.024s)
[103.931788] [026/131] (918s left) gem_lmem_swapping (massive-random)
[103.983240] Subtest massive-random: SKIP (0.000s)
[104.018825] [027/131] (918s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[104.121729] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[104.123975] Starting dynamic subtest: pipe-A-default-mode
[106.804732] Dynamic subtest pipe-A-default-mode: SUCCESS (2.682s)
[106.807149] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.683s)
[107.686448] [028/131] (915s left) gem_render_copy (x-tiled)
[107.739034] Starting subtest: x-tiled
[107.741308] Starting dynamic subtest: smem
[107.786453] Dynamic subtest smem: SUCCESS (0.049s)
[107.788820] Subtest x-tiled: SUCCESS (0.050s)
[108.023550] [029/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[108.132619] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[108.137148] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[108.248172] [030/131] (914s left) kms_cursor_crc (cursor-sliding-128x128)
[108.455902] Starting subtest: cursor-sliding-128x128
[108.458989] Starting dynamic subtest: pipe-A-eDP-1
[111.700538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.242s)
[111.728673] Starting dynamic subtest: pipe-D-eDP-1
[115.590069] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.866s)
[115.592480] Subtest cursor-sliding-128x128: SUCCESS (7.133s)
[116.455587] [031/131] (906s left) i915_pm_rpm (system-suspend-devices)
[117.977847] Starting subtest: system-suspend-devices
[125.765418] Subtest system-suspend-devices: SUCCESS (7.790s)
[126.157570] [032/131] (896s left) syncobj_wait (multi-wait-all-submitted)
[126.215952] Starting subtest: multi-wait-all-submitted
[126.323491] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[126.399260] [033/131] (896s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[126.795660] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[127.572055] [034/131] (895s left) kms_psr (psr-sprite-plane-move)
[127.661026] Starting subtest: psr-sprite-plane-move
[127.663317] Starting dynamic subtest: eDP-1
[129.430625] Dynamic subtest eDP-1: SUCCESS (1.770s)
[129.433060] Subtest psr-sprite-plane-move: SUCCESS (1.771s)
[130.255468] [035/131] (892s left) kms_color_pipeline (plane-lut1d)
[130.353296] Starting subtest: plane-lut1d
[130.476501] Starting dynamic subtest: pipe-A-plane-0
[130.821823] Dynamic subtest pipe-A-plane-0: FAIL (0.177s)
[130.832328] Starting dynamic subtest: pipe-A-plane-1
[131.048992] Dynamic subtest pipe-A-plane-1: FAIL (0.186s)
[131.059114] Starting dynamic subtest: pipe-A-plane-2
[131.283092] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[132.254172] Starting dynamic subtest: pipe-B-plane-0
[132.677772] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[132.685996] Starting dynamic subtest: pipe-B-plane-1
[132.983834] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[132.993497] Starting dynamic subtest: pipe-B-plane-2
[133.282350] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[133.984439] Starting dynamic subtest: pipe-C-plane-0
[134.471811] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[134.481826] Starting dynamic subtest: pipe-C-plane-1
[134.869467] Dynamic subtest pipe-C-plane-1: FAIL (0.132s)
[134.879279] Starting dynamic subtest: pipe-C-plane-2
[135.223571] Dynamic subtest pipe-C-plane-2: FAIL (0.641s)
[136.126267] Starting dynamic subtest: pipe-D-plane-0
[136.715623] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[136.726103] Starting dynamic subtest: pipe-D-plane-1
[137.156142] Dynamic subtest pipe-D-plane-1: FAIL (0.621s)
[137.165756] Starting dynamic subtest: pipe-D-plane-2
[137.581054] Dynamic subtest pipe-D-plane-2: FAIL (0.555s)
[137.755398] Subtest plane-lut1d: FAIL (7.406s)
[138.561888] [036/131] (884s left) gem_pxp (reject-modify-context-protection-off-2)
[138.680396] Starting subtest: reject-modify-context-protection-off-2
[138.682719] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[138.787038] [037/131] (884s left) kms_flip (modeset-vs-vblank-race-interruptible)
[138.880566] Starting subtest: modeset-vs-vblank-race-interruptible
[138.884821] Starting dynamic subtest: A-eDP1
[143.584867] Dynamic subtest A-eDP1: SUCCESS (4.701s)
[143.595603] Starting dynamic subtest: B-eDP1
[148.226827] Dynamic subtest B-eDP1: SUCCESS (4.640s)
[148.238488] Starting dynamic subtest: C-eDP1
[152.749514] Dynamic subtest C-eDP1: SUCCESS (4.521s)
[152.761079] Starting dynamic subtest: D-eDP1
[157.363310] Dynamic subtest D-eDP1: SUCCESS (4.612s)
[157.368262] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.489s)
[158.521616] [038/131] (864s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[158.628636] Starting subtest: stress-xrgb8888-ytiled
[158.632619] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[158.705959] [039/131] (864s left) drm_read (invalid-buffer)
[158.838185] Starting subtest: invalid-buffer
[158.840660] Subtest invalid-buffer: SUCCESS (0.000s)
[158.953272] [040/131] (864s left) gem_exec_schedule (timeslicing)
[159.029439] Starting subtest: timeslicing
[159.031784] Starting dynamic subtest: rcs0
[159.044154] Dynamic subtest rcs0: SUCCESS (0.024s)
[159.054729] Starting dynamic subtest: bcs0
[159.072084] Dynamic subtest bcs0: SUCCESS (0.026s)
[159.083170] Starting dynamic subtest: vcs0
[159.100098] Dynamic subtest vcs0: SUCCESS (0.026s)
[159.108881] Starting dynamic subtest: vcs1
[159.127240] Dynamic subtest vcs1: SUCCESS (0.025s)
[159.138133] Starting dynamic subtest: vecs0
[159.153622] Dynamic subtest vecs0: SUCCESS (0.024s)
[159.162395] Starting dynamic subtest: ccs0
[159.181639] Dynamic subtest ccs0: SUCCESS (0.026s)
[159.183971] Subtest timeslicing: SUCCESS (0.163s)
[160.891837] [041/131] (862s left) kms_vrr (seamless-rr-switch-vrr)
[160.992422] Starting subtest: seamless-rr-switch-vrr
[160.999261] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[161.067094] [042/131] (862s left) kms_atomic_interruptible (universal-setplane-cursor)
[161.164982] Starting subtest: universal-setplane-cursor
[161.167309] Starting dynamic subtest: pipe-A-eDP-1
[168.536577] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.369s)
[168.538879] Subtest universal-setplane-cursor: SUCCESS (7.370s)
[169.370039] [043/131] (854s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[169.470784] Starting subtest: fbcpsr-tiling-4
[176.574511] Subtest fbcpsr-tiling-4: SUCCESS (7.106s)
[176.708464] [044/131] (846s left) kms_draw_crc (draw-method-render)
[176.811391] Starting subtest: draw-method-render
[176.813337] Starting dynamic subtest: xrgb8888-untiled
[177.087322] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[177.095747] Starting dynamic subtest: rgb565-untiled
[177.332363] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[177.340981] Starting dynamic subtest: xrgb2101010-untiled
[177.575805] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.242s)
[177.584495] Starting dynamic subtest: xbgr16161616f-untiled
[177.820016] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[177.828585] Starting dynamic subtest: xrgb8888-xtiled
[177.953544] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[177.962122] Starting dynamic subtest: rgb565-xtiled
[178.064862] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[178.082803] Starting dynamic subtest: xrgb2101010-xtiled
[178.197719] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[178.206172] Starting dynamic subtest: xbgr16161616f-xtiled
[178.331033] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[178.341552] Starting dynamic subtest: xrgb8888-4tiled
[178.464742] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[178.474492] Starting dynamic subtest: rgb565-4tiled
[178.586896] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[178.595181] Starting dynamic subtest: xrgb2101010-4tiled
[178.709236] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[178.720166] Starting dynamic subtest: xbgr16161616f-4tiled
[178.842174] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[178.844080] Subtest draw-method-render: SUCCESS (2.034s)
[178.957578] [045/131] (844s left) kms_vblank (query-forked-hang)
[179.054571] Starting subtest: query-forked-hang
[179.056424] Starting dynamic subtest: pipe-A-eDP-1
[205.665496] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.609s)
[205.679412] Starting dynamic subtest: pipe-D-eDP-1
[220.770474] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.103s)
[220.772786] Subtest query-forked-hang: SUCCESS (41.717s)
[221.700425] [046/131] (802s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[221.768273] Subtest writes-after-reads-snoop: SKIP (0.000s)
[221.857374] [047/131] (801s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[221.963952] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[221.966099] Starting dynamic subtest: pipe-A-eDP-1
[222.021937] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[222.032024] Starting dynamic subtest: pipe-B-eDP-1
[222.087420] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[222.097500] Starting dynamic subtest: pipe-C-eDP-1
[222.154042] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[222.162770] Starting dynamic subtest: pipe-D-eDP-1
[222.218714] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[222.222839] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[224.117325] [048/131] (799s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[224.230220] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[225.009945] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[225.184932] [049/131] (798s left) kms_content_protection (dp-mst-type-0)
[225.318932] Starting subtest: dp-mst-type-0
[225.323590] Subtest dp-mst-type-0: SKIP (0.000s)
[225.445490] [050/131] (798s left) prime_vgem (fence-flip-hang)
[225.577260] Subtest fence-flip-hang: SKIP (0.000s)
[225.674077] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[225.677824] [051/131] (798s left) gem_mmap_offset (basic-uaf)
[225.730098] Starting subtest: basic-uaf
[225.732274] Subtest basic-uaf: SUCCESS (0.001s)
[225.820481] [052/131] (798s left) gem_exec_parallel (engines)
[225.884301] Starting subtest: engines
[225.886923] Starting dynamic subtest: basic
[227.927768] Dynamic subtest basic: SUCCESS (2.042s)
[227.937975] Starting dynamic subtest: contexts
[232.271546] Dynamic subtest contexts: SUCCESS (4.341s)
[232.282572] Starting dynamic subtest: fds
[236.068292] Dynamic subtest fds: SUCCESS (3.795s)
[236.079533] Starting dynamic subtest: userptr
[237.910043] Dynamic subtest userptr: SUCCESS (1.840s)
[237.912772] Subtest engines: SUCCESS (12.027s)
[238.123475] [053/131] (785s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[238.221646] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[238.226072] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[238.291216] [054/131] (785s left) kms_psr (pr-sprite-mmap-gtt)
[238.390366] Starting subtest: pr-sprite-mmap-gtt
[238.394512] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[238.464630] [055/131] (785s left) kms_universal_plane (universal-plane-sanity)
[238.565278] Starting subtest: universal-plane-sanity
[238.567573] Starting dynamic subtest: pipe-A-eDP-1
[239.175895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[239.185243] Starting dynamic subtest: pipe-B-eDP-1
[240.453595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[240.463550] Starting dynamic subtest: pipe-C-eDP-1
[241.665886] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[241.676087] Starting dynamic subtest: pipe-D-eDP-1
[242.901699] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[242.903844] Subtest universal-plane-sanity: SUCCESS (4.335s)
[243.769037] [056/131] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[243.875036] Starting subtest: fbcpsr-rgb101010-draw-render
[250.617565] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.745s)
[250.751610] [057/131] (773s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[250.851180] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[250.853454] Starting dynamic subtest: pipe-A-eDP-1
[250.875314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.885552] Starting dynamic subtest: pipe-B-eDP-1
[250.907659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.915719] Starting dynamic subtest: pipe-C-eDP-1
[250.936517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.944696] Starting dynamic subtest: pipe-D-eDP-1
[250.966065] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.970301] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[253.163198] [058/131] (771s left) i915_hangman (engine-engine-hang)
[253.219347] Starting subtest: engine-engine-hang
[253.221580] Starting dynamic subtest: rcs0
[254.900670] Dynamic subtest rcs0: SUCCESS (1.681s)
[254.912794] Starting dynamic subtest: bcs0
[256.821293] Dynamic subtest bcs0: SUCCESS (1.918s)
[256.833630] Starting dynamic subtest: vcs0
[258.868196] Dynamic subtest vcs0: SUCCESS (2.045s)
[258.883150] Starting dynamic subtest: vcs1
[260.853847] Dynamic subtest vcs1: SUCCESS (1.982s)
[260.865321] Starting dynamic subtest: vecs0
[262.901034] Dynamic subtest vecs0: SUCCESS (2.044s)
[262.912919] Starting dynamic subtest: ccs0
[264.885044] Dynamic subtest ccs0: SUCCESS (1.982s)
[264.887601] Subtest engine-engine-hang: SUCCESS (11.668s)
[264.974698] [059/131] (759s left) syncobj_timeline (single-wait-all-signaled)
[265.045411] Starting subtest: single-wait-all-signaled
[265.047644] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[265.158562] [060/131] (759s left) prime_vgem (basic-fence-read)
[265.233379] Starting subtest: basic-fence-read
[265.257976] Subtest basic-fence-read: SKIP (0.025s)
[265.377072] [061/131] (758s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[265.513433] Starting subtest: cursorB-vs-flipA-atomic-transitions
[265.517819] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[265.678026] [062/131] (758s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[265.742590] Starting subtest: invalid-bsd2-flag-on-vebox
[265.744878] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[265.840651] [063/131] (758s left) gem_exec_fence (submit-chain)
[266.016933] Starting subtest: submit-chain
[266.033738] Subtest submit-chain: SUCCESS (0.017s)
[268.000546] [064/131] (756s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[268.093066] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[268.097130] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[268.164918] [065/131] (756s left) gem_exec_fence (basic-busy)
[268.351090] Starting subtest: basic-busy
[268.353513] Starting dynamic subtest: rcs0
[268.430437] Dynamic subtest rcs0: SUCCESS (0.079s)
[268.441333] Starting dynamic subtest: bcs0
[268.493441] Dynamic subtest bcs0: SUCCESS (0.061s)
[268.505075] Starting dynamic subtest: vcs0
[268.552151] Dynamic subtest vcs0: SUCCESS (0.057s)
[268.562694] Starting dynamic subtest: vcs1
[268.607424] Dynamic subtest vcs1: SUCCESS (0.053s)
[268.617454] Starting dynamic subtest: vecs0
[268.665087] Dynamic subtest vecs0: SUCCESS (0.056s)
[268.675445] Starting dynamic subtest: ccs0
[268.721605] Dynamic subtest ccs0: SUCCESS (0.054s)
[268.724257] Subtest basic-busy: SUCCESS (0.372s)
[271.015928] [066/131] (753s left) kms_lease (lease-invalid-crtc)
[271.120993] Starting subtest: lease-invalid-crtc
[271.123296] Starting dynamic subtest: pipe-A-eDP-1
[271.125586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[271.139118] Starting dynamic subtest: pipe-B-eDP-1
[271.141347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[271.151101] Starting dynamic subtest: pipe-C-eDP-1
[271.152923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[271.167293] Starting dynamic subtest: pipe-D-eDP-1
[271.169392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[271.171448] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[271.227181] [067/131] (753s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[271.292261] Starting subtest: y-tiled-to-vebox-y-tiled
[271.296462] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[271.488646] [068/131] (753s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[271.576866] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[271.605458] Starting dynamic subtest: pipe-A-plane-0
[272.038417] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[272.047965] Starting dynamic subtest: pipe-A-plane-3
[272.294522] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[272.304681] Starting dynamic subtest: pipe-A-plane-5
[272.309128] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[273.456288] Starting dynamic subtest: pipe-B-plane-0
[273.892266] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[273.902305] Starting dynamic subtest: pipe-B-plane-3
[274.148656] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[274.157463] Starting dynamic subtest: pipe-B-plane-5
[274.162285] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[274.460053] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.883s)
[275.340519] [069/131] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[275.435735] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[275.440214] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[275.532916] [070/131] (749s left) perf_pmu (semaphore-busy)
[275.571546] Starting subtest: semaphore-busy
[275.573837] Starting dynamic subtest: rcs0
[277.200303] Dynamic subtest rcs0: SUCCESS (1.627s)
[277.212085] Starting dynamic subtest: bcs0
[278.833475] Dynamic subtest bcs0: SUCCESS (1.630s)
[278.843281] Starting dynamic subtest: vcs0
[283.410787] Dynamic subtest vcs0: SUCCESS (4.574s)
[283.422792] Starting dynamic subtest: vcs1
[289.425937] Dynamic subtest vcs1: SUCCESS (6.012s)
[289.438095] Starting dynamic subtest: vecs0
[295.442326] Dynamic subtest vecs0: SUCCESS (6.013s)
[295.454481] Starting dynamic subtest: ccs0
[298.515933] Dynamic subtest ccs0: SUCCESS (3.071s)
[298.518407] Subtest semaphore-busy: SUCCESS (22.945s)
[298.633206] [071/131] (726s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[298.743539] Starting subtest: psr-rgb565-draw-blt
[305.785822] Subtest psr-rgb565-draw-blt: SUCCESS (7.046s)
[305.935258] [072/131] (718s left) gem_ctx_bad_destroy (invalid-pad)
[305.991857] Starting subtest: invalid-pad
[305.994181] Subtest invalid-pad: SUCCESS (0.000s)
[306.063383] [073/131] (718s left) perf (stress-open-close)
[306.188385] Starting subtest: stress-open-close
[306.190645] Starting dynamic subtest: 0-rcs0
[308.355511] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[308.367964] Starting dynamic subtest: 1-vcs0
[310.522859] Dynamic subtest 1-vcs0: SUCCESS (2.167s)
[310.524888] Subtest stress-open-close: SUCCESS (4.338s)
[310.568865] [074/131] (714s left) i915_suspend (basic-s2idle-without-i915)
[310.605669] Starting subtest: basic-s2idle-without-i915
[331.866275] Subtest basic-s2idle-without-i915: SUCCESS (5.562s)
[331.984329] [075/131] (692s left) gem_mmap_wc (write-cpu-read-wc)
[332.057538] Subtest write-cpu-read-wc: SKIP (0.000s)
[332.115804] [076/131] (692s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[332.216507] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[332.330441] [077/131] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[332.424368] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[332.428719] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[332.519222] [078/131] (692s left) syncobj_wait (wait-any-interrupted)
[332.579957] Starting subtest: wait-any-interrupted
[332.682737] Subtest wait-any-interrupted: SUCCESS (0.104s)
[332.757844] [079/131] (692s left) gem_userptr_blits (huge-split)
[332.836123] Starting subtest: huge-split
[332.845256] Subtest huge-split: SUCCESS (0.009s)
[332.985755] [080/131] (692s left) gem_busy (extended)
[333.167930] Starting subtest: extended
[333.170217] Starting dynamic subtest: rcs0
[333.246398] Dynamic subtest rcs0: SUCCESS (0.080s)
[333.257829] Starting dynamic subtest: bcs0
[333.288600] Dynamic subtest bcs0: SUCCESS (0.041s)
[333.299994] Starting dynamic subtest: vcs0
[334.659287] Dynamic subtest vcs0: SUCCESS (1.391s)
[334.671776] Starting dynamic subtest: vcs1
[336.641704] Dynamic subtest vcs1: SUCCESS (2.008s)
[336.654647] Starting dynamic subtest: vecs0
[338.627860] Dynamic subtest vecs0: SUCCESS (2.005s)
[338.639655] Starting dynamic subtest: ccs0
[338.674327] Dynamic subtest ccs0: SUCCESS (0.045s)
[338.677026] Subtest extended: SUCCESS (5.584s)
[338.915597] [081/131] (686s left) sysfs_timeslice_duration (timeout)
[338.968985] Starting subtest: timeout
[338.971294] Starting dynamic subtest: vecs0
[348.604746] Dynamic subtest vecs0: SUCCESS (9.684s)
[348.616115] Starting dynamic subtest: ccs0
[349.713601] Dynamic subtest ccs0: SUCCESS (1.110s)
[349.724993] Starting dynamic subtest: vcs0
[359.610701] Dynamic subtest vcs0: SUCCESS (9.909s)
[359.622191] Starting dynamic subtest: bcs0
[360.091030] Dynamic subtest bcs0: SUCCESS (0.480s)
[360.102063] Starting dynamic subtest: rcs0
[361.232171] Dynamic subtest rcs0: SUCCESS (1.141s)
[361.243786] Starting dynamic subtest: vcs1
[370.624689] Dynamic subtest vcs1: SUCCESS (9.389s)
[370.627586] Subtest timeout: SUCCESS (31.723s)
[370.713891] [082/131] (654s left) kms_flip (plain-flip-ts-check)
[370.810178] Starting subtest: plain-flip-ts-check
[370.812566] Starting dynamic subtest: A-eDP1
[379.864739] Dynamic subtest A-eDP1: SUCCESS (9.052s)
[379.875647] Starting dynamic subtest: B-eDP1
[388.809652] Dynamic subtest B-eDP1: SUCCESS (8.944s)
[388.821108] Starting dynamic subtest: C-eDP1
[397.639015] Dynamic subtest C-eDP1: SUCCESS (8.829s)
[397.653582] Starting dynamic subtest: D-eDP1
[406.767472] Dynamic subtest D-eDP1: SUCCESS (9.130s)
[406.772669] Subtest plain-flip-ts-check: SUCCESS (35.966s)
[407.941356] [083/131] (617s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[408.028231] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[408.032662] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[408.103134] [084/131] (617s left) kms_cursor_legacy (torture-bo)
[408.224097] Starting subtest: torture-bo
[408.226263] Starting dynamic subtest: pipe-A
[414.070684] Dynamic subtest pipe-A: SUCCESS (5.845s)
[414.085672] Starting dynamic subtest: pipe-B
[420.189551] Dynamic subtest pipe-B: SUCCESS (6.117s)
[420.199401] Starting dynamic subtest: pipe-C
[426.780309] Dynamic subtest pipe-C: SUCCESS (6.592s)
[426.794805] Starting dynamic subtest: pipe-D
[433.538041] Dynamic subtest pipe-D: SUCCESS (6.754s)
[433.547309] Starting dynamic subtest: all-pipes
[440.089360] Dynamic subtest all-pipes: SUCCESS (6.547s)
[440.091749] Subtest torture-bo: SUCCESS (31.865s)
[440.259082] [085/131] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[440.354330] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[447.600271] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.247s)
[447.712468] [086/131] (577s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[448.138493] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[448.987615] [087/131] (576s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[449.071698] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[449.074007] Starting dynamic subtest: pipe-A-eDP-1
[465.623459] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.419s)
[465.637519] Starting dynamic subtest: pipe-B-eDP-1
[482.578806] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.400s)
[482.588758] Starting dynamic subtest: pipe-C-eDP-1
[499.512255] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.394s)
[499.521550] Starting dynamic subtest: pipe-D-eDP-1
[516.535983] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.393s)
[516.538347] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.612s)
[517.749300] [088/131] (507s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[517.857638] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[517.862006] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[517.963689] [089/131] (507s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[518.076281] Starting subtest: plane-all-modeset-transition-fencing
[518.080330] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[518.155718] [090/131] (507s left) gem_exec_params (rel-constants-invalid-ring)
[518.209307] Starting subtest: rel-constants-invalid-ring
[518.213395] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[518.303190] [091/131] (507s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[518.354894] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[518.459927] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[518.537673] [092/131] (507s left) kms_psr (fbc-pr-cursor-plane-onoff)
[518.630866] Starting subtest: fbc-pr-cursor-plane-onoff
[518.634795] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[518.703339] [093/131] (507s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[518.815064] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[522.827584] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.069s)
[523.994733] [094/131] (501s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[524.089358] Starting subtest: plane-downscale-factor-0-75-with-rotation
[524.091442] Starting dynamic subtest: pipe-A
[524.358715] Dynamic subtest pipe-A: SUCCESS (0.272s)
[524.369204] Starting dynamic subtest: pipe-B
[525.647046] Dynamic subtest pipe-B: SUCCESS (1.298s)
[525.658751] Starting dynamic subtest: pipe-C
[526.992913] Dynamic subtest pipe-C: SUCCESS (1.354s)
[527.004069] Starting dynamic subtest: pipe-D
[528.311214] Dynamic subtest pipe-D: SUCCESS (1.324s)
[528.313598] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.253s)
[529.477894] [095/131] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[529.580007] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[529.583919] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[529.681817] [096/131] (496s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[529.810252] Starting subtest: short-flip-before-cursor-atomic-transitions
[530.770286] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.963s)
[531.608567] [097/131] (494s left) kms_cursor_crc (cursor-onscreen-128x42)
[531.837516] Starting subtest: cursor-onscreen-128x42
[531.886561] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[532.076257] [098/131] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[532.171685] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[532.175950] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[532.275400] [099/131] (493s left) kms_atomic (plane-overlay-legacy)
[532.372754] Starting subtest: plane-overlay-legacy
[532.375003] Starting dynamic subtest: pipe-A-eDP-1
[532.796164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[532.798430] Subtest plane-overlay-legacy: SUCCESS (0.426s)
[533.641101] [100/131] (492s left) kms_getfb (getfb2-handle-protection)
[533.732876] Starting subtest: getfb2-handle-protection
[533.746771] Subtest getfb2-handle-protection: SUCCESS (0.014s)
[533.864536] [101/131] (492s left) gem_exec_schedule (u-submit-late-slice)
[533.943213] Starting subtest: u-submit-late-slice
[533.945267] Starting dynamic subtest: rcs0
[533.969133] Dynamic subtest rcs0: SUCCESS (0.034s)
[533.982435] Starting dynamic subtest: bcs0
[534.007197] Dynamic subtest bcs0: SUCCESS (0.037s)
[534.020591] Starting dynamic subtest: vcs0
[534.042003] Dynamic subtest vcs0: SUCCESS (0.034s)
[534.053428] Starting dynamic subtest: vcs1
[534.074761] Dynamic subtest vcs1: SUCCESS (0.032s)
[534.084946] Starting dynamic subtest: vecs0
[534.108089] Dynamic subtest vecs0: SUCCESS (0.032s)
[534.118047] Starting dynamic subtest: ccs0
[534.138877] Dynamic subtest ccs0: SUCCESS (0.030s)
[534.141191] Subtest u-submit-late-slice: SUCCESS (0.205s)
[535.696143] [102/131] (490s left) kms_psr (fbc-psr2-primary-render)
[535.805901] Starting subtest: fbc-psr2-primary-render
[535.808213] Starting dynamic subtest: eDP-1
[535.812609] Dynamic subtest eDP-1: SKIP (0.000s)
[535.816999] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[535.879175] [103/131] (490s left) gem_exec_schedule (independent)
[535.950588] Starting subtest: independent
[535.952875] Starting dynamic subtest: rcs0
[537.647991] Dynamic subtest rcs0: SUCCESS (1.709s)
[537.665306] Starting dynamic subtest: vcs0
[539.642479] Dynamic subtest vcs0: SUCCESS (1.996s)
[539.652179] Starting dynamic subtest: vcs1
[541.640450] Dynamic subtest vcs1: SUCCESS (1.998s)
[541.653294] Starting dynamic subtest: vecs0
[543.614129] Dynamic subtest vecs0: SUCCESS (1.974s)
[543.626241] Starting dynamic subtest: ccs0
[545.647504] Dynamic subtest ccs0: SUCCESS (2.033s)
[545.650610] Subtest independent: SUCCESS (9.721s)
[545.963267] [104/131] (480s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[546.020228] Starting subtest: invalid-single-wait-all-unsubmitted
[546.022627] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[546.118848] [105/131] (480s left) kms_force_connector_basic (prune-stale-modes)
[546.194766] Starting subtest: prune-stale-modes
[546.517499] Subtest prune-stale-modes: SUCCESS (0.325s)
[546.657334] [106/131] (479s left) gen9_exec_parse (shadow-peek)
[546.713447] Subtest shadow-peek: SKIP (0.000s)
[546.781553] [107/131] (479s left) syncobj_timeline (signal)
[546.834906] Starting subtest: signal
[546.836815] Subtest signal: SUCCESS (0.000s)
[546.925117] [108/131] (479s left) syncobj_wait (multi-wait-submitted)
[546.981979] Starting subtest: multi-wait-submitted
[547.091554] Subtest multi-wait-submitted: SUCCESS (0.108s)
[547.180953] [109/131] (479s left) kms_chamelium_color (ctm-limited-range)
[547.283368] Subtest ctm-limited-range: SKIP (0.000s)
[547.329658] [110/131] (479s left) kms_flip (absolute-wf_vblank)
[547.428903] Starting subtest: absolute-wf_vblank
[547.430736] Starting dynamic subtest: A-eDP1
[556.167677] Dynamic subtest A-eDP1: SUCCESS (8.737s)
[556.179065] Starting dynamic subtest: B-eDP1
[564.862843] Dynamic subtest B-eDP1: SUCCESS (8.694s)
[564.873610] Starting dynamic subtest: C-eDP1
[573.550098] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[573.560714] Starting dynamic subtest: D-eDP1
[582.247431] Dynamic subtest D-eDP1: SUCCESS (8.699s)
[582.252683] Subtest absolute-wf_vblank: SUCCESS (34.826s)
[583.433959] [111/131] (443s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[583.554589] Starting subtest: cursorA-vs-flipA-toggle
[594.665545] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.115s)
[595.539135] [112/131] (430s left) sw_sync (sync_busy_fork_unixsocket)
[595.580384] Starting subtest: sync_busy_fork_unixsocket
[595.588852] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[595.654421] [113/131] (430s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[595.706723] Starting subtest: invalid-single-wait-unsubmitted
[595.708891] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[595.818181] [114/131] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[595.922888] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[595.927014] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[596.021879] [115/131] (430s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[596.116061] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[596.120204] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[596.191668] [116/131] (430s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[596.289024] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[596.291337] Starting dynamic subtest: pipe-A-eDP-1
[596.355769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[596.656868] Starting dynamic subtest: pipe-B-eDP-1
[597.417604] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[597.729340] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.439s)
[598.532925] [117/131] (428s left) gem_userptr_blits (unsync-unmap)
[598.605631] Subtest unsync-unmap: SKIP (0.000s)
[598.737683] [118/131] (428s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[598.834796] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[598.837104] Starting dynamic subtest: pipe-A
[598.897395] Dynamic subtest pipe-A: SUCCESS (0.065s)
[598.908520] Starting dynamic subtest: pipe-B
[600.010307] Dynamic subtest pipe-B: SUCCESS (1.112s)
[600.021756] Starting dynamic subtest: pipe-C
[601.092124] Dynamic subtest pipe-C: SUCCESS (1.081s)
[601.102510] Starting dynamic subtest: pipe-D
[602.211158] Dynamic subtest pipe-D: SUCCESS (1.118s)
[602.213466] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.381s)
[603.430191] [119/131] (423s left) gem_mmap_gtt (bad-object)
[603.493607] Subtest bad-object: SKIP (0.000s)
[603.557534] [120/131] (423s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[603.642092] Starting subtest: fbc-rgb565-draw-blt
[607.738229] Subtest fbc-rgb565-draw-blt: SUCCESS (4.100s)
[608.931526] [121/131] (417s left) core_setmaster (master-drop-set-user)
[609.025942] Starting subtest: master-drop-set-user
[609.037727] Subtest master-drop-set-user: SUCCESS (0.015s)
[609.077840] [122/131] (417s left) gem_create (create-invalid-size)
[609.136822] Starting subtest: create-invalid-size
[609.138994] Subtest create-invalid-size: SUCCESS (0.000s)
[609.325675] [123/131] (417s left) gem_exec_balancer (hog)
[609.387320] Starting subtest: hog
[609.391881] Subtest hog: SKIP (0.000s)
[609.687423] [124/131] (417s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[609.742412] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[609.806514] [125/131] (417s left) kms_psr (fbc-psr-primary-mmap-gtt)
[609.893622] Starting subtest: fbc-psr-primary-mmap-gtt
[609.895757] Starting dynamic subtest: eDP-1
[609.899632] Dynamic subtest eDP-1: SKIP (0.000s)
[609.903514] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[609.967194] [126/131] (417s left) gen9_exec_parse (bb-oversize)
[610.023855] Subtest bb-oversize: SKIP (0.000s)
[610.103095] [127/131] (417s left) gem_ctx_persistence (idempotent)
[610.167813] Starting subtest: idempotent
[610.170067] Subtest idempotent: SUCCESS (0.000s)
[610.283646] [128/131] (416s left) api_intel_allocator (gem-pool)
[610.347086] Starting subtest: gem-pool
[610.354748] Subtest gem-pool: SUCCESS (0.009s)
[610.473009] [129/131] (416s left) kms_pm_rpm (modeset-non-lpsp)
[612.809050] Starting subtest: modeset-non-lpsp
[613.967580] Subtest modeset-non-lpsp: SKIP (1.159s)
[614.372740] [130/131] (412s left) gem_mmap_wc (copy)
[614.429517] Subtest copy: SKIP (0.000s)
[614.502655] [131/131] (412s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[614.599773] Starting subtest: yf-tiled-64bpp-rotate-0
[614.604096] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[614.709266] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_ccs
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_hdr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_ctx_isolation
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_pm_dc
results: parsing output: 24/ for test: gem_spin_batch
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_color_pipeline
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_pipe_stress
results: parsing output: 38/ for test: drm_read
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_vrr
results: parsing output: 41/ for test: kms_atomic_interruptible
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_draw_crc
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: prime_vgem
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: i915_hangman
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_bad_destroy
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: i915_suspend
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: sysfs_timeslice_duration
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: kms_getfb
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_force_connector_basic
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: sw_sync
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: core_setmaster
results: parsing output: 121/ for test: gem_create
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: api_intel_allocator
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: kms_big_fb
Done.