[61.354328] Initializing watchdogs
[61.354395]   /dev/watchdog0
[61.374210] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.384884] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.388570] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.390843] [001/130] (960s left) kms_async_flips (alternate-sync-async-flip-atomic)
[61.575351] Starting subtest: alternate-sync-async-flip-atomic
[61.801813] Starting dynamic subtest: pipe-A-DP-3
[64.086672] Dynamic subtest pipe-A-DP-3: SUCCESS (2.276s)
[64.328613] Starting dynamic subtest: pipe-B-DP-3
[66.414355] Dynamic subtest pipe-B-DP-3: SUCCESS (2.089s)
[66.624479] Starting dynamic subtest: pipe-C-DP-3
[68.717517] Dynamic subtest pipe-C-DP-3: SUCCESS (2.096s)
[68.940354] Starting dynamic subtest: pipe-D-DP-3
[71.027646] Dynamic subtest pipe-D-DP-3: SUCCESS (2.092s)
[71.029417] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.430s)
[71.578061] [002/130] (950s left) i915_pm_rpm (sysfs-read)
[74.115225] Starting subtest: sysfs-read
[74.533058] Subtest sysfs-read: SUCCESS (0.417s)
[74.976188] [003/130] (947s left) gem_ctx_param (invalid-size-set)
[75.053780] Starting subtest: invalid-size-set
[75.055012] Subtest invalid-size-set: SUCCESS (0.002s)
[75.244478] [004/130] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[75.425539] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[75.427239] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[75.610239] [005/130] (946s left) kms_lease (lease-invalid-crtc)
[75.786560] Starting subtest: lease-invalid-crtc
[75.787485] Starting dynamic subtest: pipe-A-DP-3
[75.788384] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[75.796539] Starting dynamic subtest: pipe-B-DP-3
[75.797435] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[75.805797] Starting dynamic subtest: pipe-C-DP-3
[75.806931] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[75.815087] Starting dynamic subtest: pipe-D-DP-3
[75.816152] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[75.817366] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[75.939520] [006/130] (946s left) gem_mmap_offset (blt-coherency)
[76.007972] Starting subtest: blt-coherency
[76.044674] Subtest blt-coherency: SUCCESS (0.038s)
[76.210349] [007/130] (946s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[76.277193] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[76.381582] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[76.562746] [008/130] (945s left) gem_ctx_shared (detached-shared-gtt)
[76.648206] Starting subtest: detached-shared-gtt
[78.801855] Subtest detached-shared-gtt: SUCCESS (2.152s)
[80.406557] [009/130] (942s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[80.584168] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[80.585057] Starting dynamic subtest: pipe-A-DP-3
[80.593382] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[80.601770] Starting dynamic subtest: pipe-B-DP-3
[80.610155] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[80.618460] Starting dynamic subtest: pipe-C-DP-3
[80.626652] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[80.634845] Starting dynamic subtest: pipe-D-DP-3
[80.644347] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[80.646361] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[81.053682] [010/130] (941s left) gem_exec_schedule (wide)
[81.250341] Starting subtest: wide
[81.251306] Starting dynamic subtest: rcs0
[93.769717] Dynamic subtest rcs0: SUCCESS (12.479s)
[93.791675] Starting dynamic subtest: bcs0
[106.354600] Dynamic subtest bcs0: SUCCESS (12.586s)
[106.363767] Starting dynamic subtest: vcs0
[119.950323] Dynamic subtest vcs0: SUCCESS (13.593s)
[119.960051] Starting dynamic subtest: vcs1
[133.147305] Dynamic subtest vcs1: SUCCESS (13.195s)
[133.156514] Starting dynamic subtest: vecs0
[146.280736] Dynamic subtest vecs0: SUCCESS (13.132s)
[146.290649] Starting dynamic subtest: vecs1
[159.519258] Dynamic subtest vecs1: SUCCESS (13.239s)
[159.528847] Starting dynamic subtest: ccs0
[172.451706] Dynamic subtest ccs0: SUCCESS (12.931s)
[172.452532] Subtest wide: SUCCESS (91.187s)
[174.422709] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[174.424521] [011/130] (848s left) kms_pm_rpm (drm-resources-equal)
[176.012216] Starting subtest: drm-resources-equal
[177.399401] Subtest drm-resources-equal: SUCCESS (1.390s)
[177.610110] [012/130] (845s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[177.686959] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[177.687880] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[177.897667] [013/130] (844s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[178.080955] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[178.081842] Starting dynamic subtest: pipe-A-DP-3
[178.091037] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[178.099974] Starting dynamic subtest: pipe-B-DP-3
[178.108889] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[178.117565] Starting dynamic subtest: pipe-C-DP-3
[178.126388] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[178.135066] Starting dynamic subtest: pipe-D-DP-3
[178.146087] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[178.147960] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[178.537091] [014/130] (844s left) syncobj_timeline (single-wait-all-signaled)
[178.613919] Starting subtest: single-wait-all-signaled
[178.615055] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[178.816828] [015/130] (844s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[179.013561] Starting subtest: yf-tiled-16bpp-rotate-90
[179.015325] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[179.201791] [016/130] (843s left) gem_ctx_bad_destroy (double-destroy)
[179.282476] Starting subtest: double-destroy
[179.283407] Subtest double-destroy: SUCCESS (0.000s)
[179.457117] [017/130] (843s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[179.645500] Starting subtest: psr-rgb565-draw-mmap-cpu
[179.647195] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[179.846453] [018/130] (843s left) fbdev (eof)
[179.905301] Starting subtest: eof
[179.906272] Subtest eof: SUCCESS (0.000s)
[180.047748] [019/130] (843s left) syncobj_basic (bad-fd-to-handle)
[180.128061] Starting subtest: bad-fd-to-handle
[180.128957] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[180.337025] [020/130] (843s left) gem_exec_fence (basic-busy-all)
[180.422198] Starting subtest: basic-busy-all
[180.552487] Subtest basic-busy-all: SUCCESS (0.130s)
[181.401138] [021/130] (842s left) gem_exec_fence (syncobj-signal)
[181.918953] Starting subtest: syncobj-signal
[181.950190] Subtest syncobj-signal: SUCCESS (0.031s)
[182.403603] [022/130] (841s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[182.484948] Starting subtest: invalid-single-wait-all-unsubmitted
[182.485873] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[182.632346] [023/130] (840s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[182.825292] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[183.521202] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.696s)
[183.785060] [024/130] (839s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[183.871323] Starting subtest: yf-tiled-to-vebox-x-tiled
[183.873172] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[184.169768] [025/130] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[184.359528] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[184.361178] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[184.524712] [026/130] (839s left) perf (invalid-create-userspace-config)
[184.941897] Starting subtest: invalid-create-userspace-config
[184.943907] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[184.999894] [027/130] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[185.192564] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[185.194253] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[185.388765] [028/130] (838s left) gem_cs_tlb (engines)
[185.469400] Starting subtest: engines
[185.470334] Starting dynamic subtest: rcs0
[187.623562] Dynamic subtest rcs0: SUCCESS (2.153s)
[187.633474] Starting dynamic subtest: bcs0
[189.778547] Dynamic subtest bcs0: SUCCESS (2.155s)
[189.788782] Starting dynamic subtest: vcs0
[191.931127] Dynamic subtest vcs0: SUCCESS (2.152s)
[191.940421] Starting dynamic subtest: vcs1
[194.084409] Dynamic subtest vcs1: SUCCESS (2.153s)
[194.094535] Starting dynamic subtest: vecs0
[196.238812] Dynamic subtest vecs0: SUCCESS (2.153s)
[196.247883] Starting dynamic subtest: vecs1
[198.391844] Dynamic subtest vecs1: SUCCESS (2.152s)
[198.401353] Starting dynamic subtest: ccs0
[200.544359] Dynamic subtest ccs0: SUCCESS (2.152s)
[200.545393] Subtest engines: SUCCESS (15.074s)
[200.711587] [029/130] (823s left) syncobj_timeline (etime-single-wait-submitted)
[200.788286] Starting subtest: etime-single-wait-submitted
[200.894420] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[201.036696] [030/130] (823s left) gem_spin_batch (resubmit-all)
[201.123798] Starting subtest: resubmit-all
[201.124673] Starting dynamic subtest: rcs0
[201.159057] Dynamic subtest rcs0: SUCCESS (0.035s)
[201.168857] Starting dynamic subtest: bcs0
[201.169734] Dynamic subtest bcs0: SUCCESS (0.003s)
[201.179774] Starting dynamic subtest: vcs0
[201.180777] Dynamic subtest vcs0: SUCCESS (0.002s)
[201.190091] Starting dynamic subtest: vcs1
[201.191137] Dynamic subtest vcs1: SUCCESS (0.002s)
[201.200060] Starting dynamic subtest: vecs0
[201.200972] Dynamic subtest vecs0: SUCCESS (0.003s)
[201.210055] Starting dynamic subtest: vecs1
[201.211198] Dynamic subtest vecs1: SUCCESS (0.003s)
[201.220130] Starting dynamic subtest: ccs0
[201.221181] Dynamic subtest ccs0: SUCCESS (0.002s)
[201.222140] Subtest resubmit-all: SUCCESS (0.052s)
[201.484881] [031/130] (822s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[201.670293] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[201.685591] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[201.861049] [032/130] (822s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[202.047614] Starting subtest: psr-2p-pri-indfb-multidraw
[202.049389] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[202.234865] [033/130] (822s left) gem_pxp (reject-modify-context-protection-off-3)
[204.835250] Starting subtest: reject-modify-context-protection-off-3
[204.838174] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[204.985504] [034/130] (819s left) gem_exec_schedule (semaphore-user)
[205.091432] Starting subtest: semaphore-user
[205.174669] Subtest semaphore-user: SUCCESS (0.083s)
[205.584327] [035/130] (818s left) gem_tiled_partial_pwrite_pread (writes)
[205.677050] Subtest writes: SKIP (0.000s)
[205.798204] [036/130] (818s left) kms_cursor_crc (cursor-dpms)
[206.054923] Starting subtest: cursor-dpms
[206.056929] Starting dynamic subtest: pipe-A-DP-3
[207.258540] Dynamic subtest pipe-A-DP-3: SUCCESS (1.202s)
[207.281598] Starting dynamic subtest: pipe-D-DP-3
[208.389745] Dynamic subtest pipe-D-DP-3: SUCCESS (1.127s)
[208.391124] Subtest cursor-dpms: SUCCESS (2.334s)
[208.958769] [037/130] (815s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[209.149461] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[209.151246] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[209.342417] [038/130] (815s left) i915_pm_freq_api (freq-reset)
[209.429372] Starting subtest: freq-reset
[209.430345] Starting dynamic subtest: gt0
[209.867559] Dynamic subtest gt0: SUCCESS (0.437s)
[209.868433] Subtest freq-reset: SUCCESS (0.438s)
[209.997356] [039/130] (814s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[210.187791] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[210.251038] [040/130] (814s left) perf_pmu (busy-accuracy-2)
[210.320561] Starting subtest: busy-accuracy-2
[210.321476] Starting dynamic subtest: rcs0
[213.387538] Dynamic subtest rcs0: SUCCESS (3.066s)
[213.398206] Starting dynamic subtest: bcs0
[216.457075] Dynamic subtest bcs0: SUCCESS (3.069s)
[216.467724] Starting dynamic subtest: vcs0
[219.525443] Dynamic subtest vcs0: SUCCESS (3.068s)
[219.536219] Starting dynamic subtest: vcs1
[222.596478] Dynamic subtest vcs1: SUCCESS (3.070s)
[222.607289] Starting dynamic subtest: vecs0
[225.666896] Dynamic subtest vecs0: SUCCESS (3.070s)
[225.677675] Starting dynamic subtest: vecs1
[228.730916] Dynamic subtest vecs1: SUCCESS (3.063s)
[228.741977] Starting dynamic subtest: ccs0
[231.798354] Dynamic subtest ccs0: SUCCESS (3.067s)
[231.799246] Subtest busy-accuracy-2: SUCCESS (21.476s)
[231.993024] [041/130] (792s left) gem_exec_balancer (bonded-true-hang)
[232.382561] Starting subtest: bonded-true-hang
[232.387322] Subtest bonded-true-hang: SKIP (0.000s)
[232.560766] [042/130] (792s left) gen9_exec_parse (valid-registers)
[232.645264] Subtest valid-registers: SKIP (0.000s)
[232.721711] [043/130] (792s left) gem_lmem_swapping (massive)
[235.406484] Starting subtest: massive
[235.407318] Starting dynamic subtest: lmem0
[245.841628] Dynamic subtest lmem0: SUCCESS (10.435s)
[245.842491] Subtest massive: SUCCESS (10.436s)
[247.252885] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[247.253861] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[247.255833] [044/130] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[248.914675] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[248.916387] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.137711] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[249.139964] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[249.143093] [045/130] (775s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[249.337335] Starting subtest: extended-pageflip-modeset-hang-oldfb
[249.339389] Starting dynamic subtest: pipe-A
[257.193917] Dynamic subtest pipe-A: SUCCESS (7.854s)
[257.206298] Starting dynamic subtest: pipe-D
[265.014516] Dynamic subtest pipe-D: SUCCESS (7.817s)
[265.015397] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.677s)
[265.296176] [046/130] (759s left) kms_vblank (wait-busy)
[265.482646] Starting subtest: wait-busy
[265.484801] Starting dynamic subtest: pipe-A-DP-3
[267.972406] Dynamic subtest pipe-A-DP-3: SUCCESS (2.488s)
[267.988497] Starting dynamic subtest: pipe-D-DP-3
[270.398240] Dynamic subtest pipe-D-DP-3: SUCCESS (2.421s)
[270.399227] Subtest wait-busy: SUCCESS (4.915s)
[270.655910] [047/130] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[270.849182] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[270.851130] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[271.044668] [048/130] (754s left) gem_tiled_pread_basic
[271.191658] [049/130] (754s left) drm_read (fault-buffer)
[271.448177] Starting subtest: fault-buffer
[271.449056] Subtest fault-buffer: SUCCESS (0.001s)
[271.712205] [050/130] (753s left) perf (short-reads)
[272.123998] Starting subtest: short-reads
[272.147967] Subtest short-reads: SUCCESS (0.024s)
[272.209964] [051/130] (753s left) kms_plane_lowres (tiling-x)
[272.397085] Starting subtest: tiling-x
[272.398009] Starting dynamic subtest: pipe-A-DP-3
[282.811986] Dynamic subtest pipe-A-DP-3: SUCCESS (10.414s)
[282.911766] Starting dynamic subtest: pipe-B-DP-3
[292.918915] Dynamic subtest pipe-B-DP-3: SUCCESS (10.017s)
[293.034508] Starting dynamic subtest: pipe-C-DP-3
[303.061977] Dynamic subtest pipe-C-DP-3: SUCCESS (10.036s)
[303.178610] Starting dynamic subtest: pipe-D-DP-3
[313.237816] Dynamic subtest pipe-D-DP-3: SUCCESS (10.069s)
[313.326217] Subtest tiling-x: SUCCESS (40.931s)
[313.645113] [052/130] (711s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[313.834276] Starting subtest: sprite-rotation-90-pos-100-0
[313.836051] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[313.995299] [053/130] (711s left) syncobj_wait (invalid-reset-zero-handles)
[314.071534] Starting subtest: invalid-reset-zero-handles
[314.072467] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[314.224884] [054/130] (711s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[314.408391] Starting subtest: basic-busy-flip-before-cursor-legacy
[314.410131] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[314.559609] [055/130] (711s left) api_intel_allocator (reopen)
[314.640501] Starting subtest: reopen
[314.665971] Subtest reopen: SUCCESS (0.027s)
[314.861658] [056/130] (710s left) kms_plane_scaling (planes-upscale-20x20)
[315.048273] Starting subtest: planes-upscale-20x20
[315.049044] Starting dynamic subtest: pipe-A
[315.146342] Dynamic subtest pipe-A: SUCCESS (0.099s)
[315.165623] Starting dynamic subtest: pipe-B
[315.359749] Dynamic subtest pipe-B: SUCCESS (0.212s)
[315.378793] Starting dynamic subtest: pipe-C
[315.590593] Dynamic subtest pipe-C: SUCCESS (0.229s)
[315.605278] Starting dynamic subtest: pipe-D
[315.785785] Dynamic subtest pipe-D: SUCCESS (0.194s)
[315.786840] Subtest planes-upscale-20x20: SUCCESS (0.739s)
[316.132282] [057/130] (709s left) kms_cursor_legacy (forked-bo)
[316.312851] Starting subtest: forked-bo
[316.313734] Starting dynamic subtest: pipe-A
[321.741831] Dynamic subtest pipe-A: SUCCESS (5.426s)
[321.767039] Starting dynamic subtest: pipe-B
[327.179861] Dynamic subtest pipe-B: SUCCESS (5.435s)
[327.201238] Starting dynamic subtest: pipe-C
[332.606094] Dynamic subtest pipe-C: SUCCESS (5.426s)
[332.616361] Starting dynamic subtest: pipe-D
[338.020061] Dynamic subtest pipe-D: SUCCESS (5.412s)
[338.042042] Starting dynamic subtest: all-pipes
[343.439629] Dynamic subtest all-pipes: SUCCESS (5.417s)
[343.440498] Subtest forked-bo: SUCCESS (27.127s)
[343.607466] [058/130] (682s left) kms_atomic_interruptible (universal-setplane-cursor)
[343.796442] Starting subtest: universal-setplane-cursor
[343.797302] Starting dynamic subtest: pipe-A-DP-3
[350.091630] Dynamic subtest pipe-A-DP-3: SUCCESS (6.292s)
[350.092726] Subtest universal-setplane-cursor: SUCCESS (6.295s)
[350.386544] [059/130] (675s left) kms_properties (crtc-properties-atomic)
[350.571738] Starting subtest: crtc-properties-atomic
[350.574659] Starting dynamic subtest: pipe-A-DP-3
[350.907676] Dynamic subtest pipe-A-DP-3: SUCCESS (0.334s)
[350.922345] Starting dynamic subtest: pipe-B-DP-3
[351.263660] Dynamic subtest pipe-B-DP-3: SUCCESS (0.353s)
[351.275528] Starting dynamic subtest: pipe-C-DP-3
[351.611908] Dynamic subtest pipe-C-DP-3: SUCCESS (0.346s)
[351.622579] Starting dynamic subtest: pipe-D-DP-3
[351.962137] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[351.962969] Subtest crtc-properties-atomic: SUCCESS (1.390s)
[352.241008] [060/130] (673s left) drm_read (short-buffer-block)
[352.491398] Starting subtest: short-buffer-block
[352.492308] Subtest short-buffer-block: SUCCESS (0.000s)
[352.756397] [061/130] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[352.945114] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[355.941193] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.996s)
[356.189892] [062/130] (670s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[356.375727] Starting subtest: primary-y-tiled-reflect-x-180
[356.475303] Subtest primary-y-tiled-reflect-x-180: SKIP (0.097s)
[356.691585] [063/130] (669s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[356.877423] Starting subtest: short-flip-after-cursor-atomic-transitions
[357.933349] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.055s)
[358.287478] [064/130] (668s left) gem_ctx_isolation (preservation)
[358.375733] Starting subtest: preservation
[358.376581] Starting dynamic subtest: rcs0
[358.774151] Dynamic subtest rcs0: SUCCESS (0.397s)
[358.784784] Starting dynamic subtest: bcs0
[359.232350] Dynamic subtest bcs0: SUCCESS (0.457s)
[359.242801] Starting dynamic subtest: vcs0
[359.672292] Dynamic subtest vcs0: SUCCESS (0.439s)
[359.684734] Starting dynamic subtest: vcs1
[360.137465] Dynamic subtest vcs1: SUCCESS (0.464s)
[360.148309] Starting dynamic subtest: vecs0
[360.605088] Dynamic subtest vecs0: SUCCESS (0.466s)
[360.615808] Starting dynamic subtest: vecs1
[361.030051] Dynamic subtest vecs1: SUCCESS (0.424s)
[361.040794] Starting dynamic subtest: ccs0
[361.451735] Dynamic subtest ccs0: SUCCESS (0.421s)
[361.452617] Subtest preservation: SUCCESS (3.076s)
[361.754154] [065/130] (664s left) kms_invalid_mode (overflow-vrefresh)
[361.938176] Starting subtest: overflow-vrefresh
[361.939055] Starting dynamic subtest: pipe-A-DP-3
[362.015218] Dynamic subtest pipe-A-DP-3: SUCCESS (0.077s)
[362.026100] Starting dynamic subtest: pipe-B-DP-3
[362.027137] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[362.037600] Starting dynamic subtest: pipe-C-DP-3
[362.038656] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[362.048927] Starting dynamic subtest: pipe-D-DP-3
[362.049841] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[362.050714] Subtest overflow-vrefresh: SUCCESS (0.086s)
[362.293523] [066/130] (664s left) kms_sequence (queue-busy)
[362.477943] Starting subtest: queue-busy
[362.480435] Starting dynamic subtest: pipe-A-DP-3
[365.065888] Dynamic subtest pipe-A-DP-3: SUCCESS (2.586s)
[365.076637] Starting dynamic subtest: pipe-B-DP-3
[367.529602] Dynamic subtest pipe-B-DP-3: SUCCESS (2.462s)
[367.544198] Starting dynamic subtest: pipe-C-DP-3
[370.001598] Dynamic subtest pipe-C-DP-3: SUCCESS (2.470s)
[370.016608] Starting dynamic subtest: pipe-D-DP-3
[372.475886] Dynamic subtest pipe-D-DP-3: SUCCESS (2.472s)
[372.476763] Subtest queue-busy: SUCCESS (9.998s)
[372.793064] [067/130] (653s left) kms_psr (psr-cursor-mmap-cpu)
[372.986756] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[373.054437] [068/130] (653s left) gem_mmap_wc (fault-concurrent)
[373.133173] Subtest fault-concurrent: SKIP (0.000s)
[373.206971] [069/130] (653s left) kms_big_fb (linear-64bpp-rotate-0)
[373.405161] Starting subtest: linear-64bpp-rotate-0
[375.561248] Subtest linear-64bpp-rotate-0: SUCCESS (2.155s)
[375.749631] [070/130] (651s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[375.939898] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[375.941572] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[376.144535] [071/130] (650s left) perf_pmu (pmu-read)
[376.213828] Starting subtest: pmu-read
[376.217843] Subtest pmu-read: SUCCESS (0.004s)
[376.424873] [072/130] (650s left) gen3_render_tiledx_blits
[376.570696] [073/130] (650s left) gem_mmap (pf-nonblock)
[376.646181] Subtest pf-nonblock: SKIP (0.000s)
[376.720189] [074/130] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[376.918952] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[376.920620] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.057944] [075/130] (650s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[377.250132] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[377.304782] [076/130] (649s left) api_intel_bb (destroy-bb)
[377.380336] Starting subtest: destroy-bb
[377.418489] Subtest destroy-bb: SUCCESS (0.037s)
[377.644669] [077/130] (649s left) kms_content_protection (atomic)
[377.895225] Starting subtest: atomic
[377.927561] Starting dynamic subtest: pipe-A-DP-3
[499.169631] Dynamic subtest pipe-A-DP-3: FAIL (121.082s)
[499.170359] Subtest atomic: FAIL (121.209s)
[499.394691] [078/130] (527s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[499.580293] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[499.581200] Starting dynamic subtest: pipe-A-DP-3
[499.602778] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[499.613434] Starting dynamic subtest: pipe-B-DP-3
[499.634736] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[499.645499] Starting dynamic subtest: pipe-C-DP-3
[499.672116] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[499.682461] Starting dynamic subtest: pipe-D-DP-3
[499.705548] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[499.707526] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.015s)
[500.060677] [079/130] (527s left) kms_rotation_crc (bad-pixel-format)
[500.250786] Starting subtest: bad-pixel-format
[500.252477] Subtest bad-pixel-format: SKIP (0.001s)
[500.419774] [080/130] (527s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[500.614182] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[500.673150] [081/130] (526s left) gem_partial_pwrite_pread (writes-after-reads-display)
[500.756360] Subtest writes-after-reads-display: SKIP (0.000s)
[500.859627] [082/130] (526s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[501.045265] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[501.046147] Starting dynamic subtest: pipe-A-DP-3
[501.054299] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[501.065047] Starting dynamic subtest: pipe-B-DP-3
[501.073411] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[501.083910] Starting dynamic subtest: pipe-C-DP-3
[501.091917] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[501.102332] Starting dynamic subtest: pipe-D-DP-3
[501.112991] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[501.115213] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[501.539445] [083/130] (526s left) kms_chamelium_hpd (dp-hpd-storm)
[501.798528] Subtest dp-hpd-storm: SKIP (0.000s)
[501.944155] [084/130] (525s left) gem_ctx_bad_destroy (invalid-pad)
[502.022796] Starting subtest: invalid-pad
[502.023713] Subtest invalid-pad: SUCCESS (0.000s)
[502.209324] [085/130] (525s left) gem_exec_schedule (pi-common)
[502.448284] Starting subtest: pi-common
[502.449652] Starting dynamic subtest: rcs0
[502.500193] Dynamic subtest rcs0: SUCCESS (0.051s)
[502.512397] Starting dynamic subtest: bcs0
[502.538375] Dynamic subtest bcs0: SUCCESS (0.037s)
[502.550742] Starting dynamic subtest: vcs0
[502.574375] Dynamic subtest vcs0: SUCCESS (0.035s)
[502.586932] Starting dynamic subtest: vcs1
[502.607062] Dynamic subtest vcs1: SUCCESS (0.032s)
[502.619839] Starting dynamic subtest: vecs0
[502.638585] Dynamic subtest vecs0: SUCCESS (0.030s)
[502.651327] Starting dynamic subtest: vecs1
[502.669615] Dynamic subtest vecs1: SUCCESS (0.030s)
[502.682403] Starting dynamic subtest: ccs0
[502.700218] Dynamic subtest ccs0: SUCCESS (0.030s)
[502.701139] Subtest pi-common: SUCCESS (0.253s)
[503.021599] [086/130] (524s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[503.211986] Starting subtest: fbcpsr-rgb565-draw-blt
[503.213778] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[503.405660] [087/130] (524s left) gem_lmem_swapping (verify-ccs)
[505.998219] Starting subtest: verify-ccs
[505.998974] Starting dynamic subtest: lmem0
[550.663200] Dynamic subtest lmem0: SUCCESS (44.665s)
[550.664179] Subtest verify-ccs: SUCCESS (44.666s)
[552.745982] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[552.747463] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[552.750092] [088/130] (475s left) kms_flip (modeset-vs-vblank-race-interruptible)
[554.451769] Starting subtest: modeset-vs-vblank-race-interruptible
[554.456574] Starting dynamic subtest: A-DP3
[557.621527] Dynamic subtest A-DP3: SUCCESS (3.164s)
[557.664892] Starting dynamic subtest: B-DP3
[560.846270] Dynamic subtest B-DP3: SUCCESS (3.219s)
[560.889219] Starting dynamic subtest: C-DP3
[564.101134] Dynamic subtest C-DP3: SUCCESS (3.249s)
[564.144357] Starting dynamic subtest: D-DP3
[567.321306] Dynamic subtest D-DP3: SUCCESS (3.214s)
[567.330117] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.877s)
[567.728208] [FACT kms_flip (modeset-vs-vblank-race-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[567.730769] [FACT kms_flip (modeset-vs-vblank-race-interruptible)] new: kernel.kmod_is_loaded.i915: true
[567.733641] [089/130] (460s left) kms_frontbuffer_tracking (fbc-tiling-4)
[567.928216] Starting subtest: fbc-tiling-4
[570.583754] Subtest fbc-tiling-4: SUCCESS (2.656s)
[570.786567] [090/130] (457s left) gem_ctx_persistence (legacy-engines-mixed-process)
[570.873438] Starting subtest: legacy-engines-mixed-process
[570.874517] Starting dynamic subtest: render
[572.861728] Dynamic subtest render: SUCCESS (1.989s)
[572.874576] Starting dynamic subtest: bsd1
[574.898553] Dynamic subtest bsd1: SUCCESS (2.035s)
[574.911212] Starting dynamic subtest: bsd2
[576.899031] Dynamic subtest bsd2: SUCCESS (1.999s)
[576.911926] Starting dynamic subtest: blt
[578.879461] Dynamic subtest blt: SUCCESS (1.979s)
[578.892615] Starting dynamic subtest: vebox
[580.868040] Dynamic subtest vebox: SUCCESS (1.986s)
[580.868997] Subtest legacy-engines-mixed-process: SUCCESS (9.996s)
[581.015325] [091/130] (447s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[581.205273] Starting subtest: disable-crc-after-crtc
[581.206175] Starting dynamic subtest: pipe-A-DP-3
[581.956446] Dynamic subtest pipe-A-DP-3: SUCCESS (0.750s)
[581.974474] Starting dynamic subtest: pipe-B-DP-3
[582.577410] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s)
[582.591651] Starting dynamic subtest: pipe-C-DP-3
[583.163237] Dynamic subtest pipe-C-DP-3: SUCCESS (0.583s)
[583.176213] Starting dynamic subtest: pipe-D-DP-3
[583.754483] Dynamic subtest pipe-D-DP-3: SUCCESS (0.589s)
[583.755422] Subtest disable-crc-after-crtc: SUCCESS (2.550s)
[584.063921] [092/130] (444s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[584.257362] Starting subtest: x-tiled-8bpp-rotate-270
[584.313651] Subtest x-tiled-8bpp-rotate-270: SKIP (0.056s)
[584.531186] [093/130] (443s left) gem_partial_pwrite_pread (reads-display)
[584.617553] Subtest reads-display: SKIP (0.000s)
[584.689447] [094/130] (443s left) gem_partial_pwrite_pread (write-display)
[584.771418] Subtest write-display: SKIP (0.000s)
[584.862669] [095/130] (443s left) gem_exec_reloc (basic-cpu-noreloc)
[584.944618] Subtest basic-cpu-noreloc: SKIP (0.000s)
[585.023990] [096/130] (443s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[585.213216] Starting subtest: blocking-absolute-wf_vblank-interruptible
[585.218073] Starting dynamic subtest: A-DP3
[593.028607] Dynamic subtest A-DP3: SUCCESS (7.810s)
[593.042222] Starting dynamic subtest: B-DP3
[600.777460] Dynamic subtest B-DP3: SUCCESS (7.747s)
[600.790675] Starting dynamic subtest: C-DP3
[608.524401] Dynamic subtest C-DP3: SUCCESS (7.745s)
[608.537455] Starting dynamic subtest: D-DP3
[616.293467] Dynamic subtest D-DP3: SUCCESS (7.767s)
[616.295763] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.081s)
[616.695869] [097/130] (412s left) sw_sync (sync_multi_producer_single_consumer)
[616.743697] Starting subtest: sync_multi_producer_single_consumer
[617.819121] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[617.950453] [098/130] (410s left) gen7_exec_parse (basic-allocation)
[618.041302] Subtest basic-allocation: SKIP (0.000s)
[618.183095] [099/130] (410s left) kms_atomic (crtc-invalid-params)
[618.366620] Starting subtest: crtc-invalid-params
[618.376129] Starting dynamic subtest: pipe-A-DP-3
[618.937847] Dynamic subtest pipe-A-DP-3: SUCCESS (0.568s)
[618.939013] Subtest crtc-invalid-params: SUCCESS (0.571s)
[619.309167] [100/130] (409s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[619.398581] Starting subtest: map-fixed-invalidate-overlap
[619.400417] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[619.566355] [101/130] (409s left) kms_cursor_crc (cursor-sliding-256x256)
[619.983329] Starting subtest: cursor-sliding-256x256
[619.988406] Starting dynamic subtest: pipe-A-DP-3
[624.415248] Dynamic subtest pipe-A-DP-3: SUCCESS (4.427s)
[624.469174] Starting dynamic subtest: pipe-D-DP-3
[628.778630] Dynamic subtest pipe-D-DP-3: SUCCESS (4.320s)
[628.779606] Subtest cursor-sliding-256x256: SUCCESS (8.795s)
[629.231346] [102/130] (399s left) kms_dp_linktrain_fallback (dsc-fallback)
[629.417711] Starting subtest: dsc-fallback
[629.420265] Subtest dsc-fallback: SKIP (0.000s)
[629.578105] [103/130] (399s left) gem_softpin (softpin)
[629.664614] Starting subtest: softpin
[661.929463] Subtest softpin: SUCCESS (32.262s)
[662.092230] [104/130] (367s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[662.289180] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[662.290893] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[662.496413] [105/130] (366s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[662.686356] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[662.687261] Starting dynamic subtest: pipe-A-valid-mode
[665.610761] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.923s)
[665.616524] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.927s)
[665.919366] [106/130] (363s left) prime_busy (hang)
[666.000842] Starting subtest: hang
[666.003210] Starting dynamic subtest: rcs0
[692.534592] Dynamic subtest rcs0: SUCCESS (26.530s)
[692.545656] Starting dynamic subtest: bcs0
[699.631217] Dynamic subtest bcs0: SUCCESS (7.095s)
[699.642314] Starting dynamic subtest: vcs0
[706.663864] Dynamic subtest vcs0: SUCCESS (7.031s)
[706.675066] Starting dynamic subtest: vcs1
[713.645237] Dynamic subtest vcs1: SUCCESS (6.979s)
[713.656384] Starting dynamic subtest: vecs0
[720.621166] Dynamic subtest vecs0: SUCCESS (6.974s)
[720.632158] Starting dynamic subtest: vecs1
[727.654900] Dynamic subtest vecs1: SUCCESS (7.035s)
[727.667409] Starting dynamic subtest: ccs0
[741.494571] Dynamic subtest ccs0: SUCCESS (13.837s)
[741.495539] Subtest hang: SUCCESS (75.491s)
[741.666327] [107/130] (287s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[741.858602] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[741.859479] Starting dynamic subtest: pipe-A
[744.073789] Dynamic subtest pipe-A: SUCCESS (2.214s)
[744.092790] Starting dynamic subtest: pipe-B
[746.285754] Dynamic subtest pipe-B: SUCCESS (2.210s)
[746.313622] Starting dynamic subtest: pipe-C
[746.600068] Dynamic subtest pipe-C: SUCCESS (0.312s)
[746.628437] Starting dynamic subtest: pipe-D
[746.912963] Dynamic subtest pipe-D: SUCCESS (0.311s)
[746.914036] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.055s)
[747.257516] [108/130] (282s left) kms_addfb_basic (addfb25-bad-modifier)
[747.446299] Starting subtest: addfb25-bad-modifier
[747.447177] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[747.636713] [109/130] (281s left) gem_exec_balancer (parallel-ordering)
[747.978047] Starting subtest: parallel-ordering
[749.643369] Subtest parallel-ordering: SUCCESS (1.665s)
[749.827632] [110/130] (279s left) kms_flip (2x-plain-flip-fb-recreate)
[750.017877] Starting subtest: 2x-plain-flip-fb-recreate
[750.033378] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[750.222383] [111/130] (279s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[750.308464] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[750.395022] [112/130] (279s left) gem_eio (in-flight-1us)
[750.679931] Starting subtest: in-flight-1us
[755.709771] Subtest in-flight-1us: SUCCESS (5.030s)
[756.010756] [113/130] (273s left) kms_flip_event_leak (basic)
[756.195262] Starting subtest: basic
[756.196170] Starting dynamic subtest: pipe-A-DP-3
[756.571270] Dynamic subtest pipe-A-DP-3: SUCCESS (0.375s)
[756.595231] Starting dynamic subtest: pipe-B-DP-3
[756.866612] Dynamic subtest pipe-B-DP-3: SUCCESS (0.291s)
[756.885663] Starting dynamic subtest: pipe-C-DP-3
[757.141691] Dynamic subtest pipe-C-DP-3: SUCCESS (0.273s)
[757.161821] Starting dynamic subtest: pipe-D-DP-3
[757.445375] Dynamic subtest pipe-D-DP-3: SUCCESS (0.301s)
[757.446461] Subtest basic: SUCCESS (1.252s)
[757.740380] [114/130] (272s left) kms_addfb_basic (clobberred-modifier)
[757.830953] Starting subtest: clobberred-modifier
[757.832701] Subtest clobberred-modifier: SKIP (0.000s)
[758.139837] [115/130] (271s left) dmabuf_sync_file (export-wait-after-attach)
[758.206271] Starting subtest: export-wait-after-attach
[758.207175] Subtest export-wait-after-attach: SUCCESS (0.001s)
[758.375128] [116/130] (271s left) kms_psr (pr-dpms)
[758.562204] Subtest pr-dpms: SKIP (0.000s)
[758.616907] [117/130] (271s left) kms_pwrite_crc
[759.719631] [118/130] (270s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[760.089592] Starting subtest: cursor-rapid-movement-128x128
[760.094618] Starting dynamic subtest: pipe-A-DP-3
[760.564505] Dynamic subtest pipe-A-DP-3: SUCCESS (0.470s)
[760.610780] Starting dynamic subtest: pipe-D-DP-3
[760.984573] Dynamic subtest pipe-D-DP-3: SUCCESS (0.385s)
[760.985511] Subtest cursor-rapid-movement-128x128: SUCCESS (0.896s)
[761.479558] [119/130] (268s left) kms_chamelium_hpd (common-hpd-after-suspend)
[761.745515] Subtest common-hpd-after-suspend: SKIP (0.000s)
[761.899511] [120/130] (268s left) i915_query (query-topology-garbage-items)
[761.976651] Starting subtest: query-topology-garbage-items
[761.977593] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[762.172031] [121/130] (268s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[762.361126] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[762.362838] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[762.566786] [122/130] (268s left) kms_scaling_modes (scaling-mode-center)
[762.759279] Starting subtest: scaling-mode-center
[762.764391] Subtest scaling-mode-center: SKIP (0.001s)
[762.920504] [123/130] (267s left) kms_pm_rpm (pm-caching)
[765.036525] Starting subtest: pm-caching
[765.038610] Subtest pm-caching: SKIP (0.000s)
[765.391778] [124/130] (265s left) kms_psr (fbc-pr-primary-mmap-gtt)
[765.577720] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[765.636337] [125/130] (265s left) kms_psr (fbc-psr-basic)
[765.823562] Subtest fbc-psr-basic: SKIP (0.000s)
[765.885171] [126/130] (264s left) gem_exec_fence (syncobj-timeline-signal)
[766.538959] Starting subtest: syncobj-timeline-signal
[766.593167] Subtest syncobj-timeline-signal: SUCCESS (0.058s)
[766.909218] [127/130] (263s left) gem_eio (wait-wedge-immediate)
[767.197641] Starting subtest: wait-wedge-immediate
[768.893256] Subtest wait-wedge-immediate: SUCCESS (1.696s)
[769.156618] [128/130] (261s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[769.339766] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[769.342014] Starting dynamic subtest: pipe-A-DP-3
[769.350169] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[769.361318] Starting dynamic subtest: pipe-B-DP-3
[769.369554] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[769.380536] Starting dynamic subtest: pipe-C-DP-3
[769.391376] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[769.402536] Starting dynamic subtest: pipe-D-DP-3
[769.413093] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[769.415023] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[769.835769] [129/130] (261s left) gen9_exec_parse (batch-zero-length)
[769.914426] Subtest batch-zero-length: SKIP (0.000s)
[769.999534] [130/130] (261s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[770.190151] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[770.191851] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[770.385758] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: i915_pm_rpm
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_ctx_bad_destroy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: fbdev
results: parsing output: 18/ for test: syncobj_basic
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_cs_tlb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: i915_pm_freq_api
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_tiled_pread_basic
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_plane_lowres
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_atomic_interruptible
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: drm_read
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: kms_sequence
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gen3_render_tiledx_blits
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: gem_ctx_bad_destroy
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_partial_pwrite_pread
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: gen7_exec_parse
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_dp_linktrain_fallback
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: prime_busy
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_flip_event_leak
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_pwrite_crc
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_scaling_modes
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.