[40.287834] Initializing watchdogs
[40.288061]   /dev/watchdog0
[40.322944] [001/138] (960s left) kms_atomic_transition (plane-all-transition-fencing)
[40.666159] Starting subtest: plane-all-transition-fencing
[40.686634] Starting dynamic subtest: pipe-A-DP-1
[44.780156] Dynamic subtest pipe-A-DP-1: SUCCESS (4.111s)
[44.941435] Starting dynamic subtest: pipe-B-DP-1
[49.409944] Dynamic subtest pipe-B-DP-1: SUCCESS (4.495s)
[49.504779] Subtest plane-all-transition-fencing: SUCCESS (8.840s)
[49.881546] [002/138] (951s left) gem_exec_whisper (basic-contexts-forked)
[50.172621] Starting subtest: basic-contexts-forked
[64.890431] Subtest basic-contexts-forked: SUCCESS (14.739s)
[65.107587] [003/138] (935s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[65.395474] Subtest get-values-valid-perfmon: SKIP (0.000s)
[65.478725] [004/138] (935s left) kms_flip (basic-plain-flip)
[65.792109] Starting subtest: basic-plain-flip
[65.813450] Starting dynamic subtest: A-DP1
[67.425640] Dynamic subtest A-DP1: SUCCESS (1.664s)
[67.458856] Starting dynamic subtest: B-DP1
[68.549207] Dynamic subtest B-DP1: SUCCESS (1.122s)
[68.585048] Starting dynamic subtest: C-DP1
[69.674833] Dynamic subtest C-DP1: SUCCESS (1.129s)
[69.694676] Subtest basic-plain-flip: SUCCESS (3.922s)
[70.118565] [005/138] (931s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[70.355834] Starting subtest: invalid-multi-wait-unsubmitted
[70.374490] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[70.460833] [006/138] (930s left) gem_exec_alignment (single)
[70.691823] Starting subtest: single
[70.715585] Subtest single: SUCCESS (0.010s)
[70.823290] [007/138] (930s left) kms_cursor_crc (cursor-onscreen-512x512)
[71.147096] Starting subtest: cursor-onscreen-512x512
[71.186896] Subtest cursor-onscreen-512x512: SKIP (0.003s)
[71.276096] [008/138] (930s left) gem_mmap_gtt (cpuset-medium-copy)
[71.514875] Starting subtest: cpuset-medium-copy
[83.375580] Subtest cpuset-medium-copy: SUCCESS (11.901s)
[83.489122] [009/138] (917s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[83.978244] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[83.999657] Starting dynamic subtest: pipe-A-DP-1
[85.041882] Dynamic subtest pipe-A-DP-1: SUCCESS (1.034s)
[85.078644] Starting dynamic subtest: pipe-B-DP-1
[86.338663] Dynamic subtest pipe-B-DP-1: SUCCESS (1.296s)
[86.378598] Starting dynamic subtest: pipe-C-DP-1
[87.315693] Dynamic subtest pipe-C-DP-1: SUCCESS (0.963s)
[87.337118] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.323s)
[87.748939] [010/138] (913s left) perf (gen12-unprivileged-single-ctx-counters)
[88.182284] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[88.273378] [011/138] (913s left) api_intel_bb (object-reloc-keep-cache)
[88.509508] Starting subtest: object-reloc-keep-cache
[88.530869] Subtest object-reloc-keep-cache: SUCCESS (0.013s)
[88.637582] [012/138] (913s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[89.003374] Starting subtest: 4-tiled-64bpp-rotate-0
[89.044878] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[89.144914] [013/138] (912s left) kms_lease (page-flip-implicit-plane)
[89.461483] Starting subtest: page-flip-implicit-plane
[89.482917] Starting dynamic subtest: pipe-A-DP-1
[89.776677] Dynamic subtest pipe-A-DP-1: SUCCESS (0.305s)
[89.811633] Starting dynamic subtest: pipe-B-DP-1
[90.241414] Dynamic subtest pipe-B-DP-1: SUCCESS (0.457s)
[90.282976] Starting dynamic subtest: pipe-C-DP-1
[90.728045] Dynamic subtest pipe-C-DP-1: SUCCESS (0.478s)
[90.748720] Subtest page-flip-implicit-plane: SUCCESS (1.248s)
[91.031851] [014/138] (910s left) syncobj_wait (wait-any-snapshot)
[91.269496] Starting subtest: wait-any-snapshot
[91.320782] Subtest wait-any-snapshot: SUCCESS (0.082s)
[91.438793] [015/138] (910s left) gem_pwrite (basic-exhaustion)
[91.670427] Starting subtest: basic-exhaustion
[108.225717] Subtest basic-exhaustion: SUCCESS (16.591s)
[108.354908] [016/138] (893s left) syncobj_timeline (transfer-timeline-point)
[108.572709] Starting subtest: transfer-timeline-point
[108.593958] Subtest transfer-timeline-point: SUCCESS (0.001s)
[108.681675] [017/138] (893s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[109.133076] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[109.172438] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[109.551304] [018/138] (892s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[109.858548] Starting subtest: modeset-transition-nonblocking-fencing
[109.877712] Starting dynamic subtest: 1x-outputs
[114.880215] Dynamic subtest 1x-outputs: SUCCESS (5.038s)
[114.998373] Subtest modeset-transition-nonblocking-fencing: SUCCESS (5.137s)
[115.349640] [019/138] (886s left) kms_flip (wf_vblank-ts-check-interruptible)
[115.678671] Starting subtest: wf_vblank-ts-check-interruptible
[115.698295] Starting dynamic subtest: A-DP1
[126.452153] Dynamic subtest A-DP1: SUCCESS (10.782s)
[126.489623] Starting dynamic subtest: B-DP1
[137.170993] Dynamic subtest B-DP1: SUCCESS (10.723s)
[137.208518] Starting dynamic subtest: C-DP1
[147.867685] Dynamic subtest C-DP1: SUCCESS (10.693s)
[147.894383] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.207s)
[148.311330] [020/138] (854s left) api_intel_allocator (fork-simple-once)
[148.542812] Starting subtest: fork-simple-once
[148.564728] Subtest fork-simple-once: SUCCESS (0.048s)
[148.687858] [021/138] (853s left) kms_rotation_crc (primary-rotation-180)
[148.987158] Starting subtest: primary-rotation-180
[153.348925] Subtest primary-rotation-180: SUCCESS (4.369s)
[153.789907] [022/138] (848s left) kms_getfb (getfb2-handle-not-fb)
[154.025288] Starting subtest: getfb2-handle-not-fb
[154.084737] Subtest getfb2-handle-not-fb: SUCCESS (0.094s)
[154.205329] [023/138] (848s left) v3d/v3d_submit_csd (bad-pad)
[154.492330] Subtest bad-pad: SKIP (0.000s)
[154.579544] [024/138] (848s left) v3d/v3d_create_bo (create-bo-4096)
[154.863085] Subtest create-bo-4096: SKIP (0.000s)
[154.953109] [025/138] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[155.314450] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[155.351470] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.445687] [026/138] (847s left) kms_psr (cursor_blt)
[155.700512] Subtest cursor_blt: SKIP (0.000s)
[155.789284] [027/138] (847s left) gem_ctx_persistence (hostile)
[156.021349] Starting subtest: hostile
[158.139735] Subtest hostile: SUCCESS (2.124s)
[158.252647] [028/138] (844s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[158.775060] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[158.824452] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[159.149999] [029/138] (844s left) gem_exec_params (secure-non-master)
[159.416645] Starting subtest: secure-non-master
[159.469140] Subtest secure-non-master: SKIP (0.000s)
[159.582478] [030/138] (843s left) gem_tiled_pread_basic
[160.196632] [031/138] (843s left) kms_cursor_crc (cursor-sliding-128x128)
[160.546686] Starting subtest: cursor-sliding-128x128
[160.572037] Starting dynamic subtest: pipe-A-DP-1
[164.218511] Dynamic subtest pipe-A-DP-1: SUCCESS (3.676s)
[164.310292] Starting dynamic subtest: pipe-C-DP-1
[168.027460] Dynamic subtest pipe-C-DP-1: SUCCESS (3.756s)
[168.048789] Subtest cursor-sliding-128x128: SUCCESS (7.512s)
[168.425305] [032/138] (835s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[168.800524] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[168.843558] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[168.933174] [033/138] (834s left) syncobj_basic (bad-pad-fd-to-handle)
[169.160825] Starting subtest: bad-pad-fd-to-handle
[169.181328] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[169.266089] [034/138] (834s left) gem_mmap_wc (read-write)
[169.500753] Starting subtest: read-write
[169.519610] Subtest read-write: SUCCESS (0.034s)
[169.640267] [035/138] (834s left) perf_pmu (event-wait)
[169.872843] Starting subtest: event-wait
[169.894431] Starting dynamic subtest: rcs0
[169.936405] Dynamic subtest rcs0: SKIP (0.000s)
[169.975719] Subtest event-wait: SKIP (0.002s)
[170.081921] [036/138] (833s left) gen9_exec_parse (bb-start-out)
[170.315052] Starting subtest: bb-start-out
[170.333689] Subtest bb-start-out: SUCCESS (0.004s)
[170.585371] [037/138] (833s left) gem_ctx_shared (q-out-order)
[170.821728] Starting subtest: Q-out-order
[170.840451] Starting dynamic subtest: rcs0
[170.918948] Dynamic subtest rcs0: SUCCESS (0.106s)
[170.958428] Starting dynamic subtest: bcs0
[171.035246] Dynamic subtest bcs0: SUCCESS (0.112s)
[171.074054] Starting dynamic subtest: vcs0
[171.126988] Dynamic subtest vcs0: SUCCESS (0.093s)
[171.166276] Starting dynamic subtest: vecs0
[171.223387] Dynamic subtest vecs0: SUCCESS (0.091s)
[171.244802] Subtest Q-out-order: SUCCESS (0.410s)
[171.468477] [038/138] (832s left) gem_ccs (block-copy-uncompressed)
[171.722730] Subtest block-copy-uncompressed: SKIP (0.000s)
[171.819977] [039/138] (832s left) kms_dirtyfb (dirtyfb-ioctl)
[172.117885] Starting subtest: dirtyfb-ioctl
[172.138376] Starting dynamic subtest: default-DP-1
[173.597710] Dynamic subtest default-DP-1: SUCCESS (1.469s)
[173.639477] Starting dynamic subtest: drrs-DP-1
[173.681531] Dynamic subtest drrs-DP-1: SKIP (0.001s)
[173.731931] Starting dynamic subtest: fbc-DP-1
[173.771031] Dynamic subtest fbc-DP-1: SKIP (0.056s)
[173.808192] Starting dynamic subtest: psr-DP-1
[173.851086] Dynamic subtest psr-DP-1: SKIP (0.000s)
[173.871463] Subtest dirtyfb-ioctl: SUCCESS (1.532s)
[174.044446] [040/138] (830s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-mc-ccs)
[174.518562] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs
[174.558975] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[174.908362] [041/138] (829s left) gem_exec_balancer (nohangcheck)
[179.235361] Starting subtest: nohangcheck
[182.961868] Subtest nohangcheck: SUCCESS (3.732s)
[183.049765] [042/138] (821s left) kms_atomic_interruptible (legacy-pageflip)
[183.368902] Starting subtest: legacy-pageflip
[183.391465] Starting dynamic subtest: pipe-A-DP-1
[189.930668] Dynamic subtest pipe-A-DP-1: SUCCESS (6.559s)
[189.949242] Subtest legacy-pageflip: SUCCESS (6.563s)
[190.288541] [043/138] (814s left) kms_big_fb (linear-32bpp-rotate-90)
[190.619597] Starting subtest: linear-32bpp-rotate-90
[190.703061] Subtest linear-32bpp-rotate-90: SKIP (0.081s)
[190.815657] [044/138] (813s left) gem_watchdog (default-physical)
[191.210226] Starting subtest: default-physical
[192.061964] Subtest default-physical: SUCCESS (1.019s)
[192.154650] [045/138] (812s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[192.455548] Starting subtest: 2x-long-cursor-vs-flip-atomic
[192.492531] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.004s)
[192.585309] [046/138] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[192.958401] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[192.998164] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[193.090625] [047/138] (811s left) gem_exec_fence (syncobj-invalid-flags)
[193.795406] Starting subtest: syncobj-invalid-flags
[193.820936] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[194.173755] [048/138] (810s left) kms_psr (psr2_sprite_mmap_cpu)
[194.427824] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[194.533255] [049/138] (810s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[194.937523] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[194.994149] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[195.099777] [050/138] (810s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[195.432246] Starting subtest: flip-vs-dpms-off-vs-modeset
[195.458367] Starting dynamic subtest: A-DP1
[196.637353] Dynamic subtest A-DP1: SUCCESS (1.241s)
[196.673605] Starting dynamic subtest: B-DP1
[197.724524] Dynamic subtest B-DP1: SUCCESS (1.082s)
[197.762681] Starting dynamic subtest: C-DP1
[198.815515] Dynamic subtest C-DP1: SUCCESS (1.083s)
[198.834373] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.418s)
[199.171275] [051/138] (806s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-ccs)
[199.637855] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-ccs
[199.656476] Subtest pipe-B-missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.001s)
[200.053274] [052/138] (805s left) perf_pmu (semaphore-wait)
[200.284131] Starting subtest: semaphore-wait
[200.303515] Starting dynamic subtest: rcs0
[200.774080] Dynamic subtest rcs0: SUCCESS (0.517s)
[200.811277] Starting dynamic subtest: bcs0
[201.295714] Dynamic subtest bcs0: SUCCESS (0.516s)
[201.333793] Starting dynamic subtest: vcs0
[201.809329] Dynamic subtest vcs0: SUCCESS (0.513s)
[201.845278] Starting dynamic subtest: vecs0
[202.327507] Dynamic subtest vecs0: SUCCESS (0.514s)
[202.349280] Subtest semaphore-wait: SUCCESS (2.072s)
[202.467721] [053/138] (802s left) gem_exec_parallel (basic)
[202.692109] Starting subtest: basic
[202.713069] Starting dynamic subtest: rcs0
[206.034754] Dynamic subtest rcs0: SUCCESS (3.167s)
[206.076448] Starting dynamic subtest: bcs0
[209.388398] Dynamic subtest bcs0: SUCCESS (3.363s)
[209.424791] Starting dynamic subtest: vcs0
[212.549617] Dynamic subtest vcs0: SUCCESS (3.145s)
[212.589821] Starting dynamic subtest: vecs0
[215.765652] Dynamic subtest vecs0: SUCCESS (3.225s)
[215.784265] Subtest basic: SUCCESS (12.908s)
[215.876520] [054/138] (789s left) gem_eio (wait-10ms)
[216.166377] Starting subtest: wait-10ms
[216.208046] Subtest wait-10ms: SUCCESS (0.096s)
[216.420873] [055/138] (789s left) syncobj_wait (multi-wait-submitted-signaled)
[216.649027] Starting subtest: multi-wait-submitted-signaled
[216.669627] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[216.756585] [056/138] (788s left) gem_userptr_blits (probe)
[217.070357] Starting subtest: probe
[217.916811] Subtest probe: SUCCESS (0.875s)
[218.065439] [057/138] (787s left) gem_exec_reloc (basic-wc-read)
[218.302663] Starting subtest: basic-wc-read
[218.321868] Subtest basic-wc-read: SUCCESS (0.020s)
[218.515650] [058/138] (787s left) kms_lease (lease-unleased-crtc)
[218.808232] Starting subtest: lease-unleased-crtc
[218.827485] Starting dynamic subtest: pipe-A-DP-1
[218.991826] Dynamic subtest pipe-A-DP-1: SUCCESS (0.174s)
[219.028797] Starting dynamic subtest: pipe-B-DP-1
[219.100816] Dynamic subtest pipe-B-DP-1: SUCCESS (0.090s)
[219.140331] Starting dynamic subtest: pipe-C-DP-1
[219.181770] Dynamic subtest pipe-C-DP-1: SUCCESS (0.092s)
[219.201189] Subtest lease-unleased-crtc: SUCCESS (0.367s)
[219.531546] [059/138] (786s left) gem_exec_schedule (preempt-queue-chain)
[219.927675] Starting subtest: preempt-queue-chain
[219.950327] Starting dynamic subtest: rcs0
[220.336753] Dynamic subtest rcs0: SUCCESS (0.565s)
[220.380647] Starting dynamic subtest: bcs0
[220.914152] Dynamic subtest bcs0: SUCCESS (0.577s)
[220.958143] Starting dynamic subtest: vcs0
[221.467165] Dynamic subtest vcs0: SUCCESS (0.548s)
[221.512738] Starting dynamic subtest: vecs0
[222.028880] Dynamic subtest vecs0: SUCCESS (0.560s)
[222.047842] Subtest preempt-queue-chain: SUCCESS (2.261s)
[222.413810] [060/138] (783s left) drm_fdinfo (virtual-idle)
[222.642448] Starting subtest: virtual-idle
[224.656577] Subtest virtual-idle: SUCCESS (2.028s)
[224.749720] [061/138] (781s left) i915_hangman (gt-error-state-capture)
[224.963876] Starting subtest: gt-error-state-capture
[224.982477] Starting dynamic subtest: rcs0
[234.421353] Dynamic subtest rcs0: SUCCESS (9.327s)
[234.458178] Starting dynamic subtest: bcs0
[244.422708] Dynamic subtest bcs0: SUCCESS (9.962s)
[244.461453] Starting dynamic subtest: vcs0
[254.548739] Dynamic subtest vcs0: SUCCESS (10.051s)
[254.584812] Starting dynamic subtest: vecs0
[264.426200] Dynamic subtest vecs0: SUCCESS (9.986s)
[264.444739] Subtest gt-error-state-capture: SUCCESS (39.334s)
[264.537355] [062/138] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[264.887497] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[266.878837] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.051s)
[267.069651] [063/138] (739s left) kms_vblank (wait-forked-hang)
[267.386191] Starting subtest: wait-forked-hang
[267.411427] Starting dynamic subtest: pipe-A-DP-1
[274.104029] Dynamic subtest pipe-A-DP-1: SUCCESS (6.593s)
[274.145600] Starting dynamic subtest: pipe-C-DP-1
[281.152396] Dynamic subtest pipe-C-DP-1: SUCCESS (7.047s)
[281.174153] Subtest wait-forked-hang: SUCCESS (13.652s)
[281.407412] [064/138] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[281.807204] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[281.857247] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[281.959792] [065/138] (724s left) i915_query (query-regions-sanity-check)
[282.199674] Starting subtest: query-regions-sanity-check
[282.218394] Subtest query-regions-sanity-check: SUCCESS (0.040s)
[282.349343] [066/138] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[282.701405] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[282.740955] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[282.835936] [067/138] (723s left) gem_softpin (allocator-evict)
[283.069932] Starting subtest: allocator-evict
[283.090981] Starting dynamic subtest: rcs0
[318.860307] Dynamic subtest rcs0: SUCCESS (35.808s)
[318.897266] Starting dynamic subtest: bcs0
[357.011934] Dynamic subtest bcs0: SUCCESS (38.156s)
[357.049831] Starting dynamic subtest: vcs0
[394.409421] Dynamic subtest vcs0: SUCCESS (37.391s)
[394.450328] Starting dynamic subtest: vecs0
[432.204401] Dynamic subtest vecs0: SUCCESS (37.797s)
[432.223169] Subtest allocator-evict: SUCCESS (149.161s)
[432.319253] [068/138] (574s left) gem_exec_schedule (u-semaphore-noskip)
[432.867844] Starting subtest: u-semaphore-noskip
[432.974426] Subtest u-semaphore-noskip: SUCCESS (0.239s)
[433.361688] [069/138] (573s left) gem_exec_parallel (userptr)
[433.604857] Starting subtest: userptr
[433.623811] Starting dynamic subtest: rcs0
[436.923751] Dynamic subtest rcs0: SUCCESS (3.141s)
[436.961766] Starting dynamic subtest: bcs0
[440.202963] Dynamic subtest bcs0: SUCCESS (3.285s)
[440.243532] Starting dynamic subtest: vcs0
[443.429088] Dynamic subtest vcs0: SUCCESS (3.216s)
[443.466634] Starting dynamic subtest: vecs0
[446.667548] Dynamic subtest vecs0: SUCCESS (3.237s)
[446.688169] Subtest userptr: SUCCESS (12.889s)
[446.777623] [070/138] (560s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[447.221686] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[447.258719] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[447.352099] [071/138] (559s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[447.706674] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[449.212968] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.536s)
[449.573351] [072/138] (557s left) v3d/v3d_submit_cl (multi-and-single-sync)
[449.862242] Subtest multi-and-single-sync: SKIP (0.000s)
[449.950165] [073/138] (557s left) gem_ctx_isolation (preservation)
[450.184080] Starting subtest: preservation
[450.203301] Starting dynamic subtest: rcs0
[451.477304] Dynamic subtest rcs0: SUCCESS (1.301s)
[451.518480] Starting dynamic subtest: bcs0
[453.008667] Dynamic subtest bcs0: SUCCESS (1.525s)
[453.048629] Starting dynamic subtest: vcs0
[454.157120] Dynamic subtest vcs0: SUCCESS (1.150s)
[454.203426] Starting dynamic subtest: vecs0
[455.281609] Dynamic subtest vecs0: SUCCESS (1.120s)
[455.302890] Subtest preservation: SUCCESS (5.106s)
[455.547386] [074/138] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[455.783474] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[455.858839] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[455.984639] [075/138] (551s left) drm_fdinfo (virtual-busy)
[456.200032] Starting subtest: virtual-busy
[458.349522] Subtest virtual-busy: SUCCESS (2.171s)
[458.462945] [076/138] (549s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-rc-ccs)
[458.872404] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs
[458.928595] Subtest pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[459.338665] [077/138] (548s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[459.874972] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[460.207176] [078/138] (547s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[460.508798] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[460.530083] Starting dynamic subtest: pipe-A-valid-mode
[460.658235] Dynamic subtest pipe-A-valid-mode: SKIP (0.119s)
[460.700745] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.124s)
[461.004400] [079/138] (546s left) kms_atomic_interruptible (universal-setplane-primary)
[461.332672] Starting subtest: universal-setplane-primary
[461.353334] Starting dynamic subtest: pipe-A-DP-1
[467.981142] Dynamic subtest pipe-A-DP-1: SUCCESS (6.552s)
[468.000540] Subtest universal-setplane-primary: SUCCESS (6.556s)
[468.221967] [080/138] (539s left) kms_cursor_crc (cursor-offscreen-64x21)
[468.543749] Starting subtest: cursor-offscreen-64x21
[468.568974] Starting dynamic subtest: pipe-A-DP-1
[471.043824] Dynamic subtest pipe-A-DP-1: SUCCESS (2.496s)
[471.155276] Starting dynamic subtest: pipe-C-DP-1
[473.717293] Dynamic subtest pipe-C-DP-1: SUCCESS (2.594s)
[473.740649] Subtest cursor-offscreen-64x21: SUCCESS (5.172s)
[474.083474] [081/138] (533s left) kms_setmode (basic)
[474.319306] Starting subtest: basic
[474.478908] Starting dynamic subtest: pipe-A-DP-1
[476.798294] Dynamic subtest pipe-A-DP-1: SUCCESS (2.295s)
[476.925072] Starting dynamic subtest: pipe-B-DP-1
[479.233808] Dynamic subtest pipe-B-DP-1: SUCCESS (2.305s)
[479.341031] Subtest basic: SUCCESS (5.021s)
[479.675999] [082/138] (528s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[480.092030] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[480.419552] [083/138] (527s left) gen3_render_linear_blits
[480.785563] [084/138] (527s left) gem_exec_reloc (basic-write-wc-active)
[481.016575] Starting subtest: basic-write-wc-active
[481.136604] Subtest basic-write-wc-active: SUCCESS (0.139s)
[481.341853] [085/138] (527s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[481.695377] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[481.736755] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[481.831906] [086/138] (526s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[482.376548] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[482.690712] [087/138] (525s left) kms_plane_lowres (tiling-y)
[482.992094] Starting subtest: tiling-y
[483.013629] Starting dynamic subtest: pipe-A-DP-1
[489.292310] Dynamic subtest pipe-A-DP-1: SUCCESS (6.297s)
[489.422304] Starting dynamic subtest: pipe-B-DP-1
[495.627088] Dynamic subtest pipe-B-DP-1: SUCCESS (6.235s)
[495.769292] Starting dynamic subtest: pipe-C-DP-1
[499.893372] Dynamic subtest pipe-C-DP-1: SUCCESS (4.155s)
[500.010093] Subtest tiling-y: SUCCESS (17.000s)
[500.429822] [088/138] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[500.793312] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[500.833106] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[500.924443] [089/138] (507s left) gem_exec_reloc (basic-cpu)
[501.155608] Starting subtest: basic-cpu
[501.174289] Subtest basic-cpu: SUCCESS (0.020s)
[501.359448] [090/138] (507s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[501.778095] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[502.079897] [091/138] (506s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[502.461458] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[502.499487] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[502.588738] [092/138] (506s left) kms_properties (crtc-properties-atomic)
[502.894065] Starting subtest: crtc-properties-atomic
[503.929086] Subtest crtc-properties-atomic: SUCCESS (1.020s)
[504.286982] [093/138] (504s left) gem_ctx_create (basic-files)
[504.528434] Starting subtest: basic-files
[506.567741] Subtest basic-files: SUCCESS (2.037s)
[506.828778] [094/138] (502s left) gem_exec_fair (basic-flow)
[507.247197] Starting subtest: basic-flow
[507.266051] Starting dynamic subtest: rcs0
[512.062199] Dynamic subtest rcs0: SUCCESS (4.998s)
[512.081254] Subtest basic-flow: SUCCESS (5.001s)
[512.301571] [095/138] (496s left) kms_flip (2x-modeset-vs-vblank-race)
[512.598041] Starting subtest: 2x-modeset-vs-vblank-race
[512.650551] Subtest 2x-modeset-vs-vblank-race: SKIP (0.003s)
[512.755665] [096/138] (496s left) syncobj_wait (wait-delayed-signal)
[513.016076] Starting subtest: wait-delayed-signal
[513.082904] Subtest wait-delayed-signal: SUCCESS (0.102s)
[513.221239] [097/138] (496s left) gem_userptr_blits (dmabuf-unsync)
[513.547991] Subtest dmabuf-unsync: SKIP (0.000s)
[513.640537] [098/138] (495s left) kms_pm_backlight (fade-with-suspend)
[513.966617] Subtest fade-with-suspend: SKIP (0.000s)
[514.057331] [099/138] (495s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-ccs)
[514.559740] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-ccs
[514.597695] Subtest pipe-C-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.001s)
[514.949651] [100/138] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[515.307208] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[515.349825] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[515.443557] [101/138] (494s left) kms_big_joiner (invalid-modeset)
[515.762058] Subtest invalid-modeset: SKIP (0.000s)
[515.858494] [102/138] (493s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[517.741384] Starting subtest: modeset-non-lpsp-stress-no-wait
[521.384225] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.634s)
[521.586799] [103/138] (488s left) kms_ccs (pipe-b-bad-rotation-90-yf-tiled-ccs)
[522.013790] Starting subtest: pipe-B-bad-rotation-90-yf-tiled-ccs
[522.475528] Subtest pipe-B-bad-rotation-90-yf-tiled-ccs: SUCCESS (0.463s)
[523.034449] [104/138] (486s left) syncobj_timeline (invalid-transfer-bad-pad)
[523.261622] Starting subtest: invalid-transfer-bad-pad
[523.282266] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[523.371601] [105/138] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[523.759900] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[523.797019] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.891122] [106/138] (486s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[524.310792] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs
[524.352366] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[524.781063] [107/138] (485s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[525.011435] Starting subtest: invalid-bsd2-flag-on-blt
[525.032938] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[525.129443] [108/138] (485s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-mc-ccs)
[525.670229] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[525.998612] [109/138] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[526.379272] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[526.415915] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[526.512292] [110/138] (484s left) i915_pm_rpm (sysfs-read)
[528.304086] Starting subtest: sysfs-read
[528.717130] Subtest sysfs-read: SUCCESS (0.381s)
[529.207420] [111/138] (481s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[529.503414] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[529.611077] [112/138] (481s left) kms_content_protection (legacy)
[529.993128] Starting subtest: legacy
[530.164795] Starting dynamic subtest: pipe-A-DP-1
[650.572401] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[657.189770] Closing watchdogs
[657.196219] Initializing watchdogs
[657.196392]   /dev/watchdog0
[657.239643] [113/138] (353s left) kms_properties (invalid-properties-atomic)
[657.540975] Starting subtest: invalid-properties-atomic
[657.774720] Subtest invalid-properties-atomic: SUCCESS (0.242s)
[657.892068] [114/138] (353s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[658.124796] Starting subtest: addfb25-framebuffer-vs-set-tiling
[658.146928] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[658.319231] [115/138] (352s left) gem_mmap_offset (basic-uaf)
[658.558232] Starting subtest: basic-uaf
[658.578210] Subtest basic-uaf: SUCCESS (0.003s)
[658.669917] [116/138] (352s left) gem_exec_reloc (basic-cpu-read-active)
[658.894992] Starting subtest: basic-cpu-read-active
[659.015606] Subtest basic-cpu-read-active: SUCCESS (0.138s)
[659.220227] [117/138] (352s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[659.621943] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[659.659518] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[660.100184] [118/138] (351s left) gem_exec_params (sol-reset-not-gen7)
[660.355376] Starting subtest: sol-reset-not-gen7
[660.384595] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[660.498971] [119/138] (350s left) api_intel_allocator (fork-simple-stress-signal)
[660.756577] Starting subtest: fork-simple-stress-signal
[666.476174] Subtest fork-simple-stress-signal: SUCCESS (5.545s)
[666.585205] [120/138] (344s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs)
[667.143770] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[667.482407] [121/138] (344s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-mc-ccs)
[667.790649] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-mc-ccs
[667.842769] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[668.404112] [122/138] (343s left) gem_lmem_swapping (random-engines)
[668.644330] Subtest random-engines: SKIP (0.000s)
[668.736360] [123/138] (343s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-mc-ccs)
[669.203182] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs
[669.245456] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.001s)
[669.600860] [124/138] (342s left) gem_eio (in-flight-contexts-1us)
[669.882183] Starting subtest: in-flight-contexts-1us
[681.227872] Subtest in-flight-contexts-1us: SUCCESS (11.392s)
[681.466647] [125/138] (330s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[681.820782] Starting subtest: fbc-rgb565-draw-blt
[683.996786] Subtest fbc-rgb565-draw-blt: SUCCESS (2.234s)
[684.151512] [126/138] (327s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[684.454431] Starting subtest: plane-upscale-20x20-with-modifiers
[684.474122] Starting dynamic subtest: pipe-A-DP-1
[684.934448] Dynamic subtest pipe-A-DP-1: SUCCESS (0.470s)
[684.980662] Starting dynamic subtest: pipe-B-DP-1
[685.744116] Dynamic subtest pipe-B-DP-1: SUCCESS (0.781s)
[685.796485] Starting dynamic subtest: pipe-C-DP-1
[686.314456] Dynamic subtest pipe-C-DP-1: SUCCESS (0.581s)
[686.336592] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (1.867s)
[686.769700] [127/138] (325s left) kms_vblank (accuracy-idle)
[687.070412] Starting subtest: accuracy-idle
[687.088997] Starting dynamic subtest: pipe-A-DP-1
[689.345074] Dynamic subtest pipe-A-DP-1: SUCCESS (2.279s)
[689.406090] Starting dynamic subtest: pipe-C-DP-1
[691.808294] Dynamic subtest pipe-C-DP-1: SUCCESS (2.455s)
[691.827916] Subtest accuracy-idle: SUCCESS (4.747s)
[692.173330] [128/138] (320s left) kms_dsc (dsc-with-bpc-formats)
[692.499398] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[692.589881] [129/138] (319s left) gem_exec_alignment (forked)