[62.164948] Initializing watchdogs
[62.165123]   /dev/watchdog0
[62.185211] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.195767] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.199497] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.210361] [001/131] (960s left) kms_content_protection (dp-mst-lic-type-1)
[64.292363] Starting subtest: dp-mst-lic-type-1
[64.294209] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[64.486642] [002/131] (958s left) gem_busy (parallel)
[64.756865] Starting subtest: parallel
[64.757774] Starting dynamic subtest: rcs0
[64.896974] Dynamic subtest rcs0: SUCCESS (0.140s)
[64.909270] Starting dynamic subtest: bcs0
[64.971629] Dynamic subtest bcs0: SUCCESS (0.074s)
[64.983733] Starting dynamic subtest: vcs0
[65.040933] Dynamic subtest vcs0: SUCCESS (0.069s)
[65.048533] Starting dynamic subtest: vcs1
[65.104692] Dynamic subtest vcs1: SUCCESS (0.064s)
[65.115812] Starting dynamic subtest: vecs0
[65.173257] Dynamic subtest vecs0: SUCCESS (0.068s)
[65.194186] Starting dynamic subtest: vecs1
[65.257394] Dynamic subtest vecs1: SUCCESS (0.084s)
[65.267848] Starting dynamic subtest: ccs0
[65.322067] Dynamic subtest ccs0: SUCCESS (0.064s)
[65.323290] Subtest parallel: SUCCESS (0.566s)
[65.603639] [003/131] (957s left) kms_flip (flip-vs-dpms-on-nop)
[67.600453] Starting subtest: flip-vs-dpms-on-nop
[67.605450] Starting dynamic subtest: A-HDMI-A3
[68.695017] Dynamic subtest A-HDMI-A3: SUCCESS (1.091s)
[68.703782] Starting dynamic subtest: B-HDMI-A3
[69.682143] Dynamic subtest B-HDMI-A3: SUCCESS (0.987s)
[69.692666] Starting dynamic subtest: C-HDMI-A3
[70.667298] Dynamic subtest C-HDMI-A3: SUCCESS (0.985s)
[70.675200] Starting dynamic subtest: D-HDMI-A3
[71.654975] Dynamic subtest D-HDMI-A3: SUCCESS (0.987s)
[71.656889] Subtest flip-vs-dpms-on-nop: SUCCESS (4.060s)
[71.913632] [004/131] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[73.924178] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[73.925866] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.151475] [005/131] (948s left) i915_power (sanity)
[74.225994] Starting subtest: sanity
[78.292566] Subtest sanity: SUCCESS (4.066s)
[78.436563] [006/131] (944s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[80.445996] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[80.447687] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[80.656492] [007/131] (942s left) kms_cursor_crc (cursor-random-64x21)
[82.835938] Starting subtest: cursor-random-64x21
[82.850098] Starting dynamic subtest: pipe-A-HDMI-A-3
[87.266739] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.417s)
[87.305093] Starting dynamic subtest: pipe-D-HDMI-A-3
[91.782524] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.484s)
[91.783396] Subtest cursor-random-64x21: SUCCESS (8.947s)
[92.196897] [008/131] (931s left) i915_drm_fdinfo (virtual-busy-idle)
[92.259379] Starting subtest: virtual-busy-idle
[92.261273] Subtest virtual-busy-idle: SKIP (0.000s)
[92.396011] [009/131] (930s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[92.482172] Subtest untiled-to-tiled: SKIP (0.000s)
[92.543933] [010/131] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[94.570945] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[94.572849] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[94.748503] [011/131] (928s left) gem_ctx_isolation (preservation-s3)
[94.854326] Starting subtest: preservation-S3
[94.855288] Starting dynamic subtest: rcs0
[114.653693] Dynamic subtest rcs0: SUCCESS (3.983s)
[114.662965] Starting dynamic subtest: bcs0
[134.704234] Dynamic subtest bcs0: SUCCESS (3.720s)
[134.714078] Starting dynamic subtest: vcs0
[154.697403] Dynamic subtest vcs0: SUCCESS (3.710s)
[154.706603] Starting dynamic subtest: vcs1
[174.652155] Dynamic subtest vcs1: SUCCESS (3.641s)
[174.661844] Starting dynamic subtest: vecs0
[194.680520] Dynamic subtest vecs0: SUCCESS (3.711s)
[194.689977] Starting dynamic subtest: vecs1
[214.670047] Dynamic subtest vecs1: SUCCESS (3.714s)
[214.679628] Starting dynamic subtest: ccs0
[234.709663] Dynamic subtest ccs0: SUCCESS (3.723s)
[234.710642] Subtest preservation-S3: SUCCESS (26.203s)
[241.052354] [012/131] (788s left) gem_exec_store (dword)
[241.138687] Starting subtest: dword
[241.139694] Starting dynamic subtest: rcs0
[241.212300] Dynamic subtest rcs0: SUCCESS (0.073s)
[241.223338] Starting dynamic subtest: bcs0
[241.253257] Dynamic subtest bcs0: SUCCESS (0.040s)
[241.267834] Starting dynamic subtest: vcs0
[241.295615] Dynamic subtest vcs0: SUCCESS (0.041s)
[241.319125] Starting dynamic subtest: vcs1
[241.342649] Dynamic subtest vcs1: SUCCESS (0.046s)
[241.367147] Starting dynamic subtest: vecs0
[241.389469] Dynamic subtest vecs0: SUCCESS (0.046s)
[241.408693] Starting dynamic subtest: vecs1
[241.433880] Dynamic subtest vecs1: SUCCESS (0.043s)
[241.455957] Starting dynamic subtest: ccs0
[241.477309] Dynamic subtest ccs0: SUCCESS (0.043s)
[241.478530] Subtest dword: SUCCESS (0.335s)
[241.770288] [013/131] (787s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[243.795772] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[243.797773] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[243.976292] [014/131] (785s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[244.065782] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[244.171084] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[244.280924] [015/131] (785s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[246.281012] Starting subtest: cursorA-vs-flipA-atomic-transitions
[257.263710] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.941s)
[257.521554] [016/131] (772s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[259.541046] Starting subtest: y-tiled-16bpp-rotate-270
[259.542974] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[259.728334] [017/131] (770s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[261.801988] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[261.903953] [018/131] (768s left) kms_joiner (basic-big-joiner)
[263.921703] Subtest basic-big-joiner: SKIP (0.000s)
[264.073712] [019/131] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[266.115387] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[266.117045] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[266.335311] [020/131] (763s left) gem_exec_suspend (basic-s3)
[266.421897] Starting subtest: basic-S3
[266.422795] Starting dynamic subtest: smem
[288.682184] Dynamic subtest smem: SUCCESS (7.033s)
[288.691886] Starting dynamic subtest: lmem0
[311.668319] Dynamic subtest lmem0: SUCCESS (7.149s)
[311.669540] Subtest basic-S3: SUCCESS (14.184s)
[316.952273] [021/131] (718s left) gem_vm_create (execbuf)
[317.038755] Starting subtest: execbuf
[317.049091] Subtest execbuf: SUCCESS (0.010s)
[317.207569] [022/131] (718s left) kms_cursor_crc (cursor-sliding-512x170)
[319.515572] Starting subtest: cursor-sliding-512x170
[319.518646] Subtest cursor-sliding-512x170: SKIP (0.001s)
[319.779119] [023/131] (715s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[321.790706] Starting subtest: compare-crc-sanitycheck-xr24
[321.791563] Starting dynamic subtest: pipe-A-HDMI-A-3
[322.330805] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.536s)
[322.344182] Starting dynamic subtest: pipe-B-HDMI-A-3
[322.721861] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.386s)
[322.732671] Starting dynamic subtest: pipe-C-HDMI-A-3
[323.113889] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.388s)
[323.124619] Starting dynamic subtest: pipe-D-HDMI-A-3
[323.506367] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.389s)
[323.507208] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.706s)
[323.725108] [024/131] (711s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[325.721446] Starting subtest: flip-vs-cursor-varying-size
[338.161231] Subtest flip-vs-cursor-varying-size: SUCCESS (12.410s)
[338.377665] [025/131] (697s left) perf (sysctl-defaults)
[338.520146] Starting subtest: sysctl-defaults
[338.521349] Subtest sysctl-defaults: SUCCESS (0.000s)
[338.882310] [026/131] (696s left) kms_plane_scaling (2x-scaler-multi-pipe)
[340.888578] Starting subtest: 2x-scaler-multi-pipe
[340.891717] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[341.070360] [027/131] (694s left) kms_psr (psr-cursor-plane-onoff)
[343.101276] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[343.149842] [028/131] (692s left) kms_3d (basic)
[343.219129] Starting subtest: basic
[345.204460] Subtest basic: SUCCESS (1.983s)
[346.509503] [029/131] (689s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[348.544839] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[348.545758] Starting dynamic subtest: pipe-A-HDMI-A-3
[348.554262] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[348.564109] Starting dynamic subtest: pipe-B-HDMI-A-3
[348.572905] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[348.582466] Starting dynamic subtest: pipe-C-HDMI-A-3
[348.591085] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[348.600773] Starting dynamic subtest: pipe-D-HDMI-A-3
[348.609796] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[348.612053] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[348.835087] [030/131] (687s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[350.852362] Starting subtest: x-tiled-addfb-size-offset-overflow
[350.853244] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[351.036291] [031/131] (685s left) gem_exec_fence (parallel)
[351.248988] Starting subtest: parallel
[351.250195] Starting dynamic subtest: rcs0
[353.400863] Dynamic subtest rcs0: SUCCESS (2.152s)
[353.410627] Starting dynamic subtest: bcs0
[355.552562] Dynamic subtest bcs0: SUCCESS (2.151s)
[355.562307] Starting dynamic subtest: vcs0
[357.706705] Dynamic subtest vcs0: SUCCESS (2.154s)
[357.716674] Starting dynamic subtest: vcs1
[359.862302] Dynamic subtest vcs1: SUCCESS (2.155s)
[359.872037] Starting dynamic subtest: vecs0
[362.011044] Dynamic subtest vecs0: SUCCESS (2.148s)
[362.020715] Starting dynamic subtest: vecs1
[364.166506] Dynamic subtest vecs1: SUCCESS (2.155s)
[364.176337] Starting dynamic subtest: ccs0
[366.318528] Dynamic subtest ccs0: SUCCESS (2.151s)
[366.319447] Subtest parallel: SUCCESS (15.072s)
[367.064449] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[367.066970] [032/131] (669s left) gem_ctx_shared (q-in-order)
[367.158337] Starting subtest: Q-in-order
[367.159295] Starting dynamic subtest: rcs0
[367.412310] Dynamic subtest rcs0: SUCCESS (0.253s)
[367.422755] Starting dynamic subtest: bcs0
[367.591210] Dynamic subtest bcs0: SUCCESS (0.178s)
[367.601713] Starting dynamic subtest: vcs0
[367.777799] Dynamic subtest vcs0: SUCCESS (0.185s)
[367.788632] Starting dynamic subtest: vcs1
[367.962420] Dynamic subtest vcs1: SUCCESS (0.184s)
[367.973071] Starting dynamic subtest: vecs0
[368.146540] Dynamic subtest vecs0: SUCCESS (0.183s)
[368.157110] Starting dynamic subtest: vecs1
[368.332669] Dynamic subtest vecs1: SUCCESS (0.185s)
[368.343441] Starting dynamic subtest: ccs0
[368.518576] Dynamic subtest ccs0: SUCCESS (0.185s)
[368.519448] Subtest Q-in-order: SUCCESS (1.361s)
[368.838361] [033/131] (667s left) perf (invalid-oa-format-id)
[369.098561] Starting subtest: invalid-oa-format-id
[369.118957] Subtest invalid-oa-format-id: SUCCESS (0.020s)
[369.180022] [034/131] (667s left) gem_userptr_blits (process-exit-busy)
[369.272936] Starting subtest: process-exit-busy
[369.292103] Subtest process-exit-busy: SUCCESS (0.019s)
[369.515062] [035/131] (666s left) gem_mmap_offset (oob-read)
[369.588451] Starting subtest: oob-read
[369.589349] Subtest oob-read: SUCCESS (0.000s)
[369.770593] [036/131] (666s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[371.784920] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[371.785865] Starting dynamic subtest: pipe-A-valid-mode
[371.844113] Dynamic subtest pipe-A-valid-mode: SKIP (0.057s)
[371.845920] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.059s)
[372.073616] [037/131] (664s left) gem_exec_await (wide-all)
[372.340743] Starting subtest: wide-all
[394.521522] Subtest wide-all: SUCCESS (22.175s)
[394.806887] [038/131] (641s left) kms_tiled_display (basic-test-pattern)
[397.861407] Subtest basic-test-pattern: SKIP (0.000s)
[397.928279] [039/131] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[399.956196] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[399.958102] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[400.173459] [040/131] (636s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[402.200502] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[402.202219] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[402.352822] [041/131] (634s left) kms_frontbuffer_tracking (fbc-stridechange)
[404.404855] Starting subtest: fbc-stridechange
[406.504868] Subtest fbc-stridechange: SUCCESS (2.099s)
[406.709659] [042/131] (630s left) syncobj_wait (wait-all-delayed-signal)
[406.799358] Starting subtest: wait-all-delayed-signal
[406.903326] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[407.053446] [043/131] (629s left) kms_cdclk (plane-scaling)
[409.062051] Starting subtest: plane-scaling
[409.062951] Starting dynamic subtest: pipe-A-HDMI-A-3
[409.116279] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.054s)
[409.127162] Starting dynamic subtest: pipe-B-HDMI-A-3
[409.128967] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[409.139669] Starting dynamic subtest: pipe-C-HDMI-A-3
[409.141345] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[409.152180] Starting dynamic subtest: pipe-D-HDMI-A-3
[409.154090] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[409.155878] Subtest plane-scaling: SKIP (0.065s)
[409.344572] [044/131] (627s left) gem_mmap_gtt (hang)
[409.423140] Subtest hang: SKIP (0.000s)
[409.513263] [045/131] (627s left) api_intel_bb (intel-bb-blit-x)
[409.589442] Starting subtest: intel-bb-blit-x
[410.281044] Subtest intel-bb-blit-x: SUCCESS (0.690s)
[410.417866] [046/131] (626s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[412.449439] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[413.544418] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.094s)
[413.770658] [047/131] (623s left) syncobj_timeline (single-wait-signaled)
[413.850287] Starting subtest: single-wait-signaled
[413.851292] Subtest single-wait-signaled: SUCCESS (0.000s)
[414.008910] [048/131] (623s left) perf (polling)
[414.245965] Starting subtest: polling
[414.246902] Starting dynamic subtest: 0-rcs0
[424.283201] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[424.284174] Subtest polling: SUCCESS (10.041s)
[424.338158] [049/131] (613s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[426.347091] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[426.348961] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[426.484845] [050/131] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[428.530963] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[428.532860] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[428.741197] [051/131] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[430.765083] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[430.766918] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[430.970463] [052/131] (606s left) kms_psr (fbc-pr-sprite-plane-move)
[432.998325] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[433.052153] [053/131] (604s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[435.068376] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[435.135729] [054/131] (602s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[437.155967] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[437.156893] Starting dynamic subtest: pipe-A-HDMI-A-3
[438.105519] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.950s)
[438.118203] Starting dynamic subtest: pipe-B-HDMI-A-3
[439.081044] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.974s)
[439.093180] Starting dynamic subtest: pipe-C-HDMI-A-3
[440.074164] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.992s)
[440.086290] Starting dynamic subtest: pipe-D-HDMI-A-3
[441.066706] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.991s)
[441.067560] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SUCCESS (3.913s)
[441.261615] [055/131] (596s left) kms_pm_rpm (pc8-residency)
[445.756840] Starting subtest: pc8-residency
[445.760594] Subtest pc8-residency: SKIP (0.000s)
[446.949734] [056/131] (590s left) gem_exec_fence (basic-busy-all)
[447.044106] Starting subtest: basic-busy-all
[447.171037] Subtest basic-busy-all: SUCCESS (0.126s)
[448.007181] [057/131] (589s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[448.086387] Starting subtest: multi-wait-available-submitted-signaled
[448.087324] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[448.270179] [058/131] (589s left) gem_lmem_swapping (verify-random)
[453.861654] Starting subtest: verify-random
[453.866450] Starting dynamic subtest: lmem0
[462.044708] Dynamic subtest lmem0: SUCCESS (8.180s)
[462.045623] Subtest verify-random: SUCCESS (8.183s)
[463.143576] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[463.144513] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[463.146892] [059/131] (574s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[469.323402] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[469.329730] Starting dynamic subtest: A-HDMI-A3
[477.373053] Dynamic subtest A-HDMI-A3: SUCCESS (8.042s)
[477.387636] Starting dynamic subtest: B-HDMI-A3
[485.329540] Dynamic subtest B-HDMI-A3: SUCCESS (7.952s)
[485.344859] Starting dynamic subtest: C-HDMI-A3
[493.283276] Dynamic subtest C-HDMI-A3: SUCCESS (7.947s)
[493.296161] Starting dynamic subtest: D-HDMI-A3
[501.238463] Dynamic subtest D-HDMI-A3: SUCCESS (7.952s)
[501.239385] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.909s)
[501.492590] [FACT kms_flip (flip-vs-absolute-wf_vblank-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[501.494922] [FACT kms_flip (flip-vs-absolute-wf_vblank-interruptible)] new: kernel.kmod_is_loaded.i915: true
[501.497837] [060/131] (536s left) kms_async_flips (test-time-stamp-atomic)
[503.509156] Starting subtest: test-time-stamp-atomic
[503.750151] Starting dynamic subtest: pipe-A-HDMI-A-3
[504.049141] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.298s)
[504.217524] Starting dynamic subtest: pipe-B-HDMI-A-3
[504.315236] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.107s)
[504.510479] Starting dynamic subtest: pipe-C-HDMI-A-3
[504.617008] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.115s)
[504.792570] Starting dynamic subtest: pipe-D-HDMI-A-3
[504.890254] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.106s)
[504.891310] Subtest test-time-stamp-atomic: SUCCESS (1.381s)
[505.307533] [061/131] (532s left) gem_fence_thrash (bo-write-verify-threaded-x)
[505.356553] Starting subtest: bo-write-verify-threaded-x
[505.388113] Subtest bo-write-verify-threaded-x: SKIP (0.031s)
[505.456234] [062/131] (532s left) gem_eio (in-flight-contexts-immediate)
[505.730320] Starting subtest: in-flight-contexts-immediate
[519.654310] Subtest in-flight-contexts-immediate: SUCCESS (13.920s)
[521.747271] [063/131] (516s left) i915_drm_fdinfo (memory-info-purgeable)
[521.847089] Starting subtest: memory-info-purgeable
[521.848058] Starting dynamic subtest: lmem0
[525.523668] Dynamic subtest lmem0: SUCCESS (3.674s)
[525.545528] Starting dynamic subtest: smem0
[529.931421] Dynamic subtest smem0: SUCCESS (4.401s)
[529.932369] Subtest memory-info-purgeable: SUCCESS (8.082s)
[530.049318] [064/131] (508s left) syncobj_wait (reset-multiple-signaled)
[530.128378] Starting subtest: reset-multiple-signaled
[530.129364] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[530.334303] [065/131] (508s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[530.429657] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[530.431492] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[530.722241] [066/131] (507s left) gen9_exec_parse (bb-large)
[530.811370] Subtest bb-large: SKIP (0.000s)
[530.896298] [067/131] (507s left) kms_plane_lowres (tiling-x)
[532.906157] Starting subtest: tiling-x
[532.907125] Starting dynamic subtest: pipe-A-HDMI-A-3
[541.895409] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.986s)
[541.982005] Starting dynamic subtest: pipe-B-HDMI-A-3
[551.231210] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (9.264s)
[551.331304] Starting dynamic subtest: pipe-C-HDMI-A-3
[559.688574] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (8.369s)
[559.789240] Starting dynamic subtest: pipe-D-HDMI-A-3
[568.520323] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (8.742s)
[568.575595] Subtest tiling-x: SUCCESS (35.673s)
[568.790242] [068/131] (469s left) gem_ppgtt (shrink-vs-evict-pinned)
[568.874467] Starting subtest: shrink-vs-evict-pinned
[574.616119] Subtest shrink-vs-evict-pinned: SUCCESS (5.742s)
[574.728845] [069/131] (464s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[576.745653] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[576.907822] [070/131] (462s left) api_intel_allocator (two-level-inception-interruptible)
[576.987839] Starting subtest: two-level-inception-interruptible
[582.409847] Subtest two-level-inception-interruptible: SUCCESS (5.422s)
[582.620687] [071/131] (456s left) gem_exec_capture (capture-recoverable)
[582.709386] Starting subtest: capture-recoverable
[582.714375] Subtest capture-recoverable: SUCCESS (0.005s)
[582.916945] [072/131] (456s left) kms_big_fb (linear-16bpp-rotate-0)
[584.948377] Starting subtest: linear-16bpp-rotate-0
[586.828401] Subtest linear-16bpp-rotate-0: SUCCESS (1.879s)
[587.097037] [073/131] (452s left) gem_exec_schedule (thriceslice)
[587.190948] Starting subtest: thriceslice
[587.191902] Starting dynamic subtest: rcs0
[587.224408] Dynamic subtest rcs0: SUCCESS (0.033s)
[587.238087] Starting dynamic subtest: bcs0
[587.276257] Dynamic subtest bcs0: SUCCESS (0.050s)
[587.292599] Starting dynamic subtest: vcs0
[587.332725] Dynamic subtest vcs0: SUCCESS (0.055s)
[587.356579] Starting dynamic subtest: vcs1
[587.371532] Dynamic subtest vcs1: SUCCESS (0.037s)
[587.395561] Starting dynamic subtest: vecs0
[587.408783] Dynamic subtest vecs0: SUCCESS (0.035s)
[587.429101] Starting dynamic subtest: vecs1
[587.467779] Dynamic subtest vecs1: SUCCESS (0.057s)
[587.491519] Starting dynamic subtest: ccs0
[587.503625] Dynamic subtest ccs0: SUCCESS (0.034s)
[587.504821] Subtest thriceslice: SUCCESS (0.314s)
[587.916518] [074/131] (451s left) gem_exec_reloc (basic-wc)
[588.006432] Subtest basic-wc: SKIP (0.000s)
[588.094369] [075/131] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[590.113111] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[590.115021] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[590.332563] [076/131] (449s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[592.354111] Starting subtest: 2x-cursor-vs-flip-legacy
[592.357404] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[592.540696] [077/131] (447s left) gem_userptr_blits (unsync-unmap-after-close)
[592.652260] Subtest unsync-unmap-after-close: SKIP (0.000s)
[592.903101] [078/131] (446s left) gem_exec_balancer (parallel)
[593.272709] Starting subtest: parallel
[594.914302] Subtest parallel: SUCCESS (1.643s)
[595.054022] [079/131] (444s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[597.061152] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[597.062102] Starting dynamic subtest: pipe-A-HDMI-A-3
[597.065835] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[597.078896] Starting dynamic subtest: pipe-B-HDMI-A-3
[597.082842] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[597.095198] Starting dynamic subtest: pipe-C-HDMI-A-3
[597.098932] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[597.111353] Starting dynamic subtest: pipe-D-HDMI-A-3
[597.116098] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[597.118195] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[597.398221] [080/131] (442s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[599.421208] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[602.228287] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.807s)
[602.410748] [081/131] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[604.433181] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[604.435033] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[604.696755] [082/131] (435s left) gem_render_copy (yf-tiled)
[604.782562] Starting subtest: yf-tiled
[604.784753] Subtest yf-tiled: SKIP (0.000s)
[605.060027] [083/131] (435s left) kms_chamelium_frames (hdmi-frame-dump)
[607.119322] Subtest hdmi-frame-dump: SKIP (0.000s)
[607.236784] [084/131] (433s left) gem_exercise_blt (fast-copy)
[607.331600] Starting subtest: fast-copy
[607.332513] Starting dynamic subtest: linear-smem-smem
[607.378417] Dynamic subtest linear-smem-smem: SUCCESS (0.046s)
[607.392515] Starting dynamic subtest: linear-smem-lmem0
[607.395975] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s)
[607.409966] Starting dynamic subtest: linear-lmem0-smem
[607.515290] Dynamic subtest linear-lmem0-smem: SUCCESS (0.111s)
[607.527517] Starting dynamic subtest: linear-lmem0-lmem0
[607.619111] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.110s)
[607.632510] Starting dynamic subtest: xmajor-smem-smem
[607.636072] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[607.649724] Starting dynamic subtest: xmajor-smem-lmem0
[607.652614] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.015s)
[607.666442] Starting dynamic subtest: xmajor-lmem0-smem
[607.748192] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.094s)
[607.761680] Starting dynamic subtest: xmajor-lmem0-lmem0
[607.844888] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.096s)
[607.858514] Starting dynamic subtest: tile4-smem-smem
[607.863120] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[607.876719] Starting dynamic subtest: tile4-smem-lmem0
[607.879467] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.015s)
[607.893226] Starting dynamic subtest: tile4-lmem0-smem
[607.981103] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.100s)
[607.994530] Starting dynamic subtest: tile4-lmem0-lmem0
[608.085639] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.103s)
[608.099416] Starting dynamic subtest: tile64-smem-smem
[608.102450] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[608.116328] Starting dynamic subtest: tile64-smem-lmem0
[608.118987] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.015s)
[608.132924] Starting dynamic subtest: tile64-lmem0-smem
[608.225548] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.105s)
[608.239479] Starting dynamic subtest: tile64-lmem0-lmem0
[608.338511] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.112s)
[608.339350] Subtest fast-copy: SUCCESS (1.007s)
[608.518135] [085/131] (431s left) prime_mmap (test_forked)
[608.606833] Starting subtest: test_forked
[608.607795] Starting dynamic subtest: test_forked-smem
[608.663926] Dynamic subtest test_forked-smem: SUCCESS (0.057s)
[608.677408] Starting dynamic subtest: test_forked-lmem0
[608.871732] Dynamic subtest test_forked-lmem0: SUCCESS (0.206s)
[608.872805] Subtest test_forked: SUCCESS (0.265s)
[609.040011] [086/131] (431s left) kms_busy (basic-hang)
[611.061134] Starting subtest: basic-hang
[611.062088] Starting dynamic subtest: flip-pipe-A
[611.717330] Dynamic subtest flip-pipe-A: SUCCESS (0.654s)
[611.732066] Starting dynamic subtest: modeset-pipe-A
[612.383841] Dynamic subtest modeset-pipe-A: SUCCESS (0.666s)
[612.398391] Starting dynamic subtest: flip-pipe-D
[612.881423] Dynamic subtest flip-pipe-D: SUCCESS (0.493s)
[612.894459] Starting dynamic subtest: modeset-pipe-D
[613.502237] Dynamic subtest modeset-pipe-D: SUCCESS (0.619s)
[613.503160] Subtest basic-hang: SUCCESS (2.442s)
[613.746547] [087/131] (426s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[615.766504] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[616.498410] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.732s)
[616.750027] [088/131] (423s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[618.767129] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[618.768054] Starting dynamic subtest: pipe-A-HDMI-A-3
[618.777028] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[618.789481] Starting dynamic subtest: pipe-B-HDMI-A-3
[618.798488] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[618.810635] Starting dynamic subtest: pipe-C-HDMI-A-3
[618.819834] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[618.831728] Starting dynamic subtest: pipe-D-HDMI-A-3
[618.840872] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[618.843338] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[619.095968] [089/131] (421s left) prime_busy (after-wait)
[619.185423] Starting subtest: after-wait
[619.190553] Starting dynamic subtest: rcs0
[619.257553] Dynamic subtest rcs0: SUCCESS (0.067s)
[619.271499] Starting dynamic subtest: bcs0
[619.314316] Dynamic subtest bcs0: SUCCESS (0.055s)
[619.337761] Starting dynamic subtest: vcs0
[619.357419] Dynamic subtest vcs0: SUCCESS (0.041s)
[619.381419] Starting dynamic subtest: vcs1
[619.398117] Dynamic subtest vcs1: SUCCESS (0.039s)
[619.418860] Starting dynamic subtest: vecs0
[619.439067] Dynamic subtest vecs0: SUCCESS (0.039s)
[619.462283] Starting dynamic subtest: vecs1
[619.480500] Dynamic subtest vecs1: SUCCESS (0.040s)
[619.503349] Starting dynamic subtest: ccs0
[619.521148] Dynamic subtest ccs0: SUCCESS (0.039s)
[619.635308] Subtest after-wait: SUCCESS (0.449s)
[619.846853] [090/131] (420s left) gem_exec_params (mmapped)
[619.931730] Starting subtest: mmapped
[619.934079] Subtest mmapped: SUCCESS (0.002s)
[620.100363] [091/131] (420s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[622.130814] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[622.228248] [092/131] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[624.273842] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[628.417507] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (4.143s)
[628.602426] [093/131] (412s left) gem_mmap_gtt (basic-write-read)
[628.678186] Subtest basic-write-read: SKIP (0.000s)
[628.748836] [094/131] (412s left) dmabuf_sync_file (export-wait-after-attach)
[628.804416] Starting subtest: export-wait-after-attach
[628.805533] Subtest export-wait-after-attach: SUCCESS (0.001s)
[628.941390] [095/131] (412s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[630.959119] Starting subtest: primary-y-tiled-reflect-x-90
[630.960956] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[631.125589] [096/131] (410s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[633.175268] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[634.930791] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.756s)
[635.216539] [097/131] (406s left) kms_getfb (getfb-addfb-different-handles)
[637.234155] Starting subtest: getfb-addfb-different-handles
[637.235094] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[637.488080] [098/131] (403s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[639.504358] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[639.506184] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[639.754133] [099/131] (401s left) kms_flip (absolute-wf_vblank-interruptible)
[641.764388] Starting subtest: absolute-wf_vblank-interruptible
[641.769328] Starting dynamic subtest: A-HDMI-A3
[649.501335] Dynamic subtest A-HDMI-A3: SUCCESS (7.731s)
[649.517907] Starting dynamic subtest: B-HDMI-A3
[657.173003] Dynamic subtest B-HDMI-A3: SUCCESS (7.668s)
[657.189368] Starting dynamic subtest: C-HDMI-A3
[664.843276] Dynamic subtest C-HDMI-A3: SUCCESS (7.664s)
[664.860150] Starting dynamic subtest: D-HDMI-A3
[672.513287] Dynamic subtest D-HDMI-A3: SUCCESS (7.664s)
[672.514218] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.747s)
[672.725911] [100/131] (368s left) syncobj_timeline (single-wait-all-signaled)
[672.805490] Starting subtest: single-wait-all-signaled
[672.806423] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[673.003719] [101/131] (368s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[675.021074] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[675.027286] Starting dynamic subtest: A-HDMI-A3
[675.775068] Dynamic subtest A-HDMI-A3: SUCCESS (0.747s)
[675.787419] Starting dynamic subtest: B-HDMI-A3
[676.423811] Dynamic subtest B-HDMI-A3: SUCCESS (0.647s)
[676.436000] Starting dynamic subtest: C-HDMI-A3
[677.094832] Dynamic subtest C-HDMI-A3: SUCCESS (0.670s)
[677.107152] Starting dynamic subtest: D-HDMI-A3
[677.780796] Dynamic subtest D-HDMI-A3: SUCCESS (0.685s)
[677.781653] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.759s)
[678.031625] [102/131] (363s left) gem_eio (wait-wedge-immediate)
[678.344429] Starting subtest: wait-wedge-immediate
[679.612832] Subtest wait-wedge-immediate: SUCCESS (1.269s)
[681.747135] [103/131] (360s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[683.788067] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[683.789849] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[684.010643] [104/131] (358s left) gem_exec_reloc (basic-wc-read)
[684.102036] Subtest basic-wc-read: SKIP (0.000s)
[684.182693] [105/131] (357s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[684.265444] Starting subtest: y-tiled-ccs-to-x-tiled
[684.267364] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[684.550444] [106/131] (357s left) gem_exec_schedule (pi-ringfull)
[684.757470] Starting subtest: pi-ringfull
[684.758404] Starting dynamic subtest: rcs0
[684.806987] Dynamic subtest rcs0: SUCCESS (0.049s)
[684.820700] Starting dynamic subtest: bcs0
[684.850127] Dynamic subtest bcs0: SUCCESS (0.042s)
[684.864514] Starting dynamic subtest: vcs0
[684.885682] Dynamic subtest vcs0: SUCCESS (0.034s)
[684.900089] Starting dynamic subtest: vcs1
[684.918888] Dynamic subtest vcs1: SUCCESS (0.032s)
[684.933104] Starting dynamic subtest: vecs0
[684.951274] Dynamic subtest vecs0: SUCCESS (0.031s)
[684.965426] Starting dynamic subtest: vecs1
[684.982826] Dynamic subtest vecs1: SUCCESS (0.030s)
[684.997424] Starting dynamic subtest: ccs0
[685.015450] Dynamic subtest ccs0: SUCCESS (0.031s)
[685.016321] Subtest pi-ringfull: SUCCESS (0.259s)
[685.318413] [107/131] (356s left) gem_softpin (reverse)
[685.407698] Starting subtest: reverse
[685.417187] Subtest reverse: SUCCESS (0.009s)
[685.618692] [108/131] (356s left) gem_create (create-ext-placement-sanity-check)
[685.806609] Starting subtest: create-ext-placement-sanity-check
[685.813142] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[685.956275] [109/131] (356s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[687.972869] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[691.051559] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.079s)
[691.258401] [110/131] (351s left) gem_ctx_persistence (legacy-engines-persistence)
[691.350507] Starting subtest: legacy-engines-persistence
[691.351443] Starting dynamic subtest: render
[692.179967] Dynamic subtest render: SUCCESS (0.828s)
[692.196038] Starting dynamic subtest: bsd1
[693.000275] Dynamic subtest bsd1: SUCCESS (0.815s)
[693.016933] Starting dynamic subtest: bsd2
[693.766224] Dynamic subtest bsd2: SUCCESS (0.760s)
[693.783276] Starting dynamic subtest: blt
[694.521399] Dynamic subtest blt: SUCCESS (0.749s)
[694.538169] Starting dynamic subtest: vebox
[695.291395] Dynamic subtest vebox: SUCCESS (0.764s)
[695.296304] Subtest legacy-engines-persistence: SUCCESS (3.942s)
[695.486568] [111/131] (347s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[697.505074] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[697.506909] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[697.732323] [112/131] (344s left) kms_draw_crc (draw-method-blt)
[699.750892] Starting subtest: draw-method-blt
[699.751868] Starting dynamic subtest: xrgb8888-untiled
[700.136814] Dynamic subtest xrgb8888-untiled: SUCCESS (0.386s)
[700.185390] Starting dynamic subtest: rgb565-untiled
[700.470242] Dynamic subtest rgb565-untiled: SUCCESS (0.328s)
[700.512250] Starting dynamic subtest: xrgb2101010-untiled
[700.770271] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.295s)
[700.812664] Starting dynamic subtest: xbgr16161616f-untiled
[701.103577] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.328s)
[701.147050] Starting dynamic subtest: xrgb8888-xtiled
[701.270605] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.162s)
[701.313721] Starting dynamic subtest: rgb565-xtiled
[701.437130] Dynamic subtest rgb565-xtiled: SUCCESS (0.162s)
[701.483053] Starting dynamic subtest: xrgb2101010-xtiled
[701.602447] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.161s)
[701.619189] Starting dynamic subtest: xbgr16161616f-xtiled
[701.737203] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[701.753916] Starting dynamic subtest: xrgb8888-4tiled
[701.887316] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.145s)
[701.932553] Starting dynamic subtest: rgb565-4tiled
[702.070598] Dynamic subtest rgb565-4tiled: SUCCESS (0.178s)
[702.113686] Starting dynamic subtest: xrgb2101010-4tiled
[702.220571] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.145s)
[702.262161] Starting dynamic subtest: xbgr16161616f-4tiled
[702.370541] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.145s)
[702.376438] Subtest draw-method-blt: SUCCESS (2.622s)
[702.588405] [113/131] (340s left) prime_vgem (shrink)
[702.691634] Starting subtest: shrink
[702.698218] Subtest shrink: SUCCESS (0.007s)
[702.908235] [114/131] (339s left) kms_scaling_modes (scaling-mode-none)
[704.923280] Starting subtest: scaling-mode-none
[704.928697] Subtest scaling-mode-none: SKIP (0.001s)
[705.103243] [115/131] (337s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[705.198394] Starting subtest: invalid-multi-wait-unsubmitted
[705.199430] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[705.385848] [116/131] (337s left) gem_workarounds (reset)
[705.484748] Starting subtest: reset
[705.747804] Subtest reset: SUCCESS (0.263s)
[705.938138] [117/131] (337s left) perf_pmu (event-wait)
[706.010406] Starting subtest: event-wait
[706.011376] Starting dynamic subtest: rcs0
[706.013201] Dynamic subtest rcs0: SKIP (0.000s)
[706.014974] Subtest event-wait: SKIP (0.001s)
[706.218857] [118/131] (336s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[708.242866] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[708.244704] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[708.470385] [119/131] (334s left) kms_psr (pr-no-drrs)
[710.489778] Subtest pr-no-drrs: SKIP (0.000s)
[710.550857] [120/131] (332s left) gem_tiled_fence_blits (basic)
[710.636394] Subtest basic: SKIP (0.000s)
[710.702842] [121/131] (332s left) kms_pm_lpsp (kms-lpsp)
[713.720957] Starting subtest: kms-lpsp
[713.722786] Subtest kms-lpsp: SKIP (0.000s)
[713.940136] [122/131] (329s left) kms_pm_backlight (bad-brightness)
[715.966386] Subtest bad-brightness: SKIP (0.000s)
[716.019073] [123/131] (327s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[718.033126] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[718.034061] Starting dynamic subtest: pipe-A-valid-mode
[718.082230] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[718.084098] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.049s)
[718.309103] [124/131] (325s left) kms_plane_scaling (planes-downscale-factor-0-5)
[720.327279] Starting subtest: planes-downscale-factor-0-5
[720.328195] Starting dynamic subtest: pipe-A
[720.414921] Dynamic subtest pipe-A: SUCCESS (0.088s)
[720.433509] Starting dynamic subtest: pipe-B
[720.560160] Dynamic subtest pipe-B: SUCCESS (0.144s)
[720.580436] Starting dynamic subtest: pipe-C
[720.705579] Dynamic subtest pipe-C: SUCCESS (0.144s)
[720.720168] Starting dynamic subtest: pipe-D
[720.832053] Dynamic subtest pipe-D: SUCCESS (0.125s)
[720.832960] Subtest planes-downscale-factor-0-5: SUCCESS (0.506s)
[721.102027] [125/131] (322s left) kms_cursor_crc (cursor-offscreen-128x128)
[723.308487] Starting subtest: cursor-offscreen-128x128
[723.313552] Starting dynamic subtest: pipe-A-HDMI-A-3
[725.852209] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.538s)
[725.898761] Starting dynamic subtest: pipe-D-HDMI-A-3
[728.274777] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.386s)
[728.275833] Subtest cursor-offscreen-128x128: SUCCESS (4.965s)
[728.689412] [126/131] (315s left) kms_psr (fbc-psr-cursor-render)
[730.702441] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[730.765752] [127/131] (313s left) kms_vrr (flip-dpms)
[732.782387] Starting subtest: flip-dpms
[732.785072] Subtest flip-dpms: SKIP (0.000s)
[732.983635] [128/131] (311s left) sw_sync (sync_busy_fork)
[733.040354] Starting subtest: sync_busy_fork
[734.053670] Subtest sync_busy_fork: SUCCESS (1.013s)
[734.172046] [129/131] (309s left) i915_pm_rc6_residency (media-rc6-accuracy)
[734.250408] Starting subtest: media-rc6-accuracy
[734.252234] Subtest media-rc6-accuracy: SKIP (0.000s)
[734.392628] [130/131] (309s left) kms_vblank (query-busy-hang)
[736.411130] Starting subtest: query-busy-hang
[736.412045] Starting dynamic subtest: pipe-A-HDMI-A-3
[763.231040] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.813s)
[763.246533] Starting dynamic subtest: pipe-D-HDMI-A-3
[788.244164] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.003s)
[788.245174] Subtest query-busy-hang: SUCCESS (51.823s)
[788.481274] [131/131] (255s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[790.498884] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[790.500641] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[790.730881] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_power
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: gem_set_tiling_vs_blt
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_ctx_isolation
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_suspend
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_pipe_crc_basic
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_3d
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_exec_await
results: parsing output: 37/ for test: kms_tiled_display
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_cdclk
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_fence_thrash
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: kms_plane_lowres
results: parsing output: 67/ for test: gem_ppgtt
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: gem_exec_capture
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: gem_exercise_blt
results: parsing output: 84/ for test: prime_mmap
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: prime_busy
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: dmabuf_sync_file
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: gem_create
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_draw_crc
results: parsing output: 112/ for test: prime_vgem
results: parsing output: 113/ for test: kms_scaling_modes
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_tiled_fence_blits
results: parsing output: 120/ for test: kms_pm_lpsp
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: i915_pm_rc6_residency
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.