[35.416514] Initializing watchdogs
[35.416571]   /dev/watchdog0
[35.420910] [001/142] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[35.506577] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[35.508095] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[35.575980] [002/142] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[35.630905] Starting subtest: invalid-bsd2-flag-on-render
[35.631647] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[35.725893] [003/142] (960s left) gem_basic (bad-close)
[35.778474] Starting subtest: bad-close
[35.779962] Subtest bad-close: SUCCESS (0.000s)
[35.833788] [004/142] (960s left) kms_atomic_interruptible (legacy-pageflip)
[35.932183] Starting subtest: legacy-pageflip
[35.932924] Starting dynamic subtest: HDMI-A-2-pipe-A
[42.181255] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (6.249s)
[42.182028] Subtest legacy-pageflip: SUCCESS (6.250s)
[42.304328] [005/142] (953s left) gem_exec_schedule (semaphore-user)
[42.356432] Starting subtest: semaphore-user
[42.363434] Subtest semaphore-user: SUCCESS (0.007s)
[42.651390] [006/142] (953s left) gem_lmem_swapping (heavy-multi)
[42.701892] Subtest heavy-multi: SKIP (0.000s)
[42.714497] [007/142] (953s left) drm_fdinfo (virtual-busy-idle)
[42.759752] Starting subtest: virtual-busy-idle
[45.317687] Subtest virtual-busy-idle: SUCCESS (2.557s)
[45.386506] [008/142] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[45.475906] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[45.477215] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[45.588140] [009/142] (950s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_mc_ccs)
[45.861735] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[45.956923] [010/142] (950s left) vgem_basic (bad-flag)
[46.030512] Starting subtest: bad-flag
[46.031224] Subtest bad-flag: SUCCESS (0.000s)
[46.073530] [011/142] (949s left) gem_exec_fair (basic-sync)
[46.123721] Starting subtest: basic-sync
[46.124438] Starting dynamic subtest: rcs0
[50.457377] Dynamic subtest rcs0: SUCCESS (4.334s)
[50.458101] Subtest basic-sync: SUCCESS (4.334s)
[50.641507] [012/142] (945s left) gem_vm_create (create-ext)
[50.702681] Starting subtest: create-ext
[50.704103] Subtest create-ext: SUCCESS (0.001s)
[50.808215] [013/142] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[50.898811] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[50.900206] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[50.974561] [014/142] (945s left) api_intel_allocator (fork-simple-once)
[51.035513] Starting subtest: fork-simple-once
[51.047068] Subtest fork-simple-once: SUCCESS (0.012s)
[51.139784] [015/142] (944s left) kms_vblank (pipe-a-wait-busy-hang)
[51.229736] Starting subtest: pipe-A-wait-busy-hang
[65.035291] Subtest pipe-A-wait-busy-hang: SUCCESS (13.806s)
[65.164732] [016/142] (930s left) kms_chamelium_color (ctm-blue-to-red)
[65.244035] Subtest ctm-blue-to-red: SKIP (0.000s)
[65.259106] [017/142] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[65.338747] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[65.340107] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[65.416940] [018/142] (930s left) kms_vblank (pipe-a-query-idle)
[65.504310] Starting subtest: pipe-A-query-idle
[67.759258] Subtest pipe-A-query-idle: SUCCESS (2.255s)
[67.877877] [019/142] (928s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[68.081334] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[68.082708] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[68.219558] [020/142] (927s left) kms_invalid_mode (zero-vdisplay)
[68.297686] Starting subtest: zero-vdisplay
[68.298389] Starting dynamic subtest: HDMI-A-2-pipe-A
[68.369676] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.073s)
[68.372896] Starting dynamic subtest: HDMI-A-2-pipe-B
[68.380383] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.010s)
[68.381085] Subtest zero-vdisplay: SUCCESS (0.085s)
[68.508216] [021/142] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[68.586577] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[68.587926] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[68.658206] [022/142] (927s left) gem_exec_gttfill (engines)
[68.706996] Starting subtest: engines
[68.707729] Starting dynamic subtest: rcs0
[91.190173] Dynamic subtest rcs0: SUCCESS (22.483s)
[91.194626] Starting dynamic subtest: bcs0
[113.411042] Dynamic subtest bcs0: SUCCESS (22.221s)
[113.415109] Starting dynamic subtest: vcs0
[135.680057] Dynamic subtest vcs0: SUCCESS (22.269s)
[135.683994] Starting dynamic subtest: vecs0
[157.940195] Dynamic subtest vecs0: SUCCESS (22.260s)
[157.940939] Subtest engines: SUCCESS (89.233s)
[158.099436] [023/142] (838s left) api_intel_bb (simple-bb)
[158.186419] Starting subtest: simple-bb
[158.188603] Subtest simple-bb: SUCCESS (0.002s)
[158.293203] [024/142] (837s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[158.552907] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[158.649578] [025/142] (837s left) gem_ctx_persistence (legacy-engines-hostile)
[158.694591] Starting subtest: legacy-engines-hostile
[158.695366] Starting dynamic subtest: render
[158.801812] Dynamic subtest render: SUCCESS (0.107s)
[158.805476] Starting dynamic subtest: bsd
[158.890428] Dynamic subtest bsd: SUCCESS (0.088s)
[158.898900] Starting dynamic subtest: blt
[158.980409] Dynamic subtest blt: SUCCESS (0.089s)
[158.994564] Starting dynamic subtest: vebox
[159.074356] Dynamic subtest vebox: SUCCESS (0.093s)
[159.075647] Subtest legacy-engines-hostile: SUCCESS (0.379s)
[159.150204] [026/142] (837s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[159.211276] Starting subtest: etime-single-wait-all-for-submit-submitted
[159.318689] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[159.386089] [027/142] (836s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[159.486626] Starting subtest: 4-tiled-32bpp-rotate-180
[159.487993] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[159.549529] [028/142] (836s left) kms_color (ctm-0-50)
[159.642738] Starting subtest: ctm-0-50
[159.643475] Starting dynamic subtest: pipe-A
[160.991755] Dynamic subtest pipe-A: SUCCESS (1.350s)
[160.995442] Starting dynamic subtest: pipe-B
[162.502622] Dynamic subtest pipe-B: SUCCESS (1.509s)
[162.503346] Subtest ctm-0-50: SUCCESS (2.860s)
[162.626705] [029/142] (833s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[162.777945] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[162.779333] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[162.971846] [030/142] (833s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[163.047388] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[163.048094] Starting dynamic subtest: pipe-A-HDMI-A-2
[163.127299] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.079s)
[163.131724] Starting dynamic subtest: pipe-B-HDMI-A-2
[163.281444] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.153s)
[163.282189] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.234s)
[163.465434] [031/142] (832s left) gem_softpin (softpin)
[163.511910] Starting subtest: softpin
[195.788491] Subtest softpin: SUCCESS (32.275s)
[195.881282] [032/142] (800s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.976682] Starting subtest: cursor-onscreen-64x64
[195.978865] Starting dynamic subtest: pipe-A-HDMI-A-2
[198.257302] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.279s)
[198.276633] Starting dynamic subtest: pipe-B-HDMI-A-2
[200.664224] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.391s)
[200.664918] Subtest cursor-onscreen-64x64: SUCCESS (4.688s)
[200.789656] [033/142] (795s left) gem_exec_reloc (basic-cpu-read-noreloc)
[200.839262] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[200.865638] [034/142] (795s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[200.953970] Starting subtest: short-flip-after-cursor-atomic-transitions
[201.937710] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.985s)
[202.062367] [035/142] (794s left) gem_exec_whisper (basic-contexts)
[202.111685] Starting subtest: basic-contexts
[203.482993] Subtest basic-contexts: SUCCESS (1.371s)
[203.654138] [036/142] (792s left) perf (short-reads)
[203.772606] Starting subtest: short-reads
[203.783519] Subtest short-reads: SUCCESS (0.012s)
[203.814491] [037/142] (792s left) kms_vblank (pipe-d-wait-forked)
[203.911963] Subtest pipe-D-wait-forked: SKIP (0.000s)
[203.961848] [038/142] (792s left) gem_mmap_wc (write)
[204.005149] Starting subtest: write
[204.060368] Subtest write: SUCCESS (0.055s)
[204.145778] [039/142] (792s left) gem_exec_schedule (manyslice)
[204.206926] Starting subtest: manyslice
[204.207598] Starting dynamic subtest: rcs0
[204.520078] Dynamic subtest rcs0: SUCCESS (0.313s)
[204.524176] Starting dynamic subtest: bcs0
[204.815025] Dynamic subtest bcs0: SUCCESS (0.295s)
[204.820013] Starting dynamic subtest: vcs0
[205.132008] Dynamic subtest vcs0: SUCCESS (0.317s)
[205.136995] Starting dynamic subtest: vecs0
[205.446822] Dynamic subtest vecs0: SUCCESS (0.315s)
[205.447579] Subtest manyslice: SUCCESS (1.240s)
[205.748987] [040/142] (790s left) gem_softpin (32b-excludes-last-page)
[205.808431] Starting subtest: 32b-excludes-last-page
[205.809927] Subtest 32b-excludes-last-page: SUCCESS (0.001s)
[205.914749] [041/142] (790s left) perf (i915-ref-count)
[206.013658] Starting subtest: i915-ref-count
[206.034521] Subtest i915-ref-count: SUCCESS (0.021s)
[206.066419] [042/142] (790s left) i915_module_load (reload-with-fault-injection)
[206.125135] Starting subtest: reload-with-fault-injection
[211.658484] Subtest reload-with-fault-injection: SUCCESS (5.533s)
[211.680565] [043/142] (784s left) syncobj_wait (invalid-signal-illegal-handle)
[213.781609] Starting subtest: invalid-signal-illegal-handle
[213.782318] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[213.838809] [044/142] (782s left) gem_ctx_engines (none)
[213.889880] Starting subtest: none
[213.891413] Subtest none: SUCCESS (0.001s)
[214.060536] [045/142] (782s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[214.146067] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[215.244722] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.098s)
[215.370120] [046/142] (781s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[215.548525] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[215.550556] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[215.649617] [047/142] (780s left) kms_busy (extended-pageflip-hang-oldfb)
[215.728205] Starting subtest: extended-pageflip-hang-oldfb
[215.728918] Starting dynamic subtest: pipe-A
[215.907701] Dynamic subtest pipe-A: SUCCESS (0.179s)
[215.911566] Starting dynamic subtest: pipe-B
[216.055416] Dynamic subtest pipe-B: SUCCESS (0.147s)
[216.056120] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.328s)
[216.192757] [048/142] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[216.274778] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[216.276085] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.358827] [049/142] (780s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[216.436030] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[218.163673] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (1.729s)
[218.380444] [050/142] (778s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[218.565980] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[218.568139] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[218.724164] [051/142] (777s left) gem_exec_big (single)
[218.769445] Starting subtest: single
[219.609301] Subtest single: SUCCESS (0.840s)
[219.764976] [052/142] (776s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[219.844436] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[219.949987] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[220.007161] [053/142] (776s left) syncobj_timeline (multi-wait-submitted-signaled)
[220.050354] Starting subtest: multi-wait-submitted-signaled
[220.051841] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[220.125475] [054/142] (776s left) prime_busy (after)
[220.178092] Starting subtest: after
[220.181420] Starting dynamic subtest: rcs0
[220.204457] Dynamic subtest rcs0: SUCCESS (0.023s)
[220.210489] Starting dynamic subtest: bcs0
[220.246112] Dynamic subtest bcs0: SUCCESS (0.040s)
[220.254070] Starting dynamic subtest: vcs0
[220.267386] Dynamic subtest vcs0: SUCCESS (0.021s)
[220.279871] Starting dynamic subtest: vecs0
[220.282324] Dynamic subtest vecs0: SUCCESS (0.014s)
[220.389759] Subtest after: SUCCESS (0.211s)
[220.460537] [055/142] (776s left) gem_busy (semaphore)
[220.657232] Starting subtest: semaphore
[220.658178] Starting dynamic subtest: rcs0
[220.702470] Dynamic subtest rcs0: SUCCESS (0.045s)
[220.712869] Starting dynamic subtest: bcs0
[220.721614] Dynamic subtest bcs0: SUCCESS (0.018s)
[220.728719] Starting dynamic subtest: vcs0
[220.738479] Dynamic subtest vcs0: SUCCESS (0.016s)
[220.748899] Starting dynamic subtest: vecs0
[220.757437] Dynamic subtest vecs0: SUCCESS (0.018s)
[220.758494] Subtest semaphore: SUCCESS (0.101s)
[220.970706] [056/142] (775s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[221.052086] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[221.052828] Starting dynamic subtest: pipe-A-valid-mode
[221.118439] Dynamic subtest pipe-A-valid-mode: SKIP (0.066s)
[221.119866] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.067s)
[221.215753] [057/142] (775s left) gem_mmap (big-bo)
[221.258949] Starting subtest: big-bo
[221.337082] Subtest big-bo: SUCCESS (0.078s)
[221.439923] [058/142] (775s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[221.569452] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[221.570814] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[221.659830] [059/142] (775s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[221.926738] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[222.023250] [060/142] (774s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[222.265655] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[222.363089] [061/142] (774s left) kms_plane_multiple (tiling-y)
[222.443893] Starting subtest: tiling-y
[222.444598] Starting dynamic subtest: pipe-A-HDMI-A-2
[223.184493] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.740s)
[223.188758] Starting dynamic subtest: pipe-B-HDMI-A-2
[223.878582] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.694s)
[223.879326] Subtest tiling-y: SUCCESS (1.435s)
[224.013700] [062/142] (772s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[224.274795] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[224.371963] [063/142] (772s left) gem_fence_thrash (bo-write-verify-x)
[224.413356] Starting subtest: bo-write-verify-x
[225.516645] Subtest bo-write-verify-x: SUCCESS (1.103s)
[225.600633] [064/142] (771s left) api_intel_bb (add-remove-objects)
[225.655659] Starting subtest: add-remove-objects
[225.658356] Subtest add-remove-objects: SUCCESS (0.004s)
[225.774917] [065/142] (771s left) drm_read (invalid-buffer)
[225.944854] Starting subtest: invalid-buffer
[225.945564] Subtest invalid-buffer: SUCCESS (0.000s)
[226.075105] [066/142] (770s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[226.331875] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[226.429620] [067/142] (770s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[226.509475] Starting subtest: fbc-1p-pri-indfb-multidraw
[241.585168] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (15.077s)
[241.710892] [068/142] (755s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[241.796173] Starting subtest: psr-rgb565-draw-render
[241.797596] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[241.862517] [069/142] (755s left) gem_exec_reloc (basic-softpin)
[241.920998] Subtest basic-softpin: SKIP (0.000s)
[241.985937] [070/142] (754s left) gem_exec_reloc (basic-write-read-noreloc)
[242.033382] Subtest basic-write-read-noreloc: SKIP (0.000s)
[242.078692] [071/142] (754s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[242.174047] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[242.175437] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[242.252442] [072/142] (754s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[242.343198] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[242.343926] Starting dynamic subtest: pipe-A-valid-mode
[243.668331] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.325s)
[243.669055] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (1.326s)
[243.798335] [073/142] (753s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[244.005184] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[244.005915] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[244.155912] [074/142] (752s left) kms_getfb (getfb-handle-not-fb)
[244.198968] Starting subtest: getfb-handle-not-fb
[244.234583] Subtest getfb-handle-not-fb: SUCCESS (0.034s)
[244.322670] [075/142] (752s left) dumb_buffer (map-uaf)
[244.366013] Starting subtest: map-uaf
[244.367553] Subtest map-uaf: SUCCESS (0.003s)
[244.452676] [076/142] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[244.547839] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[244.549222] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[244.647293] [077/142] (752s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[244.706273] Starting subtest: cpuset-basic-small-copy-odd
[249.966429] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.259s)
[250.051907] [078/142] (746s left) i915_pm_rps (reset)
[250.142611] Starting subtest: reset
[253.667195] Subtest reset: SUCCESS (3.524s)
[253.760996] [079/142] (743s left) kms_flip (2x-flip-vs-fences)
[253.849848] Starting subtest: 2x-flip-vs-fences
[253.851247] Subtest 2x-flip-vs-fences: SKIP (0.001s)
[253.959678] [080/142] (743s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[254.052289] Starting subtest: short-busy-flip-before-cursor-toggle
[254.053614] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[254.105312] [081/142] (742s left) prime_self_import (basic-with_one_bo)
[254.147946] Starting subtest: basic-with_one_bo
[254.150273] Subtest basic-with_one_bo: SUCCESS (0.002s)
[254.210547] [082/142] (742s left) kms_selftest (drm_format)
[254.257159] Starting subtest: drm_format
[254.263028] Subtest drm_format: SKIP (0.005s)
[254.327104] [083/142] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[254.418887] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[254.420395] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[254.489247] [084/142] (742s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[254.546598] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[254.572337] [085/142] (742s left) kms_psr (sprite_plane_move)
[254.628707] Subtest sprite_plane_move: SKIP (0.000s)
[254.649759] [086/142] (742s left) kms_lease (master-vs-lease)
[254.741882] Starting subtest: master-vs-lease
[254.743214] Subtest master-vs-lease: SUCCESS (0.002s)
[254.805416] [087/142] (742s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[255.070423] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[255.167625] [088/142] (742s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[255.211942] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[255.212752] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[255.267615] [089/142] (741s left) gem_ctx_shared (single-timeline)
[255.315817] Starting subtest: single-timeline
[255.320992] Subtest single-timeline: SUCCESS (0.003s)
[255.505229] [090/142] (741s left) sysfs_heartbeat_interval (nopreempt)
[255.562335] Starting subtest: nopreempt
[255.563107] Starting dynamic subtest: vecs0
[259.026438] Dynamic subtest vecs0: SUCCESS (3.463s)
[259.030837] Starting dynamic subtest: vcs0
[262.478595] Dynamic subtest vcs0: SUCCESS (3.452s)
[262.483089] Starting dynamic subtest: bcs0
[265.948471] Dynamic subtest bcs0: SUCCESS (3.469s)
[265.952854] Starting dynamic subtest: rcs0
[269.422604] Dynamic subtest rcs0: SUCCESS (3.474s)
[269.423407] Subtest nopreempt: SUCCESS (13.860s)
[269.484088] [091/142] (727s left) kms_psr2_su (page_flip-p010)
[269.527651] Subtest page_flip-P010: SKIP (0.000s)
[269.544444] [092/142] (727s left) gen3_mixed_blits
[269.611346] [093/142] (727s left) kms_getfb (getfb2-into-addfb2)
[269.662899] Starting subtest: getfb2-into-addfb2
[269.663608] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[269.771562] [094/142] (727s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[269.859405] Starting subtest: flip-vs-cursor-legacy
[277.211879] Subtest flip-vs-cursor-legacy: SUCCESS (7.353s)
[277.338451] [095/142] (719s left) kms_chamelium_hpd (dp-hpd-storm)
[277.482500] Subtest dp-hpd-storm: SKIP (0.000s)
[277.548087] [096/142] (719s left) gem_userptr_blits (access-control)
[277.605594] Starting subtest: access-control
[277.606978] Subtest access-control: SKIP (0.000s)
[277.685128] [097/142] (719s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[277.729438] Starting subtest: no-spare-fences-busy
[279.894538] Subtest no-spare-fences-busy: SUCCESS (2.165s)
[280.001066] [098/142] (717s left) kms_content_protection (content_type_change)
[280.091445] Starting subtest: content_type_change
[280.264360] Subtest content_type_change: SKIP (0.170s)
[280.427391] [099/142] (716s left) kms_rotation_crc (sprite-rotation-270)
[280.503878] Starting subtest: sprite-rotation-270
[286.886784] Subtest sprite-rotation-270: SUCCESS (6.382s)
[287.102049] [100/142] (710s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[287.173827] Subtest get-values-invalid-pointer: SKIP (0.000s)
[287.235256] [101/142] (710s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[287.320464] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[287.321846] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[287.415836] [102/142] (709s left) gem_exec_balancer (hog)
[287.473140] Starting subtest: hog
[288.242796] Subtest hog: SUCCESS (0.769s)
[289.195825] [103/142] (708s left) gem_exec_flush (basic-uc-ro-default)
[289.259137] Starting subtest: basic-uc-ro-default
[294.685498] Subtest basic-uc-ro-default: SUCCESS (5.432s)
[294.882265] [104/142] (702s left) i915_suspend (forcewake)
[294.956118] Starting subtest: forcewake
[313.610289] Subtest forcewake: SUCCESS (18.650s)
[317.663792] [105/142] (683s left) v3d/v3d_submit_cl (bad-multisync-extension)
[317.744261] Subtest bad-multisync-extension: SKIP (0.000s)
[317.807982] [106/142] (683s left) kms_cursor_legacy (torture-move)
[317.889352] Starting subtest: torture-move
[317.890053] Starting dynamic subtest: pipe-A
[323.375201] Dynamic subtest pipe-A: SUCCESS (5.485s)
[323.381309] Starting dynamic subtest: pipe-B
[329.031353] Dynamic subtest pipe-B: SUCCESS (5.656s)
[329.036412] Starting dynamic subtest: all-pipes
[334.549328] Dynamic subtest all-pipes: SUCCESS (5.518s)
[334.550057] Subtest torture-move: SUCCESS (16.660s)
[334.633248] [107/142] (666s left) gem_wait (invalid-buf)
[334.718572] Starting subtest: invalid-buf
[334.719354] Subtest invalid-buf: SUCCESS (0.000s)
[334.935786] [108/142] (666s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[335.017342] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[335.018710] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[335.119391] [109/142] (666s left) gem_pxp (protected-raw-src-copy-not-readible)
[337.687404] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[337.753543] [110/142] (663s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[337.968683] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[337.970086] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[338.103866] [111/142] (663s left) gen9_exec_parse (batch-invalid-length)
[338.148873] Subtest batch-invalid-length: SKIP (0.000s)
[338.164783] [112/142] (663s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[338.343213] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[338.344606] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[338.511900] [113/142] (663s left) gen7_exec_parse (basic-allocation)
[338.558146] Subtest basic-allocation: SKIP (0.000s)
[338.572910] [114/142] (663s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[338.649328] Starting subtest: cursor-vs-flip-toggle
[367.470957] Subtest cursor-vs-flip-toggle: SUCCESS (28.823s)
[367.591031] [115/142] (634s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[367.669448] Starting subtest: pipe-B-ts-continuation-idle-hang
[381.943730] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (14.275s)
[382.072372] [116/142] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[382.152520] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[383.743467] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.592s)
[383.887433] [117/142] (617s left) i915_query (query-topology-known-pci-ids)
[383.941316] Starting subtest: query-topology-known-pci-ids
[383.942726] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[384.025970] [118/142] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[384.110307] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[384.111653] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[384.199420] [119/142] (617s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[384.293105] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[384.626216] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.333s)
[384.760559] [120/142] (616s left) kms_hdmi_inject (inject-audio)
[384.886713] Starting subtest: inject-audio
[384.981499] Subtest inject-audio: SUCCESS (0.095s)
[385.180487] [121/142] (616s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[385.257312] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[385.258041] Starting dynamic subtest: pipe-A-HDMI-A-2
[385.334216] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.077s)
[385.411677] Starting dynamic subtest: pipe-B-HDMI-A-2
[385.562578] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.155s)
[385.623883] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.361s)
[385.733781] [122/142] (616s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[385.804961] Subtest get-values-valid-perfmon: SKIP (0.000s)
[385.850375] [123/142] (615s left) perf_pmu (busy-idle)
[385.894376] Starting subtest: busy-idle
[385.895095] Starting dynamic subtest: rcs0
[386.559522] Dynamic subtest rcs0: SUCCESS (0.660s)
[386.569296] Starting dynamic subtest: bcs0
[387.184333] Dynamic subtest bcs0: SUCCESS (0.627s)
[387.195382] Starting dynamic subtest: vcs0
[387.820334] Dynamic subtest vcs0: SUCCESS (0.634s)
[387.830802] Starting dynamic subtest: vecs0
[388.443321] Dynamic subtest vecs0: SUCCESS (0.621s)
[388.444537] Subtest busy-idle: SUCCESS (2.549s)
[388.514126] [124/142] (613s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[388.594441] Starting subtest: flip-vs-cursor-crc-legacy
[389.092850] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.499s)
[389.214260] [125/142] (612s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[389.291429] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[389.292167] Starting dynamic subtest: pipe-A-HDMI-A-2
[395.300391] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.009s)
[395.307165] Starting dynamic subtest: pipe-B-HDMI-A-2
[401.304643] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.003s)
[401.305362] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (12.015s)
[401.490430] [126/142] (600s left) gem_mmap_offset (perf)
[401.535431] Starting subtest: perf
[401.536155] Starting dynamic subtest: smem0
[401.697069] Dynamic subtest smem0: SUCCESS (0.162s)
[401.697790] Subtest perf: SUCCESS (0.162s)
[401.793954] [127/142] (600s left) i915_pm_rpm (gem-execbuf-stress)
[403.298522] Starting subtest: gem-execbuf-stress
[403.300103] Starting dynamic subtest: smem0
[404.911785] Dynamic subtest smem0: SUCCESS (1.612s)
[404.924350] Starting dynamic subtest: extra-wait-smem0
[456.524251] Dynamic subtest extra-wait-smem0: SUCCESS (51.610s)
[456.525725] Subtest gem-execbuf-stress: SUCCESS (53.227s)
[456.732474] [128/142] (545s left) gem_exec_reloc (basic-write-wc-active)
[456.777520] Subtest basic-write-wc-active: SKIP (0.000s)
[456.810254] [129/142] (545s left) i915_pm_rpm (basic-rte)
[456.855477] Starting subtest: basic-rte
[458.689318] Subtest basic-rte: SUCCESS (1.833s)
[459.235187] [130/142] (542s left) gem_exec_params (sol-reset-not-gen7)
[459.279932] Starting subtest: sol-reset-not-gen7
[459.280636] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[459.391608] [131/142] (542s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[459.476348] Starting subtest: yf-tiled-32bpp-rotate-90
[459.477746] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[459.563298] [132/142] (542s left) v3d/v3d_wait_bo (used-bo-1ns)
[459.639178] Subtest used-bo-1ns: SKIP (0.000s)
[459.698169] [133/142] (542s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[459.782570] Starting subtest: fbc-rgb565-draw-mmap-gtt
[461.955521] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.174s)
[462.083255] [134/142] (539s left) kms_vblank (pipe-b-query-busy)
[462.163481] Starting subtest: pipe-B-query-busy
[464.905169] Subtest pipe-B-query-busy: SUCCESS (2.743s)
[465.036422] [135/142] (536s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[465.079463] Starting subtest: single-wait-all-for-submit-signaled
[465.080161] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[465.150221] [136/142] (536s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[465.207203] Starting subtest: mixed-tiled-to-y-tiled-ccs
[465.207935] Starting dynamic subtest: smem
[465.346761] Dynamic subtest smem: SUCCESS (0.139s)
[465.347488] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.140s)
[465.526290] [137/142] (536s left) gem_exec_fence (syncobj-timeline-chain-engines)
[465.979571] Starting subtest: syncobj-timeline-chain-engines
[466.013340] Subtest syncobj-timeline-chain-engines: SUCCESS (0.035s)
[466.201661] [138/142] (535s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[466.294272] Starting subtest: x-tiled-64bpp-rotate-270
[466.338477] Subtest x-tiled-64bpp-rotate-270: SKIP (0.043s)
[466.437234] [139/142] (535s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[466.513875] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[467.238901] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.725s)
[467.338916] [140/142] (534s left) kms_cursor_crc (cursor-sliding-32x10)
[467.416429] Starting subtest: cursor-sliding-32x10
[467.446004] Subtest cursor-sliding-32x10: SKIP (0.028s)
[467.522355] [141/142] (534s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[467.598403] Starting subtest: cursorB-vs-flipA-toggle
[467.599804] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[467.655762] [142/142] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[467.734440] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[467.735805] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[467.821519] Closing watchdogs
Done.