[57.176430] Initializing watchdogs
[57.176501]   /dev/watchdog0
[57.196871] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.208177] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.211869] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.215137] [001/133] (960s left) kms_big_fb (x-tiled-addfb-size-overflow)
[57.414416] Starting subtest: x-tiled-addfb-size-overflow
[57.415409] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[57.587606] [002/133] (960s left) gem_exec_balancer (bonded-pair)
[57.678426] Starting subtest: bonded-pair
[57.680933] Subtest bonded-pair: SKIP (0.000s)
[58.131641] [003/133] (959s left) gem_exec_reloc (basic-gtt-read)
[58.210278] Subtest basic-gtt-read: SKIP (0.000s)
[58.267177] [004/133] (959s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[58.462504] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[58.464304] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[58.639105] [005/133] (959s left) gem_ctx_sseu (engines)
[58.722187] Subtest engines: SKIP (0.000s)
[58.818502] [006/133] (959s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[58.999117] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[59.228279] Starting dynamic subtest: pipe-A-DP-3
[61.512331] Dynamic subtest pipe-A-DP-3: SUCCESS (2.283s)
[61.724432] Starting dynamic subtest: pipe-B-DP-3
[63.821197] Dynamic subtest pipe-B-DP-3: SUCCESS (2.103s)
[64.044817] Starting dynamic subtest: pipe-C-DP-3
[66.133800] Dynamic subtest pipe-C-DP-3: SUCCESS (2.095s)
[66.343052] Starting dynamic subtest: pipe-D-DP-3
[68.431091] Dynamic subtest pipe-D-DP-3: SUCCESS (2.096s)
[68.432842] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.432s)
[68.927766] [007/133] (949s left) i915_pm_rpm (reg-read-ioctl)
[71.046129] Starting subtest: reg-read-ioctl
[71.813215] Subtest reg-read-ioctl: SUCCESS (0.766s)
[72.248983] [008/133] (945s left) syncobj_basic (illegal-fd-to-handle)
[72.321040] Starting subtest: illegal-fd-to-handle
[72.322163] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[72.495114] [009/133] (945s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[72.685032] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[72.738631] [010/133] (945s left) gem_mmap_gtt (basic-read-write)
[72.814962] Subtest basic-read-write: SKIP (0.000s)
[72.892862] [011/133] (945s left) gem_create (create-size-update)
[72.965071] Starting subtest: create-size-update
[72.966033] Subtest create-size-update: SUCCESS (0.000s)
[73.243154] [012/133] (945s left) gem_exec_schedule (u-independent)
[73.328563] Starting subtest: u-independent
[73.329513] Starting dynamic subtest: rcs0
[73.769557] Dynamic subtest rcs0: SUCCESS (0.441s)
[73.780745] Starting dynamic subtest: bcs0
[74.177406] Dynamic subtest bcs0: SUCCESS (0.407s)
[74.188299] Starting dynamic subtest: vcs0
[74.562455] Dynamic subtest vcs0: SUCCESS (0.385s)
[74.572435] Starting dynamic subtest: vcs1
[74.948355] Dynamic subtest vcs1: SUCCESS (0.385s)
[74.958480] Starting dynamic subtest: vecs0
[75.333466] Dynamic subtest vecs0: SUCCESS (0.385s)
[75.344723] Starting dynamic subtest: vecs1
[75.714370] Dynamic subtest vecs1: SUCCESS (0.381s)
[75.723031] Starting dynamic subtest: ccs0
[76.062419] Dynamic subtest ccs0: SUCCESS (0.348s)
[76.063638] Subtest u-independent: SUCCESS (2.734s)
[76.482166] [013/133] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[76.675892] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[79.434601] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.759s)
[79.644916] [014/133] (938s left) gem_exec_reloc (basic-cpu-noreloc)
[79.729435] Subtest basic-cpu-noreloc: SKIP (0.000s)
[79.852315] [015/133] (938s left) kms_vblank (wait-forked-busy)
[80.030261] Starting subtest: wait-forked-busy
[80.032224] Starting dynamic subtest: pipe-A-DP-3
[82.539665] Dynamic subtest pipe-A-DP-3: SUCCESS (2.507s)
[82.564499] Starting dynamic subtest: pipe-D-DP-3
[85.003971] Dynamic subtest pipe-D-DP-3: SUCCESS (2.454s)
[85.005250] Subtest wait-forked-busy: SUCCESS (4.973s)
[85.317494] [016/133] (933s left) gem_lmem_swapping (smem-oom)
[88.130774] Starting subtest: smem-oom
[88.131797] Starting dynamic subtest: lmem0
[115.855124] Dynamic subtest lmem0: SUCCESS (27.723s)
[115.856292] Subtest smem-oom: SUCCESS (27.724s)
[117.058299] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[117.061041] [017/133] (901s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[118.757025] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[118.863350] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[118.977833] [FACT syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[118.980553] [018/133] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[119.186517] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[119.188252] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[119.390498] [019/133] (899s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[119.583125] Starting subtest: y-tiled-64bpp-rotate-90
[119.585066] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[119.774082] [020/133] (899s left) kms_psr (psr2-sprite-plane-move)
[119.957315] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[120.015266] [021/133] (898s left) perf (polling-small-buf)
[120.471885] Starting subtest: polling-small-buf
[120.571148] Subtest polling-small-buf: SUCCESS (0.099s)
[120.634633] [022/133] (898s left) kms_color (invalid-degamma-lut-sizes)
[120.817038] Starting subtest: invalid-degamma-lut-sizes
[120.817941] Starting dynamic subtest: pipe-A
[120.903533] Dynamic subtest pipe-A: SUCCESS (0.087s)
[120.916059] Starting dynamic subtest: pipe-B
[120.917076] Dynamic subtest pipe-B: SUCCESS (0.001s)
[120.929158] Starting dynamic subtest: pipe-C
[120.930053] Dynamic subtest pipe-C: SUCCESS (0.001s)
[120.940836] Starting dynamic subtest: pipe-D
[120.941734] Dynamic subtest pipe-D: SUCCESS (0.001s)
[120.942530] Subtest invalid-degamma-lut-sizes: SUCCESS (0.091s)
[121.164077] [023/133] (897s left) gem_caching (reads)
[121.243391] Starting subtest: reads
[124.358191] Subtest reads: SUCCESS (3.115s)
[124.531892] [024/133] (894s left) gem_mmap_wc (write-cpu-read-wc)
[124.607057] Subtest write-cpu-read-wc: SKIP (0.000s)
[124.674997] [025/133] (894s left) gem_lmem_swapping (massive-random)
[127.417730] Starting subtest: massive-random
[127.418617] Starting dynamic subtest: lmem0
[127.731575] Dynamic subtest lmem0: SUCCESS (0.314s)
[127.732554] Subtest massive-random: SUCCESS (0.314s)
[131.436910] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[131.438698] [026/133] (887s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[133.004264] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[133.071746] [FACT kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)] new: kernel.kmod_is_loaded.i915: true
[133.074186] [027/133] (886s left) kms_plane (plane-position-hole)
[133.258606] Starting subtest: plane-position-hole
[133.725925] Starting dynamic subtest: pipe-A-plane-1
[134.178304] Dynamic subtest pipe-A-plane-1: SUCCESS (0.452s)
[134.199419] Starting dynamic subtest: pipe-A-plane-2
[134.667953] Dynamic subtest pipe-A-plane-2: SUCCESS (0.489s)
[134.680391] Starting dynamic subtest: pipe-A-plane-3
[135.095132] Dynamic subtest pipe-A-plane-3: SUCCESS (0.427s)
[135.105604] Starting dynamic subtest: pipe-A-plane-4
[135.536560] Dynamic subtest pipe-A-plane-4: SUCCESS (0.442s)
[135.550341] Starting dynamic subtest: pipe-A-plane-5
[135.561188] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[135.924117] Starting dynamic subtest: pipe-B-plane-1
[136.339189] Dynamic subtest pipe-B-plane-1: SUCCESS (0.425s)
[136.349964] Starting dynamic subtest: pipe-B-plane-2
[136.749172] Dynamic subtest pipe-B-plane-2: SUCCESS (0.409s)
[136.759772] Starting dynamic subtest: pipe-B-plane-3
[137.175110] Dynamic subtest pipe-B-plane-3: SUCCESS (0.425s)
[137.185512] Starting dynamic subtest: pipe-B-plane-4
[137.598026] Dynamic subtest pipe-B-plane-4: SUCCESS (0.423s)
[137.608289] Starting dynamic subtest: pipe-B-plane-5
[137.618956] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[137.619927] Subtest plane-position-hole: SUCCESS (4.360s)
[137.906222] [028/133] (881s left) kms_vrr (seamless-rr-switch-vrr)
[138.092511] Starting subtest: seamless-rr-switch-vrr
[138.095253] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[138.251332] [029/133] (881s left) gem_ctx_param (set-priority-not-supported)
[138.320549] Starting subtest: set-priority-not-supported
[138.322427] Subtest set-priority-not-supported: SKIP (0.000s)
[138.453076] [030/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[138.638786] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[138.640462] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[138.814452] [031/133] (880s left) kms_feature_discovery (display-3x)
[138.999320] Starting subtest: display-3x
[139.001161] Subtest display-3x: SKIP (0.000s)
[139.148768] [032/133] (880s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[139.333915] Starting subtest: fbcpsr-shrfb-scaledprimary
[139.335628] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[139.518498] [033/133] (880s left) i915_query (engine-info)
[139.589148] Starting subtest: engine-info
[139.601546] Subtest engine-info: SUCCESS (0.012s)
[139.760324] [034/133] (880s left) gem_ctx_persistence (processes)
[139.843211] Starting subtest: processes
[141.893226] Subtest processes: SUCCESS (2.050s)
[142.011086] [035/133] (877s left) gem_eio (wait-wedge-10ms)
[142.346044] Starting subtest: wait-wedge-10ms
[143.876523] Subtest wait-wedge-10ms: SUCCESS (1.531s)
[144.169561] [036/133] (875s left) gem_exec_suspend (basic)
[144.254244] Starting subtest: basic
[144.255186] Starting dynamic subtest: smem
[145.463196] Dynamic subtest smem: SUCCESS (1.210s)
[145.474617] Starting dynamic subtest: lmem0
[146.550548] Dynamic subtest lmem0: SUCCESS (1.087s)
[146.551584] Subtest basic: SUCCESS (2.298s)
[146.852471] [037/133] (873s left) drm_mm (drm_mm)
[146.900213] Starting subtest: drm_mm
[146.929121] Starting dynamic subtest: drm_test_mm_init
[147.011697] Dynamic subtest drm_test_mm_init: SUCCESS (0.083s)
[147.043530] Starting dynamic subtest: drm_test_mm_debug
[147.100160] Dynamic subtest drm_test_mm_debug: SUCCESS (0.087s)
[147.118394] Starting dynamic subtest: drm_test_mm_align32
[147.193117] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[147.238074] Starting dynamic subtest: drm_test_mm_align64
[147.300883] Dynamic subtest drm_test_mm_align64: SUCCESS (0.104s)
[147.339591] Starting dynamic subtest: drm_test_mm_lowest
[147.403830] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.100s)
[147.419201] Starting dynamic subtest: drm_test_mm_highest
[147.506339] Dynamic subtest drm_test_mm_highest: SUCCESS (0.100s)
[147.508263] Subtest drm_mm: SUCCESS (0.608s)
[147.754300] [038/133] (872s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[150.352161] Starting subtest: verify-pxp-key-change-after-suspend-resume
[150.354268] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[150.486814] [039/133] (869s left) gem_exec_schedule (preemptive-hang)
[150.683940] Starting subtest: preemptive-hang
[150.684977] Starting dynamic subtest: rcs0
[160.121537] Dynamic subtest rcs0: SUCCESS (9.437s)
[160.132842] Starting dynamic subtest: bcs0
[169.137573] Dynamic subtest bcs0: SUCCESS (9.015s)
[169.149102] Starting dynamic subtest: vcs0
[178.119377] Dynamic subtest vcs0: SUCCESS (8.981s)
[178.130462] Starting dynamic subtest: vcs1
[187.131443] Dynamic subtest vcs1: SUCCESS (9.011s)
[187.143034] Starting dynamic subtest: vecs0
[196.153519] Dynamic subtest vecs0: SUCCESS (9.022s)
[196.164904] Starting dynamic subtest: vecs1
[205.127433] Dynamic subtest vecs1: SUCCESS (8.973s)
[205.138491] Starting dynamic subtest: ccs0
[214.138431] Dynamic subtest ccs0: SUCCESS (9.011s)
[214.139442] Subtest preemptive-hang: SUCCESS (63.453s)
[214.428348] [040/133] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[214.611047] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[214.612720] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[214.779946] [041/133] (805s left) i915_hangman (error-state-basic)
[214.869455] Starting subtest: error-state-basic
[215.055202] Subtest error-state-basic: SUCCESS (0.186s)
[215.179484] [042/133] (805s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[215.358978] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[215.359949] Starting dynamic subtest: pipe-A-DP-3
[215.368431] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[215.379500] Starting dynamic subtest: pipe-B-DP-3
[215.387781] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[215.398847] Starting dynamic subtest: pipe-C-DP-3
[215.407127] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[215.418090] Starting dynamic subtest: pipe-D-DP-3
[215.428364] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[215.430359] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[215.857902] [043/133] (804s left) gem_exec_balancer (parallel-bb-first)
[216.205276] Starting subtest: parallel-bb-first
[217.931758] Subtest parallel-bb-first: SUCCESS (1.726s)
[218.081800] [044/133] (802s left) kms_async_flips (test-time-stamp-atomic)
[218.267133] Starting subtest: test-time-stamp-atomic
[218.492773] Starting dynamic subtest: pipe-A-DP-3
[218.823109] Dynamic subtest pipe-A-DP-3: SUCCESS (0.328s)
[219.065381] Starting dynamic subtest: pipe-B-DP-3
[219.207140] Dynamic subtest pipe-B-DP-3: SUCCESS (0.152s)
[219.419519] Starting dynamic subtest: pipe-C-DP-3
[219.553604] Dynamic subtest pipe-C-DP-3: SUCCESS (0.143s)
[219.795727] Starting dynamic subtest: pipe-D-DP-3
[219.940177] Dynamic subtest pipe-D-DP-3: SUCCESS (0.153s)
[219.942174] Subtest test-time-stamp-atomic: SUCCESS (1.674s)
[220.522342] [045/133] (800s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[220.708424] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[220.710294] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[220.867114] [046/133] (799s left) kms_colorop (plane-xr30-xr30-3dlut_17_12_rgb)
[221.155130] Subtest plane-XR30-XR30-3dlut_17_12_rgb: SKIP (0.000s)
[221.320144] [047/133] (799s left) kms_cursor_crc (cursor-onscreen-64x21)
[221.671322] Starting subtest: cursor-onscreen-64x21
[221.676056] Starting dynamic subtest: pipe-A-DP-3
[224.386572] Dynamic subtest pipe-A-DP-3: SUCCESS (2.709s)
[224.441903] Starting dynamic subtest: pipe-D-DP-3
[227.154609] Dynamic subtest pipe-D-DP-3: SUCCESS (2.723s)
[227.155659] Subtest cursor-onscreen-64x21: SUCCESS (5.483s)
[227.700476] [048/133] (793s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[227.877938] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[227.894170] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.016s)
[228.021359] [049/133] (792s left) kms_content_protection (dp-mst-type-0)
[228.267585] Starting subtest: dp-mst-type-0
[228.269381] Subtest dp-mst-type-0: SKIP (0.000s)
[228.491925] [050/133] (792s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[228.670562] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[228.672391] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[229.005753] [051/133] (792s left) kms_psr (fbc-pr-primary-page-flip)
[229.187364] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[229.246714] [052/133] (791s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[229.438285] Starting subtest: 4-tiled-16bpp-rotate-270
[229.504216] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.065s)
[229.753569] [053/133] (791s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[229.938995] Starting subtest: fbc-rgb101010-draw-render
[232.837558] Subtest fbc-rgb101010-draw-render: SUCCESS (2.899s)
[233.035019] [054/133] (788s left) syncobj_eventfd (timeline-wait-signaled)
[233.105383] Starting subtest: timeline-wait-signaled
[233.106345] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[233.239242] [055/133] (788s left) kms_rotation_crc (primary-rotation-180)
[233.420428] Starting subtest: primary-rotation-180
[243.840043] Subtest primary-rotation-180: SUCCESS (10.420s)
[244.239493] [056/133] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[244.428005] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[244.429751] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[244.653301] [057/133] (776s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[244.726350] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[244.727402] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[244.878030] [058/133] (776s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[245.061733] Starting subtest: multiplane-rotation-cropping-top
[256.854200] Subtest multiplane-rotation-cropping-top: SUCCESS (11.792s)
[257.104590] [059/133] (764s left) i915_drm_fdinfo (busy-idle-check-all)
[257.171777] Starting subtest: busy-idle-check-all
[257.172817] Starting dynamic subtest: rcs0
[257.204423] Dynamic subtest rcs0: SKIP (0.031s)
[257.216365] Starting dynamic subtest: bcs0
[257.218196] Dynamic subtest bcs0: SKIP (0.001s)
[257.229763] Starting dynamic subtest: vcs0
[257.232103] Dynamic subtest vcs0: SKIP (0.000s)
[257.243364] Starting dynamic subtest: vcs1
[257.245736] Dynamic subtest vcs1: SKIP (0.001s)
[257.256895] Starting dynamic subtest: vecs0
[257.259353] Dynamic subtest vecs0: SKIP (0.000s)
[257.272994] Starting dynamic subtest: vecs1
[257.275396] Dynamic subtest vecs1: SKIP (0.000s)
[257.286644] Starting dynamic subtest: ccs0
[257.288916] Dynamic subtest ccs0: SKIP (0.000s)
[257.291388] Subtest busy-idle-check-all: SKIP (0.042s)
[257.336500] [060/133] (764s left) gem_mmap_gtt (big-bo-tiledx)
[257.446637] Subtest big-bo-tiledX: SKIP (0.000s)
[257.549832] [061/133] (764s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[257.632585] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[257.634630] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[257.919720] [062/133] (763s left) gem_flink_basic (bad-flink)
[257.991406] Starting subtest: bad-flink
[257.992373] Subtest bad-flink: SUCCESS (0.000s)
[258.160227] [063/133] (763s left) perf_pmu (idle-no-semaphores)
[258.227449] Starting subtest: idle-no-semaphores
[258.228415] Starting dynamic subtest: rcs0
[258.792217] Dynamic subtest rcs0: SUCCESS (0.564s)
[258.808682] Starting dynamic subtest: bcs0
[259.310551] Dynamic subtest bcs0: SUCCESS (0.513s)
[259.326820] Starting dynamic subtest: vcs0
[259.828601] Dynamic subtest vcs0: SUCCESS (0.513s)
[259.844537] Starting dynamic subtest: vcs1
[260.346390] Dynamic subtest vcs1: SUCCESS (0.513s)
[260.362664] Starting dynamic subtest: vecs0
[260.861437] Dynamic subtest vecs0: SUCCESS (0.510s)
[260.877401] Starting dynamic subtest: vecs1
[261.376550] Dynamic subtest vecs1: SUCCESS (0.510s)
[261.392586] Starting dynamic subtest: ccs0
[261.897953] Dynamic subtest ccs0: SUCCESS (0.517s)
[261.902272] Subtest idle-no-semaphores: SUCCESS (3.673s)
[262.067738] [064/133] (759s left) sysfs_heartbeat_interval (mixed)
[262.146361] Starting subtest: mixed
[262.147325] Starting dynamic subtest: vecs0
[267.377863] Dynamic subtest vecs0: SUCCESS (5.230s)
[267.397574] Starting dynamic subtest: ccs0
[272.565982] Dynamic subtest ccs0: SUCCESS (5.184s)
[272.586697] Starting dynamic subtest: vcs0
[277.808142] Dynamic subtest vcs0: SUCCESS (5.238s)
[277.823918] Starting dynamic subtest: bcs0
[283.023509] Dynamic subtest bcs0: SUCCESS (5.213s)
[283.038823] Starting dynamic subtest: vecs1
[288.239245] Dynamic subtest vecs1: SUCCESS (5.214s)
[288.257529] Starting dynamic subtest: rcs0
[293.472694] Dynamic subtest rcs0: SUCCESS (5.230s)
[293.490960] Starting dynamic subtest: vcs1
[298.723496] Dynamic subtest vcs1: SUCCESS (5.246s)
[298.724877] Subtest mixed: SUCCESS (36.577s)
[298.931116] [065/133] (723s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[299.114365] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[299.115275] Starting dynamic subtest: pipe-A-valid-mode
[299.199131] Dynamic subtest pipe-A-valid-mode: SKIP (0.082s)
[299.201156] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.084s)
[299.460903] [066/133] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[299.653735] Starting subtest: psr-1p-primscrn-spr-indfb-move
[299.655514] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[299.852692] [067/133] (722s left) kms_sequence (queue-idle)
[300.051495] Starting subtest: queue-idle
[300.052429] Starting dynamic subtest: pipe-A-DP-3
[302.432419] Dynamic subtest pipe-A-DP-3: SUCCESS (2.380s)
[302.445826] Starting dynamic subtest: pipe-B-DP-3
[304.736919] Dynamic subtest pipe-B-DP-3: SUCCESS (2.303s)
[304.753478] Starting dynamic subtest: pipe-C-DP-3
[307.027820] Dynamic subtest pipe-C-DP-3: SUCCESS (2.289s)
[307.043164] Starting dynamic subtest: pipe-D-DP-3
[309.323938] Dynamic subtest pipe-D-DP-3: SUCCESS (2.294s)
[309.324903] Subtest queue-idle: SUCCESS (9.274s)
[309.602915] [068/133] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[309.791078] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[309.792906] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[310.005386] [069/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[310.193031] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[310.194866] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[310.387600] [070/133] (712s left) kms_pm_lpsp (kms-lpsp)
[311.571512] Starting subtest: kms-lpsp
[311.573189] Subtest kms-lpsp: SKIP (0.000s)
[311.707438] [071/133] (710s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[311.899522] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[311.961416] [072/133] (710s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[312.145346] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[312.146260] Starting dynamic subtest: pipe-A-valid-mode
[314.705811] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.556s)
[314.707355] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.560s)
[315.028398] [073/133] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[315.220114] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[315.221970] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[315.428305] [074/133] (707s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[315.608430] Starting subtest: psr-dirtyfb-ioctl
[315.613877] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[315.814544] [075/133] (706s left) gem_exec_await (wide-contexts)
[316.129265] Starting subtest: wide-contexts
[338.193509] Subtest wide-contexts: SUCCESS (22.065s)
[338.438513] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[338.441685] [076/133] (684s left) kms_plane_scaling (2x-scaler-multi-pipe)
[338.698266] Starting subtest: 2x-scaler-multi-pipe
[338.700163] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[338.903553] [077/133] (684s left) kms_chamelium_edid (hdmi-mode-timings)
[339.191308] Subtest hdmi-mode-timings: SKIP (0.000s)
[339.372727] [078/133] (683s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[339.649794] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[339.807127] [079/133] (683s left) kms_mmap_write_crc (main)
[340.002940] Starting subtest: main
[340.005352] Starting dynamic subtest: pipe-A-DP-3
[343.755331] Dynamic subtest pipe-A-DP-3: SUCCESS (3.750s)
[343.756353] Subtest main: SUCCESS (3.752s)
[344.098041] [080/133] (679s left) api_intel_allocator (default-alignment)
[344.178993] Starting subtest: default-alignment
[344.185075] Subtest default-alignment: SUCCESS (0.006s)
[344.410984] [081/133] (678s left) gem_workarounds (basic-read)
[344.512507] Starting subtest: basic-read
[344.552496] Subtest basic-read: SUCCESS (0.041s)
[344.804234] [082/133] (678s left) gem_mmap_wc (bad-object)
[344.884295] Subtest bad-object: SKIP (0.000s)
[344.971174] [083/133] (678s left) gem_vm_create (invalid-create)
[345.056572] Starting subtest: invalid-create
[345.061521] Subtest invalid-create: SUCCESS (0.005s)
[345.260168] [084/133] (678s left) gem_mmap_gtt (basic-small-bo-tiledx)
[345.345283] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[345.420546] [085/133] (678s left) syncobj_timeline (single-wait-all-available-signaled)
[345.512444] Starting subtest: single-wait-all-available-signaled
[345.513514] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[345.658484] [086/133] (678s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[345.850157] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[345.851986] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[346.059788] [087/133] (677s left) gem_userptr_blits (readonly-pwrite-unsync)
[346.149176] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[346.360995] [088/133] (677s left) gem_ctx_param (invalid-get-ringsize)
[346.441875] Starting subtest: invalid-get-ringsize
[346.444243] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[346.626973] [089/133] (677s left) syncobj_timeline (invalid-wait-illegal-handle)
[346.708363] Starting subtest: invalid-wait-illegal-handle
[346.709341] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[346.849987] [090/133] (677s left) kms_cursor_edge_walk (256x256-top-bottom)
[347.046506] Starting subtest: 256x256-top-bottom
[347.047398] Starting dynamic subtest: pipe-A-DP-3
[350.494064] Dynamic subtest pipe-A-DP-3: SUCCESS (3.447s)
[350.513833] Starting dynamic subtest: pipe-D-DP-3
[353.842808] Dynamic subtest pipe-D-DP-3: SUCCESS (3.344s)
[353.844267] Subtest 256x256-top-bottom: SUCCESS (6.797s)
[354.188833] [091/133] (669s left) gem_softpin (softpin)
[354.280831] Starting subtest: softpin
[386.657978] Subtest softpin: SUCCESS (32.375s)
[386.806369] [092/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[387.002297] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[387.004136] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[387.207953] [093/133] (637s left) gen7_exec_parse (load-register-reg)
[387.296579] Subtest load-register-reg: SKIP (0.000s)
[387.409455] [094/133] (636s left) syncobj_basic (test-valid-cycle)
[387.487452] Starting subtest: test-valid-cycle
[387.488511] Subtest test-valid-cycle: SUCCESS (0.000s)
[387.689510] [095/133] (636s left) kms_pm_rpm (universal-planes)
[390.013883] Starting subtest: universal-planes
[390.020054] Starting dynamic subtest: plane-33
[392.900775] Dynamic subtest plane-33: SUCCESS (2.884s)
[392.950670] Starting dynamic subtest: plane-43
[395.614749] Dynamic subtest plane-43: SUCCESS (2.708s)
[395.632711] Starting dynamic subtest: plane-53
[398.532745] Dynamic subtest plane-53: SUCCESS (2.913s)
[398.585536] Starting dynamic subtest: plane-63
[401.290712] Dynamic subtest plane-63: SUCCESS (2.752s)
[401.339574] Starting dynamic subtest: plane-73
[404.116864] Dynamic subtest plane-73: SUCCESS (2.821s)
[404.169826] Starting dynamic subtest: plane-83
[406.814768] Dynamic subtest plane-83: SUCCESS (2.692s)
[406.821349] Subtest universal-planes: SUCCESS (16.804s)
[407.275453] [096/133] (617s left) api_intel_bb (full-batch)
[407.360962] Starting subtest: full-batch
[407.389893] Subtest full-batch: SUCCESS (0.030s)
[407.574917] [097/133] (616s left) gem_exec_flush (basic-uc-ro-default)
[407.666405] Subtest basic-uc-ro-default: SKIP (0.000s)
[407.753930] [098/133] (616s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[407.947338] Starting subtest: crc-primary-suspend-y-tiled-ccs
[407.948260] Starting dynamic subtest: pipe-A-DP-3
[407.951876] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[407.965584] Starting dynamic subtest: pipe-B-DP-3
[407.969131] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[407.982574] Starting dynamic subtest: pipe-C-DP-3
[407.986135] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[407.999526] Starting dynamic subtest: pipe-D-DP-3
[408.003053] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[408.004793] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.008s)
[408.436927] [099/133] (616s left) gem_render_copy_redux (flink-interruptible)
[408.523437] Starting subtest: flink-interruptible
[411.817032] Subtest flink-interruptible: SUCCESS (3.293s)
[412.096817] [100/133] (612s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[412.300931] Starting subtest: yf-tiled-16bpp-rotate-90
[412.302767] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[412.517704] [101/133] (612s left) gem_busy (extended)
[412.796627] Starting subtest: extended
[412.797691] Starting dynamic subtest: rcs0
[412.894963] Dynamic subtest rcs0: SUCCESS (0.097s)
[412.917802] Starting dynamic subtest: bcs0
[412.943678] Dynamic subtest bcs0: SUCCESS (0.045s)
[412.963511] Starting dynamic subtest: vcs0
[412.985694] Dynamic subtest vcs0: SUCCESS (0.041s)
[413.007413] Starting dynamic subtest: vcs1
[413.028684] Dynamic subtest vcs1: SUCCESS (0.041s)
[413.050344] Starting dynamic subtest: vecs0
[413.071718] Dynamic subtest vecs0: SUCCESS (0.041s)
[413.093521] Starting dynamic subtest: vecs1
[413.115392] Dynamic subtest vecs1: SUCCESS (0.042s)
[413.137384] Starting dynamic subtest: ccs0
[413.158680] Dynamic subtest ccs0: SUCCESS (0.042s)
[413.159672] Subtest extended: SUCCESS (0.363s)
[413.500183] [102/133] (611s left) gem_ctx_param (root-set)
[413.579856] Starting subtest: root-set
[413.582261] Subtest root-set: SUCCESS (0.002s)
[413.785112] [103/133] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[413.984289] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[413.986051] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[414.146413] [104/133] (610s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[414.863226] Starting subtest: syncobj-timeline-invalid-flags
[414.865271] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[415.140052] [105/133] (610s left) gem_spin_batch (spin-all)
[415.230378] Starting subtest: spin-all
[415.280850] Subtest spin-all: SUCCESS (0.050s)
[415.616331] [106/133] (609s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[415.822802] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[416.963370] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.140s)
[417.171979] [107/133] (608s left) kms_lease (lease-again)
[417.363781] Starting subtest: lease-again
[417.366362] Starting dynamic subtest: pipe-A-DP-3
[417.368863] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s)
[417.384298] Starting dynamic subtest: pipe-B-DP-3
[417.385213] Dynamic subtest pipe-B-DP-3: SUCCESS (0.003s)
[417.399148] Starting dynamic subtest: pipe-C-DP-3
[417.400127] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s)
[417.413993] Starting dynamic subtest: pipe-D-DP-3
[417.414938] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[417.415860] Subtest lease-again: SUCCESS (0.022s)
[417.566913] [108/133] (607s left) syncobj_wait (invalid-signal-illegal-handle)
[417.645499] Starting subtest: invalid-signal-illegal-handle
[417.646475] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[417.838484] [109/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[418.038343] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[418.040149] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[418.210655] [110/133] (607s left) syncobj_wait (multi-wait-for-submit-signaled)
[418.294579] Starting subtest: multi-wait-for-submit-signaled
[418.295641] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[418.487868] [111/133] (607s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[418.687160] Starting subtest: stress-xrgb8888-ytiled
[418.689013] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[418.778618] [112/133] (606s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[418.969470] Starting subtest: 2x-cursor-vs-flip-legacy
[418.972484] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[419.132358] [113/133] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[419.326247] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[419.327945] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[419.521246] [114/133] (606s left) kms_flip (2x-wf_vblank-ts-check)
[419.718175] Starting subtest: 2x-wf_vblank-ts-check
[419.733382] Subtest 2x-wf_vblank-ts-check: SKIP (0.016s)
[419.870852] [115/133] (606s left) gem_exec_fence (basic-wait-all)
[419.963202] Starting subtest: basic-wait-all
[420.091303] Subtest basic-wait-all: SUCCESS (0.128s)
[420.886237] [116/133] (605s left) kms_psr (fbc-psr-primary-page-flip)
[421.077471] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[421.144545] [117/133] (604s left) syncobj_wait (reset-unsignaled)
[421.232620] Starting subtest: reset-unsignaled
[421.233591] Subtest reset-unsignaled: SUCCESS (0.000s)
[421.419240] [118/133] (604s left) gem_mmap_gtt (isolation)
[421.500278] Subtest isolation: SKIP (0.000s)
[421.579567] [119/133] (604s left) gem_userptr_blits (access-control)
[421.680632] Starting subtest: access-control
[421.682459] Subtest access-control: SKIP (0.000s)
[421.916749] [120/133] (604s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[422.110788] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[422.113168] Starting dynamic subtest: pipe-A-DP-3
[422.121980] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[422.135680] Starting dynamic subtest: pipe-B-DP-3
[422.144221] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[422.157597] Starting dynamic subtest: pipe-C-DP-3
[422.166148] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[422.179622] Starting dynamic subtest: pipe-D-DP-3
[422.189684] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[422.191712] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[422.621588] [121/133] (603s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[422.812487] Starting subtest: cursorA-vs-flipB-atomic-transitions
[422.814427] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[422.982780] [122/133] (603s left) gem_exec_schedule (fifo)
[423.074547] Starting subtest: fifo
[423.075495] Starting dynamic subtest: rcs0
[423.367718] Dynamic subtest rcs0: SUCCESS (0.292s)
[423.381835] Starting dynamic subtest: bcs0
[423.576522] Dynamic subtest bcs0: SUCCESS (0.207s)
[423.590731] Starting dynamic subtest: vcs0
[423.793198] Dynamic subtest vcs0: SUCCESS (0.215s)
[423.807257] Starting dynamic subtest: vcs1
[424.013930] Dynamic subtest vcs1: SUCCESS (0.220s)
[424.027853] Starting dynamic subtest: vecs0
[424.236491] Dynamic subtest vecs0: SUCCESS (0.214s)
[424.250306] Starting dynamic subtest: vecs1
[424.453850] Dynamic subtest vecs1: SUCCESS (0.216s)
[424.467765] Starting dynamic subtest: ccs0
[424.671663] Dynamic subtest ccs0: SUCCESS (0.216s)
[424.672825] Subtest fifo: SUCCESS (1.589s)
[425.176942] [123/133] (601s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[425.463800] Starting subtest: cursor-rapid-movement-32x32
[425.517509] Subtest cursor-rapid-movement-32x32: SKIP (0.051s)
[425.987695] [124/133] (600s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[426.067587] Starting subtest: single-wait-all-for-submit-unsubmitted
[426.181305] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[426.359384] [125/133] (600s left) kms_hdr (static-swap)
[426.546456] Starting subtest: static-swap
[427.120835] Starting dynamic subtest: pipe-A-DP-3
[428.260038] Dynamic subtest pipe-A-DP-3: SUCCESS (1.139s)
[428.261422] Subtest static-swap: SUCCESS (1.716s)
[428.631449] [126/133] (598s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[428.821656] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[428.824175] Starting dynamic subtest: pipe-A-DP-3
[428.845968] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[428.859468] Starting dynamic subtest: pipe-B-DP-3
[428.881436] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[428.894983] Starting dynamic subtest: pipe-C-DP-3
[428.921787] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[428.936221] Starting dynamic subtest: pipe-D-DP-3
[428.961519] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[428.963446] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.015s)
[429.286931] [127/133] (597s left) gem_exec_schedule (wide)
[429.496461] Starting subtest: wide
[429.497452] Starting dynamic subtest: rcs0
[442.087082] Dynamic subtest rcs0: SUCCESS (12.589s)
[442.101458] Starting dynamic subtest: bcs0
[456.139964] Dynamic subtest bcs0: SUCCESS (14.051s)
[456.161317] Starting dynamic subtest: vcs0
[469.174630] Dynamic subtest vcs0: SUCCESS (13.026s)
[469.201317] Starting dynamic subtest: vcs1
[482.941760] Dynamic subtest vcs1: SUCCESS (13.768s)
[482.956122] Starting dynamic subtest: vecs0
[496.566978] Dynamic subtest vecs0: SUCCESS (13.624s)
[496.581259] Starting dynamic subtest: vecs1
[510.325467] Dynamic subtest vecs1: SUCCESS (13.757s)
[510.339951] Starting dynamic subtest: ccs0
[524.185450] Dynamic subtest ccs0: SUCCESS (13.859s)
[524.186422] Subtest wide: SUCCESS (94.688s)
[526.081278] [128/133] (500s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf-gamma_2_2_oetf)
[526.384259] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s)
[526.539889] [129/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[526.737250] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[526.738979] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[526.949254] [130/133] (500s left) kms_chamelium_color (ctm-0-25)
[527.139425] Subtest ctm-0-25: SKIP (0.000s)
[527.202094] [131/133] (500s left) kms_psr (pr-cursor-mmap-cpu)
[527.397804] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[527.469357] [132/133] (499s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[527.658579] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[527.659460] Starting dynamic subtest: pipe-A
[527.769504] Dynamic subtest pipe-A: SUCCESS (0.110s)
[527.797990] Starting dynamic subtest: pipe-B
[527.984207] Dynamic subtest pipe-B: SUCCESS (0.213s)
[528.010047] Starting dynamic subtest: pipe-C
[528.213589] Dynamic subtest pipe-C: SUCCESS (0.228s)
[528.230057] Starting dynamic subtest: pipe-D
[528.412188] Dynamic subtest pipe-D: SUCCESS (0.197s)
[528.413300] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.754s)
[528.767222] [133/133] (498s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[528.965527] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[529.023275] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_ctx_sseu
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: syncobj_basic
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: gem_caching
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: kms_pipe_b_c_ivb
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_feature_discovery
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_query
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: gem_exec_suspend
results: parsing output: 36/ for test: drm_mm
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_colorop
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_eventfd
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_flink_basic
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: sysfs_heartbeat_interval
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_sequence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_pm_lpsp
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_dirtyfb
results: parsing output: 74/ for test: gem_exec_await
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_chamelium_edid
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_mmap_write_crc
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: gem_vm_create
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gen7_exec_parse
results: parsing output: 93/ for test: syncobj_basic
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: gem_exec_flush
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_render_copy_redux
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_busy
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_pipe_stress
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_colorop
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_psr2_sf
Done.