[63.714972] Initializing watchdogs
[63.715045]   /dev/watchdog0
[63.734901] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.744827] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.749123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.752746] [001/133] (960s left) i915_pm_rpm (gem-execbuf-stress)
[66.094041] Starting subtest: gem-execbuf-stress
[66.095427] Starting dynamic subtest: lmem0
[69.713142] Dynamic subtest lmem0: SUCCESS (3.621s)
[69.750524] Starting dynamic subtest: extra-wait-lmem0
[123.201730] Dynamic subtest extra-wait-lmem0: SUCCESS (53.487s)
[123.213973] Starting dynamic subtest: smem0
[126.825205] Dynamic subtest smem0: SUCCESS (3.623s)
[126.861091] Starting dynamic subtest: extra-wait-smem0
[180.548542] Dynamic subtest extra-wait-smem0: SUCCESS (53.720s)
[180.550276] Subtest gem-execbuf-stress: SUCCESS (114.456s)
[180.944251] [002/133] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[181.135547] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[181.137225] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[181.246871] [003/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[181.430594] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[181.432248] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[181.548891] [004/133] (842s left) kms_vrr (seamless-rr-switch-drrs)
[181.728432] Starting subtest: seamless-rr-switch-drrs
[181.731053] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[181.820903] [005/133] (842s left) i915_query (query-regions-sanity-check)
[181.892955] Starting subtest: query-regions-sanity-check
[181.915656] Subtest query-regions-sanity-check: SUCCESS (0.024s)
[182.096008] [006/133] (842s left) gem_lmem_swapping (parallel-multi)
[184.555750] Starting subtest: parallel-multi
[184.556545] Starting dynamic subtest: lmem0
[237.985119] Dynamic subtest lmem0: SUCCESS (53.428s)
[237.986112] Subtest parallel-multi: SUCCESS (53.429s)
[238.989385] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[238.991222] [007/133] (785s left) kms_sequence (queue-busy)
[240.643484] Starting subtest: queue-busy
[240.644393] Starting dynamic subtest: pipe-A-DP-3
[243.257339] Dynamic subtest pipe-A-DP-3: SUCCESS (2.613s)
[243.266735] Starting dynamic subtest: pipe-B-DP-3
[245.743135] Dynamic subtest pipe-B-DP-3: SUCCESS (2.485s)
[245.755492] Starting dynamic subtest: pipe-C-DP-3
[248.215025] Dynamic subtest pipe-C-DP-3: SUCCESS (2.470s)
[248.225480] Starting dynamic subtest: pipe-D-DP-3
[250.693309] Dynamic subtest pipe-D-DP-3: SUCCESS (2.476s)
[250.694206] Subtest queue-busy: SUCCESS (10.049s)
[250.952548] [FACT kms_sequence (queue-busy)] new: kernel.kmod_is_loaded.i915: true
[250.955187] [008/133] (773s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[251.149764] Starting subtest: y-tiled-16bpp-rotate-90
[251.151419] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[251.271955] [009/133] (773s left) gem_exec_whisper (basic-contexts)
[251.360099] Starting subtest: basic-contexts
[262.575720] Subtest basic-contexts: SUCCESS (11.208s)
[262.780103] [010/133] (762s left) gem_mmap_offset (clear-via-pagefault)
[262.847934] Starting subtest: clear-via-pagefault
[262.848859] Starting dynamic subtest: lmem0
[287.065621] Dynamic subtest lmem0: SUCCESS (24.215s)
[287.076684] Starting dynamic subtest: smem0
[311.102429] Dynamic subtest smem0: SUCCESS (24.036s)
[311.103348] Subtest clear-via-pagefault: SUCCESS (48.251s)
[311.275469] [011/133] (713s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[311.457481] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[311.518772] [012/133] (713s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[311.701154] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[311.702910] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[311.874441] [013/133] (713s left) gem_busy (parallel)
[312.139524] Starting subtest: parallel
[312.141032] Starting dynamic subtest: rcs0
[312.250941] Dynamic subtest rcs0: SUCCESS (0.111s)
[312.263852] Starting dynamic subtest: bcs0
[312.318761] Dynamic subtest bcs0: SUCCESS (0.067s)
[312.329941] Starting dynamic subtest: vcs0
[312.380459] Dynamic subtest vcs0: SUCCESS (0.061s)
[312.394396] Starting dynamic subtest: vcs1
[312.452457] Dynamic subtest vcs1: SUCCESS (0.071s)
[312.465984] Starting dynamic subtest: vecs0
[312.518230] Dynamic subtest vecs0: SUCCESS (0.065s)
[312.527506] Starting dynamic subtest: vecs1
[312.581854] Dynamic subtest vecs1: SUCCESS (0.063s)
[312.597424] Starting dynamic subtest: ccs0
[312.653050] Dynamic subtest ccs0: SUCCESS (0.070s)
[312.654300] Subtest parallel: SUCCESS (0.514s)
[312.929202] [014/133] (712s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[313.114076] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[313.115011] Starting dynamic subtest: pipe-A-DP-3
[313.118438] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[313.127494] Starting dynamic subtest: pipe-B-DP-3
[313.130996] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[313.140009] Starting dynamic subtest: pipe-C-DP-3
[313.143421] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[313.153916] Starting dynamic subtest: pipe-D-DP-3
[313.157260] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[313.158950] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[313.573345] [015/133] (711s left) kms_joiner (basic-big-joiner)
[313.759146] Starting subtest: basic-big-joiner
[313.760872] Subtest basic-big-joiner: SKIP (0.000s)
[313.864709] [016/133] (711s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[314.050812] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[314.052432] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[314.205758] [017/133] (711s left) prime_vgem (coherency-gtt)
[314.344828] Starting subtest: coherency-gtt
[314.347238] Subtest coherency-gtt: SKIP (0.000s)
[314.518881] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[314.520633] [018/133] (710s left) kms_pm_rpm (pm-caching)
[316.034991] Starting subtest: pm-caching
[316.037609] Subtest pm-caching: SKIP (0.000s)
[316.440278] [019/133] (708s left) gem_flink_basic (bad-flink)
[316.519376] Starting subtest: bad-flink
[316.520678] Subtest bad-flink: SUCCESS (0.000s)
[316.636874] [020/133] (708s left) kms_lease (lease-unleased-crtc)
[316.825183] Starting subtest: lease-unleased-crtc
[316.826157] Starting dynamic subtest: pipe-A-DP-3
[316.953692] Dynamic subtest pipe-A-DP-3: SUCCESS (0.128s)
[316.964220] Starting dynamic subtest: pipe-B-DP-3
[317.012417] Dynamic subtest pipe-B-DP-3: SUCCESS (0.056s)
[317.021597] Starting dynamic subtest: pipe-C-DP-3
[317.067844] Dynamic subtest pipe-C-DP-3: SUCCESS (0.055s)
[317.078369] Starting dynamic subtest: pipe-D-DP-3
[317.121643] Dynamic subtest pipe-D-DP-3: SUCCESS (0.053s)
[317.122538] Subtest lease-unleased-crtc: SUCCESS (0.298s)
[317.303530] [021/133] (708s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[317.489910] Starting subtest: cursorB-vs-flipB-legacy
[317.493052] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[317.691090] [022/133] (707s left) kms_vblank (wait-forked-busy-hang)
[317.881436] Starting subtest: wait-forked-busy-hang
[317.883393] Starting dynamic subtest: pipe-A-DP-3
[344.580416] Dynamic subtest pipe-A-DP-3: SUCCESS (26.697s)
[344.592391] Starting dynamic subtest: pipe-D-DP-3
[369.588082] Dynamic subtest pipe-D-DP-3: SUCCESS (25.003s)
[369.588992] Subtest wait-forked-busy-hang: SUCCESS (51.705s)
[369.834643] [023/133] (655s left) kms_cursor_crc (cursor-sliding-256x85)
[370.281291] Starting subtest: cursor-sliding-256x85
[370.285426] Starting dynamic subtest: pipe-A-DP-3
[374.741357] Dynamic subtest pipe-A-DP-3: SUCCESS (4.455s)
[374.788118] Starting dynamic subtest: pipe-D-DP-3
[379.151929] Dynamic subtest pipe-D-DP-3: SUCCESS (4.372s)
[379.152912] Subtest cursor-sliding-256x85: SUCCESS (8.870s)
[379.491829] [024/133] (646s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[379.683851] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[379.685446] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[379.822628] [025/133] (646s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[379.899371] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[379.901457] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[380.100709] [026/133] (645s left) gem_caching (reads)
[380.184189] Starting subtest: reads
[383.295204] Subtest reads: SUCCESS (3.111s)
[383.458008] [027/133] (642s left) kms_hdr (brightness-with-hdr)
[383.648175] Starting subtest: brightness-with-hdr
[383.650863] Subtest brightness-with-hdr: SKIP (0.001s)
[383.762678] [028/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[383.955548] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[383.957213] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[384.128141] [029/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[384.321813] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[384.323471] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[384.455160] [030/133] (641s left) syncobj_wait (single-wait-all-signaled)
[384.556624] Starting subtest: single-wait-all-signaled
[384.557565] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[384.766861] [031/133] (641s left) gem_workarounds (suspend-resume)
[384.866040] Starting subtest: suspend-resume
[404.353907] Subtest suspend-resume: SUCCESS (4.030s)
[404.516737] [032/133] (621s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[404.707083] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[404.708011] Starting dynamic subtest: pipe-A-DP-3
[404.716724] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[404.728144] Starting dynamic subtest: pipe-B-DP-3
[404.736779] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[404.747922] Starting dynamic subtest: pipe-C-DP-3
[404.756245] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[404.767629] Starting dynamic subtest: pipe-D-DP-3
[404.778041] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[404.780157] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[405.154226] [033/133] (621s left) kms_psr (psr2-cursor-plane-onoff)
[405.341692] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[405.403441] [034/133] (621s left) prime_busy (before)
[405.488762] Starting subtest: before
[405.493578] Starting dynamic subtest: rcs0
[405.540542] Dynamic subtest rcs0: SUCCESS (0.047s)
[405.552168] Starting dynamic subtest: bcs0
[405.593333] Dynamic subtest bcs0: SUCCESS (0.052s)
[405.612087] Starting dynamic subtest: vcs0
[405.635367] Dynamic subtest vcs0: SUCCESS (0.041s)
[405.664025] Starting dynamic subtest: vcs1
[405.678064] Dynamic subtest vcs1: SUCCESS (0.041s)
[405.699258] Starting dynamic subtest: vecs0
[405.718251] Dynamic subtest vecs0: SUCCESS (0.039s)
[405.732501] Starting dynamic subtest: vecs1
[405.759200] Dynamic subtest vecs1: SUCCESS (0.040s)
[405.774837] Starting dynamic subtest: ccs0
[405.802050] Dynamic subtest ccs0: SUCCESS (0.042s)
[405.910186] Subtest before: SUCCESS (0.421s)
[406.048462] [035/133] (620s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[406.234164] Starting subtest: psr-dirtyfb-ioctl
[406.239187] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[406.387625] [036/133] (620s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[406.571279] Starting subtest: primary-yf-tiled-reflect-x-180
[406.675213] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.101s)
[406.859198] [037/133] (619s left) gem_tiled_wc
[407.019818] [038/133] (619s left) gem_create (create-invalid-size)
[407.101199] Starting subtest: create-invalid-size
[407.109156] Subtest create-invalid-size: SUCCESS (0.000s)
[407.379515] [039/133] (619s left) gem_ctx_persistence (heartbeat-many)
[407.465346] Starting subtest: heartbeat-many
[407.467349] Subtest heartbeat-many: SKIP (0.000s)
[407.643353] [040/133] (619s left) gem_userptr_blits (usage-restrictions)
[407.728950] Starting subtest: usage-restrictions
[407.729868] Subtest usage-restrictions: SUCCESS (0.000s)
[407.896633] [041/133] (619s left) kms_psr (fbc-pr-primary-render)
[408.085538] Subtest fbc-pr-primary-render: SKIP (0.000s)
[408.151124] [042/133] (618s left) gem_userptr_blits (unsync-unmap-cycles)
[408.241476] Subtest unsync-unmap-cycles: SKIP (0.000s)
[408.442663] [043/133] (618s left) syncobj_timeline (single-wait-for-submit-signaled)
[408.524149] Starting subtest: single-wait-for-submit-signaled
[408.525195] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[408.682349] [044/133] (618s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[408.869275] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[408.870120] Starting dynamic subtest: pipe-A
[409.423134] Dynamic subtest pipe-A: SUCCESS (0.553s)
[409.451276] Starting dynamic subtest: pipe-B
[410.070136] Dynamic subtest pipe-B: SUCCESS (0.646s)
[410.094245] Starting dynamic subtest: pipe-C
[410.716216] Dynamic subtest pipe-C: SUCCESS (0.645s)
[410.742385] Starting dynamic subtest: pipe-D
[411.362208] Dynamic subtest pipe-D: SUCCESS (0.645s)
[411.363320] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.493s)
[411.678110] [045/133] (615s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[411.866045] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[411.867833] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[411.962386] [046/133] (615s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[412.151055] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[412.151945] Starting dynamic subtest: pipe-A-DP-3
[412.160355] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[412.171625] Starting dynamic subtest: pipe-B-DP-3
[412.179944] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[412.191006] Starting dynamic subtest: pipe-C-DP-3
[412.199274] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[412.210470] Starting dynamic subtest: pipe-D-DP-3
[412.219926] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[412.221970] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[412.587705] [047/133] (614s left) gem_lmem_swapping (verify-random-ccs)
[415.050315] Starting subtest: verify-random-ccs
[415.051207] Starting dynamic subtest: lmem0
[421.800198] Dynamic subtest lmem0: SUCCESS (6.749s)
[421.801189] Subtest verify-random-ccs: SUCCESS (6.750s)
[422.843014] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[422.844426] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[422.846439] [048/133] (604s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[424.439506] Starting subtest: yf-tiled-to-vebox-yf-tiled
[424.441233] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[424.671135] [FACT gem_render_copy (yf-tiled-to-vebox-yf-tiled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[424.673355] [FACT gem_render_copy (yf-tiled-to-vebox-yf-tiled)] new: kernel.kmod_is_loaded.i915: true
[424.676268] [049/133] (602s left) gem_exec_schedule (smoketest)
[424.934789] Starting subtest: smoketest
[424.935977] Starting dynamic subtest: rcs0
[430.417052] Dynamic subtest rcs0: SUCCESS (5.475s)
[430.427987] Starting dynamic subtest: bcs0
[435.877287] Dynamic subtest bcs0: SUCCESS (5.459s)
[435.888616] Starting dynamic subtest: vcs0
[441.338271] Dynamic subtest vcs0: SUCCESS (5.458s)
[441.350134] Starting dynamic subtest: vcs1
[446.802795] Dynamic subtest vcs1: SUCCESS (5.462s)
[446.814243] Starting dynamic subtest: vecs0
[452.258495] Dynamic subtest vecs0: SUCCESS (5.453s)
[452.269894] Starting dynamic subtest: vecs1
[457.731022] Dynamic subtest vecs1: SUCCESS (5.471s)
[457.742651] Starting dynamic subtest: ccs0
[463.190556] Dynamic subtest ccs0: SUCCESS (5.458s)
[463.191408] Subtest smoketest: SUCCESS (38.243s)
[463.495755] [050/133] (564s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[463.693184] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[464.937538] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.243s)
[465.113542] [051/133] (562s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[465.303800] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[465.364699] [052/133] (562s left) syncobj_wait (multi-wait-all-submitted-signaled)
[465.442316] Starting subtest: multi-wait-all-submitted-signaled
[465.550450] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[465.718470] [053/133] (562s left) gem_exec_schedule (implicit-read-write)
[465.809202] Starting subtest: implicit-read-write
[465.810089] Starting dynamic subtest: rcs0
[466.103775] Dynamic subtest rcs0: SUCCESS (0.295s)
[466.115279] Starting dynamic subtest: bcs0
[466.315304] Dynamic subtest bcs0: SUCCESS (0.211s)
[466.326922] Starting dynamic subtest: vcs0
[466.530753] Dynamic subtest vcs0: SUCCESS (0.214s)
[466.542281] Starting dynamic subtest: vcs1
[466.755775] Dynamic subtest vcs1: SUCCESS (0.224s)
[466.767355] Starting dynamic subtest: vecs0
[466.970171] Dynamic subtest vecs0: SUCCESS (0.213s)
[466.981654] Starting dynamic subtest: vecs1
[467.192281] Dynamic subtest vecs1: SUCCESS (0.221s)
[467.203521] Starting dynamic subtest: ccs0
[467.465120] Dynamic subtest ccs0: SUCCESS (0.272s)
[467.466049] Subtest implicit-read-write: SUCCESS (1.657s)
[467.886377] [054/133] (560s left) gem_sync (basic-store-all)
[467.979106] Starting subtest: basic-store-all
[472.398498] Subtest basic-store-all: SUCCESS (4.420s)
[472.617607] [055/133] (555s left) gem_flink_basic (double-flink)
[472.696195] Starting subtest: double-flink
[472.697095] Subtest double-flink: SUCCESS (0.000s)
[472.808711] [056/133] (555s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[473.217292] Starting subtest: cursor-rapid-movement-256x256
[473.222017] Starting dynamic subtest: pipe-A-DP-3
[473.700392] Dynamic subtest pipe-A-DP-3: SUCCESS (0.478s)
[473.745820] Starting dynamic subtest: pipe-D-DP-3
[474.108348] Dynamic subtest pipe-D-DP-3: SUCCESS (0.372s)
[474.109340] Subtest cursor-rapid-movement-256x256: SUCCESS (0.891s)
[474.520793] [057/133] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[474.711118] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[474.712717] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[474.863946] [058/133] (553s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[475.050184] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[475.109337] [059/133] (553s left) drm_read (short-buffer-nonblock)
[475.366183] Starting subtest: short-buffer-nonblock
[475.367090] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[475.586867] [060/133] (552s left) gem_spin_batch (resubmit)
[475.674290] Starting subtest: resubmit
[475.675267] Starting dynamic subtest: rcs0
[475.706591] Dynamic subtest rcs0: SUCCESS (0.032s)
[475.718501] Starting dynamic subtest: bcs0
[475.719361] Dynamic subtest bcs0: SUCCESS (0.002s)
[475.731338] Starting dynamic subtest: vcs0
[475.732489] Dynamic subtest vcs0: SUCCESS (0.002s)
[475.744143] Starting dynamic subtest: vcs1
[475.745063] Dynamic subtest vcs1: SUCCESS (0.003s)
[475.756153] Starting dynamic subtest: vecs0
[475.757280] Dynamic subtest vecs0: SUCCESS (0.003s)
[475.769999] Starting dynamic subtest: vecs1
[475.771282] Dynamic subtest vecs1: SUCCESS (0.002s)
[475.782314] Starting dynamic subtest: ccs0
[475.783466] Dynamic subtest ccs0: SUCCESS (0.002s)
[475.784601] Subtest resubmit: SUCCESS (0.053s)
[476.028498] [061/133] (552s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[476.221163] Starting subtest: psr-rgb101010-draw-mmap-cpu
[476.222875] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[476.398389] [062/133] (552s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[476.589965] Starting subtest: addfb25-y-tiled-small-legacy
[476.591690] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[476.777211] [063/133] (551s left) kms_scaling_modes (scaling-mode-full-aspect)
[476.961213] Starting subtest: scaling-mode-full-aspect
[476.966305] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[477.049450] [064/133] (551s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[477.245170] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[478.321524] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.077s)
[478.585251] [065/133] (550s left) syncobj_timeline (invalid-signal-illegal-handle)
[478.663227] Starting subtest: invalid-signal-illegal-handle
[478.664144] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[478.851120] [066/133] (550s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[479.045767] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[479.746259] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.700s)
[479.983800] [067/133] (549s left) gem_sync (basic-all)
[480.074236] Starting subtest: basic-all
[482.141989] Subtest basic-all: SUCCESS (2.068s)
[482.382128] [068/133] (546s left) api_intel_bb (destroy-bb)
[482.462404] Starting subtest: destroy-bb
[482.500368] Subtest destroy-bb: SUCCESS (0.038s)
[482.665741] [069/133] (546s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[482.860095] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[482.861922] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[482.975301] [070/133] (546s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[483.169972] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[485.530080] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.361s)
[485.732739] [071/133] (543s left) kms_color (degamma)
[485.924190] Starting subtest: degamma
[485.925076] Starting dynamic subtest: pipe-A-DP-3
[486.613959] Dynamic subtest pipe-A-DP-3: SUCCESS (0.689s)
[486.642550] Starting dynamic subtest: pipe-B-DP-3
[487.216531] Dynamic subtest pipe-B-DP-3: SUCCESS (0.600s)
[487.234584] Starting dynamic subtest: pipe-C-DP-3
[487.813853] Dynamic subtest pipe-C-DP-3: SUCCESS (0.597s)
[487.832981] Starting dynamic subtest: pipe-D-DP-3
[488.396520] Dynamic subtest pipe-D-DP-3: SUCCESS (0.581s)
[488.397524] Subtest degamma: SUCCESS (2.473s)
[488.658982] [072/133] (540s left) kms_cdclk (mode-transition-all-outputs)
[488.846267] Starting subtest: mode-transition-all-outputs
[488.945517] Subtest mode-transition-all-outputs: SKIP (0.097s)
[489.152971] [073/133] (540s left) gem_exec_reloc (basic-write-cpu-noreloc)
[489.243837] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[489.335422] [074/133] (540s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[489.596184] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[489.747709] [075/133] (539s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[489.945004] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[489.946828] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[490.096432] [076/133] (539s left) i915_hangman (gt-error-state-capture)
[490.191123] Starting subtest: gt-error-state-capture
[490.192038] Starting dynamic subtest: rcs0
[499.586234] Dynamic subtest rcs0: SUCCESS (9.394s)
[499.600063] Starting dynamic subtest: bcs0
[508.530539] Dynamic subtest bcs0: SUCCESS (8.943s)
[508.550236] Starting dynamic subtest: vcs0
[518.556270] Dynamic subtest vcs0: SUCCESS (10.024s)
[518.569889] Starting dynamic subtest: vcs1
[528.554065] Dynamic subtest vcs1: SUCCESS (9.997s)
[528.569589] Starting dynamic subtest: vecs0
[538.523295] Dynamic subtest vecs0: SUCCESS (9.968s)
[538.536845] Starting dynamic subtest: vecs1
[548.514301] Dynamic subtest vecs1: SUCCESS (9.990s)
[548.527699] Starting dynamic subtest: ccs0
[558.559257] Dynamic subtest ccs0: SUCCESS (10.044s)
[558.560175] Subtest gt-error-state-capture: SUCCESS (68.367s)
[558.742631] [077/133] (470s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[558.819397] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[558.927003] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[559.111278] [078/133] (470s left) gem_exec_balancer (hog)
[559.199647] Starting subtest: hog
[559.201631] Subtest hog: SKIP (0.000s)
[559.596830] [079/133] (470s left) drm_buddy (drm_buddy)
[559.647122] Starting subtest: drm_buddy
[559.648899] Subtest drm_buddy: SKIP (0.001s)
[559.724846] [080/133] (470s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[559.919039] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[559.920770] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[560.041484] [081/133] (469s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[560.235169] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[560.236945] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[560.393812] [082/133] (469s left) kms_getfb (getfb-addfb-different-handles)
[560.583154] Starting subtest: getfb-addfb-different-handles
[560.584041] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[560.723421] [083/133] (469s left) gem_eio (context-create)
[561.010204] Starting subtest: context-create
[561.426260] Subtest context-create: SUCCESS (0.416s)
[561.689314] [084/133] (468s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[561.875125] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[561.876876] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[562.042357] [085/133] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[562.234033] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[562.235782] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[562.357751] [086/133] (467s left) gem_create (create-size-update)
[562.437197] Starting subtest: create-size-update
[562.438100] Subtest create-size-update: SUCCESS (0.000s)
[562.761146] [087/133] (467s left) gen7_exec_parse (chained-batch)
[562.846102] Subtest chained-batch: SKIP (0.000s)
[562.938379] [088/133] (467s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[563.035084] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[563.227863] [089/133] (467s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[563.419181] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[563.420016] Starting dynamic subtest: pipe-A
[563.990743] Dynamic subtest pipe-A: SUCCESS (0.572s)
[564.025174] Starting dynamic subtest: pipe-B
[564.636239] Dynamic subtest pipe-B: SUCCESS (0.643s)
[564.666410] Starting dynamic subtest: pipe-C
[565.282237] Dynamic subtest pipe-C: SUCCESS (0.644s)
[565.317312] Starting dynamic subtest: pipe-D
[565.928826] Dynamic subtest pipe-D: SUCCESS (0.644s)
[565.929767] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.511s)
[566.245637] [090/133] (464s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[566.337605] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[566.339256] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[566.472725] [091/133] (464s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[566.665391] Starting subtest: stress-xrgb8888-4tiled
[574.925530] Subtest stress-xrgb8888-4tiled: SUCCESS (8.260s)
[575.175335] [092/133] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[575.368057] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[575.369817] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[575.529499] [093/133] (455s left) kms_flip (plain-flip-fb-recreate-interruptible)
[575.722224] Starting subtest: plain-flip-fb-recreate-interruptible
[575.727116] Starting dynamic subtest: A-DP3
[583.835449] Dynamic subtest A-DP3: SUCCESS (8.107s)
[583.881078] Starting dynamic subtest: B-DP3
[591.908657] Dynamic subtest B-DP3: SUCCESS (8.067s)
[591.952590] Starting dynamic subtest: C-DP3
[599.970621] Dynamic subtest C-DP3: SUCCESS (8.056s)
[600.015070] Starting dynamic subtest: D-DP3
[608.033757] Dynamic subtest D-DP3: SUCCESS (8.057s)
[608.042680] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.319s)
[608.383591] [094/133] (422s left) kms_chamelium_color (ctm-red-to-blue)
[608.569039] Subtest ctm-red-to-blue: SKIP (0.000s)
[608.624947] [095/133] (422s left) gem_ctx_param (non-root-set)
[608.704674] Starting subtest: non-root-set
[608.720312] Subtest non-root-set: SUCCESS (0.016s)
[608.882795] [096/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[609.075836] Starting subtest: fbcpsr-2p-rte
[609.077499] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[609.283302] [097/133] (421s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[609.470761] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[609.473210] Starting dynamic subtest: pipe-A-DP-3
[609.494478] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[609.506726] Starting dynamic subtest: pipe-B-DP-3
[609.528330] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[609.540097] Starting dynamic subtest: pipe-C-DP-3
[609.565103] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[609.577106] Starting dynamic subtest: pipe-D-DP-3
[609.599401] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[609.601359] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[609.940119] [098/133] (421s left) gem_exec_suspend (basic-s3-devices)
[610.029430] Starting subtest: basic-S3-devices
[610.030349] Starting dynamic subtest: smem
[620.161919] Dynamic subtest smem: SUCCESS (10.132s)
[620.174655] Starting dynamic subtest: lmem0
[629.938069] Dynamic subtest lmem0: SUCCESS (9.775s)
[629.939141] Subtest basic-S3-devices: SUCCESS (19.909s)
[630.222426] [099/133] (401s left) gem_ctx_persistence (engines-mixed)
[630.312072] Starting subtest: engines-mixed
[630.312979] Starting dynamic subtest: rcs0
[630.401207] Dynamic subtest rcs0: SUCCESS (0.089s)
[630.417134] Starting dynamic subtest: bcs0
[630.446494] Dynamic subtest bcs0: SUCCESS (0.044s)
[630.474143] Starting dynamic subtest: vcs0
[630.509821] Dynamic subtest vcs0: SUCCESS (0.061s)
[630.551086] Starting dynamic subtest: vcs1
[630.579182] Dynamic subtest vcs1: SUCCESS (0.067s)
[630.597594] Starting dynamic subtest: vecs0
[630.629418] Dynamic subtest vecs0: SUCCESS (0.049s)
[630.651734] Starting dynamic subtest: vecs1
[630.689700] Dynamic subtest vecs1: SUCCESS (0.058s)
[630.726462] Starting dynamic subtest: ccs0
[630.763157] Dynamic subtest ccs0: SUCCESS (0.071s)
[630.764183] Subtest engines-mixed: SUCCESS (0.452s)
[630.962303] [100/133] (400s left) gem_mmap_gtt (coherency)
[631.039339] Subtest coherency: SKIP (0.000s)
[631.128845] [101/133] (400s left) sysfs_preempt_timeout (timeout)
[631.218814] Starting subtest: timeout
[631.219756] Starting dynamic subtest: vecs0
[633.110235] Dynamic subtest vecs0: SUCCESS (1.890s)
[633.122725] Starting dynamic subtest: ccs0
[634.895197] Dynamic subtest ccs0: SUCCESS (1.784s)
[634.907978] Starting dynamic subtest: vcs0
[636.593042] Dynamic subtest vcs0: SUCCESS (1.697s)
[636.605710] Starting dynamic subtest: bcs0
[638.221493] Dynamic subtest bcs0: SUCCESS (1.627s)
[638.238137] Starting dynamic subtest: vecs1
[639.863600] Dynamic subtest vecs1: SUCCESS (1.640s)
[639.882215] Starting dynamic subtest: rcs0
[641.499005] Dynamic subtest rcs0: SUCCESS (1.633s)
[641.511875] Starting dynamic subtest: vcs1
[643.158038] Dynamic subtest vcs1: SUCCESS (1.658s)
[643.158908] Subtest timeout: SUCCESS (11.939s)
[643.277179] [102/133] (388s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[643.468909] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[643.470569] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[643.664971] [103/133] (388s left) kms_psr (pr-sprite-mmap-gtt)
[643.849300] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[643.905724] [104/133] (387s left) kms_atomic (crtc-invalid-params)
[644.093257] Starting subtest: crtc-invalid-params
[644.094143] Starting dynamic subtest: pipe-A-DP-3
[644.572144] Dynamic subtest pipe-A-DP-3: SUCCESS (0.477s)
[644.573148] Subtest crtc-invalid-params: SUCCESS (0.480s)
[644.852774] [105/133] (386s left) kms_setmode (invalid-clone-single-crtc)
[644.931839] Starting subtest: invalid-clone-single-crtc
[644.934687] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[645.072283] [106/133] (386s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[645.155879] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[645.158314] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[645.421147] [107/133] (386s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[645.611143] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[649.019659] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.409s)
[649.245704] [108/133] (382s left) perf_pmu (init-sema)
[649.316839] Starting subtest: init-sema
[649.317793] Starting dynamic subtest: rcs0
[649.320051] Dynamic subtest rcs0: SUCCESS (0.003s)
[649.332504] Starting dynamic subtest: bcs0
[649.333369] Dynamic subtest bcs0: SUCCESS (0.001s)
[649.345713] Starting dynamic subtest: vcs0
[649.346570] Dynamic subtest vcs0: SUCCESS (0.000s)
[649.359401] Starting dynamic subtest: vcs1
[649.360401] Dynamic subtest vcs1: SUCCESS (0.000s)
[649.373069] Starting dynamic subtest: vecs0
[649.376880] Dynamic subtest vecs0: SUCCESS (0.001s)
[649.389746] Starting dynamic subtest: vecs1
[649.390988] Dynamic subtest vecs1: SUCCESS (0.001s)
[649.406217] Starting dynamic subtest: ccs0
[649.407126] Dynamic subtest ccs0: SUCCESS (0.000s)
[649.408392] Subtest init-sema: SUCCESS (0.013s)
[649.457227] [109/133] (382s left) kms_big_fb (linear-8bpp-rotate-0)
[649.653286] Starting subtest: linear-8bpp-rotate-0
[651.287026] Subtest linear-8bpp-rotate-0: SUCCESS (1.633s)
[651.490408] [110/133] (380s left) kms_pm_rpm (dpms-lpsp)
[653.526451] Starting subtest: dpms-lpsp
[653.528771] Subtest dpms-lpsp: SKIP (0.001s)
[653.949007] [111/133] (378s left) kms_prop_blob (blob-prop-validate)
[654.028411] Starting subtest: blob-prop-validate
[654.029337] Subtest blob-prop-validate: SUCCESS (0.000s)
[654.190862] [112/133] (378s left) gem_exec_reloc (basic-cpu-read-noreloc)
[654.276871] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[654.371787] [113/133] (378s left) gem_exec_fence (syncobj-import)
[654.950442] Starting subtest: syncobj-import
[654.979556] Subtest syncobj-import: SUCCESS (0.029s)
[655.406443] [114/133] (377s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[655.596424] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[655.598146] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[655.696984] [115/133] (376s left) kms_flip (nonexisting-fb)
[655.885824] Starting subtest: nonexisting-fb
[655.890435] Starting dynamic subtest: A-DP3
[656.234285] Dynamic subtest A-DP3: SUCCESS (0.343s)
[656.279933] Starting dynamic subtest: B-DP3
[656.544468] Dynamic subtest B-DP3: SUCCESS (0.305s)
[656.581316] Starting dynamic subtest: C-DP3
[656.828338] Dynamic subtest C-DP3: SUCCESS (0.281s)
[656.865496] Starting dynamic subtest: D-DP3
[657.112481] Dynamic subtest D-DP3: SUCCESS (0.281s)
[657.117306] Subtest nonexisting-fb: SUCCESS (1.231s)
[657.495960] [116/133] (375s left) gem_pxp (fail-invalid-protected-context)
[660.100022] Starting subtest: fail-invalid-protected-context
[660.101940] Subtest fail-invalid-protected-context: SKIP (0.000s)
[660.202430] [117/133] (372s left) kms_content_protection (dp-mst-type-0)
[660.456095] Starting subtest: dp-mst-type-0
[660.458010] Subtest dp-mst-type-0: SKIP (0.000s)
[660.660990] [118/133] (372s left) kms_draw_crc (draw-method-render)
[660.851326] Starting subtest: draw-method-render
[660.852214] Starting dynamic subtest: xrgb8888-untiled
[661.225959] Dynamic subtest xrgb8888-untiled: SUCCESS (0.373s)
[661.268321] Starting dynamic subtest: rgb565-untiled
[661.559018] Dynamic subtest rgb565-untiled: SUCCESS (0.329s)
[661.607030] Starting dynamic subtest: xrgb2101010-untiled
[661.909118] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.346s)
[661.955822] Starting dynamic subtest: xbgr16161616f-untiled
[662.275400] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.362s)
[662.322618] Starting dynamic subtest: xrgb8888-xtiled
[662.476012] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s)
[662.521854] Starting dynamic subtest: rgb565-xtiled
[662.677981] Dynamic subtest rgb565-xtiled: SUCCESS (0.197s)
[662.719460] Starting dynamic subtest: xrgb2101010-xtiled
[662.859091] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.177s)
[662.879985] Starting dynamic subtest: xbgr16161616f-xtiled
[663.024787] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.162s)
[663.042098] Starting dynamic subtest: xrgb8888-4tiled
[663.192558] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[663.239831] Starting dynamic subtest: rgb565-4tiled
[663.392413] Dynamic subtest rgb565-4tiled: SUCCESS (0.195s)
[663.438942] Starting dynamic subtest: xrgb2101010-4tiled
[663.574764] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.179s)
[663.592484] Starting dynamic subtest: xbgr16161616f-4tiled
[663.742418] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[663.748026] Subtest draw-method-render: SUCCESS (2.893s)
[663.976017] [119/133] (368s left) prime_vgem (fence-read-hang)
[664.080506] Subtest fence-read-hang: SKIP (0.000s)
[664.212740] [120/133] (368s left) perf (invalid-open-flags)
[664.610185] Starting subtest: invalid-open-flags
[664.611106] Subtest invalid-open-flags: SUCCESS (0.000s)
[664.676606] [121/133] (368s left) gem_exec_fence (basic-await)
[664.884306] Starting subtest: basic-await
[664.885240] Starting dynamic subtest: rcs0
[664.999141] Dynamic subtest rcs0: SUCCESS (0.116s)
[665.013337] Starting dynamic subtest: bcs0
[665.084901] Dynamic subtest bcs0: SUCCESS (0.085s)
[665.102541] Starting dynamic subtest: vcs0
[665.175383] Dynamic subtest vcs0: SUCCESS (0.089s)
[665.194162] Starting dynamic subtest: vcs1
[665.269313] Dynamic subtest vcs1: SUCCESS (0.093s)
[665.285724] Starting dynamic subtest: vecs0
[665.357860] Dynamic subtest vecs0: SUCCESS (0.087s)
[665.371698] Starting dynamic subtest: vecs1
[665.444471] Dynamic subtest vecs1: SUCCESS (0.085s)
[665.464680] Starting dynamic subtest: ccs0
[665.540248] Dynamic subtest ccs0: SUCCESS (0.094s)
[665.541181] Subtest basic-await: SUCCESS (0.658s)
[666.261539] [122/133] (366s left) gem_tiled_pread_pwrite
[666.407874] [123/133] (366s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[666.606038] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[666.607830] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[666.773326] [124/133] (366s left) gen9_exec_parse (valid-registers)
[666.862090] Subtest valid-registers: SKIP (0.000s)
[666.961621] [125/133] (366s left) gem_pread (uncached)
[667.042102] Subtest uncached: SKIP (0.000s)
[667.152037] [126/133] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[667.341822] Starting subtest: fbcpsr-1p-rte
[667.343545] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[667.489190] [127/133] (365s left) kms_flip (2x-nonexisting-fb)
[667.680012] Starting subtest: 2x-nonexisting-fb
[667.695326] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[667.855774] [128/133] (365s left) kms_cursor_crc (cursor-onscreen-64x21)
[668.212437] Starting subtest: cursor-onscreen-64x21
[668.217358] Starting dynamic subtest: pipe-A-DP-3
[670.922985] Dynamic subtest pipe-A-DP-3: SUCCESS (2.705s)
[670.963486] Starting dynamic subtest: pipe-D-DP-3
[673.540693] Dynamic subtest pipe-D-DP-3: SUCCESS (2.589s)
[673.541584] Subtest cursor-onscreen-64x21: SUCCESS (5.328s)
[673.986812] [129/133] (359s left) i915_query (query-garbage)
[674.068415] Starting subtest: query-garbage
[674.069502] Subtest query-garbage: SUCCESS (0.000s)
[674.217801] [130/133] (359s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[674.294460] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[674.295360] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[674.460244] [131/133] (359s left) gem_exec_parallel (userptr)
[674.549292] Starting subtest: userptr
[674.550211] Starting dynamic subtest: rcs0
[676.245327] Dynamic subtest rcs0: SUCCESS (1.695s)
[676.260902] Starting dynamic subtest: bcs0
[677.726085] Dynamic subtest bcs0: SUCCESS (1.479s)
[677.742270] Starting dynamic subtest: vcs0
[679.250285] Dynamic subtest vcs0: SUCCESS (1.523s)
[679.266593] Starting dynamic subtest: vcs1
[680.735181] Dynamic subtest vcs1: SUCCESS (1.484s)
[680.748961] Starting dynamic subtest: vecs0
[682.197569] Dynamic subtest vecs0: SUCCESS (1.461s)
[682.214277] Starting dynamic subtest: vecs1
[683.728256] Dynamic subtest vecs1: SUCCESS (1.529s)
[683.743471] Starting dynamic subtest: ccs0
[685.184284] Dynamic subtest ccs0: SUCCESS (1.455s)
[685.185349] Subtest userptr: SUCCESS (10.635s)
[685.515843] [132/133] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[685.706021] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[685.707792] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[685.840224] [133/133] (348s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[686.031181] Starting subtest: 2x-absolute-wf_vblank-interruptible
[686.045771] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.015s)
[686.162630] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_vrr
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: kms_sequence
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_busy
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_flink_basic
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_caching
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_workarounds
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: prime_busy
results: parsing output: 34/ for test: kms_dirtyfb
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: gem_tiled_wc
results: parsing output: 37/ for test: gem_create
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gem_sync
results: parsing output: 54/ for test: gem_flink_basic
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: drm_read
results: parsing output: 59/ for test: gem_spin_batch
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_scaling_modes
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_sync
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_cdclk
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: i915_hangman
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: drm_buddy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_pipe_stress
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gem_exec_suspend
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: sysfs_preempt_timeout
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: kms_setmode
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_draw_crc
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: gem_tiled_pread_pwrite
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: gem_pread
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_exec_parallel
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip
Done.