[53.777860] Initializing watchdogs
[53.778095]   /dev/watchdog0
[53.814065] [001/142] (960s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[54.147760] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[54.231941] [002/142] (960s left) kms_flip (modeset-vs-vblank-race)
[54.534908] Starting subtest: modeset-vs-vblank-race
[54.553552] Starting dynamic subtest: A-DP1
[59.245510] Dynamic subtest A-DP1: SUCCESS (4.720s)
[59.275202] Starting dynamic subtest: B-DP1
[63.677104] Dynamic subtest B-DP1: SUCCESS (4.435s)
[63.709763] Starting dynamic subtest: C-DP1
[67.997087] Dynamic subtest C-DP1: SUCCESS (4.318s)
[68.016712] Subtest modeset-vs-vblank-race: SUCCESS (13.480s)
[68.436327] [003/142] (946s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[68.702883] Starting subtest: basic-cpu-wc-noreloc
[68.723555] Subtest basic-cpu-wc-noreloc: SUCCESS (0.015s)
[68.902394] [004/142] (945s left) prime_mmap_coherency (ioctl-errors)
[69.134678] Starting subtest: ioctl-errors
[86.018756] Subtest ioctl-errors: SUCCESS (16.902s)
[86.245744] [005/142] (928s left) gem_ctx_exec (basic)
[86.617716] Starting subtest: basic
[86.637733] Subtest basic: SUCCESS (0.008s)
[86.729918] [006/142] (927s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[87.342314] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[87.657880] [007/142] (927s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[88.218396] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[88.532137] [008/142] (926s left) kms_big_fb (x-tiled-addfb-size-overflow)
[88.900323] Starting subtest: x-tiled-addfb-size-overflow
[88.921032] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[89.005158] [009/142] (925s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[89.304661] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[89.327517] Starting dynamic subtest: pipe-A-valid-mode
[90.032781] Dynamic subtest pipe-A-valid-mode: SKIP (0.706s)
[90.070672] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.708s)
[90.429809] [010/142] (924s left) gem_exec_schedule (u-lateslice)
[90.890948] Starting subtest: u-lateslice
[90.915308] Starting dynamic subtest: rcs0
[90.940348] Dynamic subtest rcs0: SUCCESS (0.038s)
[90.980504] Starting dynamic subtest: bcs0
[91.004335] Dynamic subtest bcs0: SUCCESS (0.034s)
[91.042539] Starting dynamic subtest: vcs0
[91.067206] Dynamic subtest vcs0: SUCCESS (0.030s)
[91.108584] Starting dynamic subtest: vecs0
[91.132381] Dynamic subtest vecs0: SUCCESS (0.029s)
[91.157326] Subtest u-lateslice: SUCCESS (0.135s)
[91.261619] [011/142] (923s left) kms_atomic_transition (plane-all-transition-fencing)
[91.606233] Starting subtest: plane-all-transition-fencing
[91.631337] Starting dynamic subtest: pipe-A-DP-1
[95.567543] Dynamic subtest pipe-A-DP-1: SUCCESS (3.994s)
[95.696251] Starting dynamic subtest: pipe-B-DP-1
[100.099927] Dynamic subtest pipe-B-DP-1: SUCCESS (4.432s)
[100.214656] Subtest plane-all-transition-fencing: SUCCESS (8.623s)
[100.574998] [012/142] (914s left) dumb_buffer (map-valid)
[100.820132] Starting subtest: map-valid
[100.838789] Subtest map-valid: SUCCESS (0.000s)
[100.924885] [013/142] (914s left) gem_eio (banned)
[101.205427] Starting subtest: banned
[101.331643] Subtest banned: SUCCESS (0.142s)
[101.521658] [014/142] (913s left) api_intel_allocator (fork-simple-once)
[101.756319] Starting subtest: fork-simple-once
[101.775133] Subtest fork-simple-once: SUCCESS (0.046s)
[101.891196] [015/142] (913s left) gem_create (create-ext-cpu-access-big)
[102.224590] Starting subtest: create-ext-cpu-access-big
[102.268195] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[102.355632] [016/142] (913s left) drm_fdinfo (isolation)
[102.589435] Starting subtest: isolation
[102.609893] Starting dynamic subtest: rcs0
[103.101537] Dynamic subtest rcs0: SUCCESS (0.531s)
[103.135570] Starting dynamic subtest: bcs0
[103.638993] Dynamic subtest bcs0: SUCCESS (0.540s)
[103.674636] Starting dynamic subtest: vcs0
[104.173454] Dynamic subtest vcs0: SUCCESS (0.532s)
[104.207108] Starting dynamic subtest: vecs0
[104.708108] Dynamic subtest vecs0: SUCCESS (0.532s)
[104.729684] Subtest isolation: SUCCESS (2.142s)
[104.847588] [017/142] (910s left) kms_setmode (basic)
[105.101730] Starting subtest: basic
[105.881424] Starting dynamic subtest: pipe-A-DP-1
[108.032631] Dynamic subtest pipe-A-DP-1: SUCCESS (2.310s)
[108.157372] Starting dynamic subtest: pipe-B-DP-1
[110.468710] Dynamic subtest pipe-B-DP-1: SUCCESS (2.305s)
[110.571754] Subtest basic: SUCCESS (5.476s)
[110.912405] [018/142] (904s left) gem_exec_fence (concurrent)
[111.290829] Starting subtest: concurrent
[111.309797] Starting dynamic subtest: rcs0
[111.329441] Dynamic subtest rcs0: SUCCESS (0.040s)
[111.364229] Starting dynamic subtest: bcs0
[111.383145] Dynamic subtest bcs0: SUCCESS (0.037s)
[111.421077] Starting dynamic subtest: vcs0
[111.442483] Dynamic subtest vcs0: SUCCESS (0.032s)
[111.478431] Starting dynamic subtest: vecs0
[111.499131] Dynamic subtest vecs0: SUCCESS (0.032s)
[111.518312] Subtest concurrent: SUCCESS (0.149s)
[112.226458] [019/142] (903s left) kms_flip (flip-vs-rmfb)
[112.551528] Starting subtest: flip-vs-rmfb
[112.570323] Starting dynamic subtest: A-DP1
[123.045109] Dynamic subtest A-DP1: SUCCESS (10.503s)
[123.084735] Starting dynamic subtest: B-DP1
[133.448061] Dynamic subtest B-DP1: SUCCESS (10.421s)
[133.484123] Starting dynamic subtest: C-DP1
[143.869255] Dynamic subtest C-DP1: SUCCESS (10.419s)
[143.892096] Subtest flip-vs-rmfb: SUCCESS (31.357s)
[144.324563] [020/142] (871s left) kms_vblank (pipe-b-wait-busy-hang)
[144.629821] Starting subtest: pipe-B-wait-busy-hang
[152.124658] Subtest pipe-B-wait-busy-hang: SUCCESS (7.376s)
[152.365084] [021/142] (863s left) gem_exec_whisper (basic-queues-all)
[152.642562] Starting subtest: basic-queues-all
[162.473739] Subtest basic-queues-all: SUCCESS (9.851s)
[162.678356] [022/142] (853s left) v3d/v3d_submit_csd (bad-extension)
[162.954097] Subtest bad-extension: SKIP (0.000s)
[163.045912] [023/142] (853s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[163.381822] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[163.419465] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[163.512913] [024/142] (852s left) gem_exec_flush (basic-batch-kernel-default-wb)
[163.783191] Starting subtest: basic-batch-kernel-default-wb
[169.742411] Subtest basic-batch-kernel-default-wb: SUCCESS (5.991s)
[169.982909] [025/142] (846s left) kms_big_fb (linear-64bpp-rotate-0)
[170.491450] Starting subtest: linear-64bpp-rotate-0
[178.941126] Subtest linear-64bpp-rotate-0: SUCCESS (8.619s)
[179.896083] [026/142] (836s left) gem_spin_batch (spin-all-new)
[180.129702] Starting subtest: spin-all-new
[180.170946] Subtest spin-all-new: SUCCESS (0.032s)
[180.415317] [027/142] (836s left) syncobj_timeline (host-signal-ordered)
[180.650040] Starting subtest: host-signal-ordered
[180.670867] Subtest host-signal-ordered: SUCCESS (0.002s)
[180.760820] [028/142] (835s left) kms_frontbuffer_tracking (fbc-suspend)
[181.132686] Starting subtest: fbc-suspend
[219.099875] Subtest fbc-suspend: SUCCESS (6.127s)
[223.374871] [029/142] (829s left) kms_getfb (getfb-handle-closed)
[223.617247] Starting subtest: getfb-handle-closed
[223.638977] Subtest getfb-handle-closed: SUCCESS (0.000s)
[223.730785] [030/142] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[224.115726] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[226.096050] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.063s)
[226.271024] [031/142] (826s left) kms_vblank (pipe-a-wait-idle)
[226.568720] Starting subtest: pipe-A-wait-idle
[228.855588] Subtest pipe-A-wait-idle: SUCCESS (2.285s)
[229.218427] [032/142] (823s left) i915_suspend (basic-s2idle-without-i915)
[229.433328] Starting subtest: basic-s2idle-without-i915
[249.137974] Subtest basic-s2idle-without-i915: SUCCESS (19.717s)
[255.489394] [033/142] (803s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs)
[255.913470] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs
[255.974897] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[256.404570] [034/142] (802s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[256.645084] Starting subtest: no-spare-fences-busy-interruptible
[258.842174] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.184s)
[259.033843] [035/142] (800s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[259.514477] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[259.558317] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[259.908261] [036/142] (799s left) gem_exec_schedule (preempt-queue-chain)
[260.300720] Starting subtest: preempt-queue-chain
[260.319912] Starting dynamic subtest: rcs0
[260.677778] Dynamic subtest rcs0: SUCCESS (0.530s)
[260.724277] Starting dynamic subtest: bcs0
[261.147482] Dynamic subtest bcs0: SUCCESS (0.467s)
[261.191322] Starting dynamic subtest: vcs0
[261.696973] Dynamic subtest vcs0: SUCCESS (0.548s)
[261.741896] Starting dynamic subtest: vecs0
[262.271728] Dynamic subtest vecs0: SUCCESS (0.570s)
[262.292998] Subtest preempt-queue-chain: SUCCESS (2.128s)
[262.658530] [037/142] (796s left) kms_rmfb (close-fd)
[262.962508] Starting subtest: close-fd
[262.981894] Starting dynamic subtest: pipe-A-DP-1
[263.107750] Dynamic subtest pipe-A-DP-1: SUCCESS (0.128s)
[263.151924] Starting dynamic subtest: pipe-B-DP-1
[263.571699] Dynamic subtest pipe-B-DP-1: SUCCESS (0.457s)
[263.625807] Starting dynamic subtest: pipe-C-DP-1
[264.032932] Dynamic subtest pipe-C-DP-1: SUCCESS (0.435s)
[264.062057] Subtest close-fd: SUCCESS (1.033s)
[264.444434] [038/142] (795s left) gem_ctx_engines (invalid-engines)
[264.715762] Starting subtest: invalid-engines
[264.740476] Subtest invalid-engines: SUCCESS (0.015s)
[264.947737] [039/142] (794s left) kms_vblank (pipe-c-ts-continuation-suspend)
[265.271229] Starting subtest: pipe-C-ts-continuation-suspend
[283.342800] Subtest pipe-C-ts-continuation-suspend: SUCCESS (2.147s)
[288.925437] [040/142] (792s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[289.236106] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[289.255305] Starting dynamic subtest: pipe-A-DP-1
[289.323585] Dynamic subtest pipe-A-DP-1: SUCCESS (0.082s)
[289.381213] Starting dynamic subtest: pipe-B-DP-1
[289.718605] Dynamic subtest pipe-B-DP-1: SUCCESS (0.389s)
[289.776890] Starting dynamic subtest: pipe-C-DP-1
[289.847243] Dynamic subtest pipe-C-DP-1: SKIP (0.095s)
[289.866797] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.582s)
[290.244360] [041/142] (790s left) gem_exec_params (invalid-fence-in-submit)
[290.459146] Starting subtest: invalid-fence-in-submit
[290.480422] Subtest invalid-fence-in-submit: SUCCESS (0.006s)
[290.597729] [042/142] (790s left) kms_psr2_sf (plane-move-sf-dmg-area)
[290.854798] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[290.964237] [043/142] (790s left) gem_ctx_shared (detached-shared-gtt)
[291.209743] Starting subtest: detached-shared-gtt
[293.530946] Subtest detached-shared-gtt: SUCCESS (2.152s)
[293.775228] [044/142] (787s left) gem_exec_whisper (basic-queues-priority-all)
[294.044752] Starting subtest: basic-queues-priority-all
[316.692209] Subtest basic-queues-priority-all: SUCCESS (22.676s)
[316.908132] [045/142] (764s left) gem_pxp (reject-modify-context-protection-off-2)
[319.820279] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[319.976307] [046/142] (761s left) gem_userptr_blits (create-destroy-unsync)
[320.289508] Subtest create-destroy-unsync: SKIP (0.000s)
[320.390077] [047/142] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[320.772608] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[320.810087] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[320.909261] [048/142] (760s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[321.213266] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[321.232531] Starting dynamic subtest: pipe-A-DP-1
[321.568173] Dynamic subtest pipe-A-DP-1: SUCCESS (0.339s)
[321.627221] Starting dynamic subtest: pipe-B-DP-1
[321.969833] Dynamic subtest pipe-B-DP-1: SUCCESS (0.392s)
[322.028716] Starting dynamic subtest: pipe-C-DP-1
[322.354338] Dynamic subtest pipe-C-DP-1: SUCCESS (0.385s)
[322.376662] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.132s)
[322.777726] [049/142] (759s left) syncobj_timeline (single-wait-for-submit-signaled)
[323.009537] Starting subtest: single-wait-for-submit-signaled
[323.029551] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[323.127752] [050/142] (758s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[323.363579] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[323.384062] Starting dynamic subtest: smem
[323.692995] Dynamic subtest smem: SUCCESS (0.343s)
[323.711850] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.345s)
[323.933290] [051/142] (758s left) kms_flip (plain-flip-interruptible)
[324.214755] Starting subtest: plain-flip-interruptible
[324.235586] Starting dynamic subtest: A-DP1
[325.383597] Dynamic subtest A-DP1: SUCCESS (1.170s)
[325.423721] Starting dynamic subtest: B-DP1
[326.494165] Dynamic subtest B-DP1: SUCCESS (1.103s)
[326.536769] Starting dynamic subtest: C-DP1
[327.581820] Dynamic subtest C-DP1: SUCCESS (1.081s)
[327.606458] Subtest plain-flip-interruptible: SUCCESS (3.368s)
[328.027898] [052/142] (754s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[328.266193] Starting subtest: basic-wc-gtt-noreloc
[328.288080] Subtest basic-wc-gtt-noreloc: SUCCESS (0.011s)
[328.476960] [053/142] (753s left) perf (gen12-group-concurrent-oa-buffer-read)
[328.887532] Starting subtest: gen12-group-concurrent-oa-buffer-read
[339.154106] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.119s)
[339.246088] [054/142] (743s left) api_intel_allocator (two-level-inception-interruptible)
[339.492224] Starting subtest: two-level-inception-interruptible
[345.026398] Subtest two-level-inception-interruptible: SUCCESS (5.573s)
[345.169822] [055/142] (737s left) prime_busy (hang)
[345.410284] Starting subtest: hang
[345.429067] Starting dynamic subtest: rcs0
[351.770546] Dynamic subtest rcs0: SUCCESS (6.364s)
[351.809818] Starting dynamic subtest: bcs0
[358.982839] Dynamic subtest bcs0: SUCCESS (7.034s)
[359.022095] Starting dynamic subtest: vcs0
[365.786947] Dynamic subtest vcs0: SUCCESS (6.973s)
[365.826859] Starting dynamic subtest: vecs0
[372.939784] Dynamic subtest vecs0: SUCCESS (6.973s)
[372.959126] Subtest hang: SUCCESS (27.356s)
[373.050398] [056/142] (709s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[373.431871] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[373.469627] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[373.566823] [057/142] (709s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs)
[374.021091] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs
[374.085518] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[374.463069] [058/142] (708s left) gem_readwrite (write-bad-handle)
[374.690784] Starting subtest: write-bad-handle
[374.734825] Subtest write-bad-handle: SUCCESS (0.000s)
[374.830714] [059/142] (708s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[375.240385] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[375.280820] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[375.697159] [060/142] (707s left) gem_exec_balancer (busy)
[375.934897] Starting subtest: busy
[377.866662] Subtest busy: SUCCESS (1.936s)
[381.977848] [061/142] (701s left) gem_exec_balancer (parallel-contexts)
[386.217455] Subtest parallel-contexts: SKIP (0.000s)
[386.311660] [062/142] (696s left) kms_addfb_basic (bad-pitch-1024)
[386.547609] Starting subtest: bad-pitch-1024
[386.566472] Subtest bad-pitch-1024: SUCCESS (0.000s)
[386.741475] [063/142] (696s left) gem_mmap_gtt (cpuset-medium-copy)
[386.979670] Starting subtest: cpuset-medium-copy
[398.293362] Subtest cpuset-medium-copy: SUCCESS (11.350s)
[398.467501] [064/142] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[398.996947] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[399.037545] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[399.138328] [065/142] (684s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[399.696112] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[400.001091] [066/142] (683s left) gem_eio (wait-immediate)
[400.283310] Starting subtest: wait-immediate
[400.328588] Subtest wait-immediate: SUCCESS (0.067s)
[400.553267] [067/142] (683s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[400.822686] Starting subtest: multi-wait-all-for-submit-signaled
[400.844429] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[400.948695] [068/142] (682s left) kms_psr (primary_render)
[401.207288] Subtest primary_render: SKIP (0.000s)
[401.300811] [069/142] (682s left) i915_pm_rpm (gem-execbuf)
[403.250114] Starting subtest: gem-execbuf
[403.273306] Starting dynamic subtest: smem0
[404.780784] Dynamic subtest smem0: SUCCESS (1.526s)
[404.802477] Subtest gem-execbuf: SUCCESS (1.530s)
[405.307724] [070/142] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[405.696658] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[405.735033] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.829737] [071/142] (678s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[406.209454] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[408.235605] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.099s)
[408.421180] [072/142] (675s left) kms_vblank (invalid)
[408.728123] Starting subtest: invalid
[408.983707] Subtest invalid: SUCCESS (0.258s)
[409.347699] [073/142] (674s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[409.581514] Starting subtest: tiled-to-untiled
[409.704841] Subtest tiled-to-untiled: SUCCESS (0.110s)
[409.809994] [074/142] (674s left) kms_plane_lowres (tiling-y)
[410.130178] Starting subtest: tiling-y
[410.156676] Starting dynamic subtest: pipe-A-DP-1
[416.433251] Dynamic subtest pipe-A-DP-1: SUCCESS (6.312s)
[416.564239] Starting dynamic subtest: pipe-B-DP-1
[422.833223] Dynamic subtest pipe-B-DP-1: SUCCESS (6.302s)
[422.968521] Starting dynamic subtest: pipe-C-DP-1
[427.137460] Dynamic subtest pipe-C-DP-1: SUCCESS (4.206s)
[427.252870] Subtest tiling-y: SUCCESS (17.133s)
[427.740298] [075/142] (656s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[428.053716] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[428.159452] [076/142] (656s left) gem_render_copy_redux (normal)
[428.398380] Starting subtest: normal
[430.985640] Subtest normal: SUCCESS (2.306s)
[431.106968] [077/142] (653s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[431.428064] Subtest bad-seqno-1ns: SKIP (0.000s)
[431.539217] [078/142] (653s left) gem_mmap_wc (bad-object)
[431.805148] Starting subtest: bad-object
[431.831241] Subtest bad-object: SUCCESS (0.000s)
[431.946876] [079/142] (652s left) kms_ccs (pipe-d-bad-aux-stride-yf_tiled_ccs)
[432.495393] Subtest pipe-D-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[432.809275] [080/142] (652s left) gem_mmap_gtt (basic-write-gtt)
[433.031977] Starting subtest: basic-write-gtt
[433.746783] Subtest basic-write-gtt: SUCCESS (0.751s)
[433.904112] [081/142] (651s left) kms_cursor_crc (cursor-random-32x32)
[434.209610] Starting subtest: cursor-random-32x32
[434.386301] Subtest cursor-random-32x32: SKIP (0.120s)
[434.500482] [082/142] (650s left) gem_exec_params (cliprects-invalid)
[434.739165] Starting subtest: cliprects-invalid
[434.758031] Subtest cliprects-invalid: SUCCESS (0.001s)
[434.868348] [083/142] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[435.235063] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[435.272294] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[435.371987] [084/142] (649s left) kms_prop_blob (invalid-get-prop-any)
[435.586955] Starting subtest: invalid-get-prop-any
[435.607241] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[435.707921] [085/142] (649s left) kms_flip (2x-flip-vs-expired-vblank)
[436.013170] Starting subtest: 2x-flip-vs-expired-vblank
[436.051144] Subtest 2x-flip-vs-expired-vblank: SKIP (0.003s)
[436.151056] [086/142] (649s left) gem_render_linear_blits (basic)
[436.378533] Starting subtest: basic
[436.483825] Subtest basic: SUCCESS (0.082s)
[436.577170] [087/142] (649s left) kms_getfb (getfb2-handle-zero)
[436.817117] Starting subtest: getfb2-handle-zero
[436.836105] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[436.933950] [088/142] (648s left) kms_chamelium_color (degamma)
[437.256371] Subtest degamma: SKIP (0.000s)
[437.352105] [089/142] (648s left) gem_eio (in-flight-internal-10ms)
[437.627143] Starting subtest: in-flight-internal-10ms
[439.074447] Subtest in-flight-internal-10ms: SUCCESS (1.500s)
[439.322370] [090/142] (646s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[439.774672] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[439.817535] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[440.222922] [091/142] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[440.585114] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[440.624598] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[440.726867] [092/142] (645s left) syncobj_wait (single-wait-for-submit-signaled)
[440.963118] Starting subtest: single-wait-for-submit-signaled
[440.984206] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[441.080613] [093/142] (645s left) kms_color (ctm-0-75)
[441.390280] Starting subtest: ctm-0-75
[441.409069] Starting dynamic subtest: pipe-A
[443.879263] Dynamic subtest pipe-A: SUCCESS (2.475s)
[443.937136] Starting dynamic subtest: pipe-B
[446.557152] Dynamic subtest pipe-B: SUCCESS (2.673s)
[446.599848] Starting dynamic subtest: pipe-C
[449.169672] Dynamic subtest pipe-C: SUCCESS (2.607s)
[449.194874] Subtest ctm-0-75: SUCCESS (7.763s)
[449.515565] [094/142] (636s left) gem_eio (wait-wedge-1us)
[449.827423] Starting subtest: wait-wedge-1us
[449.851269] Subtest wait-wedge-1us: SUCCESS (0.068s)
[450.055699] [095/142] (636s left) gem_eio (hibernate)
[450.365085] Starting subtest: hibernate
[465.546969] Subtest hibernate: SUCCESS (15.223s)
[469.747205] [096/142] (620s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[470.189794] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[470.736530] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.540s)
[471.329739] [097/142] (619s left) gem_exec_parallel (contexts)
[471.567475] Starting subtest: contexts
[471.589611] Starting dynamic subtest: rcs0
[478.634241] Dynamic subtest rcs0: SUCCESS (7.076s)
[478.677585] Starting dynamic subtest: bcs0
[486.220954] Dynamic subtest bcs0: SUCCESS (7.581s)
[486.266090] Starting dynamic subtest: vcs0
[493.051782] Dynamic subtest vcs0: SUCCESS (6.827s)
[493.097857] Starting dynamic subtest: vecs0
[499.407402] Dynamic subtest vecs0: SUCCESS (6.355s)
[499.429031] Subtest contexts: SUCCESS (27.853s)
[499.645495] [098/142] (591s left) v3d/v3d_submit_csd (job-perfmon)
[499.929454] Subtest job-perfmon: SKIP (0.000s)
[500.026171] [099/142] (590s left) gem_sync (basic-many-each)
[500.424257] Starting subtest: basic-many-each
[502.882369] Subtest basic-many-each: SUCCESS (2.396s)
[502.981883] [100/142] (587s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[503.312227] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[503.388869] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.006s)
[503.491357] [101/142] (587s left) kms_plane_alpha_blend (coverage-7efc)
[503.800223] Starting subtest: coverage-7efc
[504.114711] Starting dynamic subtest: pipe-A-DP-1
[504.606880] Dynamic subtest pipe-A-DP-1: SUCCESS (0.486s)
[504.719530] Starting dynamic subtest: pipe-C-DP-1
[505.505341] Dynamic subtest pipe-C-DP-1: SUCCESS (0.832s)
[505.526180] Subtest coverage-7efc: SUCCESS (1.712s)
[505.902881] [102/142] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[506.261545] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[506.303465] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[506.405839] [103/142] (584s left) v3d/v3d_submit_cl (bad-bo)
[506.691709] Subtest bad-bo: SKIP (0.000s)
[506.786489] [104/142] (584s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[507.067987] Subtest create-bo-invalid-flags: SKIP (0.000s)
[507.168868] [105/142] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[507.526030] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[507.565046] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[507.668992] [106/142] (583s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[507.906234] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[507.947856] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[508.132891] [107/142] (583s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[508.478318] Starting subtest: 4-tiled-addfb-size-offset-overflow
[508.517621] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[508.614400] [108/142] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[508.996115] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[509.034047] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[509.134480] [109/142] (582s left) perf_pmu (init-wait)
[509.375796] Starting subtest: init-wait
[509.397276] Starting dynamic subtest: rcs0
[509.418202] Dynamic subtest rcs0: SUCCESS (0.003s)
[509.463320] Starting dynamic subtest: bcs0
[509.482985] Dynamic subtest bcs0: SUCCESS (0.001s)
[509.525922] Starting dynamic subtest: vcs0
[509.544653] Dynamic subtest vcs0: SUCCESS (0.001s)
[509.587063] Starting dynamic subtest: vecs0
[509.607205] Dynamic subtest vecs0: SUCCESS (0.001s)
[509.628838] Subtest init-wait: SUCCESS (0.017s)
[509.748122] [110/142] (582s left) gem_wait (await)
[510.007283] Starting subtest: await
[510.025993] Starting dynamic subtest: all-engines
[511.042796] Dynamic subtest all-engines: SUCCESS (1.040s)
[511.089187] Starting dynamic subtest: rcs0
[512.071813] Dynamic subtest rcs0: SUCCESS (1.025s)
[512.116069] Starting dynamic subtest: bcs0
[513.103361] Dynamic subtest bcs0: SUCCESS (1.026s)
[513.148735] Starting dynamic subtest: vcs0
[514.127084] Dynamic subtest vcs0: SUCCESS (1.026s)
[514.170502] Starting dynamic subtest: vecs0
[515.159170] Dynamic subtest vecs0: SUCCESS (1.024s)
[515.180075] Subtest await: SUCCESS (5.154s)
[515.431932] [111/142] (576s left) i915_pm_rc6_residency (media-rc6-accuracy)
[515.787246] Starting subtest: media-rc6-accuracy
[515.824532] Subtest media-rc6-accuracy: SKIP (0.000s)
[515.924641] [112/142] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[516.297400] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[516.338910] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[516.438542] [113/142] (575s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[516.740727] Starting subtest: multiplane-rotation-cropping-top
[530.747379] Subtest multiplane-rotation-cropping-top: SUCCESS (13.998s)
[530.900411] [114/142] (561s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[531.736817] Starting subtest: syncobj-timeline-invalid-flags
[531.758987] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[532.001619] [115/142] (560s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[532.459450] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[532.503066] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[533.134924] [116/142] (559s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[533.531371] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[533.580463] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[533.707282] [117/142] (558s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[534.068523] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[535.325344] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.296s)
[535.715991] [118/142] (556s left) kms_atomic (plane-invalid-params-fence)
[536.156447] Starting subtest: plane-invalid-params-fence
[536.210829] Subtest plane-invalid-params-fence: SUCCESS (0.038s)
[536.668802] [119/142] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[537.084506] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[537.131660] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[537.246885] [120/142] (555s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[537.761802] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[537.807905] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[538.166843] [121/142] (554s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[538.430438] Starting subtest: legacy-engines-hostile-preempt
[538.454471] Starting dynamic subtest: render
[538.508123] Dynamic subtest render: SUCCESS (0.102s)
[538.556552] Starting dynamic subtest: bsd
[538.603994] Dynamic subtest bsd: SUCCESS (0.087s)
[538.649242] Starting dynamic subtest: blt
[538.698994] Dynamic subtest blt: SUCCESS (0.088s)
[538.757291] Starting dynamic subtest: vebox
[538.784441] Dynamic subtest vebox: SUCCESS (0.086s)
[538.807825] Subtest legacy-engines-hostile-preempt: SUCCESS (0.375s)
[538.921466] [122/142] (554s left) kms_cursor_crc (cursor-sliding-512x512)
[539.243568] Starting subtest: cursor-sliding-512x512
[539.284605] Subtest cursor-sliding-512x512: SKIP (0.003s)
[539.379175] [123/142] (553s left) kms_addfb_basic (bad-pitch-65536)
[539.605766] Starting subtest: bad-pitch-65536
[539.626093] Subtest bad-pitch-65536: SUCCESS (0.001s)
[539.816292] [124/142] (553s left) kms_lease (page_flip_implicit_plane)
[540.120965] Starting subtest: page_flip_implicit_plane
[540.139719] Starting dynamic subtest: pipe-A-DP-1
[540.406098] Dynamic subtest pipe-A-DP-1: SUCCESS (0.291s)
[540.468355] Starting dynamic subtest: pipe-B-DP-1
[540.901751] Dynamic subtest pipe-B-DP-1: SUCCESS (0.472s)
[540.968038] Starting dynamic subtest: pipe-C-DP-1
[541.361397] Dynamic subtest pipe-C-DP-1: SUCCESS (0.476s)
[541.382487] Subtest page_flip_implicit_plane: SUCCESS (1.251s)
[541.714654] [125/142] (551s left) kms_vblank (pipe-d-wait-busy-hang)
[542.034853] Subtest pipe-D-wait-busy-hang: SKIP (0.000s)
[542.212211] [126/142] (551s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[542.715533] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[542.754036] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[543.111155] [127/142] (550s left) kms_cursor_crc (cursor-offscreen-512x170)
[543.434185] Starting subtest: cursor-offscreen-512x170
[543.477065] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[543.576218] [128/142] (550s left) vgem_basic (setversion)
[543.814290] Starting subtest: setversion
[543.854578] Subtest setversion: SUCCESS (0.000s)
[543.948850] [129/142] (549s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[544.333920] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[544.371772] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[544.471836] [130/142] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[544.831668] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[544.869214] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[544.974350] [131/142] (548s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[545.309483] Starting subtest: x-tiled-8bpp-rotate-0
[548.169600] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.883s)
[548.407217] [132/142] (545s left) kms_flip (flip-vs-suspend)
[548.702566] Starting subtest: flip-vs-suspend
[548.721144] Starting dynamic subtest: A-DP1
[603.210956] Dynamic subtest A-DP1: SUCCESS (5.317s)
[603.254974] Starting dynamic subtest: B-DP1
[656.214222] Dynamic subtest B-DP1: SUCCESS (5.152s)
[656.261092] Starting dynamic subtest: C-DP1
[708.214862] Dynamic subtest C-DP1: SUCCESS (5.110s)
[708.237069] Subtest flip-vs-suspend: SUCCESS (15.600s)
[714.809916] [133/142] (529s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[715.260538] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[715.562511] [134/142] (528s left) gen9_exec_parse (batch-without-end)
[715.800645] Starting subtest: batch-without-end
[715.819487] Subtest batch-without-end: SUCCESS (0.002s)
[716.054339] [135/142] (528s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[716.350740] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[716.389126] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[716.944380] [136/142] (527s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[717.179680] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[717.198811] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.002s)
[717.300005] [137/142] (527s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[717.589626] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[717.610428] Starting dynamic subtest: pipe-A-valid-mode
[717.752334] Dynamic subtest pipe-A-valid-mode: SKIP (0.145s)
[717.795389] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.150s)
[718.106018] [138/142] (526s left) core_setmaster (master-drop-set-user)
[720.166270] Starting subtest: master-drop-set-user
[720.226959] Subtest master-drop-set-user: SUCCESS (0.048s)
[720.327347] [139/142] (524s left) kms_setmode (invalid-clone-single-crtc-stealing)
[720.551650] Starting subtest: invalid-clone-single-crtc-stealing
[720.614736] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[720.712352] [140/142] (524s left) i915_pm_rpm (system-suspend-execbuf)
[722.485967] Starting subtest: system-suspend-execbuf
[743.147547] Subtest system-suspend-execbuf: SUCCESS (4.929s)
[746.389496] [141/142] (517s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[746.896226] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[746.937504] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[747.263446] [142/142] (516s left) kms_cursor_legacy (forked-bo)
[747.605724] Starting subtest: forked-bo
[747.633024] Starting dynamic subtest: pipe-A
[753.243485] Dynamic subtest pipe-A: SUCCESS (5.488s)
[753.317581] Starting dynamic subtest: pipe-B
[758.760310] Dynamic subtest pipe-B: SUCCESS (5.511s)
[758.839055] Starting dynamic subtest: pipe-C
[764.239940] Dynamic subtest pipe-C: SUCCESS (5.474s)
[764.330155] Starting dynamic subtest: all-pipes
[769.532824] Dynamic subtest all-pipes: SUCCESS (5.463s)
[769.553558] Subtest forked-bo: SUCCESS (21.946s)
[769.629528] Closing watchdogs
Done.