[55.479487] Initializing watchdogs
[55.479795]   /dev/watchdog0
[55.495967] [001/142] (960s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[55.835536] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[55.837038] Starting dynamic subtest: pipe-A-DP-1
[56.182673] Dynamic subtest pipe-A-DP-1: SUCCESS (0.347s)
[56.203908] Starting dynamic subtest: pipe-B-DP-1
[56.570844] Dynamic subtest pipe-B-DP-1: SUCCESS (0.385s)
[56.587913] Starting dynamic subtest: pipe-C-DP-1
[56.676320] Dynamic subtest pipe-C-DP-1: SKIP (0.100s)
[56.678199] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.842s)
[57.082954] [002/142] (958s left) fbdev (unaligned-read)
[57.297576] Starting subtest: unaligned-read
[57.310507] Subtest unaligned-read: SUCCESS (0.013s)
[57.380638] [003/142] (958s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[57.680373] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[59.050186] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.370s)
[59.403176] [004/142] (956s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[59.958451] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[59.961150] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[60.400501] [005/142] (955s left) v3d/v3d_mmap (mmap-bad-handle)
[60.667085] Subtest mmap-bad-handle: SKIP (0.000s)
[60.733058] [006/142] (955s left) kms_dsc (dsc-with-bpc-formats)
[61.040091] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[61.081652] [007/142] (955s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[61.386729] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[61.388129] Starting dynamic subtest: pipe-A-valid-mode
[61.483547] Dynamic subtest pipe-A-valid-mode: SKIP (0.095s)
[61.488465] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.097s)
[61.795455] [008/142] (954s left) kms_fbcon_fbt (fbc-suspend)
[62.009939] Starting subtest: fbc-suspend
[111.180213] Subtest fbc-suspend: SUCCESS (17.014s)
[112.231746] [009/142] (937s left) gem_ctx_persistence (legacy-engines-mixed-process)
[112.459677] Starting subtest: legacy-engines-mixed-process
[112.465057] Starting dynamic subtest: render
[112.839332] Dynamic subtest render: SUCCESS (0.375s)
[112.860132] Starting dynamic subtest: bsd
[113.196069] Dynamic subtest bsd: SUCCESS (0.354s)
[113.214379] Starting dynamic subtest: blt
[113.544579] Dynamic subtest blt: SUCCESS (0.347s)
[113.563019] Starting dynamic subtest: vebox
[113.901644] Dynamic subtest vebox: SUCCESS (0.355s)
[113.903021] Subtest legacy-engines-mixed-process: SUCCESS (1.441s)
[113.985528] [010/142] (935s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[114.291589] Starting subtest: cursorA-vs-flipB-atomic
[114.294613] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[114.384942] [011/142] (935s left) kms_rotation_crc (exhaust-fences)
[114.697870] Starting subtest: exhaust-fences
[116.379409] Subtest exhaust-fences: SUCCESS (1.685s)
[116.536235] [012/142] (932s left) i915_pm_rpm (basic-pci-d3-state)
[118.343657] Starting subtest: basic-pci-d3-state
[119.164099] Subtest basic-pci-d3-state: SUCCESS (0.820s)
[119.381540] [013/142] (930s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[119.700206] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[121.558791] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (1.861s)
[121.680730] [014/142] (927s left) gem_softpin (invalid)
[121.899809] Starting subtest: invalid
[121.913073] Subtest invalid: SUCCESS (0.013s)
[122.029403] [015/142] (927s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[122.360506] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[122.366040] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[122.463203] [016/142] (927s left) gem_exec_reloc (basic-gtt-read-active)
[122.681040] Starting subtest: basic-gtt-read-active
[122.825254] Subtest basic-gtt-read-active: SUCCESS (0.142s)
[123.013413] [017/142] (926s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[123.441668] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[124.102650] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.661s)
[124.727319] [018/142] (925s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[124.935884] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[125.046198] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[125.125324] [019/142] (924s left) gem_exec_schedule (preempt-queue)
[125.364337] Starting subtest: preempt-queue
[125.366076] Starting dynamic subtest: rcs0
[125.780166] Dynamic subtest rcs0: SUCCESS (0.411s)
[125.804528] Starting dynamic subtest: bcs0
[126.197049] Dynamic subtest bcs0: SUCCESS (0.418s)
[126.226172] Starting dynamic subtest: vcs0
[126.601568] Dynamic subtest vcs0: SUCCESS (0.404s)
[126.632185] Starting dynamic subtest: vecs0
[127.005638] Dynamic subtest vecs0: SUCCESS (0.403s)
[127.007266] Subtest preempt-queue: SUCCESS (1.640s)
[127.359262] [020/142] (922s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[127.566783] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[127.568321] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[127.657736] [021/142] (922s left) v3d/v3d_wait_bo (bad-bo)
[127.903500] Subtest bad-bo: SKIP (0.000s)
[127.976303] [022/142] (921s left) gem_exec_balancer (waits)
[128.208878] Starting subtest: waits
[131.927749] Subtest waits: SUCCESS (3.717s)
[135.842003] [023/142] (914s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[136.340751] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[136.343337] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[136.842296] [024/142] (913s left) debugfs_test (read_all_entries_display_on)
[137.159698] Starting subtest: read_all_entries_display_on
[137.404681] Subtest read_all_entries_display_on: SUCCESS (0.247s)
[137.527090] [025/142] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[137.856113] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[137.858727] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[137.959174] [026/142] (912s left) syncobj_timeline (wait-for-submit-delayed-submit)
[138.167001] Starting subtest: wait-for-submit-delayed-submit
[138.271467] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[138.359941] [027/142] (911s left) api_intel_allocator (reloc-allocator)
[138.562684] Starting subtest: reloc-allocator
[138.564175] Starting dynamic subtest: basic
[138.568097] Dynamic subtest basic: SUCCESS (0.006s)
[138.590047] Starting dynamic subtest: parallel-one
[138.591416] Dynamic subtest parallel-one: SUCCESS (0.017s)
[138.611512] Starting dynamic subtest: print
[138.612755] Dynamic subtest print: SUCCESS (0.000s)
[138.633093] Starting dynamic subtest: reuse
[138.634486] Dynamic subtest reuse: SUCCESS (0.000s)
[138.654295] Starting dynamic subtest: fork-reopen-allocator
[138.655534] Dynamic subtest fork-reopen-allocator: SUCCESS (0.041s)
[138.656767] Subtest reloc-allocator: SUCCESS (0.068s)
[138.709974] [028/142] (911s left) i915_pm_rpm (universal-planes)
[140.497994] Starting subtest: universal-planes
[140.500148] Starting dynamic subtest: plane-31
[142.862483] Dynamic subtest plane-31: SUCCESS (2.364s)
[142.883093] Starting dynamic subtest: plane-39
[145.336997] Dynamic subtest plane-39: SUCCESS (2.475s)
[145.359878] Starting dynamic subtest: plane-47
[147.785142] Dynamic subtest plane-47: SUCCESS (2.448s)
[147.805989] Starting dynamic subtest: plane-55
[150.038878] Dynamic subtest plane-55: SUCCESS (2.251s)
[150.041463] Subtest universal-planes: SUCCESS (9.542s)
[150.513220] [029/142] (899s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[150.840089] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[150.842620] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[150.944537] [030/142] (899s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[151.159967] Starting subtest: basic-wc-gtt-noreloc
[151.173084] Subtest basic-wc-gtt-noreloc: SUCCESS (0.013s)
[151.361232] [031/142] (898s left) kms_lease (cursor_implicit_plane)
[151.665327] Starting subtest: cursor_implicit_plane
[151.666611] Starting dynamic subtest: pipe-A-DP-1
[151.934151] Dynamic subtest pipe-A-DP-1: SUCCESS (0.269s)
[151.956166] Starting dynamic subtest: pipe-B-DP-1
[152.489587] Dynamic subtest pipe-B-DP-1: SUCCESS (0.552s)
[152.509616] Starting dynamic subtest: pipe-C-DP-1
[153.184781] Dynamic subtest pipe-C-DP-1: SUCCESS (0.692s)
[153.186501] Subtest cursor_implicit_plane: SUCCESS (1.521s)
[153.502505] [032/142] (896s left) syncobj_wait (single-wait-signaled)
[153.710366] Starting subtest: single-wait-signaled
[153.712229] Subtest single-wait-signaled: SUCCESS (0.002s)
[153.802231] [033/142] (896s left) syncobj_wait (single-wait-all-submitted)
[154.008923] Starting subtest: single-wait-all-submitted
[154.118216] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[154.203281] [034/142] (896s left) kms_cursor_edge_walk (128x128-top-bottom)
[154.516507] Starting subtest: 128x128-top-bottom
[154.518092] Starting dynamic subtest: pipe-A-DP-1
[158.162906] Dynamic subtest pipe-A-DP-1: SUCCESS (3.644s)
[158.189587] Starting dynamic subtest: pipe-C-DP-1
[161.659331] Dynamic subtest pipe-C-DP-1: SUCCESS (3.494s)
[161.660689] Subtest 128x128-top-bottom: SUCCESS (7.146s)
[161.986167] [035/142] (888s left) syncobj_timeline (multi-wait-available-signaled)
[162.194516] Starting subtest: multi-wait-available-signaled
[162.196321] Subtest multi-wait-available-signaled: SUCCESS (0.002s)
[162.283097] [036/142] (888s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[162.606177] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[162.608789] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[162.700175] [037/142] (887s left) api_intel_allocator (reserve-simple)
[162.904407] Starting subtest: reserve-simple
[162.909205] Subtest reserve-simple: SUCCESS (0.004s)
[163.017242] [038/142] (887s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[163.354043] Starting subtest: extended-modeset-hang-newfb-with-reset
[163.355505] Starting dynamic subtest: pipe-A
[166.592674] Dynamic subtest pipe-A: SUCCESS (3.237s)
[166.619592] Starting dynamic subtest: pipe-C
[169.989923] Dynamic subtest pipe-C: SUCCESS (3.392s)
[169.991138] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (6.640s)
[170.350818] [039/142] (880s left) kms_chamelium_frames (hdmi-aspect-ratio)
[170.758160] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[171.054306] [040/142] (879s left) gem_set_tiling_vs_gtt
[171.649396] [041/142] (879s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[171.947597] Starting subtest: blocking-absolute-wf_vblank-interruptible
[171.953345] Starting dynamic subtest: A-DP1
[182.627442] Dynamic subtest A-DP1: SUCCESS (10.674s)
[182.656116] Starting dynamic subtest: B-DP1
[193.079379] Dynamic subtest B-DP1: SUCCESS (10.444s)
[193.102383] Starting dynamic subtest: C-DP1
[203.526299] Dynamic subtest C-DP1: SUCCESS (10.444s)
[203.530228] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.581s)
[203.941724] [042/142] (846s left) gem_exec_schedule (independent)
[204.178720] Starting subtest: independent
[204.182556] Starting dynamic subtest: rcs0
[204.377138] Dynamic subtest rcs0: SUCCESS (0.195s)
[204.407343] Starting dynamic subtest: bcs0
[204.584411] Dynamic subtest bcs0: SUCCESS (0.202s)
[204.608342] Starting dynamic subtest: vcs0
[204.774746] Dynamic subtest vcs0: SUCCESS (0.188s)
[204.798870] Starting dynamic subtest: vecs0
[204.955070] Dynamic subtest vecs0: SUCCESS (0.178s)
[204.957069] Subtest independent: SUCCESS (0.776s)
[205.290072] [043/142] (845s left) gem_exec_nop (basic-series)
[205.527059] Starting subtest: basic-series
[208.595130] Subtest basic-series: SUCCESS (3.069s)
[208.822644] [044/142] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[209.136130] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[209.139331] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[209.240188] [045/142] (841s left) kms_cursor_crc (cursor-random-256x85)
[209.565438] Starting subtest: cursor-random-256x85
[209.578666] Starting dynamic subtest: pipe-A-DP-1
[213.395621] Dynamic subtest pipe-A-DP-1: SUCCESS (3.817s)
[213.481705] Starting dynamic subtest: pipe-C-DP-1
[217.602414] Dynamic subtest pipe-C-DP-1: SUCCESS (4.139s)
[217.603790] Subtest cursor-random-256x85: SUCCESS (8.037s)
[217.952526] [046/142] (832s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[218.259538] Starting subtest: primary-4-tiled-reflect-x-0
[218.262213] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[218.349473] [047/142] (832s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[218.675050] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[218.681140] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[218.766107] [048/142] (832s left) gem_partial_pwrite_pread (write-uncached)
[218.980296] Starting subtest: write-uncached
[233.569579] Subtest write-uncached: SUCCESS (14.590s)
[233.683009] [049/142] (817s left) gem_eio (in-flight-contexts-immediate)
[233.917275] Starting subtest: in-flight-contexts-immediate
[245.399935] Subtest in-flight-contexts-immediate: SUCCESS (11.483s)
[245.617705] [050/142] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[245.940520] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[245.943503] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.050819] [051/142] (805s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[246.624873] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[246.631562] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[247.062401] [052/142] (804s left) kms_big_fb (linear-64bpp-rotate-0)
[247.401055] Starting subtest: linear-64bpp-rotate-0
[255.852467] Subtest linear-64bpp-rotate-0: SUCCESS (8.449s)
[256.779598] [053/142] (794s left) vgem_basic (sysfs)
[257.069898] Starting subtest: sysfs
[257.071992] Subtest sysfs: SUCCESS (0.001s)
[257.144244] [054/142] (794s left) kms_psr (cursor_blt)
[257.355018] Subtest cursor_blt: SKIP (0.000s)
[257.409457] [055/142] (793s left) kms_prime (basic-crc-hybrid)
[259.496840] Subtest basic-crc-hybrid: SKIP (0.000s)
[259.601654] [056/142] (791s left) gem_tiled_partial_pwrite_pread (writes)
[259.822257] Starting subtest: writes
[262.039020] Subtest writes: SUCCESS (2.217s)
[262.166729] [057/142] (789s left) kms_panel_fitting (atomic-fastset)
[262.475999] Starting subtest: atomic-fastset
[262.478564] Subtest atomic-fastset: SKIP (0.001s)
[262.562221] [058/142] (788s left) gem_tiled_blits (normal)
[264.714156] Starting subtest: normal
[316.711935] Subtest normal: SUCCESS (52.000s)
[316.833800] [059/142] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[317.281554] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[319.369977] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.092s)
[319.512501] [060/142] (731s left) kms_getfb (getfb2-handle-protection)
[319.722295] Starting subtest: getfb2-handle-protection
[319.753934] Subtest getfb2-handle-protection: SUCCESS (0.033s)
[319.863609] [061/142] (731s left) gem_exec_reloc (basic-gtt-noreloc)
[320.082999] Starting subtest: basic-gtt-noreloc
[320.093598] Subtest basic-gtt-noreloc: SUCCESS (0.011s)
[320.297972] [062/142] (731s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[320.597500] Starting subtest: cursor-vs-flip-legacy
[358.765836] Subtest cursor-vs-flip-legacy: SUCCESS (38.170s)
[359.110786] [063/142] (692s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[359.448679] Starting subtest: x-tiled-64bpp-rotate-270
[359.539961] Subtest x-tiled-64bpp-rotate-270: SKIP (0.087s)
[359.658780] [064/142] (692s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[359.931745] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[360.007377] [065/142] (691s left) syncobj_timeline (host-signal-points)
[360.216745] Starting subtest: host-signal-points
[360.234919] Subtest host-signal-points: SUCCESS (0.018s)
[360.324968] [066/142] (691s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[360.656312] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[360.659275] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[360.758668] [067/142] (691s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[361.184795] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[361.187767] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[361.738021] [068/142] (690s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[362.417245] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[362.741289] [069/142] (689s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[363.345422] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[363.348359] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[363.739723] [070/142] (688s left) v3d/v3d_submit_cl (job-perfmon)
[364.011776] Subtest job-perfmon: SKIP (0.000s)
[364.089517] [071/142] (687s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[364.398759] Starting subtest: disable-crc-after-crtc
[364.400292] Starting dynamic subtest: pipe-A-DP-1
[365.140131] Dynamic subtest pipe-A-DP-1: SUCCESS (0.739s)
[365.172182] Starting dynamic subtest: pipe-B-DP-1
[366.157781] Dynamic subtest pipe-B-DP-1: SUCCESS (1.013s)
[366.189572] Starting dynamic subtest: pipe-C-DP-1
[367.349498] Dynamic subtest pipe-C-DP-1: SUCCESS (1.186s)
[367.350956] Subtest disable-crc-after-crtc: SUCCESS (2.954s)
[367.693687] [072/142] (684s left) gem_busy (semaphore)
[368.066647] Starting subtest: semaphore
[368.068281] Starting dynamic subtest: rcs0
[368.106681] Dynamic subtest rcs0: SUCCESS (0.040s)
[368.136328] Starting dynamic subtest: bcs0
[368.145797] Dynamic subtest bcs0: SUCCESS (0.036s)
[368.174689] Starting dynamic subtest: vcs0
[368.178838] Dynamic subtest vcs0: SUCCESS (0.030s)
[368.208251] Starting dynamic subtest: vecs0
[368.209766] Dynamic subtest vecs0: SUCCESS (0.027s)
[368.211508] Subtest semaphore: SUCCESS (0.144s)
[368.444416] [073/142] (683s left) syncobj_wait (invalid-wait-illegal-handle)
[368.655593] Starting subtest: invalid-wait-illegal-handle
[368.657270] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[368.743200] [074/142] (683s left) gem_ctx_shared (exec-single-timeline)
[368.974457] Starting subtest: exec-single-timeline
[368.978917] Starting dynamic subtest: rcs0
[370.032364] Dynamic subtest rcs0: SUCCESS (1.054s)
[370.057819] Starting dynamic subtest: bcs0
[371.120895] Dynamic subtest bcs0: SUCCESS (1.083s)
[371.152013] Starting dynamic subtest: vcs0
[372.209653] Dynamic subtest vcs0: SUCCESS (1.084s)
[372.237054] Starting dynamic subtest: vecs0
[373.295170] Dynamic subtest vecs0: SUCCESS (1.086s)
[373.296756] Subtest exec-single-timeline: SUCCESS (4.320s)
[373.527525] [075/142] (678s left) gem_userptr_blits (sync-unmap)
[373.777499] Starting subtest: sync-unmap
[373.828201] Subtest sync-unmap: SUCCESS (0.051s)
[373.978314] [076/142] (678s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[374.472152] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[374.475542] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[374.984322] [077/142] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[375.301421] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[375.305000] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[375.418131] [078/142] (676s left) vc4/vc4_tiling (get-bad-handle)
[375.689577] Subtest get-bad-handle: SKIP (0.000s)
[375.767019] [079/142] (676s left) gem_render_copy (yf-tiled)
[375.991780] Starting subtest: yf-tiled
[375.993497] Starting dynamic subtest: smem
[376.374612] Dynamic subtest smem: SUCCESS (0.378s)
[376.376143] Subtest yf-tiled: SUCCESS (0.381s)
[376.585794] [080/142] (675s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[377.261895] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[377.584974] [081/142] (674s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[378.169172] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[378.172180] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[378.592772] [082/142] (673s left) gem_exec_create (basic)
[378.822423] Starting subtest: basic
[378.827329] Starting dynamic subtest: smem
[380.887597] Dynamic subtest smem: SUCCESS (2.061s)
[380.889057] Subtest basic: SUCCESS (2.065s)
[381.093692] [083/142] (671s left) syncobj_wait (single-wait-submitted)
[381.304133] Starting subtest: single-wait-submitted
[381.406371] Subtest single-wait-submitted: SUCCESS (0.103s)
[381.492777] [084/142] (671s left) kms_vblank (pipe-b-query-busy-hang)
[381.804617] Starting subtest: pipe-B-query-busy-hang
[389.124813] Subtest pipe-B-query-busy-hang: SUCCESS (7.323s)
[389.478821] [085/142] (663s left) gem_exec_schedule (u-fairslice)
[389.715353] Starting subtest: u-fairslice
[389.720356] Starting dynamic subtest: rcs0
[391.755960] Dynamic subtest rcs0: SUCCESS (2.036s)
[391.781126] Starting dynamic subtest: bcs0
[393.791066] Dynamic subtest bcs0: SUCCESS (2.031s)
[393.815252] Starting dynamic subtest: vcs0
[395.820306] Dynamic subtest vcs0: SUCCESS (2.027s)
[395.844726] Starting dynamic subtest: vecs0
[397.850887] Dynamic subtest vecs0: SUCCESS (2.027s)
[397.852463] Subtest u-fairslice: SUCCESS (8.133s)
[398.195346] [086/142] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[398.516906] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[398.519817] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.612709] [087/142] (654s left) perf_pmu (idle)
[398.826518] Starting subtest: idle
[398.828226] Starting dynamic subtest: rcs0
[399.350067] Dynamic subtest rcs0: SUCCESS (0.517s)
[399.374134] Starting dynamic subtest: bcs0
[399.872766] Dynamic subtest bcs0: SUCCESS (0.518s)
[399.896620] Starting dynamic subtest: vcs0
[400.394126] Dynamic subtest vcs0: SUCCESS (0.522s)
[400.418864] Starting dynamic subtest: vecs0
[400.919610] Dynamic subtest vecs0: SUCCESS (0.522s)
[400.921222] Subtest idle: SUCCESS (2.094s)
[401.012042] [088/142] (651s left) gen3_render_mixed_blits
[401.276820] [089/142] (651s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[401.593706] Starting subtest: addfb25-y-tiled-small-legacy
[401.595513] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[401.696277] [090/142] (651s left) gem_softpin (allocator-basic)
[401.911428] Starting subtest: allocator-basic
[402.155481] Subtest allocator-basic: SUCCESS (0.242s)
[402.296114] [091/142] (650s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[402.972776] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[403.298321] [092/142] (649s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[403.701368] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[404.167418] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.465s)
[404.864116] [093/142] (648s left) i915_pm_backlight (fade-with-dpms)
[405.165507] Subtest fade-with-dpms: SKIP (0.000s)
[405.227743] [094/142] (647s left) gen9_exec_parse (bb-start-param)
[405.456071] Starting subtest: bb-start-param
[405.461454] Subtest bb-start-param: SUCCESS (0.005s)
[405.696088] [095/142] (647s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[406.004765] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[407.853214] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (1.850s)
[407.996120] [096/142] (645s left) gem_exec_whisper (basic-queues-forked)
[408.229126] Starting subtest: basic-queues-forked
[420.232426] Subtest basic-queues-forked: SUCCESS (12.000s)
[420.449675] [097/142] (632s left) gem_exec_schedule (smoketest-all)
[420.690293] Starting subtest: smoketest-all
[453.004763] Subtest smoketest-all: SUCCESS (32.308s)
[453.362758] [098/142] (599s left) kms_vblank (pipe-b-wait-forked)
[453.670160] Starting subtest: pipe-B-wait-forked
[456.443192] Subtest pipe-B-wait-forked: SUCCESS (2.770s)
[456.783359] [099/142] (596s left) gem_exec_balancer (fairslice)
[457.015197] Starting subtest: fairslice
[457.018156] Subtest fairslice: SKIP (0.000s)
[460.974140] [100/142] (592s left) gem_lmem_swapping (heavy-random)
[461.188310] Subtest heavy-random: SKIP (0.000s)
[461.247773] [101/142] (592s left) kms_cursor_crc (cursor-offscreen-32x32)
[461.547504] Starting subtest: cursor-offscreen-32x32
[461.664409] Subtest cursor-offscreen-32x32: SKIP (0.116s)
[461.799070] [102/142] (591s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[462.395267] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[462.398513] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[462.795328] [103/142] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[463.115577] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[463.119033] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[463.228374] [104/142] (590s left) gem_pxp (reject-modify-context-protection-off-3)
[465.951738] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[466.044066] [105/142] (587s left) gem_exec_fence (keep-in-fence)
[466.414189] Starting subtest: keep-in-fence
[466.415724] Starting dynamic subtest: rcs0
[466.448654] Dynamic subtest rcs0: SUCCESS (0.037s)
[466.483429] Starting dynamic subtest: bcs0
[466.604211] Dynamic subtest bcs0: SUCCESS (0.152s)
[466.632344] Starting dynamic subtest: vcs0
[466.655784] Dynamic subtest vcs0: SUCCESS (0.048s)
[466.686680] Starting dynamic subtest: vecs0
[466.706909] Dynamic subtest vecs0: SUCCESS (0.048s)
[466.708720] Subtest keep-in-fence: SUCCESS (0.298s)
[467.395785] [106/142] (586s left) gem_vm_create (invalid-create)
[467.608334] Starting subtest: invalid-create
[467.610178] Subtest invalid-create: SUCCESS (0.001s)
[467.710712] [107/142] (585s left) gem_madvise (dontneed-before-pwrite)
[467.911773] Starting subtest: dontneed-before-pwrite
[467.918614] Subtest dontneed-before-pwrite: SUCCESS (0.006s)
[468.028339] [108/142] (585s left) gem_exec_fence (syncobj-unused-fence)
[468.701524] Starting subtest: syncobj-unused-fence
[468.707674] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[469.078319] [109/142] (584s left) drm_fdinfo (all-busy-idle-check-all)
[469.289410] Starting subtest: all-busy-idle-check-all
[469.917304] Subtest all-busy-idle-check-all: SUCCESS (0.628s)
[470.011343] [110/142] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[470.327092] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[470.330347] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[470.445995] [111/142] (583s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[470.654805] Starting subtest: single-wait-all-for-submit-available-signaled
[470.656645] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[470.745155] [112/142] (583s left) kms_sequence (queue-busy)
[471.050459] Starting subtest: queue-busy
[471.052063] Starting dynamic subtest: DP-1-pipe-A
[473.528317] Dynamic subtest DP-1-pipe-A: SUCCESS (2.479s)
[473.558270] Starting dynamic subtest: DP-1-pipe-B
[476.288198] Dynamic subtest DP-1-pipe-B: SUCCESS (2.755s)
[476.316545] Starting dynamic subtest: DP-1-pipe-C
[479.199988] Dynamic subtest DP-1-pipe-C: SUCCESS (2.906s)
[479.201445] Subtest queue-busy: SUCCESS (8.153s)
[479.529445] [113/142] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[479.839503] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[479.842741] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[479.945204] [114/142] (574s left) kms_atomic_interruptible (legacy-setmode)
[480.249791] Starting subtest: legacy-setmode
[480.251245] Starting dynamic subtest: DP-1-pipe-A
[486.775266] Dynamic subtest DP-1-pipe-A: SUCCESS (6.521s)
[486.776712] Subtest legacy-setmode: SUCCESS (6.527s)
[487.115493] [115/142] (566s left) kms_chamelium_edid (dp-mode-timings)
[487.519272] Subtest dp-mode-timings: SKIP (0.000s)
[487.819151] [116/142] (566s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[488.150298] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[488.153400] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[488.265051] [117/142] (565s left) kms_psr2_su (page_flip-nv12)
[488.471595] Subtest page_flip-NV12: SKIP (0.000s)
[488.529799] [118/142] (565s left) prime_vgem (basic-fence-read)
[488.746961] Starting subtest: basic-fence-read
[488.853172] Subtest basic-fence-read: SUCCESS (0.105s)
[488.948452] [119/142] (565s left) gem_exec_reloc (basic-cpu-read)
[489.162038] Starting subtest: basic-cpu-read
[489.180506] Subtest basic-cpu-read: SUCCESS (0.018s)
[489.381146] [120/142] (564s left) kms_vblank (pipe-d-ts-continuation-modeset)
[489.684138] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[489.781307] [121/142] (564s left) kms_vblank (pipe-c-wait-forked-busy-hang)
[490.094337] Starting subtest: pipe-C-wait-forked-busy-hang
[497.164899] Subtest pipe-C-wait-forked-busy-hang: SUCCESS (7.071s)
[497.502092] [122/142] (556s left) kms_async_flips (test-time-stamp)
[497.801584] Starting subtest: test-time-stamp
[498.226810] Starting dynamic subtest: pipe-A-DP-1
[499.172351] Dynamic subtest pipe-A-DP-1: SUCCESS (0.945s)
[499.657516] Starting dynamic subtest: pipe-B-DP-1
[499.917427] Dynamic subtest pipe-B-DP-1: SUCCESS (0.285s)
[500.308587] Starting dynamic subtest: pipe-C-DP-1
[500.582250] Dynamic subtest pipe-C-DP-1: SUCCESS (0.296s)
[500.583745] Subtest test-time-stamp: SUCCESS (2.783s)
[501.181021] [123/142] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[501.494768] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[501.497953] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[501.596924] [124/142] (552s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[502.198327] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs
[502.202487] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[502.582253] [125/142] (551s left) gem_mmap_gtt (cpuset-basic-small-copy)
[502.786187] Starting subtest: cpuset-basic-small-copy
[508.332933] Subtest cpuset-basic-small-copy: SUCCESS (5.546s)
[508.468483] [126/142] (546s left) perf_pmu (enable-race)
[508.800932] Starting subtest: enable-race
[508.802473] Starting dynamic subtest: rcs0
[521.476899] Dynamic subtest rcs0: SUCCESS (12.674s)
[521.504618] Starting dynamic subtest: bcs0
[534.195112] Dynamic subtest bcs0: SUCCESS (12.714s)
[534.222523] Starting dynamic subtest: vcs0
[546.873558] Dynamic subtest vcs0: SUCCESS (12.675s)
[546.901172] Starting dynamic subtest: vecs0
[559.558134] Dynamic subtest vecs0: SUCCESS (12.681s)
[559.563688] Subtest enable-race: SUCCESS (50.759s)
[559.665552] [127/142] (494s left) prime_mmap (test_aperture_limit)
[559.877475] Starting subtest: test_aperture_limit
[559.879348] Starting dynamic subtest: test_aperture_limit-smem
[559.909410] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.033s)
[559.911299] Subtest test_aperture_limit: SUCCESS (0.036s)
[560.032002] [128/142] (494s left) gem_ctx_isolation (preservation-reset)
[560.378378] Starting subtest: preservation-reset
[560.380827] Starting dynamic subtest: rcs0
[561.570119] Dynamic subtest rcs0: SUCCESS (1.189s)
[561.596818] Starting dynamic subtest: bcs0
[563.069219] Dynamic subtest bcs0: SUCCESS (1.495s)
[563.095216] Starting dynamic subtest: vcs0
[564.201211] Dynamic subtest vcs0: SUCCESS (1.129s)
[564.225871] Starting dynamic subtest: vecs0
[565.295505] Dynamic subtest vecs0: SUCCESS (1.092s)
[565.297248] Subtest preservation-reset: SUCCESS (4.918s)
[565.432382] [129/142] (489s left) gem_mmap_gtt (basic-write)
[565.639468] Starting subtest: basic-write
[566.060178] Subtest basic-write: SUCCESS (0.420s)
[566.182068] [130/142] (488s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[566.503731] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[566.506927] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[566.615886] [131/142] (488s left) gem_sync (basic-all)
[566.853047] Starting subtest: basic-all
[569.750911] Subtest basic-all: SUCCESS (2.899s)
[569.965733] [132/142] (484s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[570.277873] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[570.279462] Starting dynamic subtest: pipe-A-valid-mode
[570.408504] Dynamic subtest pipe-A-valid-mode: SKIP (0.129s)
[570.411769] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.134s)
[570.758831] [133/142] (484s left) i915_pm_rpm (legacy-planes-dpms)
[572.779128] Starting subtest: legacy-planes-dpms
[572.781311] Starting dynamic subtest: plane-39
[575.038169] Dynamic subtest plane-39: SUCCESS (2.260s)
[575.065519] Starting dynamic subtest: plane-47
[577.421610] Dynamic subtest plane-47: SUCCESS (2.381s)
[577.424189] Subtest legacy-planes-dpms: SUCCESS (4.646s)
[577.861114] [134/142] (477s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[578.280492] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[578.563064] [135/142] (476s left) gem_mmap_gtt (pf-nonblock)
[578.766327] Starting subtest: pf-nonblock
[578.771487] Subtest pf-nonblock: SUCCESS (0.006s)
[578.890784] [136/142] (476s left) kms_properties (crtc-properties-atomic)
[579.202981] Starting subtest: crtc-properties-atomic
[580.254033] Subtest crtc-properties-atomic: SUCCESS (1.053s)
[580.601259] [137/142] (474s left) gem_userptr_blits (userfault)
[580.818537] Starting subtest: userfault
[580.827591] Subtest userfault: SUCCESS (0.010s)
[580.999228] [138/142] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[581.322672] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[581.325561] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[581.435215] [139/142] (473s left) gem_ctx_param (invalid-param-set)
[581.642661] Starting subtest: invalid-param-set
[581.644545] Subtest invalid-param-set: SUCCESS (0.000s)
[581.748080] [140/142] (473s left) kms_plane_alpha_blend (constant-alpha-mid)
[582.056315] Starting subtest: constant-alpha-mid
[582.361732] Starting dynamic subtest: pipe-A-DP-1
[583.065828] Dynamic subtest pipe-A-DP-1: SUCCESS (0.703s)
[583.095440] Starting dynamic subtest: pipe-C-DP-1
[584.008469] Dynamic subtest pipe-C-DP-1: SUCCESS (0.936s)
[584.010455] Subtest constant-alpha-mid: SUCCESS (1.953s)
[584.381481] [141/142] (470s left) kms_color (deep-color)
[584.692793] Starting subtest: deep-color
[584.695957] Subtest deep-color: SKIP (0.000s)
[584.781494] [142/142] (470s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[585.084915] Starting subtest: plane-downscale-with-rotation-factor-0-5
[585.086420] Starting dynamic subtest: pipe-A-DP-1
[585.434551] Dynamic subtest pipe-A-DP-1: SKIP (0.345s)
[585.468776] Starting dynamic subtest: pipe-B-DP-1
[585.824656] Dynamic subtest pipe-B-DP-1: SKIP (0.387s)
[585.863033] Starting dynamic subtest: pipe-C-DP-1
[586.210747] Dynamic subtest pipe-C-DP-1: SKIP (0.381s)
[586.214240] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (1.128s)
[586.621470] Closing watchdogs
Done.