[44.025454] Initializing watchdogs
[44.025718]   /dev/watchdog0
[44.058591] [001/141] (960s left) kms_addfb_basic (unused-offsets)
[44.401228] Starting subtest: unused-offsets
[44.420274] Subtest unused-offsets: SUCCESS (0.000s)
[44.622552] [002/141] (960s left) gem_exec_nop (basic-parallel)
[45.088182] Starting subtest: basic-parallel
[48.102754] Subtest basic-parallel: SUCCESS (3.158s)
[48.329768] [003/141] (956s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[48.695542] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[48.717295] Starting dynamic subtest: pipe-A-valid-mode
[49.449996] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.737s)
[49.469790] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.740s)
[49.804864] [004/141] (955s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[50.248148] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[50.291288] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[50.392390] [005/141] (954s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[50.778224] Starting subtest: pipe-B-ts-continuation-modeset-hang
[58.017530] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (7.229s)
[58.380444] [006/141] (946s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[58.879046] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[59.165458] [007/141] (945s left) syncobj_wait (wait-for-submit-complex)
[59.510182] Starting subtest: wait-for-submit-complex
[59.561174] Subtest wait-for-submit-complex: SUCCESS (0.064s)
[59.714381] [008/141] (945s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[62.093127] Starting subtest: dpms-mode-unset-non-lpsp
[63.624705] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.534s)
[64.119215] [009/141] (941s left) kms_plane_cursor (primary)
[64.506730] Starting subtest: primary
[64.544793] Starting dynamic subtest: pipe-A-DP-1-size-64
[66.915838] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.418s)
[66.981156] Starting dynamic subtest: pipe-A-DP-1-size-128
[69.373438] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.416s)
[69.442502] Starting dynamic subtest: pipe-A-DP-1-size-256
[71.840548] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.416s)
[72.001878] Starting dynamic subtest: pipe-B-DP-1-size-64
[74.587399] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.641s)
[74.656149] Starting dynamic subtest: pipe-B-DP-1-size-128
[77.026762] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.416s)
[77.080714] Starting dynamic subtest: pipe-B-DP-1-size-256
[79.492337] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.433s)
[79.661145] Starting dynamic subtest: pipe-C-DP-1-size-64
[82.262029] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.649s)
[82.315388] Starting dynamic subtest: pipe-C-DP-1-size-128
[84.713464] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.416s)
[84.773154] Starting dynamic subtest: pipe-C-DP-1-size-256
[87.163045] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.416s)
[87.291648] Subtest primary: SUCCESS (22.780s)
[87.616643] [010/141] (917s left) gem_wait (write-busy)
[87.940629] Starting subtest: write-busy
[87.959978] Starting dynamic subtest: all-engines
[88.606763] Dynamic subtest all-engines: SUCCESS (0.653s)
[88.640719] Starting dynamic subtest: rcs0
[89.122423] Dynamic subtest rcs0: SUCCESS (0.519s)
[89.154784] Starting dynamic subtest: bcs0
[89.646731] Dynamic subtest bcs0: SUCCESS (0.520s)
[89.678756] Starting dynamic subtest: vcs0
[90.161499] Dynamic subtest vcs0: SUCCESS (0.519s)
[90.192455] Starting dynamic subtest: vecs0
[90.679948] Dynamic subtest vecs0: SUCCESS (0.519s)
[90.709770] Subtest write-busy: SUCCESS (2.731s)
[90.937340] [011/141] (914s left) api_intel_bb (blit-noreloc-keep-cache)
[91.246750] Starting subtest: blit-noreloc-keep-cache
[91.270277] Subtest blit-noreloc-keep-cache: SUCCESS (0.023s)
[91.372712] [012/141] (914s left) kms_cursor_crc (cursor-random-256x256)
[91.765929] Starting subtest: cursor-random-256x256
[91.785126] Starting dynamic subtest: pipe-A-DP-1
[95.581246] Dynamic subtest pipe-A-DP-1: SUCCESS (3.813s)
[95.667946] Starting dynamic subtest: pipe-C-DP-1
[99.738728] Dynamic subtest pipe-C-DP-1: SUCCESS (4.102s)
[99.759852] Subtest cursor-random-256x256: SUCCESS (7.988s)
[100.129770] [013/141] (905s left) gem_exec_suspend (basic)
[100.457730] Starting subtest: basic
[100.484661] Starting dynamic subtest: smem
[101.879571] Dynamic subtest smem: SUCCESS (1.422s)
[101.898651] Subtest basic: SUCCESS (1.422s)
[102.095130] [014/141] (903s left) drm_read (short-buffer-block)
[102.584240] Starting subtest: short-buffer-block
[102.603633] Subtest short-buffer-block: SUCCESS (0.000s)
[102.747555] [015/141] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[103.184661] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[103.224889] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.330361] [016/141] (902s left) drm_fdinfo (busy-check-all)
[103.629204] Starting subtest: busy-check-all
[103.650368] Starting dynamic subtest: rcs0
[104.136642] Dynamic subtest rcs0: SUCCESS (0.530s)
[104.168272] Starting dynamic subtest: bcs0
[104.669215] Dynamic subtest bcs0: SUCCESS (0.529s)
[104.702437] Starting dynamic subtest: vcs0
[105.190611] Dynamic subtest vcs0: SUCCESS (0.526s)
[105.222214] Starting dynamic subtest: vecs0
[105.721381] Dynamic subtest vecs0: SUCCESS (0.529s)
[105.742744] Subtest busy-check-all: SUCCESS (2.114s)
[105.823585] [017/141] (900s left) gem_exec_params (no-bsd)
[106.122984] Starting subtest: no-bsd
[106.142249] Subtest no-bsd: SUCCESS (0.002s)
[106.226147] [018/141] (899s left) i915_suspend (debugfs-reader)
[106.511389] Starting subtest: debugfs-reader
[125.056067] Subtest debugfs-reader: SUCCESS (3.631s)
[131.155013] [019/141] (896s left) gem_ctx_engines (execute-one)
[131.456248] Starting subtest: execute-one
[134.814634] Subtest execute-one: SUCCESS (3.194s)
[134.900554] [020/141] (892s left) kms_big_fb (linear-8bpp-rotate-180)
[135.300629] Starting subtest: linear-8bpp-rotate-180
[139.164272] Subtest linear-8bpp-rotate-180: SUCCESS (3.884s)
[139.448291] [021/141] (887s left) kms_psr (psr2_sprite_mmap_gtt)
[139.752350] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[139.838804] [022/141] (887s left) kms_concurrent (pipe-a)
[140.225123] Starting subtest: pipe-A
[140.246901] Starting dynamic subtest: DP-1
[140.992919] Dynamic subtest DP-1: SUCCESS (0.769s)
[141.015030] Subtest pipe-A: SUCCESS (0.774s)
[141.343221] [023/141] (886s left) gem_fence_thrash (bo-copy)
[141.626437] Starting subtest: bo-copy
[143.101760] Subtest bo-copy: SUCCESS (1.491s)
[143.240398] [024/141] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[143.635764] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[144.942430] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.328s)
[145.128812] [025/141] (882s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[145.733026] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[145.792614] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[146.281284] [026/141] (881s left) gem_exec_balancer (bonded-chain)
[146.611733] Starting subtest: bonded-chain
[150.403393] Subtest bonded-chain: SUCCESS (3.637s)
[154.248875] [027/141] (873s left) gem_exec_fair (basic-pace-share)
[154.727398] Starting subtest: basic-pace-share
[154.748787] Starting dynamic subtest: rcs0
[159.360906] Dynamic subtest rcs0: SUCCESS (4.821s)
[159.382540] Subtest basic-pace-share: SUCCESS (4.821s)
[159.592132] [028/141] (868s left) api_intel_allocator (fork-simple-once)
[159.892747] Starting subtest: fork-simple-once
[159.911859] Subtest fork-simple-once: SUCCESS (0.044s)
[160.033546] [029/141] (868s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[160.394690] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[160.416209] Starting dynamic subtest: pipe-A-DP-1
[161.348663] Dynamic subtest pipe-A-DP-1: SUCCESS (0.951s)
[161.390417] Starting dynamic subtest: pipe-B-DP-1
[162.591878] Dynamic subtest pipe-B-DP-1: SUCCESS (1.224s)
[162.658744] Starting dynamic subtest: pipe-C-DP-1
[163.525471] Dynamic subtest pipe-C-DP-1: SUCCESS (0.922s)
[163.544864] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.107s)
[163.956028] [030/141] (864s left) perf_pmu (all-busy-check-all)
[164.260006] Starting subtest: all-busy-check-all
[164.786175] Subtest all-busy-check-all: SUCCESS (0.529s)
[164.926424] [031/141] (863s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[165.222087] Starting subtest: cpuset-medium-copy-odd
[177.839986] Subtest cpuset-medium-copy-odd: SUCCESS (12.651s)
[178.025743] [032/141] (850s left) gem_lmem_swapping (basic)
[178.493401] Subtest basic: SKIP (0.000s)
[178.582775] [033/141] (849s left) kms_scaling_modes (scaling-mode-full-aspect)
[179.002041] Starting subtest: scaling-mode-full-aspect
[179.040244] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[179.155412] [034/141] (849s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[179.603457] Starting subtest: fbcpsr-tiling-4
[179.643827] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[179.756879] [035/141] (848s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[180.123923] Starting subtest: plane-upscale-with-rotation-20x20
[180.143254] Starting dynamic subtest: pipe-A-DP-1
[180.256509] Dynamic subtest pipe-A-DP-1: SKIP (0.094s)
[180.302640] Starting dynamic subtest: pipe-B-DP-1
[180.596694] Dynamic subtest pipe-B-DP-1: SKIP (0.334s)
[180.644399] Starting dynamic subtest: pipe-C-DP-1
[180.929742] Dynamic subtest pipe-C-DP-1: SKIP (0.326s)
[180.970185] Subtest plane-upscale-with-rotation-20x20: SKIP (0.764s)
[181.318855] [036/141] (847s left) kms_busy (extended-pageflip-hang-oldfb)
[181.699807] Starting subtest: extended-pageflip-hang-oldfb
[181.718758] Starting dynamic subtest: pipe-A
[182.226865] Dynamic subtest pipe-A: SUCCESS (0.521s)
[182.268069] Starting dynamic subtest: pipe-C
[182.715038] Dynamic subtest pipe-C: SUCCESS (0.472s)
[182.734073] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.004s)
[183.091797] [037/141] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[183.509686] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[183.552219] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[183.663489] [038/141] (845s left) gem_workarounds (basic-read-context)
[183.981273] Starting subtest: basic-read-context
[184.000323] Subtest basic-read-context: SUCCESS (0.026s)
[184.156866] [039/141] (844s left) gem_exec_fence (syncobj-timeline-repeat)
[185.019017] Starting subtest: syncobj-timeline-repeat
[186.167130] Subtest syncobj-timeline-repeat: SUCCESS (1.150s)
[186.424351] [040/141] (842s left) kms_addfb_basic (bad-pitch-128)
[186.719309] Starting subtest: bad-pitch-128
[186.740626] Subtest bad-pitch-128: SUCCESS (0.000s)
[186.921444] [041/141] (842s left) dumb_buffer (invalid-bpp)
[187.215697] Starting subtest: invalid-bpp
[187.236132] Subtest invalid-bpp: SUCCESS (0.000s)
[187.351770] [042/141] (842s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[187.626436] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[187.647995] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[187.739070] [043/141] (841s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[188.040055] Starting subtest: yf-tiled-to-vebox-yf-tiled
[188.078588] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[188.253638] [044/141] (841s left) syncobj_basic (test-valid-cycle)
[188.541709] Starting subtest: test-valid-cycle
[188.562895] Subtest test-valid-cycle: SUCCESS (0.000s)
[188.653455] [045/141] (841s left) v3d/v3d_wait_bo (map-bo-0ns)
[189.006342] Subtest map-bo-0ns: SKIP (0.000s)
[189.122469] [046/141] (840s left) kms_addfb_basic (bad-pitch-32)
[189.437393] Starting subtest: bad-pitch-32
[189.462844] Subtest bad-pitch-32: SUCCESS (0.000s)
[189.674251] [047/141] (840s left) prime_vgem (shrink)
[190.000529] Starting subtest: shrink
[190.019803] Subtest shrink: SUCCESS (0.020s)
[190.133465] [048/141] (839s left) kms_cdclk (mode-transition)
[190.447628] Subtest mode-transition: SKIP (0.000s)
[190.540743] [049/141] (839s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[190.842395] Starting subtest: writes-after-reads-snoop
[211.364550] Subtest writes-after-reads-snoop: SUCCESS (20.541s)
[211.506336] [050/141] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[211.962749] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[212.014654] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[212.149571] [051/141] (818s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[212.572631] Starting subtest: 4-tiled-32bpp-rotate-0
[212.626087] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[212.765464] [052/141] (817s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[213.220062] Starting subtest: fbcpsr-suspend
[213.270656] Subtest fbcpsr-suspend: SKIP (0.000s)
[213.411947] [053/141] (817s left) syncobj_wait (wait-any-complex)
[213.715007] Starting subtest: wait-any-complex
[213.755440] Subtest wait-any-complex: SUCCESS (0.063s)
[213.871761] [054/141] (816s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[214.262351] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[214.303760] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[214.419727] [055/141] (816s left) gem_readwrite (read-write)
[214.710516] Starting subtest: read-write
[214.786853] Subtest read-write: SUCCESS (0.000s)
[214.881496] [056/141] (815s left) gem_exec_balancer (parallel-ordering)
[219.158396] Subtest parallel-ordering: SKIP (0.000s)
[219.247394] [057/141] (811s left) gem_exec_schedule (implicit-read-write)
[219.706551] Starting subtest: implicit-read-write
[219.725899] Starting dynamic subtest: rcs0
[219.744906] Dynamic subtest rcs0: SUCCESS (0.144s)
[219.786154] Starting dynamic subtest: bcs0
[219.831797] Dynamic subtest bcs0: SUCCESS (0.143s)
[219.877593] Starting dynamic subtest: vcs0
[219.962142] Dynamic subtest vcs0: SUCCESS (0.132s)
[220.003314] Starting dynamic subtest: vecs0
[220.089461] Dynamic subtest vecs0: SUCCESS (0.126s)
[220.111980] Subtest implicit-read-write: SUCCESS (0.549s)
[220.484337] [058/141] (810s left) kms_vblank (pipe-c-wait-forked-hang)
[220.848226] Starting subtest: pipe-C-wait-forked-hang
[228.071866] Subtest pipe-C-wait-forked-hang: SUCCESS (7.103s)
[228.329683] [059/141] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[228.756246] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[228.798827] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[228.911238] [060/141] (802s left) syncobj_wait (multi-wait-all-submitted)
[229.204271] Starting subtest: multi-wait-all-submitted
[229.275383] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[229.415520] [061/141] (801s left) gem_render_copy_redux (flink)
[229.722276] Starting subtest: flink
[234.399768] Subtest flink: SUCCESS (4.687s)
[234.545613] [062/141] (796s left) gem_ctx_shared (q-smoketest)
[234.841414] Starting subtest: Q-smoketest
[234.863927] Starting dynamic subtest: rcs0
[240.551614] Dynamic subtest rcs0: SUCCESS (5.459s)
[240.596685] Starting dynamic subtest: bcs0
[245.836055] Dynamic subtest bcs0: SUCCESS (5.460s)
[245.884141] Starting dynamic subtest: vcs0
[251.304147] Dynamic subtest vcs0: SUCCESS (5.466s)
[251.348743] Starting dynamic subtest: vecs0
[256.941451] Dynamic subtest vecs0: SUCCESS (5.461s)
[256.963015] Subtest Q-smoketest: SUCCESS (21.851s)
[257.055610] [063/141] (774s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[257.450558] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[258.524662] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.096s)
[258.792701] [064/141] (772s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[259.490669] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[259.531685] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[259.921528] [065/141] (771s left) i915_pm_rpm (gem-idle)
[261.796783] Starting subtest: gem-idle
[267.413210] Subtest gem-idle: SUCCESS (5.437s)
[267.695440] [066/141] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[268.139813] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[268.179391] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[268.287398] [067/141] (763s left) gem_pxp (reject-modify-context-protection-on)
[271.285758] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[271.448817] [068/141] (760s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[271.984686] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[272.428840] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.438s)
[273.121124] [069/141] (759s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[273.536342] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[274.805879] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.297s)
[275.215066] [070/141] (757s left) prime_vgem (basic-gtt)
[275.552411] Starting subtest: basic-gtt
[275.578146] Subtest basic-gtt: SUCCESS (0.030s)
[275.740553] [071/141] (756s left) syncobj_timeline (reset-signaled)
[276.064263] Starting subtest: reset-signaled
[276.087241] Subtest reset-signaled: SUCCESS (0.001s)
[276.221488] [072/141] (756s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[276.678845] Starting subtest: cursorB-vs-flipA-atomic
[276.730804] Subtest cursorB-vs-flipA-atomic: SKIP (0.005s)
[276.864944] [073/141] (755s left) gem_exec_whisper (basic-normal)
[277.247403] Starting subtest: basic-normal
[283.610518] Subtest basic-normal: SUCCESS (6.225s)
[283.717807] [074/141] (749s left) gem_userptr_blits (userfault)
[284.103522] Starting subtest: userfault
[284.125626] Subtest userfault: SUCCESS (0.010s)
[284.249773] [075/141] (748s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[284.742655] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[284.808644] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[285.395363] [076/141] (747s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[285.935223] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[285.973599] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[286.502071] [077/141] (746s left) kms_vblank (pipe-a-query-idle)
[286.846713] Starting subtest: pipe-A-query-idle
[289.095494] Subtest pipe-A-query-idle: SUCCESS (2.254s)
[289.472888] [078/141] (743s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[290.277861] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[290.616029] [079/141] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[291.061339] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[291.104942] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[291.216866] [080/141] (742s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[291.515733] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[291.535197] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[291.648764] [081/141] (741s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[291.944007] Starting subtest: basic-gtt-cpu-noreloc
[291.964630] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.013s)
[292.176894] [082/141] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[292.620452] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[294.922355] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.374s)
[295.124039] [083/141] (738s left) kms_cursor_edge_walk (64x64-top-edge)
[295.473443] Starting subtest: 64x64-top-edge
[295.496313] Starting dynamic subtest: pipe-A-DP-1
[299.153796] Dynamic subtest pipe-A-DP-1: SUCCESS (3.670s)
[299.196397] Starting dynamic subtest: pipe-C-DP-1
[302.667676] Dynamic subtest pipe-C-DP-1: SUCCESS (3.505s)
[302.688765] Subtest 64x64-top-edge: SUCCESS (7.184s)
[303.015083] [084/141] (730s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[303.469355] Starting subtest: psr-rgb565-draw-mmap-wc
[303.520803] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[303.655921] [085/141] (730s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[304.028074] Starting subtest: disable-crc-after-crtc
[304.048926] Starting dynamic subtest: pipe-A-DP-1
[304.717084] Dynamic subtest pipe-A-DP-1: SUCCESS (0.692s)
[304.766560] Starting dynamic subtest: pipe-B-DP-1
[305.661770] Dynamic subtest pipe-B-DP-1: SUCCESS (0.942s)
[305.711222] Starting dynamic subtest: pipe-C-DP-1
[306.777995] Dynamic subtest pipe-C-DP-1: SUCCESS (1.109s)
[306.799566] Subtest disable-crc-after-crtc: SUCCESS (2.757s)
[307.143437] [086/141] (726s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[307.544842] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[307.582577] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[307.704677] [087/141] (726s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[308.364950] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[308.407749] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[308.817919] [088/141] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[309.239995] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[311.589473] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.409s)
[311.763994] [089/141] (722s left) gem_exec_schedule (preempt-other-chain)
[312.224702] Starting subtest: preempt-other-chain
[312.244828] Starting dynamic subtest: rcs0
[312.264054] Dynamic subtest rcs0: SUCCESS (0.101s)
[312.315478] Starting dynamic subtest: bcs0
[312.334532] Dynamic subtest bcs0: SUCCESS (0.103s)
[312.383191] Starting dynamic subtest: vcs0
[312.404945] Dynamic subtest vcs0: SUCCESS (0.102s)
[312.461733] Starting dynamic subtest: vecs0
[312.483231] Dynamic subtest vecs0: SUCCESS (0.104s)
[312.503231] Subtest preempt-other-chain: SUCCESS (0.418s)
[312.886929] [090/141] (721s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[313.592614] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs
[313.654221] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[314.004049] [091/141] (720s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_ccs)
[314.482042] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_ccs
[315.135643] Subtest pipe-A-crc-primary-rotation-180-y_tiled_ccs: SUCCESS (0.654s)
[315.921874] [092/141] (718s left) gem_exec_schedule (u-submit-late-slice)
[316.374357] Starting subtest: u-submit-late-slice
[316.395320] Starting dynamic subtest: rcs0
[316.416503] Dynamic subtest rcs0: SUCCESS (0.060s)
[316.457283] Starting dynamic subtest: bcs0
[316.476455] Dynamic subtest bcs0: SUCCESS (0.051s)
[316.516046] Starting dynamic subtest: vcs0
[316.535027] Dynamic subtest vcs0: SUCCESS (0.048s)
[316.577907] Starting dynamic subtest: vecs0
[316.599603] Dynamic subtest vecs0: SUCCESS (0.051s)
[316.620262] Subtest u-submit-late-slice: SUCCESS (0.217s)
[316.832580] [093/141] (718s left) perf (mi-rpc)
[317.280525] Starting subtest: mi-rpc
[317.345245] Subtest mi-rpc: SUCCESS (0.066s)
[317.478355] [094/141] (717s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[317.764560] Starting subtest: framebuffer-vs-set-tiling
[317.786219] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[317.996420] [095/141] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[318.425488] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[318.463086] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[318.578520] [096/141] (716s left) perf (polling)
[318.916852] Starting subtest: polling
[318.939271] Starting dynamic subtest: 0-rcs0
[329.160653] Dynamic subtest 0-rcs0: SUCCESS (10.083s)
[329.181426] Subtest polling: SUCCESS (10.087s)
[329.293744] [097/141] (706s left) kms_psr (cursor_plane_onoff)
[329.614060] Subtest cursor_plane_onoff: SKIP (0.000s)
[329.707585] [098/141] (705s left) gem_create (create-ext-placement-sanity-check)
[330.101408] Starting subtest: create-ext-placement-sanity-check
[330.123764] Subtest create-ext-placement-sanity-check: SUCCESS (0.011s)
[330.232325] [099/141] (705s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[330.671451] Starting subtest: fbcpsr-rgb101010-draw-render
[330.713787] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[330.825395] [100/141] (704s left) kms_vblank (pipe-d-wait-idle-hang)
[331.216588] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[331.430311] [101/141] (704s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[331.720504] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[331.782549] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[331.919618] [102/141] (703s left) kms_flip (plain-flip-fb-recreate-interruptible)
[332.292943] Starting subtest: plain-flip-fb-recreate-interruptible
[332.312020] Starting dynamic subtest: A-DP1
[343.109446] Dynamic subtest A-DP1: SUCCESS (10.795s)
[343.157592] Starting dynamic subtest: B-DP1
[353.820782] Dynamic subtest B-DP1: SUCCESS (10.723s)
[353.860767] Starting dynamic subtest: C-DP1
[364.555389] Dynamic subtest C-DP1: SUCCESS (10.721s)
[364.576470] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.250s)
[365.003658] [103/141] (670s left) vc4/vc4_wait_bo (bad-bo)
[365.353699] Subtest bad-bo: SKIP (0.000s)
[365.463969] [104/141] (670s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[366.267605] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[366.587222] [105/141] (669s left) kms_color (gamma)
[366.950296] Starting subtest: gamma
[366.969298] Starting dynamic subtest: pipe-A
[367.522151] Dynamic subtest pipe-A: SUCCESS (0.542s)
[367.582409] Starting dynamic subtest: pipe-B
[368.331424] Dynamic subtest pipe-B: SUCCESS (0.827s)
[368.384134] Starting dynamic subtest: pipe-C
[369.300436] Dynamic subtest pipe-C: SUCCESS (0.959s)
[369.328654] Subtest gamma: SUCCESS (2.332s)
[369.677706] [106/141] (666s left) kms_chamelium_color (degamma)
[370.100680] Subtest degamma: SKIP (0.000s)
[370.215988] [107/141] (666s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs)
[370.678510] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs
[370.718691] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[371.328943] [108/141] (665s left) core_auth (getclient-simple)
[371.617210] Starting subtest: getclient-simple
[371.657241] Subtest getclient-simple: SUCCESS (0.004s)
[371.774877] [109/141] (664s left) gem_exec_flush (basic-wb-rw-default)
[372.111775] Starting subtest: basic-wb-rw-default
[377.733914] Subtest basic-wb-rw-default: SUCCESS (5.483s)
[377.844971] [110/141] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[378.294884] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[378.332923] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[378.451554] [111/141] (658s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[378.849606] Starting subtest: cursor-rapid-movement-max-size
[378.906334] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[379.026143] [112/141] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[379.447824] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[379.491549] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[379.610239] [113/141] (657s left) kms_psr2_sf (plane-move-sf-dmg-area)
[379.932078] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[380.023226] [114/141] (657s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[380.314635] Starting subtest: multi-wait-for-submit-available-submitted
[380.333734] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[380.430893] [115/141] (656s left) gem_linear_blits (interruptible)
[381.162330] Starting subtest: interruptible
[397.220430] Subtest interruptible: SUCCESS (16.059s)
[397.394874] [116/141] (639s left) kms_lease (atomic_implicit_crtc)
[397.980000] Starting subtest: atomic_implicit_crtc
[398.000468] Starting dynamic subtest: pipe-A-DP-1
[398.020875] Dynamic subtest pipe-A-DP-1: SUCCESS (0.004s)
[398.063335] Starting dynamic subtest: pipe-B-DP-1
[398.083142] Dynamic subtest pipe-B-DP-1: SUCCESS (0.016s)
[398.125513] Starting dynamic subtest: pipe-C-DP-1
[398.147080] Dynamic subtest pipe-C-DP-1: SUCCESS (0.018s)
[398.168380] Subtest atomic_implicit_crtc: SUCCESS (0.047s)
[398.307923] [117/141] (639s left) gem_ctx_param (invalid-size-set)
[398.610616] Starting subtest: invalid-size-set
[398.629893] Subtest invalid-size-set: SUCCESS (0.000s)
[398.728411] [118/141] (638s left) perf_pmu (busy-double-start)
[399.026538] Starting subtest: busy-double-start
[399.048528] Starting dynamic subtest: rcs0
[402.573276] Dynamic subtest rcs0: SUCCESS (3.551s)
[402.616106] Starting dynamic subtest: bcs0
[406.127644] Dynamic subtest bcs0: SUCCESS (3.563s)
[406.170576] Starting dynamic subtest: vcs0
[409.682642] Dynamic subtest vcs0: SUCCESS (3.541s)
[409.725359] Starting dynamic subtest: vecs0
[413.223895] Dynamic subtest vecs0: SUCCESS (3.547s)
[413.245704] Subtest busy-double-start: SUCCESS (14.208s)
[413.363149] [119/141] (624s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[413.789614] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[416.755253] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.024s)
[416.960066] [120/141] (620s left) prime_mmap (test_errors)
[417.256555] Starting subtest: test_errors
[417.275466] Starting dynamic subtest: test_errors-smem
[417.297217] Dynamic subtest test_errors-smem: SUCCESS (0.020s)
[417.318998] Subtest test_errors: SUCCESS (0.021s)
[417.414991] [121/141] (620s left) sysfs_timeslice_duration (timeout)
[417.712694] Starting subtest: timeout
[417.733699] Starting dynamic subtest: vecs0
[418.612417] Dynamic subtest vecs0: SUCCESS (0.891s)
[418.659341] Starting dynamic subtest: vcs0
[419.492513] Dynamic subtest vcs0: SUCCESS (0.888s)
[419.534668] Starting dynamic subtest: bcs0
[420.401198] Dynamic subtest bcs0: SUCCESS (0.897s)
[420.446513] Starting dynamic subtest: rcs0
[421.306230] Dynamic subtest rcs0: SUCCESS (0.911s)
[421.327609] Subtest timeout: SUCCESS (3.595s)
[421.419395] [122/141] (616s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[421.797029] Starting subtest: map-fixed-invalidate-overlap
[421.819195] Starting dynamic subtest: gtt
[422.092533] Dynamic subtest gtt: SUCCESS (0.363s)
[422.135761] Starting dynamic subtest: wb
[422.381786] Dynamic subtest wb: SUCCESS (0.289s)
[422.422452] Starting dynamic subtest: wc
[422.675310] Dynamic subtest wc: SUCCESS (0.289s)
[422.719113] Starting dynamic subtest: uc
[422.957922] Dynamic subtest uc: SUCCESS (0.285s)
[422.977146] Subtest map-fixed-invalidate-overlap: SUCCESS (1.231s)
[423.129582] [123/141] (614s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[423.515085] Subtest bad-multisync-out-sync: SKIP (0.000s)
[423.630264] [124/141] (614s left) i915_module_load (resize-bar)
[423.929511] Starting subtest: resize-bar
[423.999667] Subtest resize-bar: SKIP (0.012s)
[424.096269] [125/141] (614s left) kms_vblank (pipe-b-query-busy-hang)
[424.463930] Starting subtest: pipe-B-query-busy-hang
[432.106496] Subtest pipe-B-query-busy-hang: SUCCESS (7.516s)
[432.354214] [126/141] (605s left) kms_addfb_basic (legacy-format)
[432.652541] Starting subtest: legacy-format
[432.918433] Subtest legacy-format: SUCCESS (0.119s)
[433.244630] [127/141] (605s left) kms_vblank (pipe-d-ts-continuation-modeset)
[433.627424] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[433.824924] [128/141] (604s left) gem_partial_pwrite_pread (reads)
[434.122666] Starting subtest: reads
[440.733445] Subtest reads: SUCCESS (6.627s)
[440.897010] [129/141] (597s left) gem_mmap_wc (write-prefaulted)
[441.199475] Starting subtest: write-prefaulted
[441.466210] Subtest write-prefaulted: SUCCESS (0.300s)
[441.607415] [130/141] (597s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[442.404373] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[442.726967] [131/141] (596s left) vc4/vc4_perfmon (create-single-perfmon)
[443.075339] Subtest create-single-perfmon: SKIP (0.000s)
[443.190703] [132/141] (595s left) i915_hangman (engine-engine-error)
[443.484066] Starting subtest: engine-engine-error
[443.506484] Starting dynamic subtest: rcs0
[443.574113] Dynamic subtest rcs0: SUCCESS (0.082s)
[443.620712] Starting dynamic subtest: bcs0
[443.658466] Dynamic subtest bcs0: SKIP (0.003s)
[443.709399] Starting dynamic subtest: vcs0
[443.731119] Dynamic subtest vcs0: SUCCESS (0.084s)
[443.775348] Starting dynamic subtest: vecs0
[443.796286] Dynamic subtest vecs0: SUCCESS (0.079s)
[443.816989] Subtest engine-engine-error: SUCCESS (0.253s)
[443.927330] [133/141] (595s left) kms_content_protection (uevent)
[444.346710] Starting subtest: uevent
[444.388393] Starting dynamic subtest: pipe-A-DP-1
[480.378836] Dynamic subtest pipe-A-DP-1: FAIL (34.879s)
[480.397770] Subtest uevent: FAIL (35.070s)
[480.532233] [134/141] (558s left) gem_softpin (evict-prime-sanity-check)
[480.817542] Starting subtest: evict-prime-sanity-check
[480.840461] Starting dynamic subtest: rcs0
[481.925918] Dynamic subtest rcs0: SUCCESS (1.115s)
[481.968227] Starting dynamic subtest: bcs0
[483.036950] Dynamic subtest bcs0: SUCCESS (1.108s)
[483.081261] Starting dynamic subtest: vcs0
[484.146741] Dynamic subtest vcs0: SUCCESS (1.110s)
[484.192778] Starting dynamic subtest: vecs0
[485.251883] Dynamic subtest vecs0: SUCCESS (1.104s)
[485.294631] Starting dynamic subtest: all
[486.369331] Dynamic subtest all: SUCCESS (1.114s)
[486.390265] Subtest evict-prime-sanity-check: SUCCESS (5.557s)
[486.490222] [135/141] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[486.934874] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[489.351075] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.498s)
[489.515373] [136/141] (549s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[489.882060] Starting subtest: cursor-fb-leak-pipe-C
[490.707213] Subtest cursor-fb-leak-pipe-C: SUCCESS (0.823s)
[491.077205] [137/141] (548s left) sw_sync (sync_busy_fork)
[491.353656] Starting subtest: sync_busy_fork
[492.375759] Subtest sync_busy_fork: SUCCESS (1.035s)
[492.489062] [138/141] (547s left) gem_ctx_persistence (legacy-engines-mixed)
[492.795609] Starting subtest: legacy-engines-mixed
[492.814762] Starting dynamic subtest: render
[492.833872] Dynamic subtest render: SUCCESS (0.055s)
[492.876399] Starting dynamic subtest: bsd
[492.897954] Dynamic subtest bsd: SUCCESS (0.047s)
[492.945793] Starting dynamic subtest: blt
[492.966746] Dynamic subtest blt: SUCCESS (0.049s)
[493.010662] Starting dynamic subtest: vebox
[493.029795] Dynamic subtest vebox: SUCCESS (0.043s)
[493.048829] Subtest legacy-engines-mixed: SUCCESS (0.202s)
[493.167042] [139/141] (546s left) syncobj_timeline (single-wait-for-submit-signaled)
[493.461272] Starting subtest: single-wait-for-submit-signaled
[493.483058] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[493.581041] [140/141] (546s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[494.229582] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[494.271100] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.005s)
[494.709063] [141/141] (545s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[495.074813] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[495.096761] Starting dynamic subtest: pipe-A-valid-mode
[495.215825] Dynamic subtest pipe-A-valid-mode: SKIP (0.122s)
[495.256845] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.125s)
[495.541517] Closing watchdogs
Done.