[51.205137] Initializing watchdogs
[51.205461]   /dev/watchdog0
[51.222752] [001/137] (960s left) prime_busy (after-wait)
[51.462358] Starting subtest: after-wait
[51.478296] Starting dynamic subtest: rcs0
[51.503921] Dynamic subtest rcs0: SUCCESS (0.026s)
[51.519835] Starting dynamic subtest: bcs0
[51.529538] Dynamic subtest bcs0: SUCCESS (0.025s)
[51.545175] Starting dynamic subtest: vcs0
[51.550522] Dynamic subtest vcs0: SUCCESS (0.018s)
[51.563887] Starting dynamic subtest: vecs0
[51.566131] Dynamic subtest vecs0: SUCCESS (0.017s)
[51.679510] Subtest after-wait: SUCCESS (0.216s)
[51.771984] [002/137] (959s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[52.109435] Starting subtest: psr-rgb565-draw-blt
[52.113384] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[52.217190] [003/137] (959s left) kms_cursor_legacy (torture-move)
[52.520405] Starting subtest: torture-move
[52.522580] Starting dynamic subtest: pipe-A
[74.250730] Dynamic subtest pipe-A: SUCCESS (21.732s)
[74.264244] Starting dynamic subtest: pipe-B
[95.969183] Dynamic subtest pipe-B: SUCCESS (21.720s)
[95.983773] Starting dynamic subtest: pipe-C
[117.649569] Dynamic subtest pipe-C: SUCCESS (21.680s)
[117.664070] Starting dynamic subtest: all-pipes
[139.444254] Dynamic subtest all-pipes: SUCCESS (21.794s)
[139.446463] Subtest torture-move: SUCCESS (86.927s)
[139.535330] [004/137] (872s left) kms_pwrite_crc
[140.940639] [005/137] (870s left) gem_pxp (regular-baseline-src-copy-readible)
[143.650620] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[143.727109] [006/137] (868s left) kms_addfb_basic (bad-pitch-128)
[143.921471] Starting subtest: bad-pitch-128
[143.923660] Subtest bad-pitch-128: SUCCESS (0.000s)
[144.122206] [007/137] (867s left) syncobj_timeline (invalid-query-bad-pad)
[144.316402] Starting subtest: invalid-query-bad-pad
[144.318748] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[144.405414] [008/137] (867s left) gem_exec_schedule (u-semaphore-resolve)
[144.632472] Starting subtest: u-semaphore-resolve
[144.689114] Subtest u-semaphore-resolve: SUCCESS (0.057s)
[145.040572] [009/137] (866s left) gem_spin_batch (resubmit-new-all)
[145.256909] Starting subtest: resubmit-new-all
[145.259372] Starting dynamic subtest: rcs0
[145.273251] Dynamic subtest rcs0: SUCCESS (0.016s)
[145.296719] Starting dynamic subtest: bcs0
[145.298827] Dynamic subtest bcs0: SUCCESS (0.015s)
[145.316431] Starting dynamic subtest: vcs0
[145.318755] Dynamic subtest vcs0: SUCCESS (0.017s)
[145.334427] Starting dynamic subtest: vecs0
[145.336703] Dynamic subtest vecs0: SUCCESS (0.013s)
[145.338793] Subtest resubmit-new-all: SUCCESS (0.061s)
[145.539982] [010/137] (866s left) gem_exec_params (mmapped)
[145.740302] Starting subtest: mmapped
[145.748611] Subtest mmapped: SUCCESS (0.008s)
[145.856192] [011/137] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[146.171720] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[148.720975] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.574s)
[148.857232] [012/137] (863s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[149.073515] Starting subtest: mixed-tiled-to-y-tiled-ccs
[149.076244] Starting dynamic subtest: smem
[149.374769] Dynamic subtest smem: SUCCESS (0.300s)
[149.377272] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.301s)
[149.575611] [013/137] (862s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs)
[150.235990] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs
[150.244440] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[150.618724] [014/137] (861s left) i915_pm_rpm (system-suspend-modeset)
[152.401253] Starting subtest: system-suspend-modeset
[169.519982] Subtest system-suspend-modeset: SUCCESS (2.232s)
[175.173861] [015/137] (856s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[175.469305] Starting subtest: 2x-flip-vs-cursor-atomic
[175.476817] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.005s)
[175.561963] [016/137] (856s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[175.884688] Starting subtest: x-tiled-32bpp-rotate-90
[175.963358] Subtest x-tiled-32bpp-rotate-90: SKIP (0.075s)
[176.061677] [017/137] (856s left) perf (gen12-group-exclusive-stream-sample-oa)
[176.407266] Starting subtest: gen12-group-exclusive-stream-sample-oa
[176.411144] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[176.460164] [018/137] (855s left) kms_addfb_basic (invalid-get-prop-any)
[176.651542] Starting subtest: invalid-get-prop-any
[176.653631] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[176.845554] [019/137] (855s left) v3d/v3d_get_param (get-bad-param)
[177.076783] Subtest get-bad-param: SKIP (0.000s)
[177.145453] [020/137] (855s left) kms_vblank (pipe-a-query-idle-hang)
[177.433057] Starting subtest: pipe-A-query-idle-hang
[184.859930] Subtest pipe-A-query-idle-hang: SUCCESS (7.429s)
[185.202913] [021/137] (847s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[185.421613] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[185.425596] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[185.628383] [022/137] (846s left) gem_render_copy (y-tiled-ccs-to-linear)
[185.840588] Starting subtest: y-tiled-ccs-to-linear
[185.842875] Starting dynamic subtest: smem
[186.111712] Dynamic subtest smem: SUCCESS (0.269s)
[186.115227] Subtest y-tiled-ccs-to-linear: SUCCESS (0.270s)
[186.305383] [023/137] (846s left) kms_psr (psr2_basic)
[186.503954] Subtest psr2_basic: SKIP (0.000s)
[186.553947] [024/137] (845s left) kms_atomic_transition (plane-toggle-modeset-transition)
[186.854998] Starting subtest: plane-toggle-modeset-transition
[186.856987] Starting dynamic subtest: pipe-A-DP-1
[192.440772] Dynamic subtest pipe-A-DP-1: SUCCESS (5.586s)
[192.475700] Starting dynamic subtest: pipe-B-DP-1
[197.847986] Dynamic subtest pipe-B-DP-1: SUCCESS (5.395s)
[197.860563] Subtest plane-toggle-modeset-transition: SUCCESS (11.002s)
[198.190687] [025/137] (834s left) gem_exec_reloc (basic-write-gtt-noreloc)
[198.414612] Starting subtest: basic-write-gtt-noreloc
[198.424496] Subtest basic-write-gtt-noreloc: SUCCESS (0.010s)
[198.623900] [026/137] (833s left) gem_userptr_blits (invalid-null-pointer)
[198.844227] Starting subtest: invalid-null-pointer
[198.846471] Subtest invalid-null-pointer: SUCCESS (0.005s)
[199.007869] [027/137] (833s left) gem_ctx_param (invalid-size-get)
[199.210215] Starting subtest: invalid-size-get
[199.212217] Subtest invalid-size-get: SUCCESS (0.000s)
[199.293342] [028/137] (833s left) gem_exec_whisper (basic-queues-forked)
[199.512359] Starting subtest: basic-queues-forked
[213.637280] Subtest basic-queues-forked: SUCCESS (14.122s)
[213.843403] [029/137] (818s left) kms_big_fb (linear-32bpp-rotate-180)
[214.165105] Starting subtest: linear-32bpp-rotate-180
[219.984632] Subtest linear-32bpp-rotate-180: SUCCESS (5.820s)
[220.567088] [030/137] (812s left) syncobj_wait (single-wait-for-submit-submitted)
[220.777537] Starting subtest: single-wait-for-submit-submitted
[220.883376] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[220.988933] [031/137] (811s left) kms_addfb_basic (invalid-get-prop)
[221.209534] Starting subtest: invalid-get-prop
[221.211734] Subtest invalid-get-prop: SUCCESS (0.000s)
[221.528120] [032/137] (811s left) kms_flip (nonexisting-fb-interruptible)
[221.836601] Starting subtest: nonexisting-fb-interruptible
[221.841605] Starting dynamic subtest: A-DP1
[222.396049] Dynamic subtest A-DP1: SUCCESS (0.544s)
[222.420891] Starting dynamic subtest: B-DP1
[222.829020] Dynamic subtest B-DP1: SUCCESS (0.440s)
[222.852635] Starting dynamic subtest: C-DP1
[223.289892] Dynamic subtest C-DP1: SUCCESS (0.446s)
[223.292850] Subtest nonexisting-fb-interruptible: SUCCESS (1.439s)
[223.656103] [033/137] (809s left) gem_exec_big (single)
[223.865613] Starting subtest: single
[263.190363] Subtest single: SUCCESS (39.324s)
[265.986857] [034/137] (766s left) kms_prop_blob (blob-prop-core)
[266.295245] Starting subtest: blob-prop-core
[266.297468] Subtest blob-prop-core: SUCCESS (0.000s)
[266.409635] [035/137] (766s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[266.873666] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[266.879959] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[267.485304] [036/137] (765s left) syncobj_timeline (etime-single-wait-submitted)
[267.712166] Starting subtest: etime-single-wait-submitted
[267.819408] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[267.903049] [037/137] (765s left) syncobj_wait (single-wait-all-for-submit-submitted)
[268.106412] Starting subtest: single-wait-all-for-submit-submitted
[268.212679] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[268.302281] [038/137] (764s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[268.610947] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[268.613179] Starting dynamic subtest: pipe-A-DP-1
[270.924640] Dynamic subtest pipe-A-DP-1: SUCCESS (2.314s)
[270.948847] Starting dynamic subtest: pipe-B-DP-1
[273.480602] Dynamic subtest pipe-B-DP-1: SUCCESS (2.552s)
[273.504353] Starting dynamic subtest: pipe-C-DP-1
[273.853763] Dynamic subtest pipe-C-DP-1: SUCCESS (0.369s)
[273.856518] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (5.247s)
[274.256962] [039/137] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[274.560592] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[274.564569] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[274.670762] [040/137] (758s left) kms_lease (lease_invalid_connector)
[274.973943] Starting subtest: lease_invalid_connector
[274.976362] Starting dynamic subtest: pipe-A-DP-1
[274.978783] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[275.001379] Starting dynamic subtest: pipe-B-DP-1
[275.003529] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[275.025669] Starting dynamic subtest: pipe-C-DP-1
[275.027803] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[275.029889] Subtest lease_invalid_connector: SUCCESS (0.009s)
[275.071927] [041/137] (758s left) kms_ccs (pipe-d-crc-sprite-planes-basic-yf_tiled_ccs)
[275.781629] Subtest pipe-D-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.000s)
[276.106869] [042/137] (757s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[276.412199] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[276.416233] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[276.507294] [043/137] (756s left) perf (polling)
[276.836363] Starting subtest: polling
[276.838617] Starting dynamic subtest: 0-rcs0
[286.916063] Dynamic subtest 0-rcs0: SUCCESS (10.078s)
[286.918334] Subtest polling: SUCCESS (10.079s)
[286.973810] [044/137] (746s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[287.173328] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[287.175640] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[287.256787] [045/137] (746s left) sysfs_heartbeat_interval (precise)
[287.464635] Starting subtest: precise
[287.467333] Starting dynamic subtest: vecs0
[288.954373] Dynamic subtest vecs0: SUCCESS (1.489s)
[288.977543] Starting dynamic subtest: vcs0
[290.450333] Dynamic subtest vcs0: SUCCESS (1.494s)
[290.480219] Starting dynamic subtest: bcs0
[291.937597] Dynamic subtest bcs0: SUCCESS (1.487s)
[291.960633] Starting dynamic subtest: rcs0
[293.448393] Dynamic subtest rcs0: SUCCESS (1.509s)
[293.450621] Subtest precise: SUCCESS (5.984s)
[293.540264] [046/137] (739s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[293.835195] Starting subtest: primary-x-tiled-reflect-x-180
[293.839398] Subtest primary-x-tiled-reflect-x-180: SKIP (0.003s)
[293.923860] [047/137] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[294.239629] Starting subtest: fbcpsr-rgb101010-draw-render
[294.243574] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[294.341914] [048/137] (739s left) kms_atomic (plane-immutable-zpos)
[294.935957] Starting subtest: plane-immutable-zpos
[295.163076] Subtest plane-immutable-zpos: SUCCESS (0.227s)
[295.595569] [049/137] (737s left) gem_ccs (ctrl-surf-copy-new-ctx)
[295.798753] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[295.861519] [050/137] (737s left) kms_flip (2x-wf_vblank-ts-check)
[296.140894] Starting subtest: 2x-wf_vblank-ts-check
[296.144890] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[296.262731] [051/137] (737s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[296.655626] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[296.942953] [052/137] (736s left) kms_vblank (pipe-d-ts-continuation-dpms-rpm)
[297.453136] Subtest pipe-D-ts-continuation-dpms-rpm: SKIP (0.000s)
[297.497557] [053/137] (736s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[298.119256] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[298.124062] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[298.514510] [054/137] (735s left) kms_flip (2x-flip-vs-suspend)
[298.798904] Starting subtest: 2x-flip-vs-suspend
[298.802974] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[298.914546] [055/137] (735s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[299.234239] Starting subtest: yf-tiled-64bpp-rotate-180
[299.238462] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[299.347409] [056/137] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[299.652538] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[299.656600] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[299.747734] [057/137] (734s left) gem_mmap_gtt (zero-extend)
[299.944633] Starting subtest: zero-extend
[299.946938] Subtest zero-extend: SUCCESS (0.000s)
[300.046975] [058/137] (734s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[300.338951] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[300.343239] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[300.430611] [059/137] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[300.732443] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[300.736345] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[300.830661] [060/137] (733s left) gem_partial_pwrite_pread (write-display)
[301.034938] Starting subtest: write-display
[315.210621] Subtest write-display: SUCCESS (14.175s)
[315.331263] [061/137] (718s left) kms_rotation_crc (primary-rotation-90)
[315.621022] Starting subtest: primary-rotation-90
[321.785041] Subtest primary-rotation-90: SUCCESS (6.162s)
[322.204011] [062/137] (712s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[322.904725] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[322.909445] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[323.248305] [063/137] (711s left) i915_module_load (load)
[323.441339] Starting subtest: load
[323.448963] Subtest load: SKIP (0.003s)
[323.514645] [064/137] (710s left) gem_ctx_shared (create-shared-gtt)
[323.734572] Starting subtest: create-shared-gtt
[325.887026] Subtest create-shared-gtt: SUCCESS (2.151s)
[326.135689] [065/137] (708s left) kms_busy (basic-hang)
[326.443389] Starting subtest: basic-hang
[326.448850] Starting dynamic subtest: flip-pipe-A
[327.068773] Dynamic subtest flip-pipe-A: SUCCESS (0.619s)
[327.095808] Starting dynamic subtest: modeset-pipe-A
[328.487002] Dynamic subtest modeset-pipe-A: SUCCESS (1.416s)
[328.517278] Starting dynamic subtest: flip-pipe-C
[329.434241] Dynamic subtest flip-pipe-C: SUCCESS (0.938s)
[329.459802] Starting dynamic subtest: modeset-pipe-C
[331.072028] Dynamic subtest modeset-pipe-C: SUCCESS (1.630s)
[331.074248] Subtest basic-hang: SUCCESS (4.619s)
[331.421191] [066/137] (702s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[331.747216] Starting subtest: 4-tiled-8bpp-rotate-180
[331.751869] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[331.851779] [067/137] (702s left) kms_force_connector_basic (prune-stale-modes)
[332.049046] Subtest prune-stale-modes: SKIP (0.000s)
[332.100692] [068/137] (702s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[332.583701] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[332.588955] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[333.116410] [069/137] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[333.428859] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[333.433220] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[333.516694] [070/137] (701s left) syncobj_timeline (reset-during-wait-for-submit)
[333.718366] Starting subtest: reset-during-wait-for-submit
[333.822405] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[333.918808] [071/137] (700s left) i915_suspend (fence-restore-tiled2untiled)
[334.116307] Starting subtest: fence-restore-tiled2untiled
[353.955068] Subtest fence-restore-tiled2untiled: SUCCESS (4.113s)
[357.107402] [072/137] (696s left) gem_exec_flush (basic-wb-prw-default)
[357.331211] Starting subtest: basic-wb-prw-default
[362.798006] Subtest basic-wb-prw-default: SUCCESS (5.467s)
[363.014579] [073/137] (690s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[363.732899] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[364.033253] [074/137] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[364.346480] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[364.350372] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[364.466973] [075/137] (689s left) gem_mmap (big-bo)
[364.661448] Starting subtest: big-bo
[366.577798] Subtest big-bo: SUCCESS (1.918s)
[366.697099] [076/137] (686s left) kms_content_protection (uevent)
[367.154221] Starting subtest: uevent
[367.191968] Starting dynamic subtest: pipe-A-DP-1
[401.816204] Dynamic subtest pipe-A-DP-1: FAIL (34.480s)
[401.831902] Subtest uevent: FAIL (34.665s)
[402.146029] [077/137] (651s left) i915_pm_rpm (gem-idle)
[404.118756] Starting subtest: gem-idle
[409.679157] Subtest gem-idle: SUCCESS (5.560s)
[410.095883] [078/137] (643s left) drm_fdinfo (virtual-busy-hang)
[410.309775] Starting subtest: virtual-busy-hang
[414.523411] Subtest virtual-busy-hang: SUCCESS (4.214s)
[414.611484] [079/137] (639s left) kms_mmap_write_crc (main)
[414.917788] Starting subtest: main
[414.923384] Starting dynamic subtest: pipe-A-DP-1
[418.297084] Dynamic subtest pipe-A-DP-1: SUCCESS (3.373s)
[418.299121] Subtest main: SUCCESS (3.377s)
[418.638918] [080/137] (635s left) v3d/v3d_wait_bo (used-bo-1ns)
[418.901694] Subtest used-bo-1ns: SKIP (0.000s)
[418.978238] [081/137] (634s left) fbdev (unaligned-read)
[419.184667] Starting subtest: unaligned-read
[419.200841] Subtest unaligned-read: SUCCESS (0.016s)
[419.278471] [082/137] (634s left) kms_hdr (invalid-hdr)
[419.582903] Starting subtest: invalid-hdr
[421.815488] Starting dynamic subtest: pipe-A-DP-1
[428.585832] Dynamic subtest pipe-A-DP-1: SUCCESS (6.771s)
[428.588259] Subtest invalid-hdr: SUCCESS (9.009s)
[428.978387] [083/137] (624s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[429.513915] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[429.517983] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[430.006199] [084/137] (623s left) perf (polling-parameterized)
[430.326199] Starting subtest: polling-parameterized
[450.432805] Subtest polling-parameterized: SUCCESS (20.106s)
[450.488872] [085/137] (603s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[450.792977] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[456.640754] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.850s)
[456.983501] [086/137] (597s left) gen9_exec_parse (bb-oversize)
[457.210867] Starting subtest: bb-oversize
[457.566474] Subtest bb-oversize: SKIP (0.335s)
[457.792763] [087/137] (596s left) kms_universal_plane (universal-plane-pipe-d-functional)
[458.215466] Subtest universal-plane-pipe-D-functional: SKIP (0.000s)
[458.298810] [088/137] (595s left) gem_ctx_create (basic)
[458.553008] Starting subtest: basic
[458.555207] Subtest basic: SUCCESS (0.000s)
[458.765806] [089/137] (595s left) i915_pm_rpm (fences)
[460.733330] Starting subtest: fences
[463.789452] Subtest fences: SUCCESS (3.056s)
[464.015187] [090/137] (590s left) gem_ppgtt (blt-vs-render-ctx0)
[464.230169] Starting subtest: blt-vs-render-ctx0
[496.917564] Subtest blt-vs-render-ctx0: SUCCESS (32.686s)
[497.047020] [091/137] (557s left) gem_exec_fence (nb-await)
[497.518057] Starting subtest: nb-await
[497.520200] Starting dynamic subtest: rcs0
[497.591568] Dynamic subtest rcs0: SUCCESS (0.075s)
[497.619279] Starting dynamic subtest: bcs0
[497.663325] Dynamic subtest bcs0: SUCCESS (0.071s)
[497.695960] Starting dynamic subtest: vcs0
[497.739109] Dynamic subtest vcs0: SUCCESS (0.073s)
[497.766795] Starting dynamic subtest: vecs0
[497.813012] Dynamic subtest vecs0: SUCCESS (0.070s)
[497.815244] Subtest nb-await: SUCCESS (0.299s)
[498.582534] [092/137] (555s left) gem_vm_create (invalid-destroy)
[498.792720] Starting subtest: invalid-destroy
[498.795037] Subtest invalid-destroy: SUCCESS (0.001s)
[498.914244] [093/137] (555s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[499.115066] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[499.182025] [094/137] (555s left) gem_ctx_param (set-priority-not-supported)
[499.382527] Starting subtest: set-priority-not-supported
[499.386868] Subtest set-priority-not-supported: SKIP (0.000s)
[499.479512] [095/137] (554s left) syncobj_wait (invalid-wait-illegal-handle)
[499.682256] Starting subtest: invalid-wait-illegal-handle
[499.684313] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[499.780084] [096/137] (554s left) gem_lmem_swapping (random)
[499.987053] Subtest random: SKIP (0.000s)
[500.046613] [097/137] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[500.357607] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[500.361471] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[500.464255] [098/137] (554s left) core_setmaster (master-drop-set-root)
[502.356367] Starting subtest: master-drop-set-root
[502.366446] Subtest master-drop-set-root: SUCCESS (0.011s)
[502.412715] [099/137] (552s left) vc4/vc4_perfmon (create-perfmon-exceed)
[502.669951] Subtest create-perfmon-exceed: SKIP (0.000s)
[502.747071] [100/137] (551s left) kms_color (gamma)
[503.045199] Starting subtest: gamma
[503.047482] Starting dynamic subtest: pipe-A-DP-1
[503.600964] Dynamic subtest pipe-A-DP-1: SUCCESS (0.554s)
[503.630231] Starting dynamic subtest: pipe-B-DP-1
[504.427783] Dynamic subtest pipe-B-DP-1: SUCCESS (0.820s)
[504.462388] Starting dynamic subtest: pipe-C-DP-1
[505.392377] Dynamic subtest pipe-C-DP-1: SUCCESS (0.955s)
[505.394500] Subtest gamma: SUCCESS (2.349s)
[505.737930] [101/137] (549s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[505.939462] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[506.043543] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[506.136590] [102/137] (548s left) kms_psr (psr2_cursor_plane_move)
[506.332815] Subtest psr2_cursor_plane_move: SKIP (0.000s)
[506.386202] [103/137] (548s left) api_intel_bb (blit-noreloc-purge-cache)
[506.583893] Starting subtest: blit-noreloc-purge-cache
[506.598356] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[506.702956] [104/137] (548s left) kms_plane_lowres (tiling-x)
[507.000505] Starting subtest: tiling-x
[507.008692] Starting dynamic subtest: pipe-A-DP-1
[513.061007] Dynamic subtest pipe-A-DP-1: SUCCESS (6.055s)
[513.183582] Starting dynamic subtest: pipe-B-DP-1
[518.984938] Dynamic subtest pipe-B-DP-1: SUCCESS (5.825s)
[519.096609] Starting dynamic subtest: pipe-C-DP-1
[522.934257] Dynamic subtest pipe-C-DP-1: SUCCESS (3.862s)
[523.049472] Subtest tiling-x: SUCCESS (16.046s)
[523.500488] [105/137] (531s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[523.816589] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[526.253044] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.441s)
[526.416215] [106/137] (528s left) gem_ctx_persistence (file)
[526.623853] Starting subtest: file
[526.696315] Subtest file: SUCCESS (0.073s)
[526.816495] [107/137] (528s left) vc4/vc4_tiling (get-bad-flags)
[527.071789] Subtest get-bad-flags: SKIP (0.000s)
[527.149606] [108/137] (527s left) gem_mmap_gtt (basic-copy)
[527.346393] Starting subtest: basic-copy
[528.127504] Subtest basic-copy: SUCCESS (0.778s)
[528.249839] [109/137] (526s left) gem_flink_basic (basic)
[528.444305] Starting subtest: basic
[528.446448] Subtest basic: SUCCESS (0.000s)
[528.548452] [110/137] (526s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[528.883171] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[528.887517] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[528.982435] [111/137] (526s left) v3d/v3d_submit_csd (bad-extension)
[529.238117] Subtest bad-extension: SKIP (0.000s)
[529.316049] [112/137] (525s left) kms_chamelium_color (ctm-limited-range)
[529.615001] Subtest ctm-limited-range: SKIP (0.000s)
[529.665759] [113/137] (525s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[529.872276] Starting subtest: basic-cpu-gtt-noreloc
[529.885697] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.013s)
[530.082547] [114/137] (525s left) kms_flip (plain-flip-ts-check-interruptible)
[530.380104] Starting subtest: plain-flip-ts-check-interruptible
[530.386202] Starting dynamic subtest: A-DP1
[541.152508] Dynamic subtest A-DP1: SUCCESS (10.766s)
[541.181367] Starting dynamic subtest: B-DP1
[551.867623] Dynamic subtest B-DP1: SUCCESS (10.715s)
[551.892796] Starting dynamic subtest: C-DP1
[562.613380] Dynamic subtest C-DP1: SUCCESS (10.744s)
[562.615558] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.235s)
[563.006789] [115/137] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[563.317022] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[563.320983] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[563.420511] [116/137] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[563.729626] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[563.733671] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[563.837297] [117/137] (491s left) gem_exec_endless (dispatch)
[564.069511] Starting subtest: dispatch
[564.072075] Starting dynamic subtest: rcs0
[564.084554] Dynamic subtest rcs0: SUCCESS (0.010s)
[564.121198] Starting dynamic subtest: bcs0
[564.125312] Dynamic subtest bcs0: SKIP (0.001s)
[564.150614] Starting dynamic subtest: vcs0
[564.154976] Dynamic subtest vcs0: SUCCESS (0.009s)
[564.179521] Starting dynamic subtest: vecs0
[564.183825] Dynamic subtest vecs0: SUCCESS (0.009s)
[564.185990] Subtest dispatch: SUCCESS (0.036s)
[564.221704] [118/137] (491s left) kms_cursor_crc (cursor-sliding-256x85)
[564.540201] Starting subtest: cursor-sliding-256x85
[564.555128] Starting dynamic subtest: pipe-A-DP-1
[568.224096] Dynamic subtest pipe-A-DP-1: SUCCESS (3.667s)
[568.307468] Starting dynamic subtest: pipe-C-DP-1
[572.265550] Dynamic subtest pipe-C-DP-1: SUCCESS (3.980s)
[572.268130] Subtest cursor-sliding-256x85: SUCCESS (7.723s)
[572.620602] [119/137] (482s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[573.023019] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[573.027665] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[573.661495] [120/137] (481s left) gem_ctx_bad_destroy (invalid-default-ctx)
[573.857841] Starting subtest: invalid-default-ctx
[573.860018] Subtest invalid-default-ctx: SUCCESS (0.000s)
[573.944011] [121/137] (481s left) kms_cursor_crc (cursor-onscreen-256x85)
[574.247102] Starting subtest: cursor-onscreen-256x85
[574.258070] Starting dynamic subtest: pipe-A-DP-1
[576.595773] Dynamic subtest pipe-A-DP-1: SUCCESS (2.337s)
[576.682257] Starting dynamic subtest: pipe-C-DP-1
[579.300566] Dynamic subtest pipe-C-DP-1: SUCCESS (2.643s)
[579.302561] Subtest cursor-onscreen-256x85: SUCCESS (5.054s)
[579.652772] [122/137] (476s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[579.949547] Starting subtest: plane-primary-toggle-with-vblank-wait
[579.952276] Starting dynamic subtest: pipe-A-DP-1
[580.152751] Dynamic subtest pipe-A-DP-1: SUCCESS (0.204s)
[580.264708] Starting dynamic subtest: pipe-B-DP-1
[580.716792] Dynamic subtest pipe-B-DP-1: SUCCESS (0.477s)
[580.820782] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.872s)
[581.156510] [123/137] (474s left) gem_exec_balancer (bonded-sync)
[581.381906] Starting subtest: bonded-sync
[585.177179] Subtest bonded-sync: SUCCESS (3.795s)
[589.040497] [124/137] (466s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[589.334295] Starting subtest: cursorA-vs-flipB-varying-size
[589.343725] Subtest cursorA-vs-flipB-varying-size: SKIP (0.003s)
[589.423323] [125/137] (466s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[589.720551] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[589.722745] Starting dynamic subtest: pipe-A-valid-mode
[590.372120] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.647s)
[590.374448] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (0.651s)
[590.713405] [126/137] (465s left) gem_exec_schedule (in-order)
[590.950170] Starting subtest: in-order
[590.952211] Starting dynamic subtest: rcs0
[591.080960] Dynamic subtest rcs0: SUCCESS (0.131s)
[591.112007] Starting dynamic subtest: bcs0
[591.226334] Dynamic subtest bcs0: SUCCESS (0.143s)
[591.257592] Starting dynamic subtest: vcs0
[591.349492] Dynamic subtest vcs0: SUCCESS (0.121s)
[591.378826] Starting dynamic subtest: vecs0
[591.481971] Dynamic subtest vecs0: SUCCESS (0.133s)
[591.484089] Subtest in-order: SUCCESS (0.534s)
[591.847858] [127/137] (464s left) kms_vblank (pipe-a-wait-forked-busy)
[592.144700] Starting subtest: pipe-A-wait-forked-busy
[594.614940] Subtest pipe-A-wait-forked-busy: SUCCESS (2.469s)
[594.943543] [128/137] (461s left) kms_cdclk (mode-transition-all-outputs)
[595.142282] Subtest mode-transition-all-outputs: SKIP (0.000s)
[595.208885] [129/137] (460s left) gem_lmem_swapping (verify-ccs)
[595.412511] Subtest verify-ccs: SKIP (0.000s)
[595.475352] [130/137] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[595.776941] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[595.780997] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[595.876408] [131/137] (460s left) perf (whitelisted-registers-userspace-config)
[596.207752] Starting subtest: whitelisted-registers-userspace-config
[596.210138] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[596.258780] [132/137] (459s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[596.574577] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[596.578570] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[596.676370] [133/137] (459s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[596.969886] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[596.971923] Starting dynamic subtest: pipe-A-valid-mode
[597.422912] Dynamic subtest pipe-A-valid-mode: SKIP (0.449s)
[597.426959] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.452s)
[597.792964] [134/137] (458s left) gem_ctx_engines (execute-one)
[598.013995] Starting subtest: execute-one
[601.009891] Subtest execute-one: SUCCESS (2.994s)
[601.227886] [135/137] (455s left) prime_vgem (basic-write)
[601.445004] Starting subtest: basic-write
[601.503284] Subtest basic-write: SUCCESS (0.060s)
[601.611379] [136/137] (454s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[601.925890] Starting subtest: y-tiled-8bpp-rotate-90
[601.997376] Subtest y-tiled-8bpp-rotate-90: SKIP (0.069s)
[602.126422] [137/137] (454s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[602.432573] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[602.436520] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[602.522208] Closing watchdogs
Done.