[60.798620] Initializing watchdogs
[60.798686]   /dev/watchdog0
[60.820516] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.831204] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.834689] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.837095] [001/130] (960s left) perf (mi-rpc)
[61.243150] Starting subtest: mi-rpc
[61.244889] Subtest mi-rpc: SKIP (0.000s)
[61.302226] [002/130] (960s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[63.588469] Starting subtest: cursor-rapid-movement-512x512
[63.591145] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[63.835388] [003/130] (957s left) gem_lmem_swapping (heavy-verify-multi)
[69.136839] Starting subtest: heavy-verify-multi
[69.137742] Starting dynamic subtest: lmem0
[82.296664] Dynamic subtest lmem0: SUCCESS (13.170s)
[82.297580] Subtest heavy-verify-multi: SUCCESS (13.170s)
[83.521371] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[83.522946] [004/130] (937s left) syncobj_wait (multi-wait-signaled)
[87.793826] Starting subtest: multi-wait-signaled
[87.794763] Subtest multi-wait-signaled: SUCCESS (0.001s)
[87.871763] [FACT syncobj_wait (multi-wait-signaled)] new: kernel.kmod_is_loaded.i915: true
[87.874273] [005/130] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[89.881522] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[89.883411] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[90.119954] [006/130] (931s left) gem_exec_balancer (nohangcheck)
[90.468824] Starting subtest: nohangcheck
[92.045304] Subtest nohangcheck: SUCCESS (1.576s)
[92.185859] [007/130] (929s left) gem_exec_nop (basic-sequential)
[92.269285] Starting subtest: basic-sequential
[96.725501] Subtest basic-sequential: SUCCESS (4.454s)
[97.017245] [008/130] (924s left) kms_psr (fbc-pr-basic)
[99.022300] Subtest fbc-pr-basic: SKIP (0.000s)
[99.160388] [009/130] (922s left) kms_atomic_transition (modeset-transition-fencing)
[101.167081] Starting subtest: modeset-transition-fencing
[101.168007] Starting dynamic subtest: 1x-outputs
[103.055709] Dynamic subtest 1x-outputs: SUCCESS (1.888s)
[103.079921] Subtest modeset-transition-fencing: SUCCESS (1.912s)
[103.262553] [010/130] (918s left) kms_draw_crc (draw-method-render)
[105.268956] Starting subtest: draw-method-render
[105.269881] Starting dynamic subtest: xrgb8888-untiled
[105.671512] Dynamic subtest xrgb8888-untiled: SUCCESS (0.402s)
[105.703460] Starting dynamic subtest: rgb565-untiled
[106.021047] Dynamic subtest rgb565-untiled: SUCCESS (0.348s)
[106.053686] Starting dynamic subtest: xrgb2101010-untiled
[106.337552] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.316s)
[106.369722] Starting dynamic subtest: xbgr16161616f-untiled
[106.687443] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.349s)
[106.698531] Starting dynamic subtest: xrgb8888-xtiled
[106.854426] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[106.886370] Starting dynamic subtest: rgb565-xtiled
[107.036867] Dynamic subtest rgb565-xtiled: SUCCESS (0.182s)
[107.047469] Starting dynamic subtest: xrgb2101010-xtiled
[107.187670] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.150s)
[107.217696] Starting dynamic subtest: xbgr16161616f-xtiled
[107.370979] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.182s)
[107.403361] Starting dynamic subtest: xrgb8888-4tiled
[107.571190] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.199s)
[107.603204] Starting dynamic subtest: rgb565-4tiled
[107.754703] Dynamic subtest rgb565-4tiled: SUCCESS (0.182s)
[107.788414] Starting dynamic subtest: xrgb2101010-4tiled
[107.937615] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.182s)
[107.970039] Starting dynamic subtest: xbgr16161616f-4tiled
[108.120810] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.182s)
[108.122628] Subtest draw-method-render: SUCCESS (2.852s)
[108.331497] [011/130] (913s left) kms_pm_backlight (fade-with-suspend)
[110.335035] Subtest fade-with-suspend: SKIP (0.000s)
[110.395735] [012/130] (911s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[112.426770] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[112.479482] [013/130] (909s left) kms_lease (cursor-implicit-plane)
[114.498961] Starting subtest: cursor-implicit-plane
[114.499962] Starting dynamic subtest: pipe-A-HDMI-A-1
[114.845875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.346s)
[114.855255] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.062597] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.216s)
[115.073676] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.283419] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.219s)
[115.292950] Starting dynamic subtest: pipe-D-HDMI-A-1
[115.509355] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.225s)
[115.510343] Subtest cursor-implicit-plane: SUCCESS (1.011s)
[115.741179] [014/130] (906s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[117.739973] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[117.741072] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.749475] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[117.757668] Starting dynamic subtest: pipe-B-HDMI-A-1
[117.765989] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[117.774348] Starting dynamic subtest: pipe-C-HDMI-A-1
[117.782466] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[117.790379] Starting dynamic subtest: pipe-D-HDMI-A-1
[117.800566] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[117.802538] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[118.048663] [015/130] (904s left) gem_pxp (verify-pxp-stale-buf-execution)
[120.644714] Starting subtest: verify-pxp-stale-buf-execution
[120.646435] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[120.771234] [016/130] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[122.792531] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[122.794218] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[123.004710] [017/130] (899s left) gem_create (create-ext-set-pat)
[123.187470] Starting subtest: create-ext-set-pat
[123.189778] Subtest create-ext-set-pat: SKIP (0.000s)
[123.313636] [018/130] (899s left) gem_exec_reloc (basic-cpu-gtt)
[123.387574] Subtest basic-cpu-gtt: SKIP (0.000s)
[123.465258] [019/130] (899s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[125.480286] Starting subtest: fbcpsr-rgb101010-draw-render
[125.481948] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[125.715144] [020/130] (896s left) kms_tv_load_detect (load-detect)
[125.787695] Subtest load-detect: SKIP (0.000s)
[125.847178] [021/130] (896s left) syncobj_basic (bad-create-flags)
[125.916972] Starting subtest: bad-create-flags
[125.917875] Subtest bad-create-flags: SUCCESS (0.000s)
[126.082455] [022/130] (896s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[128.080014] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[128.080948] Starting dynamic subtest: pipe-A-valid-mode
[128.134975] Dynamic subtest pipe-A-valid-mode: SKIP (0.054s)
[128.136777] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.055s)
[128.357240] [023/130] (894s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[130.359788] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[130.360681] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.368280] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[130.376549] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.384434] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[130.392500] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.400203] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[130.408593] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.418389] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[130.419258] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.006s)
[130.718433] [024/130] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[132.729281] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[132.732559] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[132.925401] [025/130] (890s left) syncobj_wait (single-wait-all-submitted)
[132.994073] Starting subtest: single-wait-all-submitted
[133.101278] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[133.275754] [026/130] (889s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[135.284083] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[135.285010] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.307336] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[135.315974] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.338214] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[135.346646] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.371993] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[135.380447] Starting dynamic subtest: pipe-D-HDMI-A-1
[135.403402] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[135.405180] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.012s)
[135.610799] [027/130] (887s left) prime_mmap (test_errors)
[135.678971] Starting subtest: test_errors
[135.679941] Starting dynamic subtest: test_errors-smem
[135.833176] Dynamic subtest test_errors-smem: SUCCESS (0.147s)
[135.841512] Starting dynamic subtest: test_errors-lmem0
[136.403816] Dynamic subtest test_errors-lmem0: SUCCESS (0.577s)
[136.404864] Subtest test_errors: SUCCESS (0.725s)
[136.541232] [028/130] (886s left) kms_content_protection (uevent)
[138.612838] Starting subtest: uevent
[138.620643] Subtest uevent: SKIP (0.006s)
[138.812528] [029/130] (884s left) gem_ctx_shared (q-promotion)
[138.892521] Starting subtest: Q-promotion
[138.893386] Starting dynamic subtest: rcs0
[139.194171] Dynamic subtest rcs0: SUCCESS (0.301s)
[139.203385] Starting dynamic subtest: bcs0
[139.376411] Dynamic subtest bcs0: SUCCESS (0.182s)
[139.385526] Starting dynamic subtest: vcs0
[139.569954] Dynamic subtest vcs0: SUCCESS (0.193s)
[139.578896] Starting dynamic subtest: vcs1
[139.763606] Dynamic subtest vcs1: SUCCESS (0.193s)
[139.772893] Starting dynamic subtest: vecs0
[139.956632] Dynamic subtest vecs0: SUCCESS (0.193s)
[139.965777] Starting dynamic subtest: vecs1
[140.149618] Dynamic subtest vecs1: SUCCESS (0.193s)
[140.158813] Starting dynamic subtest: ccs0
[140.340200] Dynamic subtest ccs0: SUCCESS (0.190s)
[140.341126] Subtest Q-promotion: SUCCESS (1.448s)
[140.762426] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[140.764644] [030/130] (882s left) gem_watchdog (default-virtual)
[140.851783] Starting subtest: default-virtual
[147.928378] Subtest default-virtual: SUCCESS (7.077s)
[148.059420] [031/130] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[150.071131] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[150.072982] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[150.279087] [032/130] (873s left) kms_pm_dc (dc5-retention-flops)
[153.311072] Starting subtest: dc5-retention-flops
[153.312948] Subtest dc5-retention-flops: SKIP (0.000s)
[153.509428] [033/130] (870s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[155.529822] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[157.921588] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.393s)
[158.169242] [034/130] (865s left) kms_getfb (getfb2-handle-protection)
[160.197463] Starting subtest: getfb2-handle-protection
[160.218188] Subtest getfb2-handle-protection: SUCCESS (0.021s)
[160.454906] [035/130] (863s left) fbdev (unaligned-read)
[160.521567] Starting subtest: unaligned-read
[160.534141] Subtest unaligned-read: SUCCESS (0.012s)
[160.695927] [036/130] (863s left) kms_psr (fbc-psr-basic)
[162.709989] Subtest fbc-psr-basic: SKIP (0.000s)
[162.849194] [037/130] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[164.860857] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[164.862809] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[165.102543] [038/130] (859s left) gem_mmap_gtt (zero-extend)
[165.183007] Subtest zero-extend: SKIP (0.000s)
[165.254539] [039/130] (859s left) gem_exec_schedule (thriceslice)
[165.342481] Starting subtest: thriceslice
[165.343418] Starting dynamic subtest: rcs0
[165.395450] Dynamic subtest rcs0: SUCCESS (0.053s)
[165.405424] Starting dynamic subtest: bcs0
[165.448145] Dynamic subtest bcs0: SUCCESS (0.052s)
[165.465811] Starting dynamic subtest: vcs0
[165.510213] Dynamic subtest vcs0: SUCCESS (0.061s)
[165.542722] Starting dynamic subtest: vcs1
[165.564776] Dynamic subtest vcs1: SUCCESS (0.054s)
[165.581114] Starting dynamic subtest: vecs0
[165.626337] Dynamic subtest vecs0: SUCCESS (0.060s)
[165.647998] Starting dynamic subtest: vecs1
[165.670742] Dynamic subtest vecs1: SUCCESS (0.044s)
[165.679865] Starting dynamic subtest: ccs0
[165.701722] Dynamic subtest ccs0: SUCCESS (0.030s)
[165.702608] Subtest thriceslice: SUCCESS (0.359s)
[166.116136] [040/130] (858s left) drm_read (empty-block)
[168.203478] Starting subtest: empty-block
[169.205160] Subtest empty-block: SUCCESS (1.000s)
[169.467017] [041/130] (855s left) gem_ctx_persistence (engines-mixed-process)
[169.550275] Starting subtest: engines-mixed-process
[169.551192] Starting dynamic subtest: rcs0
[170.882533] Dynamic subtest rcs0: SUCCESS (1.332s)
[170.893263] Starting dynamic subtest: bcs0
[172.870075] Dynamic subtest bcs0: SUCCESS (1.987s)
[172.881435] Starting dynamic subtest: vcs0
[174.906216] Dynamic subtest vcs0: SUCCESS (2.036s)
[174.917217] Starting dynamic subtest: vcs1
[176.895242] Dynamic subtest vcs1: SUCCESS (1.989s)
[176.906319] Starting dynamic subtest: vecs0
[178.881142] Dynamic subtest vecs0: SUCCESS (1.985s)
[178.891649] Starting dynamic subtest: vecs1
[180.860945] Dynamic subtest vecs1: SUCCESS (1.979s)
[180.871199] Starting dynamic subtest: ccs0
[182.919922] Dynamic subtest ccs0: SUCCESS (2.058s)
[182.921224] Subtest engines-mixed-process: SUCCESS (13.371s)
[183.034790] [042/130] (841s left) gem_exec_schedule (preempt-other-chain)
[183.126386] Starting subtest: preempt-other-chain
[183.127310] Starting dynamic subtest: rcs0
[183.583233] Dynamic subtest rcs0: SUCCESS (0.456s)
[183.592595] Starting dynamic subtest: bcs0
[184.008237] Dynamic subtest bcs0: SUCCESS (0.425s)
[184.017587] Starting dynamic subtest: vcs0
[184.432559] Dynamic subtest vcs0: SUCCESS (0.424s)
[184.442034] Starting dynamic subtest: vcs1
[184.866341] Dynamic subtest vcs1: SUCCESS (0.433s)
[184.876511] Starting dynamic subtest: vecs0
[185.283965] Dynamic subtest vecs0: SUCCESS (0.417s)
[185.294130] Starting dynamic subtest: vecs1
[185.697739] Dynamic subtest vecs1: SUCCESS (0.413s)
[185.707498] Starting dynamic subtest: ccs0
[186.278242] Dynamic subtest ccs0: SUCCESS (0.580s)
[186.279141] Subtest preempt-other-chain: SUCCESS (3.152s)
[186.731172] [043/130] (837s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[188.742216] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[188.743147] Starting dynamic subtest: pipe-A-valid-mode
[188.793549] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[188.795286] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.052s)
[189.014291] [044/130] (835s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[191.050775] Starting subtest: x-tiled-32bpp-rotate-90
[191.107503] Subtest x-tiled-32bpp-rotate-90: SKIP (0.056s)
[191.312927] [045/130] (833s left) vgem_basic (dmabuf-fence)
[191.375038] Starting subtest: dmabuf-fence
[191.376167] Subtest dmabuf-fence: SUCCESS (0.000s)
[191.511578] [046/130] (833s left) i915_drm_fdinfo (virtual-busy-idle)
[191.580946] Starting subtest: virtual-busy-idle
[191.582760] Subtest virtual-busy-idle: SKIP (0.000s)
[191.707243] [047/130] (833s left) gem_userptr_blits (stress-mm-invalidate-close)
[191.799311] Starting subtest: stress-mm-invalidate-close
[193.947430] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[194.149532] [048/130] (830s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[196.171455] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[197.457537] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.285s)
[197.669040] [049/130] (827s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[197.752627] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[197.861968] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[198.051781] [050/130] (827s left) gem_exec_fence (long-history)
[198.563095] Starting subtest: long-history
[205.057682] Subtest long-history: SUCCESS (6.495s)
[206.214724] [051/130] (819s left) api_intel_allocator (simple-allocator)
[206.296110] Starting subtest: simple-allocator
[206.297068] Starting dynamic subtest: basic
[206.320892] Dynamic subtest basic: SUCCESS (0.026s)
[206.330669] Starting dynamic subtest: parallel-one
[206.502972] Dynamic subtest parallel-one: SUCCESS (0.174s)
[206.521236] Starting dynamic subtest: print
[206.529206] Dynamic subtest print: SUCCESS (0.000s)
[206.542387] Starting dynamic subtest: reuse
[206.543595] Dynamic subtest reuse: SUCCESS (0.000s)
[206.554485] Starting dynamic subtest: reserve
[206.555464] Dynamic subtest reserve: SUCCESS (0.000s)
[206.566196] Starting dynamic subtest: fork-reopen-allocator
[206.567431] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[206.568602] Subtest simple-allocator: SUCCESS (0.216s)
[206.698223] [052/130] (818s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[208.712131] Starting subtest: cursorA-vs-flipB-atomic
[208.714035] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[208.908897] [053/130] (816s left) kms_pipe_crc_basic (read-crc)
[210.934069] Starting subtest: read-crc
[210.935067] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.599882] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.665s)
[211.614259] Starting dynamic subtest: pipe-B-HDMI-A-1
[212.100553] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.499s)
[212.111792] Starting dynamic subtest: pipe-C-HDMI-A-1
[212.621394] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.519s)
[212.631651] Starting dynamic subtest: pipe-D-HDMI-A-1
[213.144422] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.522s)
[213.145341] Subtest read-crc: SUCCESS (2.211s)
[213.383576] [054/130] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[215.401915] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[215.403836] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[215.605171] [055/130] (810s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[217.631572] Starting subtest: y-tiled-32bpp-rotate-180
[217.633274] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[217.850077] [056/130] (807s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[219.876886] Starting subtest: yf-tiled-8bpp-rotate-90
[219.878562] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[220.116558] [057/130] (805s left) gem_pwrite (basic-random)
[220.194148] Subtest basic-random: SKIP (0.000s)
[220.271764] [058/130] (805s left) api_intel_bb (crc32)
[220.356055] Starting subtest: crc32
[220.356935] Starting dynamic subtest: rcs0-lmem0
[220.609538] Dynamic subtest rcs0-lmem0: SUCCESS (0.253s)
[220.648996] Starting dynamic subtest: rcs0-smem0
[220.964068] Dynamic subtest rcs0-smem0: SUCCESS (0.352s)
[220.976223] Starting dynamic subtest: bcs0-lmem0
[221.200619] Dynamic subtest bcs0-lmem0: SUCCESS (0.234s)
[221.238732] Starting dynamic subtest: bcs0-smem0
[221.560754] Dynamic subtest bcs0-smem0: SUCCESS (0.358s)
[221.575136] Starting dynamic subtest: vcs0-lmem0
[221.982595] Dynamic subtest vcs0-lmem0: SUCCESS (0.420s)
[221.994838] Starting dynamic subtest: vcs0-smem0
[222.523380] Dynamic subtest vcs0-smem0: SUCCESS (0.538s)
[222.534805] Starting dynamic subtest: vcs1-lmem0
[222.943360] Dynamic subtest vcs1-lmem0: SUCCESS (0.418s)
[222.957265] Starting dynamic subtest: vcs1-smem0
[223.496862] Dynamic subtest vcs1-smem0: SUCCESS (0.551s)
[223.508946] Starting dynamic subtest: vecs0-lmem0
[223.914067] Dynamic subtest vecs0-lmem0: SUCCESS (0.416s)
[223.927826] Starting dynamic subtest: vecs0-smem0
[224.474600] Dynamic subtest vecs0-smem0: SUCCESS (0.559s)
[224.486680] Starting dynamic subtest: vecs1-lmem0
[224.899101] Dynamic subtest vecs1-lmem0: SUCCESS (0.422s)
[224.913367] Starting dynamic subtest: vecs1-smem0
[225.442823] Dynamic subtest vecs1-smem0: SUCCESS (0.541s)
[225.454766] Starting dynamic subtest: ccs0-lmem0
[225.689403] Dynamic subtest ccs0-lmem0: SUCCESS (0.244s)
[225.729300] Starting dynamic subtest: ccs0-smem0
[226.063587] Dynamic subtest ccs0-smem0: SUCCESS (0.372s)
[226.065525] Subtest crc32: SUCCESS (5.709s)
[226.255858] [059/130] (799s left) gem_userptr_blits (sync-overlap)
[226.345492] Starting subtest: sync-overlap
[226.346393] Subtest sync-overlap: SUCCESS (0.000s)
[226.508338] [060/130] (799s left) kms_cursor_edge_walk (64x64-left-edge)
[228.520095] Starting subtest: 64x64-left-edge
[228.521028] Starting dynamic subtest: pipe-A-HDMI-A-1
[231.852657] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.332s)
[231.863418] Starting dynamic subtest: pipe-D-HDMI-A-1
[235.069975] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.216s)
[235.071021] Subtest 64x64-left-edge: SUCCESS (6.551s)
[235.302504] [061/130] (790s left) core_auth (basic-auth)
[235.379162] Starting subtest: basic-auth
[235.394906] Subtest basic-auth: SUCCESS (0.017s)
[235.551236] [062/130] (790s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[237.572400] Starting subtest: 4-tiled-addfb-size-offset-overflow
[237.573256] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[237.807318] [063/130] (788s left) gem_ctx_param (invalid-ctx-get)
[237.884471] Starting subtest: invalid-ctx-get
[237.885409] Subtest invalid-ctx-get: SUCCESS (0.000s)
[238.041873] [064/130] (788s left) gem_softpin (softpin)
[238.128509] Starting subtest: softpin
[270.538123] Subtest softpin: SUCCESS (32.409s)
[270.707915] [065/130] (755s left) kms_plane (plane-panning-bottom-right)
[272.721073] Starting subtest: plane-panning-bottom-right
[272.721998] Starting dynamic subtest: pipe-A
[273.393779] Dynamic subtest pipe-A: SUCCESS (0.672s)
[273.403923] Starting dynamic subtest: pipe-B
[273.884460] Dynamic subtest pipe-B: SUCCESS (0.490s)
[273.885331] Subtest plane-panning-bottom-right: SUCCESS (1.165s)
[274.120775] [066/130] (752s left) kms_sequence (queue-busy)
[276.135178] Starting subtest: queue-busy
[276.136042] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.686358] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.550s)
[278.696146] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.084893] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.397s)
[281.094594] Starting dynamic subtest: pipe-C-HDMI-A-1
[283.482929] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.397s)
[283.493141] Starting dynamic subtest: pipe-D-HDMI-A-1
[285.887153] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.403s)
[285.888047] Subtest queue-busy: SUCCESS (9.752s)
[286.133962] [067/130] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[288.153813] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[288.155544] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[288.380395] [068/130] (738s left) kms_big_fb (linear-8bpp-rotate-270)
[290.408444] Starting subtest: linear-8bpp-rotate-270
[290.469865] Subtest linear-8bpp-rotate-270: SKIP (0.060s)
[290.690386] [069/130] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[292.706860] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[292.708534] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[292.921949] [070/130] (734s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[294.977340] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[295.083196] [071/130] (732s left) kms_cursor_legacy (forked-bo)
[297.102155] Starting subtest: forked-bo
[297.103121] Starting dynamic subtest: pipe-A
[302.543161] Dynamic subtest pipe-A: SUCCESS (5.438s)
[302.563251] Starting dynamic subtest: pipe-B
[307.974039] Dynamic subtest pipe-B: SUCCESS (5.431s)
[307.992300] Starting dynamic subtest: pipe-C
[313.394922] Dynamic subtest pipe-C: SUCCESS (5.420s)
[313.406014] Starting dynamic subtest: pipe-D
[318.810863] Dynamic subtest pipe-D: SUCCESS (5.415s)
[318.833299] Starting dynamic subtest: all-pipes
[324.230302] Dynamic subtest all-pipes: SUCCESS (5.418s)
[324.231182] Subtest forked-bo: SUCCESS (27.128s)
[324.404744] [072/130] (702s left) kms_joiner (basic-force-big-joiner)
[326.422215] Starting subtest: basic-force-big-joiner
[326.423952] Subtest basic-force-big-joiner: SKIP (0.000s)
[326.611642] [073/130] (700s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[328.635172] Starting subtest: 2x-long-cursor-vs-flip-atomic
[328.638253] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[328.872926] [074/130] (698s left) kms_psr (pr-sprite-mmap-cpu)
[330.904063] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[330.958693] [075/130] (696s left) gem_spin_batch (resubmit-all)
[331.047883] Starting subtest: resubmit-all
[331.048811] Starting dynamic subtest: rcs0
[331.081635] Dynamic subtest rcs0: SUCCESS (0.034s)
[331.092040] Starting dynamic subtest: bcs0
[331.092955] Dynamic subtest bcs0: SUCCESS (0.003s)
[331.102656] Starting dynamic subtest: vcs0
[331.103513] Dynamic subtest vcs0: SUCCESS (0.003s)
[331.113180] Starting dynamic subtest: vcs1
[331.114367] Dynamic subtest vcs1: SUCCESS (0.003s)
[331.123734] Starting dynamic subtest: vecs0
[331.124841] Dynamic subtest vecs0: SUCCESS (0.003s)
[331.134073] Starting dynamic subtest: vecs1
[331.135165] Dynamic subtest vecs1: SUCCESS (0.003s)
[331.144490] Starting dynamic subtest: ccs0
[331.145586] Dynamic subtest ccs0: SUCCESS (0.002s)
[331.146716] Subtest resubmit-all: SUCCESS (0.056s)
[331.410840] [076/130] (696s left) tools_test (sysfs_l3_parity)
[331.464073] Starting subtest: sysfs_l3_parity
[331.533283] Subtest sysfs_l3_parity: SKIP (0.074s)
[331.664988] [077/130] (695s left) prime_vgem (basic-fence-blt)
[331.752718] Starting subtest: basic-fence-blt
[331.870338] Subtest basic-fence-blt: SUCCESS (0.117s)
[332.016840] [078/130] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[334.030745] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[334.032380] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[334.258456] [079/130] (693s left) gem_exec_params (rsvd2-dirt)
[334.342666] Starting subtest: rsvd2-dirt
[334.344371] Subtest rsvd2-dirt: SKIP (0.000s)
[334.526858] [080/130] (693s left) kms_flip (blocking-wf_vblank)
[336.548681] Starting subtest: blocking-wf_vblank
[336.552807] Starting dynamic subtest: A-HDMI-A1
[344.585843] Dynamic subtest A-HDMI-A1: SUCCESS (8.033s)
[344.599292] Starting dynamic subtest: B-HDMI-A1
[352.556800] Dynamic subtest B-HDMI-A1: SUCCESS (7.970s)
[352.567211] Starting dynamic subtest: C-HDMI-A1
[360.528191] Dynamic subtest C-HDMI-A1: SUCCESS (7.970s)
[360.538630] Starting dynamic subtest: D-HDMI-A1
[368.498192] Dynamic subtest D-HDMI-A1: SUCCESS (7.969s)
[368.500357] Subtest blocking-wf_vblank: SUCCESS (31.952s)
[368.732925] [081/130] (659s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[370.746612] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[370.750575] Starting dynamic subtest: A-HDMI-A1
[371.538228] Dynamic subtest A-HDMI-A1: SUCCESS (0.787s)
[371.549563] Starting dynamic subtest: B-HDMI-A1
[372.230391] Dynamic subtest B-HDMI-A1: SUCCESS (0.692s)
[372.240321] Starting dynamic subtest: C-HDMI-A1
[372.918424] Dynamic subtest C-HDMI-A1: SUCCESS (0.687s)
[372.929382] Starting dynamic subtest: D-HDMI-A1
[373.607440] Dynamic subtest D-HDMI-A1: SUCCESS (0.688s)
[373.609521] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.863s)
[373.859685] [082/130] (654s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[375.876344] Starting subtest: cursorA-vs-flipA-atomic
[386.792745] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.916s)
[387.021594] [083/130] (641s left) gem_ctx_exec (basic)
[387.099253] Starting subtest: basic
[387.105934] Subtest basic: SUCCESS (0.007s)
[387.293418] [084/130] (640s left) syncobj_wait (invalid-signal-one-illegal-handle)
[387.371245] Starting subtest: invalid-signal-one-illegal-handle
[387.372138] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[387.501794] [085/130] (640s left) i915_pm_rps (basic-api)
[387.584631] Starting subtest: basic-api
[387.586335] Subtest basic-api: SKIP (0.000s)
[387.724451] [086/130] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[389.742814] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[389.744470] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[389.961732] [087/130] (638s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[391.977291] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[391.979042] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[392.243080] [088/130] (636s left) kms_plane (plane-position-hole)
[394.265282] Starting subtest: plane-position-hole
[394.681951] Starting dynamic subtest: pipe-A-plane-1
[395.066642] Dynamic subtest pipe-A-plane-1: SUCCESS (0.385s)
[395.076800] Starting dynamic subtest: pipe-A-plane-2
[395.451925] Dynamic subtest pipe-A-plane-2: SUCCESS (0.384s)
[395.462135] Starting dynamic subtest: pipe-A-plane-3
[395.836979] Dynamic subtest pipe-A-plane-3: SUCCESS (0.384s)
[395.847288] Starting dynamic subtest: pipe-A-plane-4
[396.220972] Dynamic subtest pipe-A-plane-4: SUCCESS (0.383s)
[396.231258] Starting dynamic subtest: pipe-A-plane-5
[396.239073] Dynamic subtest pipe-A-plane-5: SUCCESS (0.017s)
[396.513169] Starting dynamic subtest: pipe-B-plane-1
[396.870492] Dynamic subtest pipe-B-plane-1: SUCCESS (0.368s)
[396.880568] Starting dynamic subtest: pipe-B-plane-2
[397.239968] Dynamic subtest pipe-B-plane-2: SUCCESS (0.368s)
[397.250164] Starting dynamic subtest: pipe-B-plane-3
[397.575648] Dynamic subtest pipe-B-plane-3: SUCCESS (0.335s)
[397.585603] Starting dynamic subtest: pipe-B-plane-4
[397.894437] Dynamic subtest pipe-B-plane-4: SUCCESS (0.317s)
[397.904505] Starting dynamic subtest: pipe-B-plane-5
[397.913471] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s)
[397.914344] Subtest plane-position-hole: SUCCESS (3.649s)
[398.157152] [089/130] (630s left) drm_read (short-buffer-wakeup)
[400.250444] Starting subtest: short-buffer-wakeup
[432.462535] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[432.674644] [090/130] (596s left) gem_exec_whisper (basic-fds)
[432.765569] Starting subtest: basic-fds
[443.637824] Subtest basic-fds: SUCCESS (10.871s)
[443.941535] [091/130] (584s left) kms_content_protection (dp-mst-type-0)
[446.014872] Starting subtest: dp-mst-type-0
[446.016601] Subtest dp-mst-type-0: SKIP (0.000s)
[446.246023] [092/130] (582s left) kms_async_flips (alternate-sync-async-flip)
[448.264420] Starting subtest: alternate-sync-async-flip
[448.469838] Starting dynamic subtest: pipe-A-HDMI-A-1
[450.762761] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.292s)
[450.960519] Starting dynamic subtest: pipe-B-HDMI-A-1
[453.024973] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.073s)
[453.204204] Starting dynamic subtest: pipe-C-HDMI-A-1
[455.279662] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.083s)
[455.470660] Starting dynamic subtest: pipe-D-HDMI-A-1
[457.535765] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.074s)
[457.536627] Subtest alternate-sync-async-flip: SUCCESS (9.273s)
[457.953270] [093/130] (571s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[458.038428] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[458.039609] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[458.175806] [094/130] (570s left) syncobj_timeline (wait-all-interrupted)
[458.258424] Starting subtest: wait-all-interrupted
[458.361719] Subtest wait-all-interrupted: SUCCESS (0.102s)
[458.508088] [095/130] (570s left) kms_rotation_crc (cursor-rotation-180)
[460.522398] Starting subtest: cursor-rotation-180
[461.321461] Subtest cursor-rotation-180: SUCCESS (0.799s)
[461.616681] [096/130] (567s left) perf_pmu (busy-check-all)
[461.687202] Starting subtest: busy-check-all
[461.688222] Starting dynamic subtest: rcs0
[462.272439] Dynamic subtest rcs0: SUCCESS (0.585s)
[462.288209] Starting dynamic subtest: bcs0
[462.827561] Dynamic subtest bcs0: SUCCESS (0.552s)
[462.842475] Starting dynamic subtest: vcs0
[463.383668] Dynamic subtest vcs0: SUCCESS (0.551s)
[463.398463] Starting dynamic subtest: vcs1
[463.936473] Dynamic subtest vcs1: SUCCESS (0.549s)
[463.952523] Starting dynamic subtest: vecs0
[464.494676] Dynamic subtest vecs0: SUCCESS (0.555s)
[464.509532] Starting dynamic subtest: vecs1
[465.052790] Dynamic subtest vecs1: SUCCESS (0.553s)
[465.067493] Starting dynamic subtest: ccs0
[465.610711] Dynamic subtest ccs0: SUCCESS (0.553s)
[465.613865] Subtest busy-check-all: SUCCESS (3.926s)
[465.777275] [097/130] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[467.792976] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[467.794539] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[467.996467] [098/130] (561s left) kms_psr (fbc-psr-dpms)
[470.008996] Subtest fbc-psr-dpms: SKIP (0.000s)
[470.070866] [099/130] (559s left) gem_ctx_persistence (hang)
[470.159556] Starting subtest: hang
[470.161595] Subtest hang: SKIP (0.000s)
[470.338522] [100/130] (559s left) gem_exec_reloc (basic-wc-read-active)
[470.422595] Subtest basic-wc-read-active: SKIP (0.000s)
[470.504546] [101/130] (559s left) gem_render_copy (yf-tiled-to-vebox-linear)
[470.587757] Starting subtest: yf-tiled-to-vebox-linear
[470.589765] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[470.870265] [102/130] (558s left) kms_chamelium_color (ctm-0-25)
[472.881590] Subtest ctm-0-25: SKIP (0.000s)
[472.937114] [103/130] (556s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[478.052120] Starting subtest: modeset-non-lpsp-stress-no-wait
[479.129640] Subtest modeset-non-lpsp-stress-no-wait: SKIP (1.081s)
[479.366748] [104/130] (550s left) gem_mmap_wc (write-cpu-read-wc)
[479.445253] Subtest write-cpu-read-wc: SKIP (0.000s)
[479.523839] [105/130] (550s left) perf_pmu (init-wait)
[479.593793] Starting subtest: init-wait
[479.594672] Starting dynamic subtest: rcs0
[479.596980] Dynamic subtest rcs0: SUCCESS (0.002s)
[479.607669] Starting dynamic subtest: bcs0
[479.608556] Dynamic subtest bcs0: SUCCESS (0.001s)
[479.619141] Starting dynamic subtest: vcs0
[479.620065] Dynamic subtest vcs0: SUCCESS (0.001s)
[479.630850] Starting dynamic subtest: vcs1
[479.632064] Dynamic subtest vcs1: SUCCESS (0.001s)
[479.642773] Starting dynamic subtest: vecs0
[479.643917] Dynamic subtest vecs0: SUCCESS (0.001s)
[479.654571] Starting dynamic subtest: vecs1
[479.655786] Dynamic subtest vecs1: SUCCESS (0.001s)
[479.666381] Starting dynamic subtest: ccs0
[479.667625] Dynamic subtest ccs0: SUCCESS (0.001s)
[479.668758] Subtest init-wait: SUCCESS (0.014s)
[479.770396] [106/130] (550s left) gem_reg_read (timestamp-monotonic)
[479.849583] Starting subtest: timestamp-monotonic
[484.046413] Subtest timestamp-monotonic: SUCCESS (4.197s)
[484.180784] [107/130] (545s left) i915_query (query-regions-garbage-items)
[484.255443] Starting subtest: query-regions-garbage-items
[484.256396] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[484.407047] [108/130] (545s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[486.425423] Starting subtest: 2x-flip-vs-cursor-atomic
[486.427226] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[486.648576] [109/130] (543s left) gem_exec_fence (syncobj-timeline-unused-fence)
[487.309507] Starting subtest: syncobj-timeline-unused-fence
[487.330872] Subtest syncobj-timeline-unused-fence: SUCCESS (0.028s)
[487.688371] [110/130] (542s left) kms_vrr (seamless-rr-switch-vrr)
[489.704499] Starting subtest: seamless-rr-switch-vrr
[489.707149] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[489.886801] [111/130] (540s left) gem_fence_thrash (bo-write-verify-threaded-x)
[489.940958] Starting subtest: bo-write-verify-threaded-x
[489.971259] Subtest bo-write-verify-threaded-x: SKIP (0.030s)
[490.057770] [112/130] (540s left) kms_hdmi_inject (inject-4k)
[490.185416] Starting subtest: inject-4k
[490.361053] Subtest inject-4k: SUCCESS (0.175s)
[490.521765] [113/130] (539s left) gem_eio (in-flight-10ms)
[490.801936] Starting subtest: in-flight-10ms
[495.760319] Subtest in-flight-10ms: SUCCESS (4.959s)
[497.907277] [114/130] (532s left) kms_chamelium_edid (hdmi-edid-read)
[499.975313] Subtest hdmi-edid-read: SKIP (0.000s)
[500.087934] [115/130] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[502.114961] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[502.116794] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[502.334395] [116/130] (528s left) kms_sequence (get-busy)
[504.352280] Starting subtest: get-busy
[504.353193] Starting dynamic subtest: pipe-A-HDMI-A-1
[506.902952] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.550s)
[506.915247] Starting dynamic subtest: pipe-B-HDMI-A-1
[509.300675] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.396s)
[509.312093] Starting dynamic subtest: pipe-C-HDMI-A-1
[511.706946] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.405s)
[511.719434] Starting dynamic subtest: pipe-D-HDMI-A-1
[514.112547] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.404s)
[514.113414] Subtest get-busy: SUCCESS (9.762s)
[514.327497] [117/130] (516s left) kms_addfb_basic (tile-pitch-mismatch)
[514.405949] Starting subtest: tile-pitch-mismatch
[514.407733] Subtest tile-pitch-mismatch: SKIP (0.000s)
[516.559840] [118/130] (514s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[518.577150] Starting subtest: psr-rgb101010-draw-blt
[518.578988] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[518.814615] [119/130] (512s left) gem_exec_balancer (parallel-bb-first)
[519.189835] Starting subtest: parallel-bb-first
[520.836792] Subtest parallel-bb-first: SUCCESS (1.647s)
[521.018183] [120/130] (510s left) kms_psr (psr-primary-mmap-gtt)
[523.035839] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[523.092175] [121/130] (508s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[525.108982] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[525.159410] [122/130] (506s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[525.237378] Starting subtest: multi-wait-all-for-submit-signaled
[525.238288] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[525.440689] [123/130] (505s left) i915_drm_fdinfo (busy-idle)
[525.509954] Starting subtest: busy-idle
[525.510820] Starting dynamic subtest: rcs0
[525.523378] Dynamic subtest rcs0: SKIP (0.012s)
[525.534444] Starting dynamic subtest: bcs0
[525.541162] Dynamic subtest bcs0: SKIP (0.017s)
[525.551970] Starting dynamic subtest: vcs0
[525.554138] Dynamic subtest vcs0: SKIP (0.000s)
[525.564966] Starting dynamic subtest: vcs1
[525.567384] Dynamic subtest vcs1: SKIP (0.000s)
[525.578207] Starting dynamic subtest: vecs0
[525.580136] Dynamic subtest vecs0: SKIP (0.000s)
[525.590869] Starting dynamic subtest: vecs1
[525.592881] Dynamic subtest vecs1: SKIP (0.000s)
[525.603491] Starting dynamic subtest: ccs0
[525.605757] Dynamic subtest ccs0: SKIP (0.000s)
[525.607986] Subtest busy-idle: SKIP (0.038s)
[525.661550] [124/130] (505s left) syncobj_timeline (reset-multiple-signaled)
[525.741444] Starting subtest: reset-multiple-signaled
[525.742381] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[525.894893] [125/130] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[527.919772] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[527.921351] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[528.147822] [126/130] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[530.161988] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[534.131674] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.970s)
[534.398236] [127/130] (497s left) gen9_exec_parse (batch-without-end)
[534.482163] Subtest batch-without-end: SKIP (0.000s)
[534.565455] [128/130] (497s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[536.582183] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[536.583883] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[536.829116] [129/130] (495s left) gem_lmem_swapping (random)
[542.112382] Starting subtest: random
[542.113196] Starting dynamic subtest: lmem0
[543.065878] Dynamic subtest lmem0: SUCCESS (0.955s)
[543.066783] Subtest random: SUCCESS (0.956s)
[546.082728] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[546.083915] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[546.085953] [130/130] (485s left) gem_caching (reads)
[550.407964] Starting subtest: reads
[553.478828] Subtest reads: SUCCESS (3.071s)
[553.572068] [FACT gem_caching (reads)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[553.574389] [FACT gem_caching (reads)] new: kernel.kmod_is_loaded.i915: true
[553.575740] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_exec_nop
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_draw_crc
results: parsing output: 10/ for test: kms_pm_backlight
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_lease
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_tv_load_detect
results: parsing output: 20/ for test: syncobj_basic
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: prime_mmap
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: gem_watchdog
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_pm_dc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_getfb
results: parsing output: 34/ for test: fbdev
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: drm_read
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: vgem_basic
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: api_intel_allocator
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_pwrite
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_cursor_edge_walk
results: parsing output: 60/ for test: core_auth
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_sequence
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: tools_test
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: i915_pm_rps
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: drm_read
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_reg_read
results: parsing output: 106/ for test: i915_query
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_vrr
results: parsing output: 110/ for test: gem_fence_thrash
results: parsing output: 111/ for test: kms_hdmi_inject
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_sequence
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: gem_caching
Done.