[52.818411] Initializing watchdogs
[52.818611]   /dev/watchdog0
[52.834453] [001/140] (960s left) sysfs_defaults (readonly)
[53.016472] Starting subtest: readonly
[53.018144] Starting dynamic subtest: vecs0
[53.019598] Dynamic subtest vecs0: SUCCESS (0.001s)
[53.035889] Starting dynamic subtest: vcs0
[53.037286] Dynamic subtest vcs0: SUCCESS (0.001s)
[53.050344] Starting dynamic subtest: bcs0
[53.051838] Dynamic subtest bcs0: SUCCESS (0.001s)
[53.064646] Starting dynamic subtest: rcs0
[53.066086] Dynamic subtest rcs0: SUCCESS (0.001s)
[53.067329] Subtest readonly: SUCCESS (0.009s)
[53.115746] [002/140] (960s left) kms_properties (crtc-properties-legacy)
[53.350298] Starting subtest: crtc-properties-legacy
[54.938364] Subtest crtc-properties-legacy: SUCCESS (1.590s)
[55.278330] [003/140] (958s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[55.624189] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[55.907771] [004/140] (957s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[56.140364] Starting subtest: plane-upscale-20x20-with-rotation
[56.150074] Starting dynamic subtest: pipe-A-DP-1
[56.208918] Dynamic subtest pipe-A-DP-1: SKIP (0.057s)
[56.229281] Starting dynamic subtest: pipe-B-DP-1
[56.578340] Dynamic subtest pipe-B-DP-1: SKIP (0.361s)
[56.596634] Starting dynamic subtest: pipe-C-DP-1
[56.935179] Dynamic subtest pipe-C-DP-1: SKIP (0.347s)
[56.937549] Subtest plane-upscale-20x20-with-rotation: SKIP (0.795s)
[57.341333] [005/140] (956s left) kms_psr (psr2_sprite_blt)
[57.583248] Subtest psr2_sprite_blt: SKIP (0.000s)
[57.626896] [006/140] (955s left) gem_reg_read (timestamp-moving)
[57.763691] Starting subtest: timestamp-moving
[58.766513] Subtest timestamp-moving: SUCCESS (1.001s)
[58.844570] [007/140] (954s left) prime_vgem (basic-gtt)
[59.092345] Starting subtest: basic-gtt
[59.130759] Subtest basic-gtt: SUCCESS (0.038s)
[59.242699] [008/140] (954s left) gem_ctx_exec (basic-close-race)
[59.383894] Starting subtest: basic-close-race
[64.933902] Subtest basic-close-race: SUCCESS (5.548s)
[65.043779] [009/140] (948s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[65.418718] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[65.421415] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[65.830256] [010/140] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[66.079161] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[66.081672] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[66.163945] [011/140] (947s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[66.404809] Starting subtest: fbc-2p-pri-indfb-multidraw
[66.407421] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[66.497416] [012/140] (947s left) gem_exec_balancer (noheartbeat)
[70.334864] Starting subtest: noheartbeat
[73.913764] Subtest noheartbeat: SUCCESS (3.578s)
[73.999160] [013/140] (939s left) gem_exec_schedule (u-submit-golden-slice)
[74.174685] Starting subtest: u-submit-golden-slice
[74.176289] Starting dynamic subtest: rcs0
[74.238741] Dynamic subtest rcs0: SUCCESS (0.063s)
[74.255769] Starting dynamic subtest: bcs0
[74.292910] Dynamic subtest bcs0: SUCCESS (0.054s)
[74.308936] Starting dynamic subtest: vcs0
[74.341430] Dynamic subtest vcs0: SUCCESS (0.048s)
[74.358255] Starting dynamic subtest: vecs0
[74.391422] Dynamic subtest vecs0: SUCCESS (0.049s)
[74.392981] Subtest u-submit-golden-slice: SUCCESS (0.217s)
[74.749696] [014/140] (939s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[74.894346] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[75.005204] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[75.079260] [015/140] (938s left) v3d/v3d_submit_csd (bad-perfmon)
[75.283560] Subtest bad-perfmon: SKIP (0.000s)
[75.346032] [016/140] (938s left) syncobj_basic (bad-flags-fd-to-handle)
[75.482310] Starting subtest: bad-flags-fd-to-handle
[75.483703] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[75.564637] [017/140] (938s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[75.823688] Starting subtest: 4-tiled-64bpp-rotate-90
[75.826713] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[75.913457] [018/140] (937s left) gem_spin_batch (spin-each)
[76.080452] Starting subtest: spin-each
[79.492969] Subtest spin-each: SUCCESS (3.411s)
[79.715252] [019/140] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[79.958839] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[79.961329] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[80.046274] [020/140] (933s left) kms_frontbuffer_tracking (fbc-2p-rte)
[80.287581] Starting subtest: fbc-2p-rte
[80.290192] Subtest fbc-2p-rte: SKIP (0.000s)
[80.382133] [021/140] (933s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[80.525417] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[80.583171] [022/140] (933s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[80.824527] Starting subtest: fbcpsr-rgb565-draw-blt
[80.826955] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[80.913252] [023/140] (933s left) vgem_basic (bad-pad)
[81.064654] Starting subtest: bad-pad
[81.066040] Subtest bad-pad: SUCCESS (0.000s)
[81.132130] [024/140] (932s left) syncobj_wait (wait-any-complex)
[81.271526] Starting subtest: wait-any-complex
[81.335508] Subtest wait-any-complex: SUCCESS (0.063s)
[81.413179] [025/140] (932s left) device_reset (unbind-cold-reset-rebind)
[81.584524] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[81.663676] [026/140] (932s left) kms_selftest (drm_dp_mst_helper)
[81.804183] Starting subtest: drm_dp_mst_helper
[81.950355] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[81.968935] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.018s)
[81.986678] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[81.994606] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.023s)
[81.996126] Subtest drm_dp_mst_helper: SUCCESS (0.191s)
[82.180131] [027/140] (932s left) gen9_exec_parse (bb-oversize)
[82.347136] Starting subtest: bb-oversize
[83.456455] Subtest bb-oversize: SKIP (1.096s)
[83.694835] [028/140] (930s left) kms_psr (pr_primary_blt)
[84.058127] Subtest pr_primary_blt: SKIP (0.000s)
[84.115555] [029/140] (930s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[84.347671] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[84.351665] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.003s)
[84.449130] [030/140] (929s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[84.716678] Starting subtest: x-tiled-16bpp-rotate-180
[88.413957] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.696s)
[88.733972] [031/140] (925s left) gem_mmap_gtt (big-bo-tiledx)
[88.871763] Starting subtest: big-bo-tiledX
[89.637267] Subtest big-bo-tiledX: SUCCESS (0.764s)
[89.840357] [032/140] (924s left) kms_flip (modeset-vs-vblank-race)
[90.186177] Starting subtest: modeset-vs-vblank-race
[90.187691] Starting dynamic subtest: A-DP1
[94.878112] Dynamic subtest A-DP1: SUCCESS (4.690s)
[94.895047] Starting dynamic subtest: B-DP1
[99.012654] Dynamic subtest B-DP1: SUCCESS (4.133s)
[99.028673] Starting dynamic subtest: C-DP1
[103.128044] Dynamic subtest C-DP1: SUCCESS (4.116s)
[103.131581] Subtest modeset-vs-vblank-race: SUCCESS (12.947s)
[103.554451] [033/140] (910s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[103.726873] Starting subtest: yf-tiled-to-vebox-yf-tiled
[103.729624] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[103.919154] [034/140] (910s left) gem_vm_create (invalid-destroy)
[104.068438] Starting subtest: invalid-destroy
[104.070689] Subtest invalid-destroy: SUCCESS (0.001s)
[104.168064] [035/140] (910s left) prime_mmap_coherency (ioctl-errors)
[104.315776] Starting subtest: ioctl-errors
[119.904860] Subtest ioctl-errors: SUCCESS (15.588s)
[120.024589] [036/140] (894s left) i915_pm_rps (thresholds)
[120.295980] Starting subtest: thresholds
[120.297404] Starting dynamic subtest: gt0
[130.408068] Dynamic subtest gt0: SUCCESS (10.110s)
[130.409452] Subtest thresholds: SUCCESS (10.113s)
[130.486377] [037/140] (884s left) gem_lmem_swapping (smem-oom)
[130.650994] Subtest smem-oom: SKIP (0.000s)
[130.703275] [038/140] (883s left) gem_mmap_wc (read-write)
[130.839908] Starting subtest: read-write
[130.874150] Subtest read-write: SUCCESS (0.032s)
[130.985612] [039/140] (883s left) fbdev (write)
[131.134299] Starting subtest: write
[131.874453] Subtest write: SUCCESS (0.738s)
[131.935710] [040/140] (882s left) perf_pmu (gt-awake)
[132.083741] Starting subtest: gt-awake
[134.642222] Subtest gt-awake: SUCCESS (2.556s)
[134.737478] [041/140] (880s left) gem_exec_params (dr4-dirt)
[134.888498] Starting subtest: DR4-dirt
[134.890051] Subtest DR4-dirt: SUCCESS (0.001s)
[134.986633] [042/140] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[135.239506] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[135.242098] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.337660] [043/140] (879s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[135.482542] Starting subtest: etime-multi-wait-for-submit-submitted
[135.588128] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[135.674102] [044/140] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[135.920829] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[135.923633] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[136.020118] [045/140] (878s left) gem_pxp (create-regular-context-1)
[138.684545] Subtest create-regular-context-1: SKIP (0.000s)
[138.769754] [046/140] (876s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[139.172734] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs
[139.175462] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[139.553856] [047/140] (875s left) sw_sync (timeline_closed_signaled)
[139.691408] Starting subtest: timeline_closed_signaled
[139.693066] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[139.752719] [048/140] (875s left) drm_fdinfo (memory-info-idle)
[139.898110] Starting subtest: memory-info-idle
[139.899727] Starting dynamic subtest: smem0
[139.915786] Dynamic subtest smem0: SKIP (0.015s)
[139.918719] Subtest memory-info-idle: SKIP (0.017s)
[140.004314] [049/140] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[140.248176] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[140.251042] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[140.351927] [050/140] (874s left) gem_exec_capture (capture-invisible)
[140.503827] Starting subtest: capture-invisible
[140.505713] Starting dynamic subtest: smem0
[140.508272] Dynamic subtest smem0: SKIP (0.000s)
[140.510836] Subtest capture-invisible: SKIP (0.001s)
[140.602700] [051/140] (874s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[140.955677] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[140.958273] Subtest pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[141.387789] [052/140] (873s left) kms_big_fb (linear-16bpp-rotate-180)
[141.651445] Starting subtest: linear-16bpp-rotate-180
[146.367582] Subtest linear-16bpp-rotate-180: SUCCESS (4.712s)
[146.705218] [053/140] (868s left) kms_content_protection (lic)
[146.981694] Starting subtest: lic
[147.016714] Starting dynamic subtest: pipe-A-DP-1
[267.123233] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[267.657573] Closing watchdogs
[267.665469] Initializing watchdogs
[267.665657]   /dev/watchdog0
[267.687919] [054/140] (747s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[267.882748] Subtest destroy-valid-perfmon: SKIP (0.000s)
[267.953594] [055/140] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[268.201117] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[270.515307] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.318s)
[270.673299] [056/140] (744s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-mc-ccs)
[271.123055] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs
[271.125906] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.002s)
[271.481628] [057/140] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[271.723621] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[271.726506] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[271.815296] [058/140] (743s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-mc-ccs)
[272.051199] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs
[272.053822] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[272.608719] [059/140] (742s left) api_intel_bb (full-batch)
[272.752938] Starting subtest: full-batch
[272.756420] Subtest full-batch: SUCCESS (0.006s)
[272.856668] [060/140] (742s left) kms_chamelium_hpd (dp-hpd-storm)
[273.201658] Subtest dp-hpd-storm: SKIP (0.000s)
[273.500157] [061/140] (742s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[273.960495] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[274.261763] [062/140] (741s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[274.656440] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs-cc
[274.660327] Subtest pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[275.041544] [063/140] (740s left) gem_fence_thrash (bo-write-verify-threaded-y)
[275.178939] Starting subtest: bo-write-verify-threaded-y
[280.638799] Subtest bo-write-verify-threaded-y: SUCCESS (5.459s)
[280.744593] [064/140] (734s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[280.939328] Subtest get-values-invalid-pointer: SKIP (0.000s)
[281.008526] [065/140] (734s left) gem_exec_schedule (u-fairslice-all)
[281.180771] Starting subtest: u-fairslice-all
[283.303278] Subtest u-fairslice-all: SUCCESS (2.122s)
[283.659480] [066/140] (732s left) gem_flink_race (flink_close)
[283.794516] Starting subtest: flink_close
[288.816592] Subtest flink_close: SUCCESS (5.022s)
[288.908974] [067/140] (726s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[289.154724] Starting subtest: psr-rgb101010-draw-render
[289.157910] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[289.258239] [068/140] (726s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[289.400614] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[289.402161] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[289.491490] [069/140] (726s left) gem_exec_gttfill (all-engines)
[289.658274] Starting subtest: all-engines
[330.251430] Subtest all-engines: SUCCESS (40.593s)
[330.460430] [070/140] (685s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[330.937218] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[330.940902] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[331.396129] [071/140] (684s left) gem_ctx_persistence (heartbeat-many)
[331.545471] Starting subtest: heartbeat-many
[332.129750] Subtest heartbeat-many: SUCCESS (0.584s)
[332.230841] [072/140] (683s left) kms_lease (atomic-implicit-crtc)
[332.465157] Starting subtest: atomic-implicit-crtc
[332.466702] Starting dynamic subtest: pipe-A-DP-1
[332.474493] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[332.503481] Starting dynamic subtest: pipe-B-DP-1
[332.505301] Dynamic subtest pipe-B-DP-1: SUCCESS (0.021s)
[332.532238] Starting dynamic subtest: pipe-C-DP-1
[332.533483] Dynamic subtest pipe-C-DP-1: SUCCESS (0.020s)
[332.534674] Subtest atomic-implicit-crtc: SUCCESS (0.058s)
[332.613448] [073/140] (683s left) kms_plane_multiple (tiling-4)
[332.846224] Starting subtest: tiling-4
[332.848841] Subtest tiling-4: SKIP (0.000s)
[332.930203] [074/140] (683s left) gen9_exec_parse (unaligned-jump)
[333.095158] Starting subtest: unaligned-jump
[333.348963] Subtest unaligned-jump: SUCCESS (0.254s)
[333.582665] [075/140] (682s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[333.843306] Starting subtest: y-tiled-32bpp-rotate-90
[338.957636] Subtest y-tiled-32bpp-rotate-90: SUCCESS (5.113s)
[339.501057] [076/140] (676s left) syncobj_basic (illegal-fd-to-handle)
[339.643046] Starting subtest: illegal-fd-to-handle
[339.644547] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[339.728870] [077/140] (676s left) kms_plane_cursor (overlay)
[339.967994] Starting subtest: overlay
[339.972968] Starting dynamic subtest: pipe-A-DP-1-size-64
[342.423415] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.451s)
[342.492766] Starting dynamic subtest: pipe-A-DP-1-size-128
[344.922496] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.449s)
[344.991888] Starting dynamic subtest: pipe-A-DP-1-size-256
[347.405914] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.432s)
[347.574320] Starting dynamic subtest: pipe-B-DP-1-size-64
[350.205853] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.651s)
[350.275906] Starting dynamic subtest: pipe-B-DP-1-size-128
[352.689150] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s)
[352.763691] Starting dynamic subtest: pipe-B-DP-1-size-256
[355.172381] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.432s)
[355.343714] Starting dynamic subtest: pipe-C-DP-1-size-64
[358.001523] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.678s)
[358.071717] Starting dynamic subtest: pipe-C-DP-1-size-128
[360.468316] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s)
[360.539736] Starting dynamic subtest: pipe-C-DP-1-size-256
[362.967957] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.449s)
[363.098481] Subtest overlay: SUCCESS (23.129s)
[363.405242] [078/140] (652s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[363.667466] Starting subtest: fbcpsr-tiling-y
[363.670335] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[363.770124] [079/140] (652s left) syncobj_basic (bad-fd-to-handle)
[363.907860] Starting subtest: bad-fd-to-handle
[363.909186] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[364.004852] [080/140] (652s left) gem_exec_params (no-vebox)
[364.150731] Starting subtest: no-vebox
[364.160952] Subtest no-vebox: SUCCESS (0.002s)
[364.271909] [081/140] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[364.517606] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[364.520788] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[364.620340] [082/140] (651s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[365.088180] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[365.094285] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[365.419778] [083/140] (651s left) gem_exec_reloc (basic-wc-noreloc)
[365.572296] Starting subtest: basic-wc-noreloc
[365.579258] Subtest basic-wc-noreloc: SUCCESS (0.007s)
[365.769369] [084/140] (650s left) gem_exec_fence (concurrent)
[366.066720] Starting subtest: concurrent
[366.068563] Starting dynamic subtest: rcs0
[366.123824] Dynamic subtest rcs0: SUCCESS (0.055s)
[366.146965] Starting dynamic subtest: bcs0
[366.160982] Dynamic subtest bcs0: SUCCESS (0.035s)
[366.183958] Starting dynamic subtest: vcs0
[366.197708] Dynamic subtest vcs0: SUCCESS (0.033s)
[366.221884] Starting dynamic subtest: vecs0
[366.234157] Dynamic subtest vecs0: SUCCESS (0.034s)
[366.235612] Subtest concurrent: SUCCESS (0.170s)
[366.920836] [085/140] (649s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[367.244564] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[367.540387] [086/140] (649s left) kms_dsc (dsc-with-formats)
[367.771467] Subtest dsc-with-formats: SKIP (0.000s)
[367.834308] [087/140] (648s left) kms_ccs (pipe-d-ccs-on-another-bo-yf-tiled-ccs)
[368.298582] Subtest pipe-D-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[368.622928] [088/140] (648s left) syncobj_wait (wait-all-snapshot)
[368.766582] Starting subtest: wait-all-snapshot
[368.850779] Subtest wait-all-snapshot: SUCCESS (0.083s)
[368.939148] [089/140] (647s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[369.307035] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[369.310670] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[369.733771] [090/140] (647s left) syncobj_timeline (multi-wait-all-available-signaled)
[369.879195] Starting subtest: multi-wait-all-available-signaled
[369.884191] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s)
[369.966083] [091/140] (646s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[370.219762] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[370.243914] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.022s)
[370.366154] [092/140] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[370.607071] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[370.609722] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[370.699233] [093/140] (646s left) kms_pm_rpm (universal-planes)
[372.515481] Starting subtest: universal-planes
[372.518217] Starting dynamic subtest: plane-31
[375.075364] Dynamic subtest plane-31: SUCCESS (2.557s)
[375.096442] Starting dynamic subtest: plane-39
[377.482939] Dynamic subtest plane-39: SUCCESS (2.403s)
[377.512595] Starting dynamic subtest: plane-47
[380.101310] Dynamic subtest plane-47: SUCCESS (2.613s)
[380.124764] Starting dynamic subtest: plane-55
[382.509880] Dynamic subtest plane-55: SUCCESS (2.404s)
[382.512623] Subtest universal-planes: SUCCESS (9.995s)
[382.987314] [094/140] (633s left) kms_atomic (crtc-invalid-params)
[383.224288] Starting subtest: crtc-invalid-params
[383.228638] Starting dynamic subtest: pipe-A-DP-1
[383.492151] Dynamic subtest pipe-A-DP-1: SUCCESS (0.266s)
[383.493430] Subtest crtc-invalid-params: SUCCESS (0.271s)
[383.828147] [095/140] (633s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[384.070309] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[384.073650] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[384.177091] [096/140] (632s left) kms_cursor_crc (cursor-onscreen-128x42)
[384.425867] Starting subtest: cursor-onscreen-128x42
[384.437928] Starting dynamic subtest: pipe-A-DP-1
[386.765364] Dynamic subtest pipe-A-DP-1: SUCCESS (2.326s)
[386.856578] Starting dynamic subtest: pipe-C-DP-1
[389.275238] Dynamic subtest pipe-C-DP-1: SUCCESS (2.443s)
[389.276703] Subtest cursor-onscreen-128x42: SUCCESS (4.850s)
[389.649874] [097/140] (627s left) gem_softpin (evict-active)
[389.805069] Starting subtest: evict-active
[389.829738] Subtest evict-active: SUCCESS (0.025s)
[389.946311] [098/140] (627s left) sw_sync (sync_expired_merge)
[390.084338] Starting subtest: sync_expired_merge
[391.159691] Subtest sync_expired_merge: SUCCESS (1.074s)
[391.229697] [099/140] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[391.475937] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[393.570976] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.097s)
[393.711997] [100/140] (623s left) syncobj_timeline (single-wait-available-signaled)
[393.855166] Starting subtest: single-wait-available-signaled
[393.856794] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[393.945199] [101/140] (623s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[394.212204] Starting subtest: x-tiled-8bpp-rotate-90
[394.298302] Subtest x-tiled-8bpp-rotate-90: SKIP (0.088s)
[394.432307] [102/140] (622s left) i915_pm_rps (engine-order)
[394.583718] Starting subtest: engine-order
[409.190728] Subtest engine-order: FAIL (14.587s)
[409.796976] [103/140] (607s left) kms_vblank (query-idle-hang)
[410.032974] Starting subtest: query-idle-hang
[410.037799] Starting dynamic subtest: pipe-A-DP-1
[417.017410] Dynamic subtest pipe-A-DP-1: SUCCESS (6.979s)
[417.042027] Starting dynamic subtest: pipe-C-DP-1
[423.988694] Dynamic subtest pipe-C-DP-1: SUCCESS (6.964s)
[423.990111] Subtest query-idle-hang: SUCCESS (13.957s)
[424.341113] [104/140] (592s left) v3d/v3d_submit_cl (job-perfmon)
[424.535950] Subtest job-perfmon: SKIP (0.000s)
[424.608073] [105/140] (592s left) kms_flip (2x-flip-vs-panning-interruptible)
[424.846508] Starting subtest: 2x-flip-vs-panning-interruptible
[424.852131] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.003s)
[424.958567] [106/140] (592s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[425.197152] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[425.198536] Starting dynamic subtest: pipe-A-valid-mode
[425.870194] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.672s)
[425.872236] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.676s)
[426.201771] [107/140] (591s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[426.436031] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[426.447892] Starting dynamic subtest: pipe-A-DP-1
[428.825855] Dynamic subtest pipe-A-DP-1: SUCCESS (2.377s)
[428.854969] Starting dynamic subtest: pipe-B-DP-1
[431.479479] Dynamic subtest pipe-B-DP-1: SUCCESS (2.643s)
[431.512748] Starting dynamic subtest: pipe-C-DP-1
[431.869464] Dynamic subtest pipe-C-DP-1: SUCCESS (0.379s)
[431.870768] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.435s)
[432.302285] [108/140] (585s left) core_auth (getclient-master-drop)
[432.441158] Starting subtest: getclient-master-drop
[432.446935] Subtest getclient-master-drop: SUCCESS (0.005s)
[432.531762] [109/140] (585s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[435.195201] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[435.284264] [110/140] (582s left) perf (polling-small-buf)
[435.559165] Starting subtest: polling-small-buf
[435.696682] Subtest polling-small-buf: SUCCESS (0.138s)
[435.749686] [111/140] (581s left) kms_flip (dpms-off-confusion-interruptible)
[435.985339] Starting subtest: dpms-off-confusion-interruptible
[435.990127] Starting dynamic subtest: A-DP1
[446.499277] Dynamic subtest A-DP1: SUCCESS (10.506s)
[446.520191] Starting dynamic subtest: B-DP1
[456.914475] Dynamic subtest B-DP1: SUCCESS (10.413s)
[456.938057] Starting dynamic subtest: C-DP1
[467.345489] Dynamic subtest C-DP1: SUCCESS (10.428s)
[467.351559] Subtest dpms-off-confusion-interruptible: SUCCESS (31.362s)
[467.754112] [112/140] (549s left) gem_exec_whisper (basic-queues-all)
[467.923447] Starting subtest: basic-queues-all
[478.916286] Subtest basic-queues-all: SUCCESS (10.990s)
[479.119298] [113/140] (538s left) kms_cursor_legacy (single-move)
[479.351442] Starting subtest: single-move
[479.352797] Starting dynamic subtest: pipe-A
[484.760353] Dynamic subtest pipe-A: SUCCESS (5.407s)
[484.781507] Starting dynamic subtest: pipe-B
[490.168934] Dynamic subtest pipe-B: SUCCESS (5.405s)
[490.189461] Starting dynamic subtest: pipe-C
[495.577183] Dynamic subtest pipe-C: SUCCESS (5.405s)
[495.598938] Starting dynamic subtest: all-pipes
[500.988330] Dynamic subtest all-pipes: SUCCESS (5.408s)
[500.989960] Subtest single-move: SUCCESS (21.637s)
[501.085893] [114/140] (516s left) kms_getfb (getfb2-handle-not-fb)
[501.228303] Starting subtest: getfb2-handle-not-fb
[501.327343] Subtest getfb2-handle-not-fb: SUCCESS (0.097s)
[501.436186] [115/140] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[501.678623] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[501.681165] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[501.784935] [116/140] (516s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[502.195285] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[502.201893] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[502.571666] [117/140] (515s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[502.815912] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[502.818574] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[502.921494] [118/140] (515s left) gem_eio (execbuf)
[503.090769] Starting subtest: execbuf
[503.132347] Subtest execbuf: SUCCESS (0.043s)
[503.338483] [119/140] (514s left) perf (gen12-group-exclusive-stream-ctx-handle)
[503.581645] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[503.584442] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[503.641168] [120/140] (514s left) gem_mmap_wc (invalid-flags)
[503.781184] Starting subtest: invalid-flags
[503.782966] Subtest invalid-flags: SUCCESS (0.000s)
[503.871504] [121/140] (514s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[504.017779] Starting subtest: legacy-engines-hostile-preempt
[504.019654] Starting dynamic subtest: render
[504.116654] Dynamic subtest render: SUCCESS (0.097s)
[504.140900] Starting dynamic subtest: bsd
[504.210972] Dynamic subtest bsd: SUCCESS (0.090s)
[504.236495] Starting dynamic subtest: blt
[504.302479] Dynamic subtest blt: SUCCESS (0.087s)
[504.326680] Starting dynamic subtest: vebox
[504.390810] Dynamic subtest vebox: SUCCESS (0.084s)
[504.395398] Subtest legacy-engines-hostile-preempt: SUCCESS (0.375s)
[504.488633] [122/140] (513s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[504.731732] Starting subtest: cursor-rapid-movement-128x42
[504.743811] Starting dynamic subtest: pipe-A-DP-1
[505.243771] Dynamic subtest pipe-A-DP-1: SUCCESS (0.497s)
[505.334803] Starting dynamic subtest: pipe-C-DP-1
[505.920412] Dynamic subtest pipe-C-DP-1: SUCCESS (0.608s)
[505.921785] Subtest cursor-rapid-movement-128x42: SUCCESS (1.187s)
[506.284625] [123/140] (511s left) syncobj_timeline (invalid-wait-illegal-handle)
[506.427398] Starting subtest: invalid-wait-illegal-handle
[506.428947] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[506.511307] [124/140] (511s left) syncobj_eventfd (timeline-wait-signaled)
[506.653178] Starting subtest: timeline-wait-signaled
[506.654691] Subtest timeline-wait-signaled: SUCCESS (0.002s)
[506.743245] [125/140] (511s left) kms_psr (psr_dpms)
[506.988322] Subtest psr_dpms: SKIP (0.000s)
[507.044966] [126/140] (511s left) gem_eio (in-flight-immediate)
[507.202785] Starting subtest: in-flight-immediate
[508.104496] Subtest in-flight-immediate: SUCCESS (0.905s)
[508.310469] [127/140] (510s left) kms_feature_discovery (psr1)
[508.544801] Starting subtest: psr1
[508.547480] Subtest psr1: SKIP (0.000s)
[508.643521] [128/140] (509s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[508.784612] Starting subtest: cpuset-medium-copy-XY
[521.243960] Subtest cpuset-medium-copy-XY: SUCCESS (12.460s)
[521.378603] [129/140] (497s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-mc-ccs)
[521.982538] Subtest pipe-D-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[522.306929] [130/140] (496s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[522.573397] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[523.845295] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.272s)
[524.174553] [131/140] (494s left) gem_eio (in-flight-internal-immediate)
[524.336403] Starting subtest: in-flight-internal-immediate
[524.414694] Subtest in-flight-internal-immediate: SUCCESS (0.079s)
[524.641662] [132/140] (493s left) perf (invalid-oa-format-id)
[524.919255] Starting subtest: invalid-oa-format-id
[524.965410] Subtest invalid-oa-format-id: SUCCESS (0.047s)
[525.023098] [133/140] (493s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs)
[525.492510] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[525.817460] [134/140] (492s left) gem_exec_schedule (in-order)
[525.994900] Starting subtest: in-order
[525.996483] Starting dynamic subtest: rcs0
[526.132380] Dynamic subtest rcs0: SUCCESS (0.135s)
[526.159766] Starting dynamic subtest: bcs0
[526.282139] Dynamic subtest bcs0: SUCCESS (0.146s)
[526.309495] Starting dynamic subtest: vcs0
[526.415095] Dynamic subtest vcs0: SUCCESS (0.130s)
[526.442071] Starting dynamic subtest: vecs0
[526.549875] Dynamic subtest vecs0: SUCCESS (0.131s)
[526.552191] Subtest in-order: SUCCESS (0.557s)
[526.916264] [135/140] (491s left) perf (buffer-fill)
[527.137428] Starting subtest: buffer-fill
[527.138732] Starting dynamic subtest: 0-rcs0
[529.991755] Dynamic subtest 0-rcs0: SUCCESS (2.853s)
[529.993296] Subtest buffer-fill: SUCCESS (2.855s)
[530.052094] [136/140] (488s left) gem_exec_balancer (bonded-false-hang)
[533.865479] Starting subtest: bonded-false-hang
[537.329423] Subtest bonded-false-hang: SUCCESS (3.464s)
[537.435129] [137/140] (481s left) kms_pm_rpm (drm-resources-equal)
[539.159725] Starting subtest: drm-resources-equal
[540.792936] Subtest drm-resources-equal: SUCCESS (1.633s)
[540.985320] [138/140] (477s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-ccs)
[541.425474] Starting subtest: pipe-C-bad-rotation-90-y-tiled-ccs
[541.428187] Subtest pipe-C-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[541.799643] [139/140] (477s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[542.032227] Starting subtest: cursorB-vs-flipB-atomic-transitions
[542.034713] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s)
[542.117389] [140/140] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[542.367560] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[542.370376] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[542.462660] Closing watchdogs
Done.