[41.337904] Initializing watchdogs
[41.338255]   /dev/watchdog0
[41.353474] [001/142] (960s left) vc4/vc4_purgeable_bo (mark-purgeable)
[41.642512] Subtest mark-purgeable: SKIP (0.000s)
[41.710680] [002/142] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[42.033500] Starting subtest: psr-rgb565-draw-mmap-gtt
[42.036106] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[42.124171] [003/142] (959s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[42.456351] Starting subtest: yf-tiled-64bpp-rotate-0
[42.459388] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[42.557111] [004/142] (959s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[42.806639] Starting subtest: basic-gtt-cpu-noreloc
[42.830423] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.025s)
[43.025601] [005/142] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[43.340716] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[43.343285] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[43.441712] [006/142] (958s left) kms_psr (cursor_blt)
[43.650642] Subtest cursor_blt: SKIP (0.000s)
[43.690477] [007/142] (958s left) vgem_basic (bad-handle)
[43.975726] Starting subtest: bad-handle
[43.977215] Subtest bad-handle: SUCCESS (0.000s)
[44.040050] [008/142] (958s left) kms_big_fb (linear-8bpp-rotate-0)
[44.367646] Starting subtest: linear-8bpp-rotate-0
[48.590395] Subtest linear-8bpp-rotate-0: SUCCESS (4.223s)
[48.827124] [009/142] (953s left) gem_lmem_swapping (verify-random-ccs)
[49.043819] Subtest verify-random-ccs: SKIP (0.000s)
[49.091807] [010/142] (953s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[49.743069] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[49.746224] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[50.077277] [011/142] (952s left) kms_vblank (pipe-b-ts-continuation-idle)
[50.377828] Starting subtest: pipe-B-ts-continuation-idle
[51.017824] Subtest pipe-B-ts-continuation-idle: SUCCESS (0.637s)
[51.356203] [012/142] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[51.675769] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[51.678428] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[51.773797] [013/142] (950s left) gem_mmap_offset (bad-extensions)
[51.977178] Starting subtest: bad-extensions
[51.979169] Subtest bad-extensions: SUCCESS (0.000s)
[52.072852] [014/142] (950s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[52.500590] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[52.951381] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SUCCESS (0.450s)
[53.585875] [015/142] (948s left) gen3_render_tiledx_blits
[53.834505] [016/142] (948s left) gem_ctx_param (basic)
[54.036141] Starting subtest: basic
[54.037609] Subtest basic: SUCCESS (0.002s)
[54.118529] [017/142] (948s left) gem_exec_fence (submit)
[54.482718] Starting subtest: submit
[54.484670] Starting dynamic subtest: rcs0
[54.516452] Dynamic subtest rcs0: SUCCESS (0.035s)
[54.537921] Starting dynamic subtest: bcs0
[54.543780] Dynamic subtest bcs0: SUCCESS (0.026s)
[54.561253] Starting dynamic subtest: vcs0
[54.568234] Dynamic subtest vcs0: SUCCESS (0.024s)
[54.584357] Starting dynamic subtest: vecs0
[54.589756] Dynamic subtest vecs0: SUCCESS (0.021s)
[54.591363] Subtest submit: SUCCESS (0.109s)
[55.270385] [018/142] (947s left) kms_vblank (pipe-c-query-forked)
[55.577031] Starting subtest: pipe-C-query-forked
[58.490601] Subtest pipe-C-query-forked: SUCCESS (2.914s)
[58.818130] [019/142] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[59.135633] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[59.138371] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[59.234466] [020/142] (943s left) template (b)
[59.437360] Starting subtest: B
[59.438861] Subtest B: SUCCESS (0.000s)
[59.516379] [021/142] (943s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[60.027363] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[60.029934] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[60.523503] [022/142] (942s left) i915_hangman (engine-engine-hang)
[60.751506] Starting subtest: engine-engine-hang
[60.753208] Starting dynamic subtest: rcs0
[61.350049] Dynamic subtest rcs0: SUCCESS (0.599s)
[61.366089] Starting dynamic subtest: bcs0
[61.940856] Dynamic subtest bcs0: SUCCESS (0.591s)
[61.960774] Starting dynamic subtest: vcs0
[62.529933] Dynamic subtest vcs0: SUCCESS (0.589s)
[62.547403] Starting dynamic subtest: vecs0
[63.114928] Dynamic subtest vecs0: SUCCESS (0.585s)
[63.117145] Subtest engine-engine-hang: SUCCESS (2.364s)
[63.223485] [023/142] (939s left) kms_vblank (pipe-b-wait-idle-hang)
[63.530623] Starting subtest: pipe-B-wait-idle-hang
[70.963415] Subtest pipe-B-wait-idle-hang: SUCCESS (7.436s)
[71.311868] [024/142] (931s left) core_getstats
[71.592161] [025/142] (931s left) sysfs_timeslice_duration (invalid)
[71.804191] Starting subtest: invalid
[71.805687] Starting dynamic subtest: vecs0
[71.808680] Dynamic subtest vecs0: SUCCESS (0.002s)
[71.824260] Starting dynamic subtest: vcs0
[71.825630] Dynamic subtest vcs0: SUCCESS (0.001s)
[71.840627] Starting dynamic subtest: bcs0
[71.841992] Dynamic subtest bcs0: SUCCESS (0.001s)
[71.856280] Starting dynamic subtest: rcs0
[71.857534] Dynamic subtest rcs0: SUCCESS (0.001s)
[71.858778] Subtest invalid: SUCCESS (0.009s)
[71.893349] [026/142] (930s left) kms_getfb (getfb2-handle-protection)
[72.095767] Starting subtest: getfb2-handle-protection
[72.129377] Subtest getfb2-handle-protection: SUCCESS (0.034s)
[72.226677] [027/142] (930s left) gem_userptr_blits (sync-unmap-after-close)
[72.475452] Starting subtest: sync-unmap-after-close
[72.513645] Subtest sync-unmap-after-close: SUCCESS (0.035s)
[72.642905] [028/142] (930s left) kms_plane (pixel-format)
[72.947412] Starting subtest: pixel-format
[72.948942] Starting dynamic subtest: pipe-A-planes
[79.721601] Dynamic subtest pipe-A-planes: SUCCESS (6.773s)
[79.742632] Starting dynamic subtest: pipe-B-planes
[86.782829] Dynamic subtest pipe-B-planes: SUCCESS (7.058s)
[86.784698] Subtest pixel-format: SUCCESS (13.838s)
[87.110105] [029/142] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[87.425432] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[87.427916] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.526915] [030/142] (915s left) kms_cursor_crc (cursor-offscreen-32x32)
[87.834315] Starting subtest: cursor-offscreen-32x32
[87.967951] Subtest cursor-offscreen-32x32: SKIP (0.131s)
[88.093315] [031/142] (914s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_mc_ccs)
[88.762449] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[89.065752] [032/142] (913s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[89.386733] Starting subtest: 4-tiled-64bpp-rotate-270
[89.389599] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[89.482739] [033/142] (913s left) kms_cursor_crc (cursor-sliding-512x170)
[89.813737] Starting subtest: cursor-sliding-512x170
[89.818322] Subtest cursor-sliding-512x170: SKIP (0.003s)
[89.915902] [034/142] (913s left) gem_eio (in-flight-contexts-10ms)
[90.148807] Starting subtest: in-flight-contexts-10ms
[102.196701] Subtest in-flight-contexts-10ms: SUCCESS (12.050s)
[102.419185] [035/142] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[102.718934] Starting subtest: primary-4-tiled-reflect-x-180
[102.721643] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[102.800625] [036/142] (900s left) gem_ccs (block-copy-compressed)
[103.011429] Subtest block-copy-compressed: SKIP (0.000s)
[103.065851] [037/142] (900s left) i915_module_load (reload-with-fault-injection)
[103.260538] Starting subtest: reload-with-fault-injection
[109.128770] Subtest reload-with-fault-injection: SUCCESS (5.868s)
[109.160112] [038/142] (893s left) gem_exec_balancer (full)
[110.667409] Starting subtest: full
[114.822981] Subtest full: SUCCESS (4.155s)
[118.746882] [039/142] (884s left) perf_pmu (rc6-all-gts)
[118.965783] Starting subtest: rc6-all-gts
[118.968713] Subtest rc6-all-gts: SKIP (0.000s)
[119.060447] [040/142] (884s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[119.271871] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[119.376380] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[119.460945] [041/142] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[119.780812] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[119.783384] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[119.878428] [042/142] (883s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[120.585286] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[120.923854] [043/142] (882s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[121.227323] Starting subtest: primary-y-tiled-reflect-x-0
[121.230100] Subtest primary-y-tiled-reflect-x-0: SKIP (0.003s)
[121.307486] [044/142] (882s left) perf (gen12-group-exclusive-stream-ctx-handle)
[121.656659] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[121.659208] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[121.705208] [045/142] (881s left) kms_content_protection (atomic-dpms)
[122.039666] Starting subtest: atomic-dpms
[122.071284] Starting dynamic subtest: pipe-A-DP-1
[242.680324] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[243.387185] Closing watchdogs
[243.394519] Initializing watchdogs
[243.394712]   /dev/watchdog0
[243.415694] [046/142] (760s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[243.889322] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[243.896224] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.006s)
[244.463303] [047/142] (759s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[244.666654] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[244.670769] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[244.762149] [048/142] (758s left) gem_exec_reloc (basic-wc-gtt-active)
[244.978551] Starting subtest: basic-wc-gtt-active
[245.129334] Subtest basic-wc-gtt-active: SUCCESS (0.150s)
[245.312869] [049/142] (758s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[245.627868] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[245.631360] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[245.729503] [050/142] (757s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[246.031171] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[246.032499] Starting dynamic subtest: pipe-A-valid-mode
[246.687414] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.656s)
[246.688913] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.659s)
[247.024372] [051/142] (756s left) kms_async_flips (async-flip-with-page-flip-events)
[247.327728] Starting subtest: async-flip-with-page-flip-events
[247.807366] Starting dynamic subtest: pipe-A-DP-1-Yf-CCS
[248.648390] Dynamic subtest pipe-A-DP-1-Yf-CCS: SKIP (0.836s)
[248.666426] Starting dynamic subtest: pipe-A-DP-1-Y-CCS
[249.262730] Dynamic subtest pipe-A-DP-1-Y-CCS: SKIP (0.613s)
[249.280330] Starting dynamic subtest: pipe-A-DP-1-Yf
[251.888873] Dynamic subtest pipe-A-DP-1-Yf: SUCCESS (2.629s)
[251.906948] Starting dynamic subtest: pipe-A-DP-1-Y
[254.492283] Dynamic subtest pipe-A-DP-1-Y: SUCCESS (2.598s)
[254.509245] Starting dynamic subtest: pipe-A-DP-1-X
[257.171794] Dynamic subtest pipe-A-DP-1-X: SUCCESS (2.681s)
[257.188562] Starting dynamic subtest: pipe-A-DP-1-linear
[257.323299] Dynamic subtest pipe-A-DP-1-linear: SKIP (0.150s)
[257.810059] Starting dynamic subtest: pipe-B-DP-1-Yf-CCS
[258.718401] Dynamic subtest pipe-B-DP-1-Yf-CCS: SKIP (0.921s)
[258.738369] Starting dynamic subtest: pipe-B-DP-1-Y-CCS
[259.348305] Dynamic subtest pipe-B-DP-1-Y-CCS: SKIP (0.626s)
[259.365404] Starting dynamic subtest: pipe-B-DP-1-Yf
[261.974519] Dynamic subtest pipe-B-DP-1-Yf: SUCCESS (2.628s)
[261.992232] Starting dynamic subtest: pipe-B-DP-1-Y
[264.574279] Dynamic subtest pipe-B-DP-1-Y: SUCCESS (2.598s)
[264.591643] Starting dynamic subtest: pipe-B-DP-1-X
[267.241531] Dynamic subtest pipe-B-DP-1-X: SUCCESS (2.665s)
[267.258366] Starting dynamic subtest: pipe-B-DP-1-linear
[267.427738] Dynamic subtest pipe-B-DP-1-linear: SKIP (0.183s)
[267.797995] Starting dynamic subtest: pipe-C-DP-1-Yf
[270.633856] Dynamic subtest pipe-C-DP-1-Yf: SUCCESS (2.854s)
[270.654367] Starting dynamic subtest: pipe-C-DP-1-Y
[273.280074] Dynamic subtest pipe-C-DP-1-Y: SUCCESS (2.642s)
[273.297132] Starting dynamic subtest: pipe-C-DP-1-X
[275.946088] Dynamic subtest pipe-C-DP-1-X: SUCCESS (2.664s)
[275.965178] Starting dynamic subtest: pipe-C-DP-1-linear
[276.082229] Dynamic subtest pipe-C-DP-1-linear: SKIP (0.133s)
[276.083746] Subtest async-flip-with-page-flip-events: SUCCESS (28.756s)
[276.618158] [052/142] (727s left) gem_exec_schedule (pi-shared-iova)
[276.990376] Starting subtest: pi-shared-iova
[276.991626] Starting dynamic subtest: rcs0
[277.073330] Dynamic subtest rcs0: SUCCESS (0.079s)
[277.097383] Starting dynamic subtest: bcs0
[277.147723] Dynamic subtest bcs0: SUCCESS (0.077s)
[277.178796] Starting dynamic subtest: vcs0
[277.206535] Dynamic subtest vcs0: SUCCESS (0.056s)
[277.229596] Starting dynamic subtest: vecs0
[277.267913] Dynamic subtest vecs0: SUCCESS (0.059s)
[277.269565] Subtest pi-shared-iova: SUCCESS (0.281s)
[277.485766] [053/142] (726s left) gem_pipe_control_store_loop (fresh-buffer)
[277.701022] Starting subtest: fresh-buffer
[279.856254] Subtest fresh-buffer: SUCCESS (2.154s)
[279.969069] [054/142] (723s left) prime_mmap_coherency (ioctl-errors)
[280.183589] Starting subtest: ioctl-errors
[296.215483] Subtest ioctl-errors: SUCCESS (16.030s)
[296.407785] [055/142] (707s left) kms_atomic (plane-invalid-params)
[297.246539] Starting subtest: plane-invalid-params
[297.396380] Subtest plane-invalid-params: SUCCESS (0.150s)
[297.828623] [056/142] (705s left) i915_pm_rpm (modeset-lpsp)
[299.737990] Starting subtest: modeset-lpsp
[300.174758] Subtest modeset-lpsp: SKIP (0.433s)
[300.659627] [057/142] (703s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[300.880464] Starting subtest: yf-tiled-to-vebox-x-tiled
[300.883203] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[301.091685] [058/142] (702s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[301.307958] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[301.416122] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[301.506744] [059/142] (702s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[302.075891] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[302.082530] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[302.488971] [060/142] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[302.807820] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[302.810929] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[302.905662] [061/142] (701s left) kms_cursor_crc (cursor-sliding-128x128)
[303.222490] Starting subtest: cursor-sliding-128x128
[303.234891] Starting dynamic subtest: pipe-A-DP-1
[306.910112] Dynamic subtest pipe-A-DP-1: SUCCESS (3.675s)
[306.993406] Starting dynamic subtest: pipe-C-DP-1
[310.978752] Dynamic subtest pipe-C-DP-1: SUCCESS (4.003s)
[310.980197] Subtest cursor-sliding-128x128: SUCCESS (7.756s)
[311.341163] [062/142] (692s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[311.648890] Starting subtest: basic-flip-before-cursor-varying-size
[312.727039] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.080s)
[313.067448] [063/142] (691s left) kms_vblank (pipe-a-query-busy)
[313.378497] Starting subtest: pipe-A-query-busy
[315.838756] Subtest pipe-A-query-busy: SUCCESS (2.463s)
[316.173992] [064/142] (687s left) kms_pipe_crc_basic (nonblocking-crc)
[316.486365] Starting subtest: nonblocking-crc
[316.487675] Starting dynamic subtest: pipe-A-DP-1
[317.077028] Dynamic subtest pipe-A-DP-1: SUCCESS (0.590s)
[317.102449] Starting dynamic subtest: pipe-B-DP-1
[317.966853] Dynamic subtest pipe-B-DP-1: SUCCESS (0.883s)
[317.991664] Starting dynamic subtest: pipe-C-DP-1
[318.995363] Dynamic subtest pipe-C-DP-1: SUCCESS (1.023s)
[318.997066] Subtest nonblocking-crc: SUCCESS (2.511s)
[319.315821] [065/142] (684s left) kms_chamelium_edid (dp-edid-read)
[319.723137] Subtest dp-edid-read: SKIP (0.000s)
[320.017424] [066/142] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[320.335334] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[320.338561] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[320.446453] [067/142] (683s left) gem_unfence_active_buffers
[320.965948] [068/142] (683s left) gem_exec_reloc (basic-cpu)
[321.180108] Starting subtest: basic-cpu
[321.203704] Subtest basic-cpu: SUCCESS (0.022s)
[321.396305] [069/142] (682s left) kms_chamelium_frames (hdmi-aspect-ratio)
[321.787726] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[322.083907] [070/142] (682s left) i915_pm_rpm (debugfs-read)
[323.989100] Starting subtest: debugfs-read
[327.800510] Subtest debugfs-read: SUCCESS (3.807s)
[328.241260] [071/142] (676s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[328.587921] Starting subtest: x-tiled-64bpp-rotate-270
[328.670831] Subtest x-tiled-64bpp-rotate-270: SKIP (0.081s)
[328.790662] [072/142] (675s left) v3d/v3d_submit_csd (multi-and-single-sync)
[329.047857] Subtest multi-and-single-sync: SKIP (0.000s)
[329.124716] [073/142] (675s left) device_reset (unbind-cold-reset-rebind)
[329.363959] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[329.456441] [074/142] (675s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[329.659531] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[329.664324] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.002s)
[329.756937] [075/142] (674s left) gem_ctx_persistence (engines-hang)
[329.968268] Starting subtest: engines-hang
[329.970266] Starting dynamic subtest: rcs0
[330.002843] Dynamic subtest rcs0: SUCCESS (0.033s)
[330.033330] Starting dynamic subtest: bcs0
[330.035967] Dynamic subtest bcs0: SKIP (0.005s)
[330.057368] Starting dynamic subtest: vcs0
[330.058873] Dynamic subtest vcs0: SUCCESS (0.036s)
[330.083918] Starting dynamic subtest: vecs0
[330.094169] Dynamic subtest vecs0: SUCCESS (0.040s)
[330.095618] Subtest engines-hang: SUCCESS (0.126s)
[330.189834] [076/142] (674s left) kms_flip (absolute-wf_vblank)
[330.478302] Starting subtest: absolute-wf_vblank
[330.483061] Starting dynamic subtest: A-DP1
[341.028490] Dynamic subtest A-DP1: SUCCESS (10.547s)
[341.052667] Starting dynamic subtest: B-DP1
[351.513618] Dynamic subtest B-DP1: SUCCESS (10.482s)
[351.538410] Starting dynamic subtest: C-DP1
[361.976399] Dynamic subtest C-DP1: SUCCESS (10.460s)
[361.984739] Subtest absolute-wf_vblank: SUCCESS (31.505s)
[362.401995] [077/142] (642s left) i915_pm_rps (thresholds-idle)
[362.617520] Starting subtest: thresholds-idle
[362.622348] Starting dynamic subtest: gt0
[362.625488] Dynamic subtest gt0: SKIP (0.004s)
[362.628737] Subtest thresholds-idle: SKIP (0.009s)
[362.733844] [078/142] (642s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[363.063600] Starting subtest: extended-modeset-hang-oldfb-with-reset
[363.067972] Starting dynamic subtest: pipe-A
[365.099497] Dynamic subtest pipe-A: SUCCESS (2.030s)
[365.129218] Starting dynamic subtest: pipe-C
[367.307912] Dynamic subtest pipe-C: SUCCESS (2.200s)
[367.309384] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.246s)
[367.680503] [079/142] (637s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs)
[368.359588] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[368.687036] [080/142] (636s left) kms_vblank (pipe-d-query-idle-hang)
[368.993176] Subtest pipe-D-query-idle-hang: SKIP (0.000s)
[369.087601] [081/142] (635s left) syncobj_timeline (reset-signaled)
[369.292114] Starting subtest: reset-signaled
[369.293817] Subtest reset-signaled: SUCCESS (0.001s)
[369.386669] [082/142] (635s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[369.990391] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[369.993088] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[370.376357] [083/142] (634s left) gem_ctx_engines (none)
[370.605206] Starting subtest: none
[370.606560] Subtest none: SUCCESS (0.003s)
[370.809897] [084/142] (634s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[371.013740] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[371.120574] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[371.209207] [085/142] (633s left) perf (oa-exponents)
[371.542657] Starting subtest: oa-exponents
[371.544377] Starting dynamic subtest: 0-rcs0
[375.685905] Dynamic subtest 0-rcs0: SUCCESS (4.141s)
[375.687644] Subtest oa-exponents: SUCCESS (4.144s)
[375.744265] [086/142] (629s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[375.999531] Subtest destroy-valid-perfmon: SKIP (0.000s)
[376.075083] [087/142] (629s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[376.488414] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[376.491148] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[377.072142] [088/142] (628s left) kms_flip (2x-modeset-vs-vblank-race)
[377.354434] Starting subtest: 2x-modeset-vs-vblank-race
[377.357064] Subtest 2x-modeset-vs-vblank-race: SKIP (0.003s)
[377.473170] [089/142] (627s left) kms_force_connector_basic (prune-stale-modes)
[377.678944] Subtest prune-stale-modes: SKIP (0.000s)
[377.737741] [090/142] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[378.046146] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[380.143965] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.101s)
[380.288099] [091/142] (625s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[380.586936] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[380.588533] Starting dynamic subtest: pipe-A-DP-1
[381.243642] Dynamic subtest pipe-A-DP-1: SUCCESS (0.657s)
[381.275792] Starting dynamic subtest: pipe-B-DP-1
[382.225562] Dynamic subtest pipe-B-DP-1: SUCCESS (0.975s)
[382.252455] Starting dynamic subtest: pipe-C-DP-1
[382.607198] Dynamic subtest pipe-C-DP-1: SUCCESS (0.377s)
[382.608678] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (2.025s)
[383.014402] [092/142] (622s left) gem_exec_whisper (basic-fds-all)
[383.247938] Starting subtest: basic-fds-all
[404.367201] Subtest basic-fds-all: SUCCESS (21.118s)
[404.579705] [093/142] (600s left) kms_flip (2x-flip-vs-dpms)
[404.868698] Starting subtest: 2x-flip-vs-dpms
[404.871435] Subtest 2x-flip-vs-dpms: SKIP (0.003s)
[404.997612] [094/142] (600s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[405.657294] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[405.968983] [095/142] (599s left) v3d/v3d_submit_cl (bad-perfmon)
[406.225718] Subtest bad-perfmon: SKIP (0.000s)
[406.301730] [096/142] (599s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend)
[406.616887] Subtest pipe-D-ts-continuation-dpms-suspend: SKIP (0.000s)
[406.702437] [097/142] (598s left) gem_exec_params (secure-non-root)
[406.912640] Starting subtest: secure-non-root
[406.915581] Subtest secure-non-root: SKIP (0.000s)
[407.018599] [098/142] (598s left) gem_mmap_gtt (big-bo-tiledx)
[407.221442] Starting subtest: big-bo-tiledX
[408.202099] Subtest big-bo-tiledX: SUCCESS (0.979s)
[408.429492] [099/142] (597s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[409.161050] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[409.164298] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[409.585293] [100/142] (596s left) gem_exec_flush (basic-uc-pro-default)
[409.818804] Starting subtest: basic-uc-pro-default
[415.313136] Subtest basic-uc-pro-default: SUCCESS (5.494s)
[415.517984] [101/142] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[415.828359] Starting subtest: psr-1p-primscrn-spr-indfb-move
[415.831719] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[415.935355] [102/142] (589s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[416.234730] Starting subtest: universal-plane-pipe-B-sanity
[417.080165] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.847s)
[417.413411] [103/142] (588s left) kms_chamelium_hpd (vga-hpd-fast)
[417.805417] Subtest vga-hpd-fast: SKIP (0.000s)
[418.083080] [104/142] (587s left) kms_psr (psr2_cursor_plane_onoff)
[418.291832] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[418.344372] [105/142] (587s left) drm_fdinfo (virtual-busy-idle)
[418.548466] Starting subtest: virtual-busy-idle
[421.146808] Subtest virtual-busy-idle: SUCCESS (2.597s)
[421.243862] [106/142] (584s left) gem_exec_whisper (basic-sync-all)
[421.478609] Starting subtest: basic-sync-all
[431.235316] Subtest basic-sync-all: SUCCESS (9.755s)
[431.445196] [107/142] (574s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[431.670603] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[431.672027] Starting dynamic subtest: smem
[431.984433] Dynamic subtest smem: SUCCESS (0.314s)
[431.985842] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.317s)
[432.196563] [108/142] (573s left) gem_exec_fence (invalid-timeline-fence-array)
[433.012181] Starting subtest: invalid-timeline-fence-array
[433.022679] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[433.246343] [109/142] (572s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[433.549440] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[433.550766] Starting dynamic subtest: pipe-A-valid-mode
[433.684426] Dynamic subtest pipe-A-valid-mode: SKIP (0.133s)
[433.687393] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.138s)
[434.032865] [110/142] (572s left) gem_ctx_shared (disjoint-timelines)
[434.261443] Starting subtest: disjoint-timelines
[434.276135] Subtest disjoint-timelines: SUCCESS (0.014s)
[434.499337] [111/142] (571s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[434.813219] Starting subtest: cursorA-vs-flipA-toggle
[446.102182] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.290s)
[446.446651] [112/142] (559s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[446.749725] Starting subtest: cursor-vs-flip-atomic-transitions
[484.888813] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (38.142s)
[485.243406] [113/142] (521s left) gem_exec_schedule (u-fairslice)
[485.490502] Starting subtest: u-fairslice
[485.491952] Starting dynamic subtest: rcs0
[487.528455] Dynamic subtest rcs0: SUCCESS (2.035s)
[487.551977] Starting dynamic subtest: bcs0
[489.564975] Dynamic subtest bcs0: SUCCESS (2.033s)
[489.587727] Starting dynamic subtest: vcs0
[491.595863] Dynamic subtest vcs0: SUCCESS (2.027s)
[491.620746] Starting dynamic subtest: vecs0
[493.625719] Dynamic subtest vecs0: SUCCESS (2.027s)
[493.627194] Subtest u-fairslice: SUCCESS (8.136s)
[493.974588] [114/142] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[494.293219] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[494.296579] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[494.407247] [115/142] (511s left) api_intel_bb (object-noreloc-keep-cache-simple)
[494.611993] Starting subtest: object-noreloc-keep-cache-simple
[494.619723] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[494.739153] [116/142] (511s left) debugfs_test (read_all_entries)
[494.954607] Starting subtest: read_all_entries
[495.242478] Subtest read_all_entries: SUCCESS (0.286s)
[495.440422] [117/142] (511s left) kms_display_modes (mst-extended-mode-negative)
[495.749976] Starting subtest: mst-extended-mode-negative
[495.753242] Subtest mst-extended-mode-negative: SKIP (0.000s)
[495.805887] [118/142] (510s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[496.104575] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[496.105896] Starting dynamic subtest: pipe-A-DP-1
[496.140194] Dynamic subtest pipe-A-DP-1: SKIP (0.032s)
[496.164066] Starting dynamic subtest: pipe-B-DP-1
[496.224105] Dynamic subtest pipe-B-DP-1: SKIP (0.081s)
[496.251166] Starting dynamic subtest: pipe-C-DP-1
[496.310089] Dynamic subtest pipe-C-DP-1: SKIP (0.080s)
[496.313269] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.208s)
[496.423852] [119/142] (510s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[496.724693] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[496.730649] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.003s)
[496.840979] [120/142] (509s left) syncobj_wait (single-wait-for-submit-signaled)
[497.047394] Starting subtest: single-wait-for-submit-signaled
[497.048742] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[497.139986] [121/142] (509s left) kms_plane_alpha_blend (constant-alpha-max)
[497.446115] Starting subtest: constant-alpha-max
[497.754525] Starting dynamic subtest: pipe-A-DP-1
[498.517760] Dynamic subtest pipe-A-DP-1: FAIL (0.402s)
[498.539141] Starting dynamic subtest: pipe-C-DP-1
[499.211870] Dynamic subtest pipe-C-DP-1: FAIL (0.654s)
[499.213166] Subtest constant-alpha-max: FAIL (1.375s)
[499.272350] [122/142] (507s left) syncobj_wait (wait-all-interrupted)
[499.476623] Starting subtest: wait-all-interrupted
[499.584355] Subtest wait-all-interrupted: SUCCESS (0.107s)
[499.681371] [123/142] (507s left) gem_pxp (create-regular-buffer)
[502.402956] Subtest create-regular-buffer: SKIP (0.000s)
[502.498235] [124/142] (504s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[502.828762] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[502.855210] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.025s)
[502.983218] [125/142] (503s left) kms_hdr (static-swap)
[503.292237] Starting subtest: static-swap
[503.295211] Subtest static-swap: SKIP (0.000s)
[503.381951] [126/142] (503s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[503.955946] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[503.959039] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[504.365390] [127/142] (502s left) gem_exec_reloc (basic-scanout)
[504.685486] Starting subtest: basic-scanout
[504.687104] Starting dynamic subtest: rcs0
[505.003420] Dynamic subtest rcs0: SUCCESS (0.317s)
[505.029294] Starting dynamic subtest: bcs0
[505.221371] Dynamic subtest bcs0: SUCCESS (0.214s)
[505.243473] Starting dynamic subtest: vcs0
[505.436479] Dynamic subtest vcs0: SUCCESS (0.213s)
[505.462538] Starting dynamic subtest: vecs0
[505.656149] Dynamic subtest vecs0: SUCCESS (0.214s)
[505.657584] Subtest basic-scanout: SUCCESS (0.969s)
[505.784079] [128/142] (501s left) core_setmaster_vs_auth
[506.082459] [129/142] (500s left) gem_render_copy_redux (interruptible)
[506.313287] Starting subtest: interruptible
[508.620162] Subtest interruptible: SUCCESS (2.306s)
[508.715794] [130/142] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[509.023136] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[509.025744] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[509.132721] [131/142] (497s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[509.430928] Starting subtest: plane-all-modeset-transition-fencing
[509.432476] Starting dynamic subtest: pipe-A-DP-1
[567.842438] Dynamic subtest pipe-A-DP-1: SUCCESS (58.411s)
[567.971614] Starting dynamic subtest: pipe-B-DP-1
[626.245141] Dynamic subtest pipe-B-DP-1: SUCCESS (58.301s)
[626.344165] Subtest plane-all-modeset-transition-fencing: SUCCESS (116.916s)
[626.692238] [132/142] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[627.016198] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[627.020055] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[627.124895] [133/142] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[627.438336] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[627.441524] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[627.541353] [134/142] (379s left) gem_exec_balancer (individual)
[627.771998] Starting subtest: individual
[631.667174] Subtest individual: SUCCESS (3.894s)
[635.659583] [135/142] (371s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[636.047603] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[636.050579] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[636.653663] [136/142] (370s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[636.875863] Starting subtest: y-tiled-ccs-to-y-tiled
[636.880696] Starting dynamic subtest: smem
[637.175419] Dynamic subtest smem: SUCCESS (0.296s)
[637.176933] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.299s)
[637.388624] [137/142] (369s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[637.709885] Starting subtest: y-tiled-8bpp-rotate-90
[637.801984] Subtest y-tiled-8bpp-rotate-90: SKIP (0.088s)
[637.920305] [138/142] (369s left) gem_close (basic)
[638.128736] Starting subtest: basic
[638.130868] Subtest basic: SUCCESS (0.000s)
[638.237289] [139/142] (369s left) gem_watchdog (default-physical)
[638.452308] Starting subtest: default-physical
[639.723352] Subtest default-physical: SUCCESS (1.271s)
[639.803251] [140/142] (367s left) fbdev (info)
[639.998860] Starting subtest: info
[640.000215] Subtest info: SUCCESS (0.000s)
[640.087190] [141/142] (367s left) gem_partial_pwrite_pread (write-display)
[640.300244] Starting subtest: write-display
[655.062712] Subtest write-display: SUCCESS (14.763s)
[655.186822] [142/142] (352s left) gem_softpin (safe-alignment)
[655.401716] Starting subtest: safe-alignment
[655.436828] Subtest safe-alignment: SUCCESS (0.035s)
[655.549655] Closing watchdogs
Done.