[66.257848] Initializing watchdogs
[66.257914]   /dev/watchdog0
[66.277681] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[66.288360] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.292313] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.294735] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[67.812167] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[67.813895] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[68.016338] [002/134] (958s left) kms_hdr (bpc-switch)
[69.516832] Starting subtest: bpc-switch
[69.519384] Subtest bpc-switch: SKIP (0.001s)
[69.693760] [003/134] (957s left) i915_module_load (reload)
[69.771416] Starting subtest: reload
[74.281516] Subtest reload: SUCCESS (4.511s)
[74.321592] [004/134] (952s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[75.873727] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[75.943834] [005/134] (951s left) kms_pm_rpm (cursor)
[80.014152] Starting subtest: cursor
[80.016929] Subtest cursor: SKIP (0.000s)
[80.953707] [006/134] (946s left) kms_rotation_crc (cursor-rotation-180)
[82.456926] Starting subtest: cursor-rotation-180
[83.298220] Subtest cursor-rotation-180: SUCCESS (0.841s)
[83.640548] [007/134] (943s left) vgem_basic (bad-pad)
[83.720128] Starting subtest: bad-pad
[83.721051] Subtest bad-pad: SUCCESS (0.000s)
[83.871252] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[83.872932] [008/134] (943s left) kms_addfb_basic (invalid-get-prop)
[83.948953] Starting subtest: invalid-get-prop
[83.949898] Subtest invalid-get-prop: SUCCESS (0.000s)
[85.610355] [009/134] (941s left) gem_mmap_gtt (hang-busy)
[85.692942] Subtest hang-busy: SKIP (0.000s)
[85.787785] [010/134] (941s left) gem_eio (in-flight-1us)
[86.074273] Starting subtest: in-flight-1us
[90.934124] Subtest in-flight-1us: SUCCESS (4.860s)
[92.549959] [011/134] (935s left) gem_ctx_shared (disjoint-timelines)
[92.668276] Starting subtest: disjoint-timelines
[92.705678] Subtest disjoint-timelines: SUCCESS (0.037s)
[93.047336] [012/134] (934s left) kms_rotation_crc (bad-tiling)
[94.557254] Starting subtest: bad-tiling
[94.559051] Subtest bad-tiling: SKIP (0.001s)
[94.724366] [013/134] (933s left) gem_exec_fence (syncobj-channel)
[95.281574] Starting subtest: syncobj-channel
[96.301293] Subtest syncobj-channel: SUCCESS (1.019s)
[96.749213] [014/134] (931s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[98.271499] Starting subtest: y-tiled-64bpp-rotate-270
[98.273184] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[98.491438] [015/134] (929s left) kms_psr (psr2-cursor-plane-move)
[100.004401] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[100.061156] [016/134] (927s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[101.579277] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[101.580967] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[101.813127] [017/134] (926s left) i915_pm_rpm (gem-execbuf)
[105.971706] Starting subtest: gem-execbuf
[105.973451] Starting dynamic subtest: lmem0
[110.220931] Dynamic subtest lmem0: SUCCESS (4.251s)
[110.270160] Starting dynamic subtest: smem0
[114.085341] Dynamic subtest smem0: SUCCESS (3.864s)
[114.086574] Subtest gem-execbuf: SUCCESS (8.116s)
[115.158244] [018/134] (912s left) syncobj_timeline (wait-zero-handles)
[115.241252] Starting subtest: wait-zero-handles
[115.242116] Subtest wait-zero-handles: SUCCESS (0.000s)
[115.422673] [019/134] (912s left) kms_pm_rpm (dpms-non-lpsp)
[119.056153] Starting subtest: dpms-non-lpsp
[119.226257] Subtest dpms-non-lpsp: SUCCESS (0.170s)
[120.142797] [020/134] (908s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[121.696457] Starting subtest: yf-tiled-addfb-size-offset-overflow
[121.698329] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[121.935349] [021/134] (906s left) gem_render_copy (linear)
[122.016420] Starting subtest: linear
[122.017347] Starting dynamic subtest: smem
[122.124452] Dynamic subtest smem: SUCCESS (0.108s)
[122.133750] Starting dynamic subtest: lmem0
[122.447348] Dynamic subtest lmem0: SUCCESS (0.322s)
[122.448251] Subtest linear: SUCCESS (0.431s)
[122.780830] [022/134] (905s left) i915_drm_fdinfo (basics)
[122.848656] Starting subtest: basics
[122.849524] Subtest basics: SUCCESS (0.000s)
[123.011302] [023/134] (905s left) kms_cursor_edge_walk (64x64-top-bottom)
[124.524985] Starting subtest: 64x64-top-bottom
[124.527122] Starting dynamic subtest: pipe-A-HDMI-A-3
[127.855933] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.330s)
[127.866555] Starting dynamic subtest: pipe-D-HDMI-A-3
[131.076142] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.218s)
[131.077163] Subtest 64x64-top-bottom: SUCCESS (6.550s)
[131.317569] [024/134] (897s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[132.845504] Starting subtest: 4-tiled-addfb-size-offset-overflow
[132.847456] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.002s)
[133.098128] [025/134] (895s left) kms_psr (fbc-pr-primary-blt)
[134.619079] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[134.672386] [026/134] (894s left) kms_cursor_crc (cursor-size-hints)
[136.268111] Starting subtest: cursor-size-hints
[136.270226] Starting dynamic subtest: pipe-A-HDMI-A-3
[136.788787] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.519s)
[136.799709] Starting dynamic subtest: pipe-D-HDMI-A-3
[137.178542] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.389s)
[137.179429] Subtest cursor-size-hints: SUCCESS (0.911s)
[137.761874] [027/134] (891s left) kms_color (ctm-green-to-red)
[139.273992] Starting subtest: ctm-green-to-red
[139.274886] Starting dynamic subtest: pipe-A-HDMI-A-3
[139.981215] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.707s)
[139.991527] Starting dynamic subtest: pipe-B-HDMI-A-3
[140.476326] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.494s)
[140.485897] Starting dynamic subtest: pipe-C-HDMI-A-3
[140.973282] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.496s)
[140.982992] Starting dynamic subtest: pipe-D-HDMI-A-3
[141.475197] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.502s)
[141.476086] Subtest ctm-green-to-red: SUCCESS (2.202s)
[141.730538] [028/134] (887s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[143.240397] Starting subtest: 2x-flip-vs-cursor-atomic
[143.242247] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[143.431895] [029/134] (885s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[144.952347] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[145.002458] [030/134] (884s left) gem_create (create-clear)
[145.079154] Starting subtest: create-clear
[145.080129] Starting dynamic subtest: lmem0
[181.248772] Dynamic subtest lmem0: SUCCESS (36.168s)
[181.260168] Starting dynamic subtest: smem0
[216.815970] Dynamic subtest smem0: SUCCESS (35.566s)
[216.816949] Subtest create-clear: SUCCESS (71.735s)
[217.088623] [031/134] (812s left) kms_chamelium_hpd (hdmi-hpd)
[218.654493] Subtest hdmi-hpd: SKIP (0.000s)
[218.755408] [032/134] (810s left) i915_suspend (fence-restore-untiled)
[218.851991] Starting subtest: fence-restore-untiled
[218.853849] Subtest fence-restore-untiled: SKIP (0.000s)
[219.045902] [033/134] (810s left) gem_sync (basic-each)
[219.131194] Starting subtest: basic-each
[221.948314] Subtest basic-each: SUCCESS (2.818s)
[222.246139] [034/134] (807s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu)
[223.763553] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu
[223.765198] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[224.007193] [035/134] (805s left) gem_userptr_blits (map-fixed-invalidate)
[224.100291] Starting subtest: map-fixed-invalidate
[224.102170] Subtest map-fixed-invalidate: SKIP (0.000s)
[224.314578] [036/134] (805s left) api_intel_allocator (reloc-allocator)
[224.391008] Starting subtest: reloc-allocator
[224.391864] Starting dynamic subtest: basic
[224.420057] Dynamic subtest basic: SUCCESS (0.029s)
[224.430171] Starting dynamic subtest: parallel-one
[224.431070] Dynamic subtest parallel-one: SUCCESS (0.005s)
[224.440870] Starting dynamic subtest: print
[224.441887] Dynamic subtest print: SUCCESS (0.000s)
[224.451641] Starting dynamic subtest: reuse
[224.452523] Dynamic subtest reuse: SUCCESS (0.000s)
[224.461966] Starting dynamic subtest: fork-reopen-allocator
[224.463100] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[224.464124] Subtest reloc-allocator: SUCCESS (0.049s)
[224.651734] [037/134] (805s left) kms_flip (2x-flip-vs-fences)
[226.170100] Starting subtest: 2x-flip-vs-fences
[226.171753] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[226.396529] [038/134] (803s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[227.911391] Starting subtest: 2x-cursor-vs-flip-legacy
[227.913245] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[228.067717] [039/134] (801s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[229.608442] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[229.609326] Starting dynamic subtest: pipe-A-valid-mode
[235.149296] Dynamic subtest pipe-A-valid-mode: SUCCESS (5.540s)
[235.150192] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (5.542s)
[235.357566] [040/134] (794s left) gem_exec_params (cliprects-invalid)
[235.438113] Starting subtest: cliprects-invalid
[235.439068] Subtest cliprects-invalid: SUCCESS (0.000s)
[235.623762] [041/134] (794s left) gem_mmap (pf-nonblock)
[235.701112] Subtest pf-nonblock: SKIP (0.000s)
[235.773770] [042/134] (794s left) kms_atomic_transition (modeset-transition)
[237.283474] Starting subtest: modeset-transition
[237.284369] Starting dynamic subtest: 1x-outputs
[239.182142] Dynamic subtest 1x-outputs: SUCCESS (1.898s)
[239.183912] Subtest modeset-transition: SUCCESS (1.900s)
[239.438106] [043/134] (790s left) sw_sync (sync_expired_merge)
[239.484416] Starting subtest: sync_expired_merge
[240.558495] Subtest sync_expired_merge: SUCCESS (1.074s)
[240.660710] [044/134] (789s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[240.738197] Starting subtest: invalid-signal-one-illegal-handle
[240.739241] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[240.935692] [045/134] (789s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[242.447975] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[242.449757] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[242.660975] [046/134] (787s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[242.777563] Subtest no-spare-fences-busy: SKIP (0.000s)
[242.857837] [047/134] (787s left) syncobj_wait (wait-all-delayed-signal)
[242.942218] Starting subtest: wait-all-delayed-signal
[243.043572] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[243.175807] [048/134] (787s left) gem_exec_reloc (basic-concurrent16)
[243.257109] Subtest basic-concurrent16: SKIP (0.000s)
[243.350746] [049/134] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[244.866259] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[244.867997] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[245.096784] [050/134] (785s left) kms_big_fb (x-tiled-addfb)
[246.623511] Starting subtest: x-tiled-addfb
[246.624448] Subtest x-tiled-addfb: SUCCESS (0.000s)
[246.862493] [051/134] (784s left) perf_pmu (semaphore-wait)
[246.931985] Starting subtest: semaphore-wait
[246.932841] Starting dynamic subtest: rcs0
[247.470071] Dynamic subtest rcs0: SUCCESS (0.537s)
[247.482786] Starting dynamic subtest: bcs0
[247.984672] Dynamic subtest bcs0: SUCCESS (0.513s)
[247.996848] Starting dynamic subtest: vcs0
[248.498565] Dynamic subtest vcs0: SUCCESS (0.512s)
[248.510864] Starting dynamic subtest: vcs1
[249.012572] Dynamic subtest vcs1: SUCCESS (0.512s)
[249.024763] Starting dynamic subtest: vecs0
[249.524713] Dynamic subtest vecs0: SUCCESS (0.510s)
[249.537577] Starting dynamic subtest: vecs1
[250.037987] Dynamic subtest vecs1: SUCCESS (0.511s)
[250.050690] Starting dynamic subtest: ccs0
[250.551039] Dynamic subtest ccs0: SUCCESS (0.510s)
[250.552910] Subtest semaphore-wait: SUCCESS (3.619s)
[250.745321] [052/134] (780s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[252.252134] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[252.252992] Starting dynamic subtest: pipe-A-HDMI-A-3
[252.262146] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[252.272990] Starting dynamic subtest: pipe-B-HDMI-A-3
[252.289939] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[252.300191] Starting dynamic subtest: pipe-C-HDMI-A-3
[252.310217] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[252.320298] Starting dynamic subtest: pipe-D-HDMI-A-3
[252.331360] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[252.333257] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[252.573700] [053/134] (778s left) syncobj_timeline (multi-wait-for-submit-signaled)
[252.652158] Starting subtest: multi-wait-for-submit-signaled
[252.653101] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[252.844921] [054/134] (778s left) gem_userptr_blits (invalid-null-pointer)
[252.929509] Starting subtest: invalid-null-pointer
[252.930418] Subtest invalid-null-pointer: SUCCESS (0.001s)
[253.129373] [055/134] (778s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[253.210361] Starting subtest: y-tiled-to-vebox-y-tiled
[253.212257] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[253.444186] [056/134] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[254.958180] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[254.959897] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[255.171536] [057/134] (776s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[256.694135] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[256.695885] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[256.928911] [058/134] (774s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[258.438172] Starting subtest: bad-aux-stride-y-tiled-ccs
[258.439040] Starting dynamic subtest: pipe-A-HDMI-A-3
[258.447260] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[258.458140] Starting dynamic subtest: pipe-B-HDMI-A-3
[258.466371] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[258.477111] Starting dynamic subtest: pipe-C-HDMI-A-3
[258.485250] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[258.495814] Starting dynamic subtest: pipe-D-HDMI-A-3
[258.504947] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[258.507142] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[258.758237] [059/134] (772s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[258.840167] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[258.841058] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[259.026615] [060/134] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[260.539234] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[260.540917] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[260.793813] [061/134] (771s left) kms_sequence (get-forked)
[262.306192] Starting subtest: get-forked
[262.307048] Starting dynamic subtest: pipe-A-HDMI-A-3
[264.704469] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.397s)
[264.714978] Starting dynamic subtest: pipe-B-HDMI-A-3
[266.980393] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.274s)
[266.991133] Starting dynamic subtest: pipe-C-HDMI-A-3
[269.230438] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.249s)
[269.241015] Starting dynamic subtest: pipe-D-HDMI-A-3
[271.497628] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.266s)
[271.498474] Subtest get-forked: SUCCESS (9.191s)
[271.755755] [062/134] (760s left) gen3_render_tiledy_blits
[271.898836] [063/134] (760s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[271.978068] Starting subtest: etime-single-wait-for-submit-submitted
[272.086459] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[272.264650] [064/134] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[273.780418] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[273.782167] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[274.017788] [065/134] (758s left) kms_feature_discovery (display-3x)
[275.529196] Starting subtest: display-3x
[275.530968] Subtest display-3x: SKIP (0.000s)
[275.683910] [066/134] (756s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[277.228594] Starting subtest: fbc-rgb101010-draw-mmap-wc
[277.230234] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[277.446776] [067/134] (754s left) gem_exec_balancer (full-pulse)
[277.533538] Starting subtest: full-pulse
[279.576382] Subtest full-pulse: SUCCESS (2.042s)
[280.029399] [068/134] (752s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[281.538488] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[281.539395] Starting dynamic subtest: pipe-A-valid-mode
[281.806988] Dynamic subtest pipe-A-valid-mode: SKIP (0.267s)
[281.809422] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.268s)
[282.082090] [069/134] (750s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[283.609053] Starting subtest: yf-tiled-32bpp-rotate-270
[283.610860] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[283.832780] [070/134] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[285.346876] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[285.348473] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[285.544716] [071/134] (747s left) gem_fence_thrash (bo-write-verify-threaded-none)
[285.604560] Starting subtest: bo-write-verify-threaded-none
[285.634005] Subtest bo-write-verify-threaded-none: SKIP (0.029s)
[285.701825] [072/134] (747s left) gem_ctx_persistence (engines-hang)
[285.787545] Starting subtest: engines-hang
[285.788621] Starting dynamic subtest: rcs0
[285.961436] Dynamic subtest rcs0: SUCCESS (0.173s)
[285.974713] Starting dynamic subtest: bcs0
[286.067285] Dynamic subtest bcs0: SUCCESS (0.104s)
[286.110277] Starting dynamic subtest: vcs0
[286.125390] Dynamic subtest vcs0: SUCCESS (0.056s)
[286.142342] Starting dynamic subtest: vcs1
[286.217188] Dynamic subtest vcs1: SUCCESS (0.090s)
[286.235859] Starting dynamic subtest: vecs0
[286.320034] Dynamic subtest vecs0: SUCCESS (0.100s)
[286.364728] Starting dynamic subtest: vecs1
[286.382455] Dynamic subtest vecs1: SUCCESS (0.061s)
[286.400349] Starting dynamic subtest: ccs0
[286.475204] Dynamic subtest ccs0: SUCCESS (0.091s)
[286.476969] Subtest engines-hang: SUCCESS (0.688s)
[286.704263] [073/134] (746s left) kms_plane_lowres (tiling-4)
[288.212225] Starting subtest: tiling-4
[288.214408] Starting dynamic subtest: pipe-A-HDMI-A-3
[297.107023] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.892s)
[297.190300] Starting dynamic subtest: pipe-B-HDMI-A-3
[306.055144] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (8.874s)
[306.124009] Starting dynamic subtest: pipe-C-HDMI-A-3
[314.686026] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (8.571s)
[314.768896] Starting dynamic subtest: pipe-D-HDMI-A-3
[323.270548] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (8.510s)
[323.342427] Subtest tiling-4: SUCCESS (35.129s)
[323.616357] [074/134] (709s left) gem_exercise_blt (fast-copy)
[323.707365] Starting subtest: fast-copy
[323.708288] Starting dynamic subtest: linear-smem-smem
[323.755982] Dynamic subtest linear-smem-smem: SUCCESS (0.048s)
[323.768684] Starting dynamic subtest: linear-smem-lmem0
[323.772907] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s)
[323.785346] Starting dynamic subtest: linear-lmem0-smem
[323.873975] Dynamic subtest linear-lmem0-smem: SUCCESS (0.100s)
[323.885972] Starting dynamic subtest: linear-lmem0-lmem0
[323.974258] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.099s)
[323.986235] Starting dynamic subtest: xmajor-smem-smem
[323.991392] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[324.004055] Starting dynamic subtest: xmajor-smem-lmem0
[324.007477] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.015s)
[324.019964] Starting dynamic subtest: xmajor-lmem0-smem
[324.114675] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.106s)
[324.127055] Starting dynamic subtest: xmajor-lmem0-lmem0
[324.227674] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.112s)
[324.239970] Starting dynamic subtest: tile4-smem-smem
[324.244295] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[324.256495] Starting dynamic subtest: tile4-smem-lmem0
[324.260261] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.015s)
[324.272478] Starting dynamic subtest: tile4-lmem0-smem
[324.377549] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.116s)
[324.389801] Starting dynamic subtest: tile4-lmem0-lmem0
[324.493358] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.115s)
[324.505554] Starting dynamic subtest: tile64-smem-smem
[324.510714] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[324.522973] Starting dynamic subtest: tile64-smem-lmem0
[324.527124] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.015s)
[324.539321] Starting dynamic subtest: tile64-lmem0-smem
[324.643895] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.116s)
[324.656284] Starting dynamic subtest: tile64-lmem0-lmem0
[324.758935] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.114s)
[324.759889] Subtest fast-copy: SUCCESS (1.052s)
[324.943111] [075/134] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[326.458114] Starting subtest: compare-crc-sanitycheck-xr24
[326.459039] Starting dynamic subtest: pipe-A-HDMI-A-3
[326.977538] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.519s)
[326.991886] Starting dynamic subtest: pipe-B-HDMI-A-3
[327.359147] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.379s)
[327.372131] Starting dynamic subtest: pipe-C-HDMI-A-3
[327.744673] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.382s)
[327.758069] Starting dynamic subtest: pipe-D-HDMI-A-3
[328.133883] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.388s)
[328.134882] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.677s)
[328.344813] [076/134] (704s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[328.424285] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[328.526496] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[328.679011] [077/134] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[330.192977] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[330.194813] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[330.435780] [078/134] (702s left) gem_exec_reloc (basic-cpu)
[330.527175] Subtest basic-cpu: SKIP (0.000s)
[330.655858] [079/134] (702s left) syncobj_timeline (reset-unsignaled)
[330.741173] Starting subtest: reset-unsignaled
[330.742091] Subtest reset-unsignaled: SUCCESS (0.000s)
[330.915640] [080/134] (702s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[332.428218] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[332.429142] Starting dynamic subtest: pipe-A-HDMI-A-3
[332.437665] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[332.448729] Starting dynamic subtest: pipe-B-HDMI-A-3
[332.457244] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[332.467841] Starting dynamic subtest: pipe-C-HDMI-A-3
[332.475992] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[332.486247] Starting dynamic subtest: pipe-D-HDMI-A-3
[332.497163] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[332.499522] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[332.760080] [081/134] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[334.274899] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[334.276526] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[334.484278] [082/134] (699s left) kms_psr (psr-cursor-plane-move)
[336.003226] Subtest psr-cursor-plane-move: SKIP (0.000s)
[336.062659] [083/134] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[337.579945] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[337.581554] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[337.831490] [084/134] (695s left) gem_wait (write-wait)
[337.922234] Starting subtest: write-wait
[337.923175] Starting dynamic subtest: all-engines
[339.031566] Dynamic subtest all-engines: SUCCESS (1.109s)
[339.047158] Starting dynamic subtest: rcs0
[340.094169] Dynamic subtest rcs0: SUCCESS (1.060s)
[340.109813] Starting dynamic subtest: bcs0
[341.154402] Dynamic subtest bcs0: SUCCESS (1.059s)
[341.168741] Starting dynamic subtest: vcs0
[342.212551] Dynamic subtest vcs0: SUCCESS (1.056s)
[342.232251] Starting dynamic subtest: vcs1
[343.275698] Dynamic subtest vcs1: SUCCESS (1.058s)
[343.295639] Starting dynamic subtest: vecs0
[344.339541] Dynamic subtest vecs0: SUCCESS (1.059s)
[344.359632] Starting dynamic subtest: vecs1
[345.405330] Dynamic subtest vecs1: SUCCESS (1.061s)
[345.425894] Starting dynamic subtest: ccs0
[346.471731] Dynamic subtest ccs0: SUCCESS (1.061s)
[346.474762] Subtest write-wait: SUCCESS (8.551s)
[346.821605] [085/134] (687s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[348.333034] Starting subtest: cursorB-vs-flipA-varying-size
[348.336191] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[348.510657] [086/134] (685s left) perf (blocking-parameterized)
[348.974370] Starting subtest: blocking-parameterized
[369.008300] Subtest blocking-parameterized: SUCCESS (20.033s)
[369.066789] [087/134] (664s left) kms_chamelium_edid (hdmi-edid-read)
[370.629440] Subtest hdmi-edid-read: SKIP (0.000s)
[370.734858] [088/134] (663s left) prime_mmap (test_errors)
[370.818955] Starting subtest: test_errors
[370.819894] Starting dynamic subtest: test_errors-smem
[370.956833] Dynamic subtest test_errors-smem: SUCCESS (0.137s)
[370.967482] Starting dynamic subtest: test_errors-lmem0
[371.512055] Dynamic subtest test_errors-lmem0: SUCCESS (0.554s)
[371.512992] Subtest test_errors: SUCCESS (0.693s)
[371.671630] [089/134] (662s left) fbdev (pan)
[371.724430] Starting subtest: pan
[371.763576] Subtest pan: SUCCESS (0.039s)
[371.941723] [090/134] (662s left) kms_invalid_mode (zero-clock)
[373.450247] Starting subtest: zero-clock
[373.451190] Starting dynamic subtest: pipe-A-HDMI-A-3
[373.504165] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.052s)
[373.517575] Starting dynamic subtest: pipe-B-HDMI-A-3
[373.518627] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[373.529466] Starting dynamic subtest: pipe-C-HDMI-A-3
[373.530373] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[373.541573] Starting dynamic subtest: pipe-D-HDMI-A-3
[373.542487] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s)
[373.543401] Subtest zero-clock: SUCCESS (0.063s)
[373.748199] [091/134] (660s left) kms_atomic_transition (plane-all-transition-nonblocking)
[375.257192] Starting subtest: plane-all-transition-nonblocking
[375.258099] Starting dynamic subtest: pipe-A-HDMI-A-3
[379.028214] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.770s)
[379.111323] Starting dynamic subtest: pipe-B-HDMI-A-3
[383.058289] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (3.956s)
[383.115875] Subtest plane-all-transition-nonblocking: SUCCESS (7.859s)
[383.326258] [092/134] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[384.865121] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[384.866938] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[385.110819] [093/134] (649s left) gem_pxp (regular-baseline-src-copy-readible)
[387.715851] Starting subtest: regular-baseline-src-copy-readible
[387.718145] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[387.853492] [094/134] (646s left) kms_plane_scaling (planes-downscale-factor-0-5)
[389.365147] Starting subtest: planes-downscale-factor-0-5
[389.366026] Starting dynamic subtest: pipe-A
[389.457283] Dynamic subtest pipe-A: SUCCESS (0.093s)
[389.477182] Starting dynamic subtest: pipe-B
[389.602400] Dynamic subtest pipe-B: SUCCESS (0.143s)
[389.619774] Starting dynamic subtest: pipe-C
[389.744239] Dynamic subtest pipe-C: SUCCESS (0.140s)
[389.757792] Starting dynamic subtest: pipe-D
[389.868592] Dynamic subtest pipe-D: SUCCESS (0.123s)
[389.869518] Subtest planes-downscale-factor-0-5: SUCCESS (0.505s)
[390.117272] [095/134] (644s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[391.628513] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[391.687416] [096/134] (643s left) kms_content_protection (legacy-hdcp14)
[393.261968] Starting subtest: legacy-hdcp14
[393.269796] Subtest legacy-hdcp14: SKIP (0.006s)
[393.486714] [097/134] (641s left) gem_caching (writes)
[393.570357] Starting subtest: writes
[397.802311] Subtest writes: SUCCESS (4.233s)
[398.018437] [098/134] (636s left) kms_cursor_crc (cursor-onscreen-128x42)
[399.739465] Starting subtest: cursor-onscreen-128x42
[399.744483] Starting dynamic subtest: pipe-A-HDMI-A-3
[402.349437] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.605s)
[402.386493] Starting dynamic subtest: pipe-D-HDMI-A-3
[404.941813] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.566s)
[404.942613] Subtest cursor-onscreen-128x42: SUCCESS (5.202s)
[405.344030] [099/134] (629s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[406.868062] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[409.790381] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.923s)
[410.037522] [100/134] (625s left) core_auth (getclient-master-drop)
[410.083335] Starting subtest: getclient-master-drop
[410.127395] Subtest getclient-master-drop: SUCCESS (0.045s)
[410.337713] [101/134] (624s left) gem_lmem_swapping (random)
[414.950414] Starting subtest: random
[414.952965] Starting dynamic subtest: lmem0
[415.928130] Dynamic subtest lmem0: SUCCESS (0.976s)
[415.929029] Subtest random: SUCCESS (0.978s)
[418.849707] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[418.850672] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[418.852771] [102/134] (616s left) kms_psr (pr-cursor-blt)
[423.842471] Subtest pr-cursor-blt: SKIP (0.000s)
[423.919687] [FACT kms_psr (pr-cursor-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[423.921962] [FACT kms_psr (pr-cursor-blt)] new: kernel.kmod_is_loaded.i915: true
[423.924792] [103/134] (611s left) kms_async_flips (alternate-sync-async-flip)
[425.449190] Starting subtest: alternate-sync-async-flip
[425.699519] Starting dynamic subtest: pipe-A-HDMI-A-3
[427.984932] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.285s)
[428.187067] Starting dynamic subtest: pipe-B-HDMI-A-3
[430.249849] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.072s)
[430.429682] Starting dynamic subtest: pipe-C-HDMI-A-3
[432.492153] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.071s)
[432.666677] Starting dynamic subtest: pipe-D-HDMI-A-3
[434.754220] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.096s)
[434.755232] Subtest alternate-sync-async-flip: SUCCESS (9.307s)
[435.170295] [104/134] (600s left) gem_exec_whisper (basic-contexts-all)
[435.263627] Starting subtest: basic-contexts-all
[457.289103] Subtest basic-contexts-all: SUCCESS (22.024s)
[457.570935] [105/134] (577s left) syncobj_wait (wait-any-interrupted)
[457.647534] Starting subtest: wait-any-interrupted
[457.750189] Subtest wait-any-interrupted: SUCCESS (0.102s)
[457.926387] [106/134] (577s left) kms_rotation_crc (bad-pixel-format)
[459.438142] Starting subtest: bad-pixel-format
[459.440163] Subtest bad-pixel-format: SKIP (0.001s)
[459.619769] [107/134] (575s left) kms_addfb_basic (too-wide)
[461.158326] Starting subtest: too-wide
[461.159239] Subtest too-wide: SUCCESS (0.000s)
[461.393192] [108/134] (574s left) gem_spin_batch (legacy-resubmit-new)
[461.483940] Starting subtest: legacy-resubmit-new
[461.484912] Starting dynamic subtest: default
[461.515036] Dynamic subtest default: SUCCESS (0.030s)
[461.527060] Starting dynamic subtest: render
[461.528009] Dynamic subtest render: SUCCESS (0.004s)
[461.538173] Starting dynamic subtest: bsd
[461.539101] Dynamic subtest bsd: SUCCESS (0.004s)
[461.549301] Starting dynamic subtest: bsd1
[461.550200] Dynamic subtest bsd1: SUCCESS (0.004s)
[461.560506] Starting dynamic subtest: bsd2
[461.561589] Dynamic subtest bsd2: SUCCESS (0.004s)
[461.571662] Starting dynamic subtest: blt
[461.572696] Dynamic subtest blt: SUCCESS (0.005s)
[461.582696] Starting dynamic subtest: vebox
[461.583696] Dynamic subtest vebox: SUCCESS (0.007s)
[461.584729] Subtest legacy-resubmit-new: SUCCESS (0.068s)
[461.892969] [109/134] (573s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[463.417179] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[463.418100] Starting dynamic subtest: pipe-A-valid-mode
[463.473254] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[463.475028] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.057s)
[463.696637] [110/134] (572s left) gem_exec_balancer (parallel-keep-submit-fence)
[464.078719] Starting subtest: parallel-keep-submit-fence
[466.335514] Subtest parallel-keep-submit-fence: SUCCESS (2.258s)
[466.489357] [111/134] (569s left) perf (non-system-wide-paranoid)
[466.920599] Starting subtest: non-system-wide-paranoid
[466.956268] Subtest non-system-wide-paranoid: SUCCESS (0.035s)
[467.019191] [112/134] (569s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[468.540132] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[468.541946] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[468.715030] [113/134] (567s left) kms_busy (basic)
[470.264201] Starting subtest: basic
[470.265061] Starting dynamic subtest: flip
[470.913396] Dynamic subtest flip: SUCCESS (0.648s)
[470.925260] Starting dynamic subtest: modeset
[471.647348] Dynamic subtest modeset: SUCCESS (0.732s)
[471.648229] Subtest basic: SUCCESS (1.383s)
[471.913128] [114/134] (564s left) kms_plane (plane-panning-bottom-right-suspend)
[473.427212] Starting subtest: plane-panning-bottom-right-suspend
[473.428173] Starting dynamic subtest: pipe-A
[493.166728] Dynamic subtest pipe-A: SUCCESS (4.547s)
[493.179613] Starting dynamic subtest: pipe-B
[513.124296] Dynamic subtest pipe-B: SUCCESS (3.747s)
[513.125235] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.298s)
[519.374506] [115/134] (522s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[519.456930] Starting subtest: invalid-multi-wait-all-unsubmitted
[519.457786] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[519.607064] [116/134] (522s left) kms_big_fb (linear-64bpp-rotate-180)
[521.179950] Starting subtest: linear-64bpp-rotate-180
[523.648337] Subtest linear-64bpp-rotate-180: SUCCESS (2.407s)
[523.838752] [117/134] (518s left) perf (invalid-oa-metric-set-id)
[524.106172] Starting subtest: invalid-oa-metric-set-id
[524.123905] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s)
[524.189791] [118/134] (518s left) gen7_exec_parse (batch-without-end)
[524.285461] Subtest batch-without-end: SKIP (0.000s)
[524.381930] [119/134] (518s left) perf_pmu (most-busy-idle-check-all)
[524.451346] Starting subtest: most-busy-idle-check-all
[524.452358] Starting dynamic subtest: rcs0
[525.178350] Dynamic subtest rcs0: FAIL (0.689s)
[525.193025] Starting dynamic subtest: bcs0
[525.829802] Dynamic subtest bcs0: SUCCESS (0.663s)
[525.848778] Starting dynamic subtest: vcs0
[526.499945] Dynamic subtest vcs0: SUCCESS (0.657s)
[526.514012] Starting dynamic subtest: vcs1
[527.161992] Dynamic subtest vcs1: SUCCESS (0.652s)
[527.176565] Starting dynamic subtest: vecs0
[527.822913] Dynamic subtest vecs0: SUCCESS (0.651s)
[527.837353] Starting dynamic subtest: vecs1
[528.485603] Dynamic subtest vecs1: SUCCESS (0.654s)
[528.499887] Starting dynamic subtest: ccs0
[529.144861] Dynamic subtest ccs0: SUCCESS (0.651s)
[529.145807] Subtest most-busy-idle-check-all: FAIL (4.628s)
[529.332577] [120/134] (513s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[530.854560] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[530.856381] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[531.126878] [121/134] (511s left) perf_pmu (all-busy-idle-check-all)
[531.196547] Starting subtest: all-busy-idle-check-all
[531.902167] Subtest all-busy-idle-check-all: SUCCESS (0.700s)
[532.161817] [122/134] (510s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[533.683414] Starting subtest: primary-x-tiled-reflect-x-0
[544.019165] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.300s)
[544.320733] [123/134] (498s left) syncobj_wait (multi-wait-submitted)
[544.402858] Starting subtest: multi-wait-submitted
[544.508997] Subtest multi-wait-submitted: SUCCESS (0.106s)
[544.693089] [124/134] (498s left) dmabuf_sync_file (export-before-signal)
[544.756480] Starting subtest: export-before-signal
[544.757455] Subtest export-before-signal: SUCCESS (0.001s)
[544.906436] [125/134] (498s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[546.421537] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[546.422413] Starting dynamic subtest: pipe-A-HDMI-A-3
[546.430683] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[546.443497] Starting dynamic subtest: pipe-B-HDMI-A-3
[546.452600] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[546.464864] Starting dynamic subtest: pipe-C-HDMI-A-3
[546.473143] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[546.485728] Starting dynamic subtest: pipe-D-HDMI-A-3
[546.495164] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[546.496763] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[546.751706] [126/134] (496s left) kms_prop_blob (blob-prop-validate)
[546.825993] Starting subtest: blob-prop-validate
[546.826843] Subtest blob-prop-validate: SUCCESS (0.000s)
[547.025556] [127/134] (496s left) kms_vblank (query-busy-hang)
[548.541780] Starting subtest: query-busy-hang
[548.542701] Starting dynamic subtest: pipe-A-HDMI-A-3
[574.915000] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.358s)
[574.930880] Starting dynamic subtest: pipe-D-HDMI-A-3
[599.932298] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.001s)
[599.933255] Subtest query-busy-hang: SUCCESS (51.365s)
[600.166416] [128/134] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[601.681528] Starting subtest: psr-2p-primscrn-cur-indfb-move
[601.683355] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[601.910105] [129/134] (441s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[603.428324] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[603.429962] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[603.663998] [130/134] (439s left) gem_exec_schedule (promotion)
[603.754861] Starting subtest: promotion
[603.755796] Starting dynamic subtest: rcs0
[604.042406] Dynamic subtest rcs0: SUCCESS (0.287s)
[604.055021] Starting dynamic subtest: bcs0
[604.255097] Dynamic subtest bcs0: SUCCESS (0.212s)
[604.267735] Starting dynamic subtest: vcs0
[604.475572] Dynamic subtest vcs0: SUCCESS (0.219s)
[604.488353] Starting dynamic subtest: vcs1
[604.696286] Dynamic subtest vcs1: SUCCESS (0.220s)
[604.709084] Starting dynamic subtest: vecs0
[604.914719] Dynamic subtest vecs0: SUCCESS (0.217s)
[604.927548] Starting dynamic subtest: vecs1
[605.138927] Dynamic subtest vecs1: SUCCESS (0.223s)
[605.151563] Starting dynamic subtest: ccs0
[605.414862] Dynamic subtest ccs0: SUCCESS (0.275s)
[605.415759] Subtest promotion: SUCCESS (1.660s)
[605.902964] [131/134] (437s left) gem_ctx_persistence (legacy-engines-queued)
[605.983491] Starting subtest: legacy-engines-queued
[605.984535] Starting dynamic subtest: render
[606.058589] Dynamic subtest render: SUCCESS (0.074s)
[606.072877] Starting dynamic subtest: bsd1
[606.113608] Dynamic subtest bsd1: SUCCESS (0.054s)
[606.129194] Starting dynamic subtest: bsd2
[606.158546] Dynamic subtest bsd2: SUCCESS (0.044s)
[606.174192] Starting dynamic subtest: blt
[606.245988] Dynamic subtest blt: SUCCESS (0.086s)
[606.263042] Starting dynamic subtest: vebox
[606.308686] Dynamic subtest vebox: SUCCESS (0.059s)
[606.309770] Subtest legacy-engines-queued: SUCCESS (0.326s)
[606.534147] [132/134] (437s left) gem_readwrite (new-obj)
[606.610593] Subtest new-obj: SKIP (0.000s)
[606.684554] [133/134] (437s left) gem_exec_reloc (basic-cpu-read-noreloc)
[606.767879] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[606.872308] [134/134] (436s left) gem_exec_schedule (preemptive-hang)
[607.068344] Starting subtest: preemptive-hang
[607.069318] Starting dynamic subtest: rcs0
[616.542031] Dynamic subtest rcs0: SUCCESS (9.471s)
[616.554628] Starting dynamic subtest: bcs0
[625.567032] Dynamic subtest bcs0: SUCCESS (9.026s)
[625.579880] Starting dynamic subtest: vcs0
[634.525871] Dynamic subtest vcs0: SUCCESS (8.959s)
[634.538603] Starting dynamic subtest: vcs1
[643.562934] Dynamic subtest vcs1: SUCCESS (9.036s)
[643.575816] Starting dynamic subtest: vecs0
[652.526027] Dynamic subtest vecs0: SUCCESS (8.962s)
[652.538830] Starting dynamic subtest: vecs1
[661.542902] Dynamic subtest vecs1: SUCCESS (9.008s)
[661.555923] Starting dynamic subtest: ccs0
[670.559602] Dynamic subtest ccs0: SUCCESS (9.020s)
[670.560530] Subtest preemptive-hang: SUCCESS (63.490s)
[670.867024] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: i915_module_load
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_pm_rpm
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_sync
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_mmap
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_fenced_exec_thrash
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: gen3_render_tiledy_blits
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_plane_lowres
results: parsing output: 73/ for test: gem_exercise_blt
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_wait
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_chamelium_edid
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: fbdev
results: parsing output: 89/ for test: kms_invalid_mode
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_caching
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gen7_exec_parse
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: dmabuf_sync_file
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: gem_readwrite
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: gem_exec_schedule
Done.