[43.217640] Initializing watchdogs
[43.217724]   /dev/watchdog0
[43.231388] [001/142] (960s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[43.329432] Starting subtest: cursor-fb-leak-pipe-B
[45.066428] Subtest cursor-fb-leak-pipe-B: SUCCESS (1.746s)
[45.952268] [002/142] (957s left) gem_userptr_blits (readonly-pwrite-unsync)
[46.018651] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[46.133908] [003/142] (957s left) gem_exec_reloc (basic-write-wc-active)
[46.206699] Subtest basic-write-wc-active: SKIP (0.000s)
[46.261541] [004/142] (957s left) gem_exec_schedule (in-order)
[46.316321] Starting subtest: in-order
[46.317760] Starting dynamic subtest: rcs0
[46.371432] Dynamic subtest rcs0: SUCCESS (0.054s)
[46.380899] Starting dynamic subtest: bcs0
[46.426444] Dynamic subtest bcs0: SUCCESS (0.055s)
[46.435341] Starting dynamic subtest: vcs0
[46.486298] Dynamic subtest vcs0: SUCCESS (0.060s)
[46.495104] Starting dynamic subtest: vcs1
[46.582127] Dynamic subtest vcs1: SUCCESS (0.096s)
[46.591344] Starting dynamic subtest: vecs0
[46.686140] Dynamic subtest vecs0: SUCCESS (0.104s)
[46.695633] Starting dynamic subtest: ccs0
[46.778635] Dynamic subtest ccs0: SUCCESS (0.092s)
[46.780245] Subtest in-order: SUCCESS (0.462s)
[48.515075] [005/142] (955s left) gem_ctx_persistence (engines-mixed-process)
[48.557150] Starting subtest: engines-mixed-process
[48.558274] Starting dynamic subtest: rcs0
[50.435150] Dynamic subtest rcs0: SUCCESS (1.879s)
[50.444931] Starting dynamic subtest: bcs0
[52.479134] Dynamic subtest bcs0: SUCCESS (2.044s)
[52.488996] Starting dynamic subtest: vcs0
[72.541487] Dynamic subtest vcs0: SUCCESS (20.061s)
[72.551565] Starting dynamic subtest: vcs1
[92.602073] Dynamic subtest vcs1: SUCCESS (20.058s)
[92.612032] Starting dynamic subtest: vecs0
[112.647817] Dynamic subtest vecs0: SUCCESS (20.049s)
[112.658664] Starting dynamic subtest: ccs0
[114.508891] Dynamic subtest ccs0: SUCCESS (1.860s)
[114.510721] Subtest engines-mixed-process: SUCCESS (65.952s)
[114.576416] [006/142] (889s left) gem_exec_nop (basic-parallel)
[114.629431] Starting subtest: basic-parallel
[130.399847] Subtest basic-parallel: SUCCESS (15.773s)
[130.613709] [007/142] (873s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[130.662071] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[130.663421] Starting dynamic subtest: pipe-A-eDP-1
[130.670880] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[130.680444] Starting dynamic subtest: pipe-B-eDP-1
[130.686962] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[130.695824] Starting dynamic subtest: pipe-C-eDP-1
[130.701823] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[130.708933] Starting dynamic subtest: pipe-D-eDP-1
[130.718406] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[130.720423] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.056s)
[130.812690] [008/142] (873s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[130.902387] Starting subtest: cursor-rapid-movement-64x21
[130.906649] Starting dynamic subtest: pipe-A-eDP-1
[131.650199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[131.677898] Starting dynamic subtest: pipe-D-eDP-1
[132.925976] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[132.927225] Subtest cursor-rapid-movement-64x21: SUCCESS (2.023s)
[133.810971] [009/142] (870s left) syncobj_timeline (invalid-transfer-illegal-handle)
[133.860795] Starting subtest: invalid-transfer-illegal-handle
[133.861939] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[133.918777] [010/142] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[133.978484] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[133.980344] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[134.062282] [011/142] (869s left) kms_legacy_colorkey (invalid-plane)
[134.138557] Starting subtest: invalid-plane
[134.139903] Starting dynamic subtest: zero-id
[134.141155] Dynamic subtest zero-id: SUCCESS (0.000s)
[134.151423] Starting dynamic subtest: outrange-id
[134.152482] Dynamic subtest outrange-id: SUCCESS (0.000s)
[134.153548] Subtest invalid-plane: SUCCESS (0.000s)
[134.193703] [012/142] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[134.274046] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[138.959643] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.688s)
[139.080499] [013/142] (864s left) sysfs_preempt_timeout (timeout)
[139.153415] Starting subtest: timeout
[139.154742] Starting dynamic subtest: vecs0
[148.470418] Dynamic subtest vecs0: SUCCESS (9.313s)
[148.483111] Starting dynamic subtest: ccs0
[149.434778] Dynamic subtest ccs0: SUCCESS (0.966s)
[149.444786] Starting dynamic subtest: vcs0
[159.477758] Dynamic subtest vcs0: SUCCESS (10.041s)
[159.488846] Starting dynamic subtest: bcs0
[160.488373] Dynamic subtest bcs0: SUCCESS (1.014s)
[160.494316] Starting dynamic subtest: rcs0
[161.471672] Dynamic subtest rcs0: SUCCESS (0.982s)
[161.482462] Starting dynamic subtest: vcs1
[171.444644] Dynamic subtest vcs1: SUCCESS (9.970s)
[171.446371] Subtest timeout: SUCCESS (32.288s)
[171.507972] [014/142] (832s left) kms_big_fb (4-tiled-addfb)
[171.572103] Starting subtest: 4-tiled-addfb
[171.573203] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[171.659731] [015/142] (832s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[171.716218] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[171.718141] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[171.888719] [016/142] (832s left) gem_exec_fence (syncobj-repeat)
[172.370921] Starting subtest: syncobj-repeat
[172.530315] Subtest syncobj-repeat: SUCCESS (0.157s)
[173.498866] [017/142] (830s left) vc4/vc4_wait_bo (used-bo)
[173.594340] Subtest used-bo: SKIP (0.000s)
[173.641632] [018/142] (830s left) prime_mmap (test_correct_cpu_write)
[173.690407] Starting subtest: test_correct_cpu_write
[173.691644] Starting dynamic subtest: test_correct_cpu_write-smem
[173.692841] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[173.694099] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[173.772294] [019/142] (830s left) kms_frontbuffer_tracking (basic)
[173.859438] Starting subtest: basic
[177.198828] Subtest basic: SUCCESS (3.341s)
[177.282218] [020/142] (826s left) drm_read (short-buffer-wakeup)
[177.410728] Starting subtest: short-buffer-wakeup
[209.627272] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[209.744028] [021/142] (794s left) kms_universal_plane (universal-plane-pipe-a-functional)
[209.807763] Starting subtest: universal-plane-pipe-A-functional
[214.111397] Subtest universal-plane-pipe-A-functional: SUCCESS (4.303s)
[215.038171] [022/142] (789s left) i915_suspend (fence-restore-untiled)
[215.087050] Starting subtest: fence-restore-untiled
[215.089712] Subtest fence-restore-untiled: SKIP (0.000s)
[215.139828] [023/142] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[215.209988] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[220.279772] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (5.071s)
[220.379222] [024/142] (783s left) perf_pmu (idle)
[220.453416] Starting subtest: idle
[220.454957] Starting dynamic subtest: rcs0
[220.996681] Dynamic subtest rcs0: SUCCESS (0.541s)
[221.009553] Starting dynamic subtest: bcs0
[221.521669] Dynamic subtest bcs0: SUCCESS (0.525s)
[221.534500] Starting dynamic subtest: vcs0
[222.035607] Dynamic subtest vcs0: SUCCESS (0.513s)
[222.048143] Starting dynamic subtest: vcs1
[222.548978] Dynamic subtest vcs1: SUCCESS (0.512s)
[222.561896] Starting dynamic subtest: vecs0
[223.064923] Dynamic subtest vecs0: SUCCESS (0.515s)
[223.077405] Starting dynamic subtest: ccs0
[223.586596] Dynamic subtest ccs0: SUCCESS (0.521s)
[223.588335] Subtest idle: SUCCESS (3.131s)
[223.657067] [025/142] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[223.747958] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[223.750036] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[223.828394] [026/142] (780s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[223.875416] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[223.878290] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[223.922898] [027/142] (780s left) kms_psr (cursor_blt)
[223.987353] Starting subtest: cursor_blt
[225.747584] Subtest cursor_blt: SUCCESS (1.760s)
[226.691296] [028/142] (777s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[226.740841] Starting subtest: invalid-multi-wait-unsubmitted
[226.742141] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[226.801226] [029/142] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[226.884080] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[226.886671] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[226.978496] [030/142] (777s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[227.026509] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[227.028722] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[227.198702] [031/142] (777s left) kms_vblank (pipe-d-wait-forked)
[227.269020] Starting subtest: pipe-D-wait-forked
[230.250132] Subtest pipe-D-wait-forked: SUCCESS (2.981s)
[231.170438] [032/142] (773s left) kms_chamelium_color (ctm-blue-to-red)
[231.260702] Subtest ctm-blue-to-red: SKIP (0.000s)
[231.298131] [033/142] (773s left) gem_exec_flush (basic-uc-rw-default)
[231.354807] Starting subtest: basic-uc-rw-default
[236.825321] Subtest basic-uc-rw-default: SUCCESS (5.471s)
[237.004815] [034/142] (767s left) kms_frontbuffer_tracking (fbc-1p-rte)
[237.072745] Starting subtest: fbc-1p-rte
[241.562161] Subtest fbc-1p-rte: SUCCESS (4.491s)
[241.701438] [035/142] (762s left) v3d/v3d_job_submission (threaded-job-submission)
[241.762206] Subtest threaded-job-submission: SKIP (0.000s)
[241.806896] [036/142] (762s left) gem_exec_whisper (basic-fds-forked)
[241.852880] Starting subtest: basic-fds-forked
[266.400459] Subtest basic-fds-forked: SUCCESS (24.544s)
[266.576960] [037/142] (737s left) kms_selftest (drm_damage)
[266.625034] Starting subtest: drm_damage
[266.627301] Subtest drm_damage: SKIP (0.001s)
[266.670287] [038/142] (737s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[267.079092] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[267.084629] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[267.932422] [039/142] (736s left) gem_barrier_race (remote-request)
[267.999396] Starting subtest: remote-request
[268.001016] Starting dynamic subtest: rcs0
[273.108311] Dynamic subtest rcs0: SUCCESS (5.113s)
[273.109598] Subtest remote-request: SUCCESS (5.114s)
[273.223444] [040/142] (731s left) kms_vblank (pipe-d-query-forked-busy)
[273.330891] Starting subtest: pipe-D-query-forked-busy
[276.370711] Subtest pipe-D-query-forked-busy: SUCCESS (3.039s)
[277.311166] [041/142] (727s left) kms_setmode (clone-exclusive-crtc)
[277.360758] Starting subtest: clone-exclusive-crtc
[277.363540] Subtest clone-exclusive-crtc: SKIP (0.000s)
[277.409466] [042/142] (727s left) gem_exec_schedule (noreorder-priority)
[277.597826] Starting subtest: noreorder-priority
[277.599622] Starting dynamic subtest: rcs0
[305.935220] Dynamic subtest rcs0: FAIL (28.307s)
[305.943517] Starting dynamic subtest: bcs0
[316.135116] Dynamic subtest bcs0: SUCCESS (10.231s)
[316.141235] Starting dynamic subtest: vcs0
[317.417368] Dynamic subtest vcs0: SUCCESS (1.279s)
[317.431099] Starting dynamic subtest: vcs1
[319.469644] Dynamic subtest vcs1: SUCCESS (2.051s)
[319.484762] Starting dynamic subtest: vecs0
[321.454143] Dynamic subtest vecs0: SUCCESS (1.984s)
[321.467944] Starting dynamic subtest: ccs0
[331.205458] Dynamic subtest ccs0: SUCCESS (9.753s)
[331.207776] Subtest noreorder-priority: FAIL (53.611s)
[331.387291] [043/142] (673s left) gem_mmap_wc (close)
[331.453431] Subtest close: SKIP (0.000s)
[331.480467] [044/142] (673s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[331.563490] Starting subtest: plane-all-modeset-transition-fencing
[331.565710] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[331.624665] [045/142] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[331.698948] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[331.701049] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[331.779576] [046/142] (672s left) kms_plane_lowres (tiling-x)
[331.842172] Starting subtest: tiling-x
[331.843653] Starting dynamic subtest: pipe-A-eDP-1
[331.846422] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.139991] Starting dynamic subtest: pipe-B-eDP-1
[332.142384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.154036] Starting dynamic subtest: pipe-C-eDP-1
[332.156124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.163553] Starting dynamic subtest: pipe-D-eDP-1
[332.165623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.167680] Subtest tiling-x: SKIP (0.298s)
[333.058949] [047/142] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[333.142416] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[333.144514] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[333.226612] [048/142] (671s left) v3d/v3d_wait_bo (used-bo-1ns)
[333.298978] Subtest used-bo-1ns: SKIP (0.000s)
[333.347823] [049/142] (671s left) kms_flip (blocking-wf_vblank)
[333.401437] Starting subtest: blocking-wf_vblank
[333.402751] Starting dynamic subtest: A-eDP1
[342.436592] Dynamic subtest A-eDP1: SUCCESS (9.035s)
[342.447848] Starting dynamic subtest: B-eDP1
[351.460652] Dynamic subtest B-eDP1: SUCCESS (9.023s)
[351.474068] Starting dynamic subtest: C-eDP1
[360.473813] Dynamic subtest C-eDP1: SUCCESS (9.012s)
[360.489543] Starting dynamic subtest: D-eDP1
[369.497858] Dynamic subtest D-eDP1: SUCCESS (9.023s)
[369.505208] Subtest blocking-wf_vblank: SUCCESS (36.107s)
[370.819435] [050/142] (634s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[371.212301] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[371.215361] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[372.069261] [051/142] (632s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[372.135327] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[372.136572] Starting dynamic subtest: pipe-A-default-mode
[372.421018] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[372.423154] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.287s)
[373.297343] [052/142] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[373.381819] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[378.181630] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.799s)
[378.321960] [053/142] (626s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[378.727236] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[378.729053] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[379.589036] [054/142] (625s left) api_intel_allocator (standalone)
[379.652794] Starting subtest: standalone
[379.676893] Subtest standalone: SUCCESS (0.026s)
[379.778899] [055/142] (625s left) gem_mmap_gtt (basic-read-write)
[379.846265] Subtest basic-read-write: SKIP (0.000s)
[379.884445] [056/142] (625s left) i915_hangman (gt-engine-hang)
[379.953708] Starting subtest: gt-engine-hang
[379.954826] Starting dynamic subtest: rcs0
[381.472107] Dynamic subtest rcs0: SUCCESS (1.517s)
[381.486700] Starting dynamic subtest: bcs0
[383.391850] Dynamic subtest bcs0: SUCCESS (1.918s)
[383.406302] Starting dynamic subtest: vcs0
[384.414982] Dynamic subtest vcs0: SUCCESS (1.022s)
[384.429057] Starting dynamic subtest: vcs1
[386.464057] Dynamic subtest vcs1: SUCCESS (2.047s)
[386.479885] Starting dynamic subtest: vecs0
[388.447596] Dynamic subtest vecs0: SUCCESS (1.983s)
[388.462237] Starting dynamic subtest: ccs0
[390.432964] Dynamic subtest ccs0: SUCCESS (1.984s)
[390.434804] Subtest gt-engine-hang: SUCCESS (10.478s)
[390.508230] [057/142] (614s left) gem_exec_flush (basic-uc-ro-default)
[390.558617] Starting subtest: basic-uc-ro-default
[396.041706] Subtest basic-uc-ro-default: SUCCESS (5.483s)
[396.223683] [058/142] (608s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[396.615988] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[396.620774] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[397.509409] [059/142] (607s left) kms_color (ctm-signed)
[397.585990] Starting subtest: ctm-signed
[397.587320] Starting dynamic subtest: pipe-A
[399.784653] Dynamic subtest pipe-A: SUCCESS (2.199s)
[399.799783] Starting dynamic subtest: pipe-B
[402.803620] Dynamic subtest pipe-B: SUCCESS (3.017s)
[402.821565] Starting dynamic subtest: pipe-C
[405.667085] Dynamic subtest pipe-C: SUCCESS (2.863s)
[405.681097] Starting dynamic subtest: pipe-D
[408.553444] Dynamic subtest pipe-D: SUCCESS (2.879s)
[408.554913] Subtest ctm-signed: SUCCESS (10.963s)
[409.476654] [060/142] (595s left) syncobj_wait (invalid-signal-illegal-handle)
[409.516892] Starting subtest: invalid-signal-illegal-handle
[409.518121] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[409.570865] [061/142] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[409.653126] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[409.655272] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[409.740411] [062/142] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[409.828487] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[409.830618] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[409.916016] [063/142] (595s left) gem_softpin (evict-active-interruptible)
[409.967805] Starting subtest: evict-active-interruptible
[409.977186] Subtest evict-active-interruptible: SUCCESS (0.009s)
[410.075489] [064/142] (595s left) gem_exec_reloc (basic-gtt-read-noreloc)
[410.118464] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[410.177441] [065/142] (595s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[410.229432] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[410.334718] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[410.402113] [066/142] (594s left) kms_getfb (getfb2-into-addfb2)
[410.440345] Starting subtest: getfb2-into-addfb2
[410.441478] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[410.525411] [067/142] (594s left) kms_vblank (pipe-a-accuracy-idle)
[410.568986] Starting subtest: pipe-A-accuracy-idle
[412.333186] Subtest pipe-A-accuracy-idle: SUCCESS (1.765s)
[413.253723] [068/142] (592s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[413.319536] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[414.056382] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.736s)
[414.201715] [069/142] (591s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[414.611560] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[414.614686] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[415.464292] [070/142] (589s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[415.502110] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[415.536768] [071/142] (589s left) kms_atomic_transition (plane-toggle-modeset-transition)
[415.604083] Starting subtest: plane-toggle-modeset-transition
[415.605305] Starting dynamic subtest: pipe-A-eDP-1
[429.957833] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.351s)
[429.972886] Starting dynamic subtest: pipe-B-eDP-1
[443.970551] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.009s)
[443.973460] Subtest plane-toggle-modeset-transition: SUCCESS (28.369s)
[444.863873] [072/142] (560s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[445.288842] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[445.290310] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[446.136390] [073/142] (559s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[446.551169] Starting subtest: pipe-D-crc-primary-rotation-180-yf_tiled_ccs
[446.553812] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[447.426940] [074/142] (557s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[447.496798] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[447.606632] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[447.673256] [075/142] (557s left) i915_pm_rpm (legacy-planes)
[449.607931] Starting subtest: legacy-planes
[449.609436] Starting dynamic subtest: plane-40
[477.303186] Dynamic subtest plane-40: SUCCESS (27.694s)
[477.317662] Starting dynamic subtest: plane-49
[505.460673] Dynamic subtest plane-49: SUCCESS (28.156s)
[505.477143] Starting dynamic subtest: plane-58
[533.756085] Dynamic subtest plane-58: SUCCESS (28.294s)
[533.772072] Starting dynamic subtest: plane-67
[561.868088] Dynamic subtest plane-67: SUCCESS (28.110s)
[561.870100] Subtest legacy-planes: SUCCESS (112.261s)
[562.660286] [076/142] (442s left) kms_addfb_basic (invalid-set-prop)
[562.714666] Starting subtest: invalid-set-prop
[562.715986] Subtest invalid-set-prop: SUCCESS (0.000s)
[562.830726] [077/142] (442s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[562.909120] Starting subtest: x-tiled-addfb-size-offset-overflow
[562.910325] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[563.004704] [078/142] (442s left) prime_mmap (test_errors)
[563.070352] Starting subtest: test_errors
[563.071519] Starting dynamic subtest: test_errors-smem
[563.187722] Dynamic subtest test_errors-smem: SUCCESS (0.116s)
[563.189628] Subtest test_errors: SUCCESS (0.117s)
[563.251852] [079/142] (442s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling)
[563.314664] Starting subtest: plane-scaler-with-modifiers-unity-scaling
[563.316043] Starting dynamic subtest: pipe-A-eDP-1
[563.926615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[563.942412] Starting dynamic subtest: pipe-B-eDP-1
[565.801919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.873s)
[565.817793] Starting dynamic subtest: pipe-C-eDP-1
[567.566370] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.761s)
[567.577781] Starting dynamic subtest: pipe-D-eDP-1
[569.393714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[569.395482] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (6.079s)
[570.686967] [080/142] (434s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[570.761491] Starting subtest: single-wait-all-for-submit-available-signaled
[570.763028] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[570.829253] [081/142] (434s left) kms_pm_lpsp (kms-lpsp)
[571.924949] Starting subtest: kms-lpsp
[571.926152] Starting dynamic subtest: kms-lpsp-eDP
[572.072970] Dynamic subtest kms-lpsp-eDP: SUCCESS (0.150s)
[572.372487] Subtest kms-lpsp: SUCCESS (0.448s)
[573.320411] [082/142] (432s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[573.408590] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[573.412507] Starting dynamic subtest: pipe-A-default-mode
[574.627811] Dynamic subtest pipe-A-default-mode: SKIP (1.212s)
[574.631022] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.216s)
[574.753124] [083/142] (430s left) gem_ctx_isolation (nonpriv)
[574.805353] Starting subtest: nonpriv
[574.806803] Starting dynamic subtest: rcs0
[574.943278] Dynamic subtest rcs0: SUCCESS (0.137s)
[574.949709] Starting dynamic subtest: bcs0
[575.140618] Dynamic subtest bcs0: SUCCESS (0.197s)
[575.154934] Starting dynamic subtest: vcs0
[575.338698] Dynamic subtest vcs0: SUCCESS (0.197s)
[575.352999] Starting dynamic subtest: vcs1
[576.608351] Dynamic subtest vcs1: SUCCESS (1.269s)
[576.621777] Starting dynamic subtest: vecs0
[578.606171] Dynamic subtest vecs0: SUCCESS (1.997s)
[578.618194] Starting dynamic subtest: ccs0
[580.684731] Dynamic subtest ccs0: SUCCESS (2.078s)
[580.686486] Subtest nonpriv: SUCCESS (5.879s)
[580.918562] [084/142] (424s left) kms_lease (atomic_implicit_crtc)
[581.010187] Starting subtest: atomic_implicit_crtc
[581.015311] Starting dynamic subtest: pipe-A-eDP-1
[581.016530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[581.030949] Starting dynamic subtest: pipe-B-eDP-1
[581.032706] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[581.039562] Starting dynamic subtest: pipe-C-eDP-1
[581.040622] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[581.045135] Starting dynamic subtest: pipe-D-eDP-1
[581.046121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[581.047037] Subtest atomic_implicit_crtc: SUCCESS (0.020s)
[581.138239] [085/142] (424s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[581.228060] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[585.898540] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.671s)
[586.006341] [086/142] (419s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[586.383076] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[587.230699] [087/142] (418s left) i915_pm_rps (thresholds-idle)
[587.281276] Starting subtest: thresholds-idle
[587.282741] Starting dynamic subtest: gt0
[587.285352] Dynamic subtest gt0: SKIP (0.001s)
[587.292250] Starting dynamic subtest: gt1
[587.294504] Dynamic subtest gt1: SKIP (0.000s)
[587.296820] Subtest thresholds-idle: SKIP (0.003s)
[587.315796] [088/142] (418s left) gem_lmem_swapping (heavy-verify-random)
[587.370629] Subtest heavy-verify-random: SKIP (0.000s)
[587.398263] [089/142] (418s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[587.532827] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[588.494141] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.961s)
[589.379440] [090/142] (416s left) gem_exec_reloc (basic-cpu-wc-active)
[589.456384] Subtest basic-cpu-wc-active: SKIP (0.000s)
[589.518443] [091/142] (416s left) gem_exec_balancer (noheartbeat)
[589.772220] Starting subtest: noheartbeat
[589.776088] Subtest noheartbeat: SKIP (0.000s)
[589.840921] [092/142] (416s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[590.232964] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[590.236818] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[591.099407] [093/142] (414s left) prime_vgem (shrink)
[591.211261] Starting subtest: shrink
[591.237051] Subtest shrink: SUCCESS (0.025s)
[591.326839] [094/142] (414s left) gem_unref_active_buffers
[591.505231] [095/142] (414s left) gem_exec_params (invalid-bsd2-flag-on-render)
[591.565185] Starting subtest: invalid-bsd2-flag-on-render
[591.566665] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[591.656160] [096/142] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[591.734936] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[595.408690] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.678s)
[595.551055] [097/142] (410s left) kms_frontbuffer_tracking (fbc-badstride)
[595.645711] Starting subtest: fbc-badstride
[604.245381] Subtest fbc-badstride: SUCCESS (8.601s)
[604.365063] [098/142] (401s left) kms_chamelium_edid (dp-edid-read)
[604.751122] Subtest dp-edid-read: SKIP (0.000s)
[605.598076] [099/142] (400s left) gem_eio (context-create)
[605.839846] Starting subtest: context-create
[607.490559] Subtest context-create: SUCCESS (1.648s)
[609.509449] [100/142] (396s left) kms_getfb (getfb-handle-not-fb)
[609.578098] Starting subtest: getfb-handle-not-fb
[609.607858] Subtest getfb-handle-not-fb: SUCCESS (0.031s)
[609.694942] [101/142] (396s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[609.766618] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[609.798153] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.027s)
[609.871434] [102/142] (396s left) gem_softpin (safe-alignment)
[609.936928] Starting subtest: safe-alignment
[609.947535] Subtest safe-alignment: SUCCESS (0.011s)
[611.488394] [103/142] (394s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[616.740172] Starting subtest: overlay-plane-move-continuous-exceed-fully-sf
[616.741581] Starting dynamic subtest: pipe-A-eDP-1
[634.037639] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.296s)
[634.053829] Starting dynamic subtest: pipe-B-eDP-1
[651.301854] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.260s)
[651.303569] Subtest overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.564s)
[652.230916] [104/142] (353s left) dmabuf (all-tests)
[652.304992] Starting subtest: all-tests
[652.306667] Starting dynamic subtest: sanitycheck
[652.379206] Dynamic subtest sanitycheck: SUCCESS (0.073s)
[652.394560] Starting dynamic subtest: dma_fence
[652.564421] Dynamic subtest dma_fence: SUCCESS (0.184s)
[652.582461] Starting dynamic subtest: dma_fence_chain
[661.895139] Dynamic subtest dma_fence_chain: SUCCESS (9.328s)
[661.911172] Starting dynamic subtest: dma_fence_unwrap
[661.962909] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s)
[661.978322] Starting dynamic subtest: dma_resv
[662.037659] Dynamic subtest dma_resv: SUCCESS (0.073s)
[662.039045] Subtest all-tests: SUCCESS (9.734s)
[662.097949] [105/142] (344s left) kms_async_flips (async-flip-with-page-flip-events)
[662.160086] Starting subtest: async-flip-with-page-flip-events
[662.533500] Starting dynamic subtest: pipe-A-eDP-1-4-MC_CCS
[663.358324] Dynamic subtest pipe-A-eDP-1-4-MC_CCS: SKIP (0.824s)
[663.365059] Starting dynamic subtest: pipe-A-eDP-1-4-RC_CCS
[663.511609] Dynamic subtest pipe-A-eDP-1-4-RC_CCS: SKIP (0.153s)
[663.525382] Starting dynamic subtest: pipe-A-eDP-1-4-RC_CCS-CC
[663.680587] Dynamic subtest pipe-A-eDP-1-4-RC_CCS-CC: SKIP (0.167s)
[663.694810] Starting dynamic subtest: pipe-A-eDP-1-4
[665.830957] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.150s)
[665.836656] Starting dynamic subtest: pipe-A-eDP-1-X
[667.986252] Dynamic subtest pipe-A-eDP-1-X: SUCCESS (2.155s)
[667.991619] Starting dynamic subtest: pipe-A-eDP-1-linear
[670.164094] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.177s)
[670.542087] Starting dynamic subtest: pipe-B-eDP-1-4-MC_CCS
[671.359037] Dynamic subtest pipe-B-eDP-1-4-MC_CCS: SKIP (0.827s)
[671.372169] Starting dynamic subtest: pipe-B-eDP-1-4-RC_CCS
[671.532238] Dynamic subtest pipe-B-eDP-1-4-RC_CCS: SKIP (0.172s)
[671.539503] Starting dynamic subtest: pipe-B-eDP-1-4-RC_CCS-CC
[671.689210] Dynamic subtest pipe-B-eDP-1-4-RC_CCS-CC: SKIP (0.156s)
[671.701458] Starting dynamic subtest: pipe-B-eDP-1-4
[673.853723] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.162s)
[673.867756] Starting dynamic subtest: pipe-B-eDP-1-X
[676.008109] Dynamic subtest pipe-B-eDP-1-X: SUCCESS (2.155s)
[676.022055] Starting dynamic subtest: pipe-B-eDP-1-linear
[678.208982] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.200s)
[678.585613] Starting dynamic subtest: pipe-C-eDP-1-4-MC_CCS
[679.406079] Dynamic subtest pipe-C-eDP-1-4-MC_CCS: SKIP (0.831s)
[679.412503] Starting dynamic subtest: pipe-C-eDP-1-4-RC_CCS
[679.593468] Dynamic subtest pipe-C-eDP-1-4-RC_CCS: SKIP (0.182s)
[679.607061] Starting dynamic subtest: pipe-C-eDP-1-4-RC_CCS-CC
[679.738268] Dynamic subtest pipe-C-eDP-1-4-RC_CCS-CC: SKIP (0.148s)
[679.744970] Starting dynamic subtest: pipe-C-eDP-1-4
[681.878396] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.139s)
[681.889036] Starting dynamic subtest: pipe-C-eDP-1-X
[684.069208] Dynamic subtest pipe-C-eDP-1-X: SUCCESS (2.188s)
[684.077733] Starting dynamic subtest: pipe-C-eDP-1-linear
[686.234218] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.167s)
[686.608398] Starting dynamic subtest: pipe-D-eDP-1-4-MC_CCS
[687.433145] Dynamic subtest pipe-D-eDP-1-4-MC_CCS: SKIP (0.834s)
[687.440838] Starting dynamic subtest: pipe-D-eDP-1-4-RC_CCS
[687.580589] Dynamic subtest pipe-D-eDP-1-4-RC_CCS: SKIP (0.148s)
[687.587070] Starting dynamic subtest: pipe-D-eDP-1-4-RC_CCS-CC
[687.717712] Dynamic subtest pipe-D-eDP-1-4-RC_CCS-CC: SKIP (0.135s)
[687.731855] Starting dynamic subtest: pipe-D-eDP-1-4
[689.892139] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[689.906913] Starting dynamic subtest: pipe-D-eDP-1-X
[692.058579] Dynamic subtest pipe-D-eDP-1-X: SUCCESS (2.166s)
[692.066698] Starting dynamic subtest: pipe-D-eDP-1-linear
[694.225044] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.166s)
[694.226624] Subtest async-flip-with-page-flip-events: SUCCESS (32.063s)
[695.493121] [106/142] (310s left) kms_addfb_basic (tile-pitch-mismatch)
[695.539181] Starting subtest: tile-pitch-mismatch
[695.541453] Subtest tile-pitch-mismatch: SKIP (0.000s)
[695.651420] [107/142] (310s left) gen9_exec_parse (bb-start-param)
[695.686740] Subtest bb-start-param: SKIP (0.000s)
[695.720198] [108/142] (310s left) v3d/v3d_submit_cl (bad-pad)
[695.781492] Subtest bad-pad: SKIP (0.000s)
[695.829050] [109/142] (310s left) kms_cursor_crc (cursor-onscreen-256x85)
[695.996306] Starting subtest: cursor-onscreen-256x85
[696.004334] Starting dynamic subtest: pipe-A-eDP-1
[698.160793] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.155s)
[698.205383] Starting dynamic subtest: pipe-D-eDP-1
[701.060127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s)
[701.061411] Subtest cursor-onscreen-256x85: SUCCESS (5.063s)
[701.951559] [110/142] (304s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[702.055698] Starting subtest: y-tiled-16bpp-rotate-90
[702.058635] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[702.150960] [111/142] (304s left) kms_display_modes (extended-mode-basic)
[702.236847] Starting subtest: extended-mode-basic
[702.238985] Subtest extended-mode-basic: SKIP (0.000s)
[702.255702] [112/142] (304s left) gem_exec_suspend (basic)
[702.300824] Starting subtest: basic
[702.302368] Starting dynamic subtest: smem
[703.455138] Dynamic subtest smem: SUCCESS (1.151s)
[703.456814] Subtest basic: SUCCESS (1.153s)
[703.631374] [113/142] (302s left) gem_exec_schedule (u-semaphore-resolve)
[703.691737] Starting subtest: u-semaphore-resolve
[703.729731] Subtest u-semaphore-resolve: SUCCESS (0.041s)
[704.058776] [114/142] (302s left) gem_ppgtt (shrink-vs-evict-any)
[704.120607] Starting subtest: shrink-vs-evict-any
[709.475111] Subtest shrink-vs-evict-any: SUCCESS (5.352s)
[709.548421] [115/142] (296s left) kms_flip (2x-nonexisting-fb)
[709.608530] Starting subtest: 2x-nonexisting-fb
[709.619749] Subtest 2x-nonexisting-fb: SKIP (0.013s)
[709.693820] [116/142] (296s left) gen7_exec_parse (basic-allowed)
[709.753560] Subtest basic-allowed: SKIP (0.000s)
[709.792793] [117/142] (296s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[709.864620] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[709.866730] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[709.958137] [118/142] (296s left) kms_content_protection (mei_interface)
[710.068457] Starting subtest: mei_interface
[710.071103] Subtest mei_interface: SKIP (0.001s)
[710.169898] [119/142] (296s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs)
[710.563939] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs
[710.565837] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[711.401595] [120/142] (295s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_mc_ccs)
[711.762974] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs
[711.841618] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.079s)
[712.623893] [121/142] (293s left) gem_exec_alignment (pi-isolated)