[63.067608] Initializing watchdogs
[63.067675]   /dev/watchdog0
[63.088239] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.099470] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.103236] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.106181] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[63.301764] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[63.303409] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.498886] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[63.682494] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[63.684190] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[63.831952] [003/131] (959s left) kms_plane_multiple (2x-tiling-none)
[64.011448] Starting subtest: 2x-tiling-none
[64.013282] Subtest 2x-tiling-none: SKIP (0.000s)
[64.149940] [004/131] (959s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[64.333980] Starting subtest: basic-max-pipe-crc-check
[64.336386] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[64.384249] [005/131] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[64.569328] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[67.149500] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.608s)
[67.532094] [006/131] (956s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[67.954713] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[68.087660] [007/131] (955s left) perf_pmu (invalid-init)
[68.156218] Starting subtest: invalid-init
[68.157162] Subtest invalid-init: SUCCESS (0.000s)
[68.317465] [008/131] (955s left) kms_cursor_edge_walk (64x64-top-edge)
[68.494595] Starting subtest: 64x64-top-edge
[68.496413] Starting dynamic subtest: pipe-A-DP-3
[71.994639] Dynamic subtest pipe-A-DP-3: SUCCESS (3.519s)
[72.004971] Starting dynamic subtest: pipe-D-DP-3
[75.311926] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[75.313059] Subtest 64x64-top-edge: SUCCESS (6.850s)
[75.654096] [009/131] (948s left) gem_render_copy_redux (flink-interruptible)
[75.732444] Starting subtest: flink-interruptible
[78.560293] Subtest flink-interruptible: SUCCESS (2.834s)
[78.796978] [010/131] (945s left) kms_atomic (plane-invalid-params-fence)
[78.978075] Starting subtest: plane-invalid-params-fence
[78.978959] Starting dynamic subtest: pipe-A-DP-3
[79.506796] Dynamic subtest pipe-A-DP-3: SUCCESS (0.528s)
[79.507845] Subtest plane-invalid-params-fence: SUCCESS (0.530s)
[79.828963] [011/131] (944s left) sysfs_heartbeat_interval (nopreempt)
[79.906653] Starting subtest: nopreempt
[79.907522] Starting dynamic subtest: vecs0
[84.247336] Dynamic subtest vecs0: SUCCESS (4.345s)
[84.255707] Starting dynamic subtest: ccs0
[88.505186] Dynamic subtest ccs0: SUCCESS (4.260s)
[88.513690] Starting dynamic subtest: vcs0
[92.762362] Dynamic subtest vcs0: SUCCESS (4.258s)
[92.771550] Starting dynamic subtest: bcs0
[96.996790] Dynamic subtest bcs0: SUCCESS (4.234s)
[97.005514] Starting dynamic subtest: vecs1
[101.219986] Dynamic subtest vecs1: SUCCESS (4.223s)
[101.229241] Starting dynamic subtest: rcs0
[105.535571] Dynamic subtest rcs0: SUCCESS (4.315s)
[105.544182] Starting dynamic subtest: vcs1
[109.780459] Dynamic subtest vcs1: SUCCESS (4.245s)
[109.781421] Subtest nopreempt: SUCCESS (29.883s)
[109.986223] [012/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[110.169577] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[110.171253] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[110.366118] [013/131] (914s left) gem_ctx_engines (independent)
[110.452091] Starting subtest: independent
[110.453074] Starting dynamic subtest: rcs0
[110.626585] Dynamic subtest rcs0: SUCCESS (0.174s)
[110.635377] Starting dynamic subtest: bcs0
[110.791434] Dynamic subtest bcs0: SUCCESS (0.164s)
[110.800058] Starting dynamic subtest: vcs0
[110.962012] Dynamic subtest vcs0: SUCCESS (0.170s)
[110.970842] Starting dynamic subtest: vcs1
[111.141767] Dynamic subtest vcs1: SUCCESS (0.179s)
[111.150654] Starting dynamic subtest: vecs0
[111.312244] Dynamic subtest vecs0: SUCCESS (0.170s)
[111.320625] Starting dynamic subtest: vecs1
[111.483982] Dynamic subtest vecs1: SUCCESS (0.171s)
[111.492534] Starting dynamic subtest: ccs0
[111.658550] Dynamic subtest ccs0: SUCCESS (0.174s)
[111.667290] Starting dynamic subtest: all-engines
[112.169872] Dynamic subtest all-engines: SUCCESS (0.511s)
[112.170776] Subtest independent: SUCCESS (1.718s)
[112.905918] [014/131] (911s left) perf (disabled-read-error)
[113.353418] Starting subtest: disabled-read-error
[113.388066] Subtest disabled-read-error: SUCCESS (0.035s)
[113.453124] [015/131] (911s left) gem_userptr_blits (sync-unmap-after-close)
[113.539761] Starting subtest: sync-unmap-after-close
[113.561513] Subtest sync-unmap-after-close: SUCCESS (0.022s)
[113.780620] [016/131] (910s left) vgem_basic (dmabuf-fence-before)
[113.889467] Starting subtest: dmabuf-fence-before
[113.890432] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[114.053425] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[114.055482] [017/131] (910s left) dumb_buffer (map-valid)
[114.135130] Starting subtest: map-valid
[114.136162] Subtest map-valid: SUCCESS (0.000s)
[114.321162] [018/131] (910s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[114.512579] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[114.567053] [019/131] (910s left) gem_exec_schedule (u-semaphore-user)
[114.662508] Starting subtest: u-semaphore-user
[114.749280] Subtest u-semaphore-user: SUCCESS (0.087s)
[115.205440] [020/131] (909s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[115.398635] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[115.400385] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[115.585617] [021/131] (909s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[115.777980] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[115.778912] Starting dynamic subtest: pipe-A-valid-mode
[118.240440] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.459s)
[118.241949] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.461s)
[118.568918] [022/131] (906s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[118.756494] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[118.757418] Starting dynamic subtest: pipe-A
[118.848904] Dynamic subtest pipe-A: SUCCESS (0.092s)
[118.859214] Starting dynamic subtest: pipe-B
[119.047127] Dynamic subtest pipe-B: SUCCESS (0.198s)
[119.061888] Starting dynamic subtest: pipe-C
[119.278208] Dynamic subtest pipe-C: SUCCESS (0.231s)
[119.287200] Starting dynamic subtest: pipe-D
[119.475143] Dynamic subtest pipe-D: SUCCESS (0.196s)
[119.476223] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.719s)
[119.817055] [023/131] (905s left) kms_psr (psr-sprite-blt)
[120.007955] Subtest psr-sprite-blt: SKIP (0.000s)
[120.067717] [024/131] (905s left) kms_psr (pr-basic)
[120.266466] Subtest pr-basic: SKIP (0.000s)
[120.319408] [025/131] (905s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[120.404425] Starting subtest: etime-multi-wait-available-unsubmitted
[120.511066] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s)
[120.680401] [026/131] (904s left) gem_lmem_swapping (parallel-random-verify-ccs)
[123.440858] Starting subtest: parallel-random-verify-ccs
[123.441717] Starting dynamic subtest: lmem0
[189.480830] Dynamic subtest lmem0: SUCCESS (66.040s)
[189.481768] Subtest parallel-random-verify-ccs: SUCCESS (66.040s)
[190.701429] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[190.702378] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[190.704245] [027/131] (834s left) syncobj_wait (wait-for-submit-complex)
[192.301899] Starting subtest: wait-for-submit-complex
[192.363446] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[192.412942] [FACT syncobj_wait (wait-for-submit-complex)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[192.415653] [FACT syncobj_wait (wait-for-submit-complex)] new: kernel.kmod_is_loaded.i915: true
[192.418151] [028/131] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[192.617742] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[192.619430] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[192.822720] [029/131] (832s left) gem_eio (in-flight-1us)
[193.073500] Starting subtest: in-flight-1us
[197.369790] Subtest in-flight-1us: SUCCESS (4.297s)
[197.608980] [030/131] (828s left) gem_exec_async (forked-writes)
[197.699104] Starting subtest: forked-writes
[197.700117] Starting dynamic subtest: rcs0
[197.763641] Dynamic subtest rcs0: SUCCESS (0.064s)
[197.776700] Starting dynamic subtest: bcs0
[197.804537] Dynamic subtest bcs0: SUCCESS (0.041s)
[197.814319] Starting dynamic subtest: vcs0
[197.841372] Dynamic subtest vcs0: SUCCESS (0.036s)
[197.850931] Starting dynamic subtest: vcs1
[197.876160] Dynamic subtest vcs1: SUCCESS (0.034s)
[197.885795] Starting dynamic subtest: vecs0
[197.910621] Dynamic subtest vecs0: SUCCESS (0.034s)
[197.920243] Starting dynamic subtest: vecs1
[197.945807] Dynamic subtest vecs1: SUCCESS (0.034s)
[197.955447] Starting dynamic subtest: ccs0
[197.980610] Dynamic subtest ccs0: SUCCESS (0.034s)
[197.981526] Subtest forked-writes: SUCCESS (0.282s)
[198.343788] [031/131] (827s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[198.421990] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[198.504847] [032/131] (827s left) gen7_exec_parse (oacontrol-tracking)
[198.592453] Subtest oacontrol-tracking: SKIP (0.000s)
[198.695786] [033/131] (827s left) kms_psr (psr-primary-blt)
[198.892388] Subtest psr-primary-blt: SKIP (0.000s)
[198.950331] [034/131] (826s left) kms_lease (cursor-implicit-plane)
[199.138291] Starting subtest: cursor-implicit-plane
[199.139198] Starting dynamic subtest: pipe-A-DP-3
[199.533236] Dynamic subtest pipe-A-DP-3: SUCCESS (0.394s)
[199.546149] Starting dynamic subtest: pipe-B-DP-3
[199.805551] Dynamic subtest pipe-B-DP-3: SUCCESS (0.272s)
[199.817785] Starting dynamic subtest: pipe-C-DP-3
[200.130768] Dynamic subtest pipe-C-DP-3: SUCCESS (0.323s)
[200.142356] Starting dynamic subtest: pipe-D-DP-3
[200.448142] Dynamic subtest pipe-D-DP-3: SUCCESS (0.315s)
[200.449124] Subtest cursor-implicit-plane: SUCCESS (1.310s)
[200.805010] [035/131] (825s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[201.025714] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[202.137094] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.111s)
[202.309592] [036/131] (823s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[202.512402] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[202.565711] [037/131] (823s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[202.652935] Starting subtest: y-tiled-to-vebox-x-tiled
[202.655424] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[202.889051] [038/131] (823s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[203.079158] Starting subtest: plane-all-modeset-transition-internal-panels
[203.080986] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[203.202987] [039/131] (823s left) kms_cursor_crc (cursor-offscreen-512x170)
[203.703561] Starting subtest: cursor-offscreen-512x170
[203.706576] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[203.955594] [040/131] (822s left) kms_color (ctm-max)
[204.152382] Starting subtest: ctm-max
[204.153345] Starting dynamic subtest: pipe-A-DP-3
[204.883757] Dynamic subtest pipe-A-DP-3: SUCCESS (0.730s)
[204.902402] Starting dynamic subtest: pipe-B-DP-3
[205.465390] Dynamic subtest pipe-B-DP-3: SUCCESS (0.580s)
[205.479180] Starting dynamic subtest: pipe-C-DP-3
[206.093147] Dynamic subtest pipe-C-DP-3: SUCCESS (0.627s)
[206.103125] Starting dynamic subtest: pipe-D-DP-3
[206.721590] Dynamic subtest pipe-D-DP-3: SUCCESS (0.628s)
[206.722616] Subtest ctm-max: SUCCESS (2.569s)
[207.063738] [041/131] (819s left) kms_atomic_interruptible (universal-setplane-primary)
[207.255442] Starting subtest: universal-setplane-primary
[207.257485] Starting dynamic subtest: pipe-A-DP-3
[213.574653] Dynamic subtest pipe-A-DP-3: SUCCESS (6.316s)
[213.575731] Subtest universal-setplane-primary: SUCCESS (6.318s)
[213.892054] [042/131] (812s left) kms_vblank (crtc-id)
[214.081499] Starting subtest: crtc-id
[214.083573] Starting dynamic subtest: pipe-A-DP-3
[214.474858] Dynamic subtest pipe-A-DP-3: SUCCESS (0.391s)
[214.491451] Starting dynamic subtest: pipe-D-DP-3
[214.791575] Dynamic subtest pipe-D-DP-3: SUCCESS (0.312s)
[214.792561] Subtest crtc-id: SUCCESS (0.710s)
[215.071249] [043/131] (811s left) perf_pmu (semaphore-wait)
[215.146226] Starting subtest: semaphore-wait
[215.147182] Starting dynamic subtest: rcs0
[215.685748] Dynamic subtest rcs0: SUCCESS (0.539s)
[215.698194] Starting dynamic subtest: bcs0
[216.198147] Dynamic subtest bcs0: SUCCESS (0.510s)
[216.212389] Starting dynamic subtest: vcs0
[216.711505] Dynamic subtest vcs0: SUCCESS (0.510s)
[216.725709] Starting dynamic subtest: vcs1
[217.225318] Dynamic subtest vcs1: SUCCESS (0.510s)
[217.239196] Starting dynamic subtest: vecs0
[217.738564] Dynamic subtest vecs0: SUCCESS (0.509s)
[217.752735] Starting dynamic subtest: vecs1
[218.253055] Dynamic subtest vecs1: SUCCESS (0.510s)
[218.267224] Starting dynamic subtest: ccs0
[218.767118] Dynamic subtest ccs0: SUCCESS (0.510s)
[218.769130] Subtest semaphore-wait: SUCCESS (3.622s)
[218.948986] [044/131] (807s left) gem_softpin (allocator-basic)
[219.036203] Starting subtest: allocator-basic
[219.261834] Subtest allocator-basic: SUCCESS (0.225s)
[219.477833] [045/131] (807s left) gem_pxp (create-regular-context-2)
[222.087682] Starting subtest: create-regular-context-2
[222.089628] Subtest create-regular-context-2: SKIP (0.000s)
[222.232893] [046/131] (804s left) i915_pm_rpm (reg-read-ioctl)
[224.070742] Starting subtest: reg-read-ioctl
[224.819223] Subtest reg-read-ioctl: SUCCESS (0.751s)
[225.264775] [047/131] (801s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[225.467755] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[225.469490] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[225.677321] [048/131] (801s left) kms_prop_blob (invalid-get-prop)
[225.756571] Starting subtest: invalid-get-prop
[225.757460] Subtest invalid-get-prop: SUCCESS (0.000s)
[225.944553] [049/131] (801s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[226.132927] Starting subtest: bad-aux-stride-yf-tiled-ccs
[226.135180] Starting dynamic subtest: pipe-A-DP-3
[226.143717] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[226.154564] Starting dynamic subtest: pipe-B-DP-3
[226.163336] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[226.173928] Starting dynamic subtest: pipe-C-DP-3
[226.182312] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[226.192775] Starting dynamic subtest: pipe-D-DP-3
[226.203039] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[226.204959] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s)
[226.605908] [050/131] (800s left) gem_exec_params (invalid-batch-start-offset)
[226.694290] Starting subtest: invalid-batch-start-offset
[226.696470] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[226.900473] [051/131] (800s left) gem_exec_params (secure-non-master)
[226.987263] Starting subtest: secure-non-master
[226.989378] Subtest secure-non-master: SKIP (0.000s)
[227.135828] [052/131] (800s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[227.337203] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[228.633616] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.296s)
[228.801650] [053/131] (798s left) api_intel_bb (object-noreloc-purge-cache-simple)
[228.881430] Starting subtest: object-noreloc-purge-cache-simple
[228.910053] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.030s)
[229.170768] [054/131] (798s left) kms_cursor_crc (cursor-sliding-32x10)
[229.486505] Starting subtest: cursor-sliding-32x10
[229.539240] Subtest cursor-sliding-32x10: SKIP (0.050s)
[229.960165] [055/131] (797s left) gem_mmap_gtt (basic-small-copy-odd)
[230.041199] Subtest basic-small-copy-odd: SKIP (0.000s)
[230.111374] [056/131] (797s left) i915_drm_fdinfo (busy-check-all)
[230.186251] Starting subtest: busy-check-all
[230.187160] Starting dynamic subtest: rcs0
[230.216965] Dynamic subtest rcs0: SKIP (0.031s)
[230.227948] Starting dynamic subtest: bcs0
[230.230405] Dynamic subtest bcs0: SKIP (0.000s)
[230.241250] Starting dynamic subtest: vcs0
[230.243553] Dynamic subtest vcs0: SKIP (0.000s)
[230.254362] Starting dynamic subtest: vcs1
[230.256809] Dynamic subtest vcs1: SKIP (0.000s)
[230.267212] Starting dynamic subtest: vecs0
[230.269546] Dynamic subtest vecs0: SKIP (0.000s)
[230.279879] Starting dynamic subtest: vecs1
[230.281992] Dynamic subtest vecs1: SKIP (0.000s)
[230.292903] Starting dynamic subtest: ccs0
[230.295182] Dynamic subtest ccs0: SKIP (0.000s)
[230.297495] Subtest busy-check-all: SKIP (0.039s)
[230.343925] [057/131] (797s left) gem_ctx_persistence (legacy-engines-cleanup)
[230.455055] Starting subtest: legacy-engines-cleanup
[230.456184] Starting dynamic subtest: render
[230.568369] Dynamic subtest render: SUCCESS (0.113s)
[230.582069] Starting dynamic subtest: bsd1
[230.610591] Dynamic subtest bsd1: SUCCESS (0.040s)
[230.625625] Starting dynamic subtest: bsd2
[230.674604] Dynamic subtest bsd2: SUCCESS (0.062s)
[230.706092] Starting dynamic subtest: blt
[230.722447] Dynamic subtest blt: SUCCESS (0.043s)
[230.750690] Starting dynamic subtest: vebox
[230.771362] Dynamic subtest vebox: SUCCESS (0.046s)
[230.772396] Subtest legacy-engines-cleanup: SUCCESS (0.317s)
[231.003812] [058/131] (796s left) kms_rotation_crc (sprite-rotation-90)
[231.190903] Starting subtest: sprite-rotation-90
[231.192639] Subtest sprite-rotation-90: SKIP (0.001s)
[231.313792] [059/131] (796s left) gem_exec_fence (concurrent)
[231.522721] Starting subtest: concurrent
[231.524774] Subtest concurrent: SKIP (0.000s)
[232.246564] [060/131] (795s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[232.443431] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[232.497038] [061/131] (795s left) prime_mmap (test_errors)
[232.578768] Starting subtest: test_errors
[232.579644] Starting dynamic subtest: test_errors-smem
[232.731954] Dynamic subtest test_errors-smem: SUCCESS (0.152s)
[232.743055] Starting dynamic subtest: test_errors-lmem0
[233.355153] Dynamic subtest test_errors-lmem0: SUCCESS (0.622s)
[233.356153] Subtest test_errors: SUCCESS (0.777s)
[233.538130] [062/131] (794s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[233.735556] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[233.752062] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.016s)
[233.921534] [063/131] (794s left) gem_exec_suspend (basic-s4-devices)
[234.017189] Starting subtest: basic-S4-devices
[234.018172] Starting dynamic subtest: smem
[244.368963] Dynamic subtest smem: SUCCESS (10.351s)
[244.381367] Starting dynamic subtest: lmem0
[254.651385] Dynamic subtest lmem0: SUCCESS (10.281s)
[254.652500] Subtest basic-S4-devices: SUCCESS (20.634s)
[273.012073] [064/131] (773s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[273.204987] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[273.207238] Starting dynamic subtest: pipe-A-valid-mode
[275.633812] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.426s)
[275.635133] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.428s)
[275.959528] [065/131] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[276.153257] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[276.155053] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.330186] [066/131] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[276.523290] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[276.525056] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.724101] [067/131] (769s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[276.806552] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[276.807605] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[277.007292] [068/131] (769s left) i915_pm_sseu (full-enable)
[277.095431] Subtest full-enable: SKIP (0.000s)
[277.261255] [069/131] (769s left) kms_fbcon_fbt (psr-suspend)
[277.346464] Starting subtest: psr-suspend
[277.348262] Subtest psr-suspend: SKIP (0.000s)
[277.508459] [070/131] (769s left) perf_pmu (busy-idle-check-all)
[277.581638] Starting subtest: busy-idle-check-all
[277.582540] Starting dynamic subtest: rcs0
[278.285789] Dynamic subtest rcs0: SUCCESS (0.703s)
[278.325905] Starting dynamic subtest: bcs0
[278.964946] Dynamic subtest bcs0: SUCCESS (0.676s)
[278.981538] Starting dynamic subtest: vcs0
[279.621971] Dynamic subtest vcs0: SUCCESS (0.652s)
[279.643566] Starting dynamic subtest: vcs1
[280.286114] Dynamic subtest vcs1: SUCCESS (0.659s)
[280.307170] Starting dynamic subtest: vecs0
[280.949872] Dynamic subtest vecs0: SUCCESS (0.659s)
[280.971056] Starting dynamic subtest: vecs1
[281.613727] Dynamic subtest vecs1: SUCCESS (0.659s)
[281.634776] Starting dynamic subtest: ccs0
[282.276877] Dynamic subtest ccs0: SUCCESS (0.658s)
[282.283194] Subtest busy-idle-check-all: SUCCESS (4.697s)
[282.458375] [071/131] (764s left) gem_workarounds (reset-fd)
[282.556329] Starting subtest: reset-fd
[282.747605] Subtest reset-fd: SUCCESS (0.191s)
[282.915663] [072/131] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[283.110998] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[283.112821] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[283.275245] [073/131] (763s left) kms_chamelium_color (ctm-0-50)
[283.469471] Subtest ctm-0-50: SKIP (0.000s)
[283.534833] [074/131] (763s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[283.722452] Starting subtest: flip-vs-cursor-crc-atomic
[284.311533] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.589s)
[284.617797] [075/131] (762s left) kms_pm_dc (dc9-dpms)
[285.820784] Starting subtest: dc9-dpms
[286.321879] Subtest dc9-dpms: SUCCESS (0.502s)
[286.574414] [076/131] (760s left) gem_mmap_gtt (zero-extend)
[286.657196] Subtest zero-extend: SKIP (0.000s)
[286.723376] [077/131] (760s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[286.917427] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[286.919170] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[287.135749] [078/131] (760s left) syncobj_timeline (etime-multi-wait-submitted)
[287.216418] Starting subtest: etime-multi-wait-submitted
[287.326548] Subtest etime-multi-wait-submitted: SUCCESS (0.109s)
[287.519060] [079/131] (759s left) gem_mmap_gtt (big-copy-xy)
[287.601014] Subtest big-copy-XY: SKIP (0.000s)
[287.677131] [080/131] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[287.870420] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[287.872147] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[288.066143] [081/131] (759s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[288.258761] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[288.324724] [082/131] (759s left) syncobj_eventfd (binary-wait-before-signal)
[288.401581] Starting subtest: binary-wait-before-signal
[288.432694] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[288.601779] [083/131] (758s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[288.797322] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[288.799125] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[289.016629] [084/131] (758s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[289.208780] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[289.209648] Starting dynamic subtest: pipe-A
[289.793167] Dynamic subtest pipe-A: SUCCESS (0.584s)
[289.814656] Starting dynamic subtest: pipe-B
[290.442190] Dynamic subtest pipe-B: SUCCESS (0.648s)
[290.459275] Starting dynamic subtest: pipe-C
[291.072562] Dynamic subtest pipe-C: SUCCESS (0.629s)
[291.102459] Starting dynamic subtest: pipe-D
[291.718448] Dynamic subtest pipe-D: SUCCESS (0.643s)
[291.719525] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.511s)
[292.105745] [085/131] (755s left) sw_sync (sync_busy_fork_unixsocket)
[292.155972] Starting subtest: sync_busy_fork_unixsocket
[292.164935] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[292.330502] [086/131] (755s left) gem_exec_create (basic)
[292.420456] Starting subtest: basic
[292.421436] Starting dynamic subtest: smem
[294.516996] Dynamic subtest smem: SUCCESS (2.096s)
[294.533467] Starting dynamic subtest: lmem0
[296.621784] Dynamic subtest lmem0: SUCCESS (2.104s)
[296.622679] Subtest basic: SUCCESS (4.202s)
[296.885591] [087/131] (751s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[297.074775] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[297.077302] Starting dynamic subtest: pipe-A-DP-3
[297.085862] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[297.098554] Starting dynamic subtest: pipe-B-DP-3
[297.107213] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[297.119773] Starting dynamic subtest: pipe-C-DP-3
[297.128133] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[297.140730] Starting dynamic subtest: pipe-D-DP-3
[297.151081] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[297.153524] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[297.588497] [088/131] (750s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[297.778397] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[297.779296] Starting dynamic subtest: pipe-A-DP-3
[297.787902] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[297.800407] Starting dynamic subtest: pipe-B-DP-3
[297.809143] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[297.821443] Starting dynamic subtest: pipe-C-DP-3
[297.829947] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[297.842321] Starting dynamic subtest: pipe-D-DP-3
[297.852280] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[297.854296] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[298.286275] [089/131] (749s left) syncobj_wait (wait-all-snapshot)
[298.366499] Starting subtest: wait-all-snapshot
[298.449674] Subtest wait-all-snapshot: SUCCESS (0.082s)
[298.607938] [090/131] (749s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[298.797486] Starting subtest: bad-pixel-format-y-tiled-ccs
[298.798418] Starting dynamic subtest: pipe-A-DP-3
[298.807041] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[298.820155] Starting dynamic subtest: pipe-B-DP-3
[298.829011] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[298.841561] Starting dynamic subtest: pipe-C-DP-3
[298.849950] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[298.862645] Starting dynamic subtest: pipe-D-DP-3
[298.873895] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[298.876152] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[299.278886] [091/131] (749s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[299.477507] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[299.478421] Starting dynamic subtest: pipe-A-DP-3
[299.487055] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[299.499913] Starting dynamic subtest: pipe-B-DP-3
[299.508532] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[299.521475] Starting dynamic subtest: pipe-C-DP-3
[299.529841] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[299.542393] Starting dynamic subtest: pipe-D-DP-3
[299.552446] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[299.554326] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[299.973397] [092/131] (748s left) gem_ctx_shared (create-shared-gtt)
[300.067313] Starting subtest: create-shared-gtt
[302.218486] Subtest create-shared-gtt: SUCCESS (2.150s)
[304.811105] [093/131] (743s left) prime_mmap (test_reprime)
[304.897928] Starting subtest: test_reprime
[304.898867] Starting dynamic subtest: test_reprime-smem
[304.948932] Dynamic subtest test_reprime-smem: SUCCESS (0.051s)
[304.962978] Starting dynamic subtest: test_reprime-lmem0
[305.151448] Dynamic subtest test_reprime-lmem0: SUCCESS (0.201s)
[305.152374] Subtest test_reprime: SUCCESS (0.254s)
[305.374467] [094/131] (743s left) kms_vblank (wait-forked-hang)
[305.566926] Starting subtest: wait-forked-hang
[305.569214] Starting dynamic subtest: pipe-A-DP-3
[332.591467] Dynamic subtest pipe-A-DP-3: SUCCESS (27.019s)
[332.624532] Starting dynamic subtest: pipe-D-DP-3
[357.554296] Dynamic subtest pipe-D-DP-3: SUCCESS (24.949s)
[357.555256] Subtest wait-forked-hang: SUCCESS (51.985s)
[357.875820] [095/131] (690s left) gem_render_copy (linear-to-vebox-yf-tiled)
[357.967591] Starting subtest: linear-to-vebox-yf-tiled
[357.969588] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[358.276229] [096/131] (690s left) gem_exec_suspend (basic-s0)
[358.367453] Starting subtest: basic-S0
[358.368432] Starting dynamic subtest: smem