[53.441219] Initializing watchdogs
[53.441693]   /dev/watchdog0
[53.475590] [001/142] (960s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[53.942263] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[53.974148] Starting dynamic subtest: A-eDP1
[58.890640] Dynamic subtest A-eDP1: SUCCESS (4.916s)
[58.918872] Starting dynamic subtest: B-eDP1
[62.541986] Dynamic subtest B-eDP1: SUCCESS (3.648s)
[62.568868] Starting dynamic subtest: C-eDP1
[66.078877] Dynamic subtest C-eDP1: SUCCESS (3.534s)
[66.111959] Starting dynamic subtest: D-eDP1
[69.599055] Dynamic subtest D-eDP1: SUCCESS (3.518s)
[69.610172] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (15.668s)
[70.555761] [002/142] (943s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[70.810360] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[70.813439] Starting dynamic subtest: pipe-A-eDP-1
[98.440614] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.627s)
[98.472138] Starting dynamic subtest: pipe-B-eDP-1
[129.356440] Dynamic subtest pipe-B-eDP-1: SUCCESS (30.909s)
[129.393070] Starting dynamic subtest: pipe-C-eDP-1
[131.256293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.891s)
[131.294698] Starting dynamic subtest: pipe-D-eDP-1
[133.188550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.924s)
[133.192185] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (62.380s)
[134.730846] [003/142] (879s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[135.287465] Starting subtest: yf-tiled-32bpp-rotate-90
[135.294327] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[135.435353] [004/142] (878s left) vc4/vc4_wait_bo (unused-bo-1ns)
[135.915578] Subtest unused-bo-1ns: SKIP (0.000s)
[136.022471] [005/142] (878s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[136.502252] Starting subtest: flip-primary-invalidate-overlay
[153.872337] Subtest flip-primary-invalidate-overlay: SUCCESS (17.371s)
[155.244661] [006/142] (859s left) kms_plane_multiple (tiling-4)
[155.721295] Starting subtest: tiling-4
[155.728373] Starting dynamic subtest: pipe-A-eDP-1
[160.503122] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.778s)
[160.540379] Starting dynamic subtest: pipe-B-eDP-1
[166.004132] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.493s)
[166.045800] Starting dynamic subtest: pipe-C-eDP-1
[171.374760] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.365s)
[171.413135] Starting dynamic subtest: pipe-D-eDP-1
[176.856141] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.474s)
[176.859409] Subtest tiling-4: SUCCESS (21.138s)
[177.788891] [007/142] (836s left) gem_exec_whisper (basic-normal)
[178.235311] Starting subtest: basic-normal
[201.191331] Subtest basic-normal: FAIL (22.941s)
[201.710535] [008/142] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[202.228610] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[223.390162] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (21.167s)
[223.636106] [009/142] (790s left) kms_plane (plane-panning-bottom-right)
[224.128762] Starting subtest: plane-panning-bottom-right
[224.132292] Starting dynamic subtest: pipe-A-planes
[226.484478] Dynamic subtest pipe-A-planes: SUCCESS (2.352s)
[226.520989] Starting dynamic subtest: pipe-B-planes
[229.017891] Dynamic subtest pipe-B-planes: SUCCESS (2.523s)
[229.021750] Subtest plane-panning-bottom-right: SUCCESS (4.893s)
[229.952893] [010/142] (784s left) perf_pmu (busy-start)
[230.343821] Starting subtest: busy-start
[230.347277] Starting dynamic subtest: rcs0
[232.900872] Dynamic subtest rcs0: SUCCESS (2.561s)
[232.944242] Starting dynamic subtest: bcs0
[235.457623] Dynamic subtest bcs0: SUCCESS (2.552s)
[235.494782] Starting dynamic subtest: vcs0
[238.549966] Dynamic subtest vcs0: SUCCESS (3.087s)
[238.586578] Starting dynamic subtest: vcs1
[242.582218] Dynamic subtest vcs1: SUCCESS (4.028s)
[242.618095] Starting dynamic subtest: vecs0
[246.554923] Dynamic subtest vecs0: SUCCESS (3.969s)
[246.589919] Starting dynamic subtest: ccs0
[249.108106] Dynamic subtest ccs0: SUCCESS (2.552s)
[249.111752] Subtest busy-start: SUCCESS (18.771s)
[249.290352] [011/142] (765s left) gem_fence_thrash (bo-copy)
[249.653701] Starting subtest: bo-copy
[249.669283] Subtest bo-copy: SKIP (0.010s)
[249.784227] [012/142] (764s left) gem_softpin (allocator-nopin-reserve)
[250.180430] Starting subtest: allocator-nopin-reserve
[250.718319] Subtest allocator-nopin-reserve: SUCCESS (0.537s)
[250.979555] [013/142] (763s left) i915_query (query-topology-unsupported)
[251.355850] Starting subtest: query-topology-unsupported
[251.364888] Subtest query-topology-unsupported: SKIP (0.000s)
[251.531428] [014/142] (763s left) gem_ccs (ctrl-surf-copy-new-ctx)
[251.933307] Starting subtest: ctrl-surf-copy-new-ctx
[251.943775] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[252.127447] [015/142] (762s left) kms_color (ctm-max)
[252.625321] Starting subtest: ctm-max
[252.628220] Starting dynamic subtest: pipe-A
[253.895753] Dynamic subtest pipe-A: SUCCESS (1.268s)
[253.928846] Starting dynamic subtest: pipe-B
[255.825835] Dynamic subtest pipe-B: SUCCESS (1.929s)
[255.864281] Starting dynamic subtest: pipe-C
[257.230523] Dynamic subtest pipe-C: SUCCESS (1.393s)
[257.268931] Starting dynamic subtest: pipe-D
[258.646366] Dynamic subtest pipe-D: SUCCESS (1.419s)
[258.650348] Subtest ctm-max: SUCCESS (6.022s)
[259.591405] [016/142] (755s left) gem_ctx_persistence (legacy-engines-cleanup)
[259.990762] Starting subtest: legacy-engines-cleanup
[259.994500] Starting dynamic subtest: render
[260.049643] Dynamic subtest render: SUCCESS (0.055s)
[260.093069] Starting dynamic subtest: bsd1
[260.111540] Dynamic subtest bsd1: SUCCESS (0.057s)
[260.154117] Starting dynamic subtest: bsd2
[260.157132] Dynamic subtest bsd2: SUCCESS (0.025s)
[260.194826] Starting dynamic subtest: blt
[260.212779] Dynamic subtest blt: SUCCESS (0.067s)
[260.256825] Starting dynamic subtest: vebox
[260.270752] Dynamic subtest vebox: SUCCESS (0.053s)
[260.274476] Subtest legacy-engines-cleanup: SUCCESS (0.282s)
[260.418881] [017/142] (754s left) gem_exec_schedule (noreorder-priority)
[261.017259] Starting subtest: noreorder-priority
[261.020794] Starting dynamic subtest: rcs0
[262.173270] Dynamic subtest rcs0: SUCCESS (1.160s)
[262.212591] Starting dynamic subtest: bcs0
[263.324961] Dynamic subtest bcs0: SUCCESS (1.148s)
[263.361921] Starting dynamic subtest: vcs0
[264.557795] Dynamic subtest vcs0: SUCCESS (1.228s)
[264.594562] Starting dynamic subtest: vcs1
[266.536098] Dynamic subtest vcs1: SUCCESS (1.972s)
[266.579467] Starting dynamic subtest: vecs0
[268.582898] Dynamic subtest vecs0: SUCCESS (2.044s)
[268.619326] Starting dynamic subtest: ccs0
[269.742761] Dynamic subtest ccs0: SUCCESS (1.157s)
[269.746504] Subtest noreorder-priority: SUCCESS (8.733s)
[270.041207] [018/142] (745s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[270.427247] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[270.430697] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.003s)
[270.600351] [019/142] (744s left) kms_hdmi_inject (inject-4k)
[271.398363] Starting subtest: inject-4k
[271.923673] Subtest inject-4k: SUCCESS (0.526s)
[272.559443] [020/142] (742s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[273.803350] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[273.810100] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[274.933154] [021/142] (740s left) kms_cursor_crc (cursor-random-128x128)
[275.777885] Starting subtest: cursor-random-128x128
[275.811907] Starting dynamic subtest: pipe-A-eDP-1
[281.988911] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.176s)
[282.156717] Starting dynamic subtest: pipe-D-eDP-1
[289.412057] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.294s)
[289.416165] Subtest cursor-random-128x128: SUCCESS (13.636s)
[290.500878] [022/142] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[291.013596] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[291.020779] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[291.186681] [023/142] (724s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[292.547123] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[300.883905] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SUCCESS (8.336s)
[302.213101] [024/142] (713s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[302.594433] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[302.699732] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[302.837218] [025/142] (712s left) gen7_exec_parse (oacontrol-tracking)
[303.240533] Subtest oacontrol-tracking: SKIP (0.000s)
[303.361124] [026/142] (712s left) kms_cursor_legacy (single-move)
[303.929513] Starting subtest: single-move
[303.933126] Starting dynamic subtest: pipe-A
[309.378181] Dynamic subtest pipe-A: SUCCESS (5.444s)
[309.419948] Starting dynamic subtest: pipe-B
[314.825398] Dynamic subtest pipe-B: SUCCESS (5.447s)
[314.863821] Starting dynamic subtest: pipe-C
[320.280065] Dynamic subtest pipe-C: SUCCESS (5.450s)
[320.317997] Starting dynamic subtest: pipe-D
[325.733117] Dynamic subtest pipe-D: SUCCESS (5.450s)
[325.776787] Starting dynamic subtest: all-pipes
[331.210729] Dynamic subtest all-pipes: SUCCESS (5.471s)
[331.214091] Subtest single-move: SUCCESS (27.283s)
[331.569747] [027/142] (684s left) gem_fence_thrash (bo-write-verify-y)
[331.946355] Starting subtest: bo-write-verify-y
[331.957072] Subtest bo-write-verify-y: SKIP (0.009s)
[332.062319] [028/142] (683s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[332.590633] Starting subtest: y-tiled-8bpp-rotate-180
[332.597599] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[332.752470] [029/142] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[333.288359] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[333.295894] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[333.448495] [030/142] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[333.934359] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[333.940841] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[334.084280] [031/142] (682s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[335.466542] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs
[338.186685] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (2.714s)
[339.447671] [032/142] (676s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[339.952833] Starting subtest: fbcpsr-rgb565-draw-blt
[355.690434] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (15.741s)
[355.985420] [033/142] (660s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[356.494505] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[356.501264] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[356.660059] [034/142] (659s left) gem_mmap_gtt (hang)
[357.031890] Subtest hang: SKIP (0.000s)
[357.143864] [035/142] (659s left) kms_vblank (crtc-id)
[357.625174] Starting subtest: crtc-id
[358.267057] Subtest crtc-id: SUCCESS (0.641s)
[359.211442] [036/142] (657s left) kms_chamelium_frames (dp-crc-multiple)
[360.102416] Subtest dp-crc-multiple: SKIP (0.000s)
[360.963997] [037/142] (655s left) gem_exec_balancer (noheartbeat)
[362.220926] Starting subtest: noheartbeat
[362.227848] Subtest noheartbeat: SKIP (0.001s)
[362.366261] [038/142] (654s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[362.780070] Starting subtest: 2x-absolute-wf_vblank-interruptible
[362.950629] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.167s)
[363.116667] [039/142] (653s left) gem_mmap_gtt (basic-small-bo)
[363.483985] Subtest basic-small-bo: SKIP (0.000s)
[363.593561] [040/142] (653s left) kms_lease (cursor_implicit_plane)
[364.080483] Starting subtest: cursor_implicit_plane
[364.084350] Starting dynamic subtest: pipe-A-eDP-1
[364.776336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[364.820276] Starting dynamic subtest: pipe-B-eDP-1
[366.138957] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[366.182826] Starting dynamic subtest: pipe-C-eDP-1
[367.797051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.647s)
[367.839848] Starting dynamic subtest: pipe-D-eDP-1
[369.752277] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.944s)
[369.755157] Subtest cursor_implicit_plane: SUCCESS (5.675s)
[370.694721] [041/142] (646s left) kms_flip (flip-vs-panning-vs-hang)
[371.086708] Starting subtest: flip-vs-panning-vs-hang
[371.099604] Starting dynamic subtest: A-eDP1
[412.495653] Dynamic subtest A-eDP1: SUCCESS (41.395s)
[412.518576] Starting dynamic subtest: D-eDP1
[453.448971] Dynamic subtest D-eDP1: SUCCESS (40.946s)
[453.461480] Subtest flip-vs-panning-vs-hang: SUCCESS (82.380s)
[455.051558] [042/142] (562s left) kms_sequence (queue-busy)
[455.530767] Starting subtest: queue-busy
[455.539864] Starting dynamic subtest: eDP-1-pipe-A
[457.764720] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.225s)
[457.809358] Starting dynamic subtest: eDP-1-pipe-B
[460.686384] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.907s)
[460.724889] Starting dynamic subtest: eDP-1-pipe-C
[463.832360] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.141s)
[463.876136] Starting dynamic subtest: eDP-1-pipe-D
[467.302723] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.462s)
[467.305762] Subtest queue-busy: SUCCESS (11.773s)
[468.247806] [043/142] (548s left) gem_ctx_bad_destroy (invalid-ctx)
[468.629921] Starting subtest: invalid-ctx
[468.633429] Subtest invalid-ctx: SUCCESS (0.000s)
[468.763468] [044/142] (548s left) syncobj_wait (wait-for-submit-delayed-submit)
[469.134143] Starting subtest: wait-for-submit-delayed-submit
[469.241693] Subtest wait-for-submit-delayed-submit: SUCCESS (0.106s)
[469.393237] [045/142] (547s left) gem_spin_batch (legacy-resubmit)
[469.822522] Starting subtest: legacy-resubmit
[469.825409] Starting dynamic subtest: default
[469.839795] Dynamic subtest default: SUCCESS (0.015s)
[469.886563] Starting dynamic subtest: render
[469.890066] Dynamic subtest render: SUCCESS (0.006s)
[469.932113] Starting dynamic subtest: bsd
[469.935565] Dynamic subtest bsd: SUCCESS (0.007s)
[469.971162] Starting dynamic subtest: bsd1
[469.974600] Dynamic subtest bsd1: SUCCESS (0.007s)
[470.009765] Starting dynamic subtest: bsd2
[470.013329] Dynamic subtest bsd2: SUCCESS (0.006s)
[470.056439] Starting dynamic subtest: blt
[470.059423] Dynamic subtest blt: SUCCESS (0.009s)
[470.094498] Starting dynamic subtest: vebox
[470.097544] Dynamic subtest vebox: SUCCESS (0.009s)
[470.100561] Subtest legacy-resubmit: SUCCESS (0.093s)
[471.689503] [046/142] (545s left) dumb_buffer (invalid-bpp)
[472.065566] Starting subtest: invalid-bpp
[472.069783] Subtest invalid-bpp: SUCCESS (0.000s)
[472.230217] [047/142] (545s left) kms_chamelium_edid (dp-edid-resolution-list)
[473.147720] Subtest dp-edid-resolution-list: SKIP (0.000s)
[474.013352] [048/142] (543s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[474.575103] Starting subtest: flip-vs-cursor-crc-atomic
[476.210226] Subtest flip-vs-cursor-crc-atomic: SUCCESS (1.635s)
[477.159520] [049/142] (540s left) syncobj_wait (invalid-signal-zero-handles)
[477.532122] Starting subtest: invalid-signal-zero-handles
[477.535619] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[477.679191] [050/142] (540s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[478.155314] Starting subtest: primary-yf-tiled-reflect-x-90
[478.167522] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.007s)
[478.310324] [051/142] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[478.815424] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[492.840354] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (14.031s)
[493.096245] [052/142] (524s left) kms_addfb_basic (invalid-set-prop-any)
[493.470344] Starting subtest: invalid-set-prop-any
[493.473713] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[493.721906] [053/142] (524s left) gem_lmem_swapping (parallel-random-verify-ccs)
[494.106215] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[494.217094] [054/142] (523s left) vc4/vc4_label_bo (set-bad-handle)
[494.661456] Subtest set-bad-handle: SKIP (0.000s)
[494.787757] [055/142] (523s left) kms_addfb_basic (unused-offsets)
[495.151882] Starting subtest: unused-offsets
[495.155117] Subtest unused-offsets: SUCCESS (0.000s)
[495.421437] [056/142] (522s left) i915_pm_rpm (gem-evict-pwrite)
[497.742777] Starting subtest: gem-evict-pwrite
[497.749828] Subtest gem-evict-pwrite: SKIP (0.000s)
[498.557666] [057/142] (519s left) gem_exec_schedule (u-submit-golden-slice)
[498.993145] Starting subtest: u-submit-golden-slice
[498.996750] Starting dynamic subtest: rcs0
[499.138462] Dynamic subtest rcs0: SUCCESS (0.142s)
[499.174751] Starting dynamic subtest: bcs0
[499.264582] Dynamic subtest bcs0: SUCCESS (0.122s)
[499.310148] Starting dynamic subtest: vcs0
[499.390925] Dynamic subtest vcs0: SUCCESS (0.122s)
[499.436690] Starting dynamic subtest: vcs1
[499.527391] Dynamic subtest vcs1: SUCCESS (0.131s)
[499.565847] Starting dynamic subtest: vecs0
[499.655897] Dynamic subtest vecs0: SUCCESS (0.125s)
[499.702768] Starting dynamic subtest: ccs0
[499.786354] Dynamic subtest ccs0: SUCCESS (0.126s)
[499.789960] Subtest u-submit-golden-slice: SUCCESS (0.795s)
[500.734542] [058/142] (517s left) kms_flip (flip-vs-panning)
[501.125357] Starting subtest: flip-vs-panning
[501.159770] Starting dynamic subtest: A-eDP1
[510.637796] Dynamic subtest A-eDP1: SUCCESS (9.482s)
[510.681137] Starting dynamic subtest: B-eDP1
[519.953040] Dynamic subtest B-eDP1: SUCCESS (9.310s)
[519.994866] Starting dynamic subtest: C-eDP1
[529.267262] Dynamic subtest C-eDP1: SUCCESS (9.309s)
[529.308905] Starting dynamic subtest: D-eDP1
[538.560521] Dynamic subtest D-eDP1: SUCCESS (9.288s)
[538.586538] Subtest flip-vs-panning: SUCCESS (37.464s)
[540.190140] [059/142] (478s left) kms_big_fb (linear-16bpp-rotate-270)
[540.719310] Starting subtest: linear-16bpp-rotate-270
[540.779889] Subtest linear-16bpp-rotate-270: SKIP (0.056s)
[540.958440] [060/142] (477s left) kms_cursor_edge_walk (256x256-right-edge)
[541.439813] Starting subtest: 256x256-right-edge
[541.448188] Starting dynamic subtest: pipe-A-eDP-1
[545.391879] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.944s)
[545.438326] Starting dynamic subtest: pipe-D-eDP-1
[548.871833] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.466s)
[548.875426] Subtest 256x256-right-edge: SUCCESS (7.431s)
[549.810855] [061/142] (468s left) gem_mmap_gtt (coherency)
[550.178660] Subtest coherency: SKIP (0.000s)
[550.293168] [062/142] (468s left) gem_exec_fair (basic-none-solo)
[550.701842] Subtest basic-none-solo: SKIP (0.000s)
[550.832359] [063/142] (467s left) gem_mmap_wc (bad-size)
[551.210813] Subtest bad-size: SKIP (0.000s)
[551.322268] [064/142] (467s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[551.794249] Starting subtest: pipe-B-wait-forked-busy-hang
[567.881150] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (16.091s)
[568.823324] [065/142] (450s left) i915_selftest (live)
[572.567796] Starting subtest: live
[572.571556] Starting dynamic subtest: sanitycheck
[576.713374] Dynamic subtest sanitycheck: SUCCESS (4.144s)
[576.741430] Starting dynamic subtest: uncore
[580.617110] Dynamic subtest uncore: SUCCESS (3.900s)
[580.645340] Starting dynamic subtest: workarounds
[585.530551] Dynamic subtest workarounds: SUCCESS (4.910s)
[585.561102] Starting dynamic subtest: gt_engines
[589.658545] Dynamic subtest gt_engines: SUCCESS (4.123s)
[589.684483] Starting dynamic subtest: gt_timelines
[607.662096] Dynamic subtest gt_timelines: SUCCESS (17.998s)
[607.690392] Starting dynamic subtest: gt_contexts
[611.684251] Dynamic subtest gt_contexts: SUCCESS (4.018s)
[611.711993] Starting dynamic subtest: gt_lrc
[617.652855] Dynamic subtest gt_lrc: SUCCESS (5.965s)
[617.681879] Starting dynamic subtest: gt_mocs
[622.306389] Dynamic subtest gt_mocs: SUCCESS (4.649s)
[622.346433] Starting dynamic subtest: gt_pm
[627.013440] Dynamic subtest gt_pm: SUCCESS (4.703s)
[627.042715] Starting dynamic subtest: gt_heartbeat
[631.018907] Dynamic subtest gt_heartbeat: SUCCESS (4.000s)
[631.047531] Starting dynamic subtest: gt_tlb
[636.894598] Dynamic subtest gt_tlb: SUCCESS (5.872s)
[636.922223] Starting dynamic subtest: requests
[674.306214] Dynamic subtest requests: SUCCESS (37.407s)
[674.333971] Starting dynamic subtest: migrate
[682.323323] Dynamic subtest migrate: SUCCESS (8.012s)
[682.350854] Starting dynamic subtest: active
[686.272209] Dynamic subtest active: SUCCESS (3.946s)
[686.300619] Starting dynamic subtest: objects
[693.077529] Dynamic subtest objects: SUCCESS (6.802s)
[693.107447] Starting dynamic subtest: mman
[701.151517] Dynamic subtest mman: SUCCESS (8.070s)
[701.180785] Starting dynamic subtest: dmabuf
[705.165743] Dynamic subtest dmabuf: SUCCESS (4.010s)
[705.195588] Starting dynamic subtest: vma
[708.958622] Dynamic subtest vma: SUCCESS (3.789s)
[708.986888] Starting dynamic subtest: coherency
[715.363580] Dynamic subtest coherency: SUCCESS (6.400s)
[715.391813] Starting dynamic subtest: gtt
[729.829479] Dynamic subtest gtt: SUCCESS (14.462s)
[729.857963] Starting dynamic subtest: gem
[735.936914] Dynamic subtest gem: SUCCESS (6.103s)
[735.964172] Starting dynamic subtest: evict
[742.423522] Dynamic subtest evict: SUCCESS (6.482s)
[742.452804] Starting dynamic subtest: hugepages
[752.408836] Dynamic subtest hugepages: SUCCESS (9.981s)
[752.438146] Starting dynamic subtest: gem_contexts
[799.367461] Dynamic subtest gem_contexts: SUCCESS (46.955s)
[799.398623] Starting dynamic subtest: client
[803.293147] Dynamic subtest client: SUCCESS (3.923s)
[803.322276] Starting dynamic subtest: gem_migrate
[807.055400] Dynamic subtest gem_migrate: SUCCESS (3.759s)
[807.084772] Starting dynamic subtest: reset
[811.007287] Dynamic subtest reset: SUCCESS (3.948s)
[811.039174] Starting dynamic subtest: memory_region
[814.525430] Dynamic subtest memory_region: SUCCESS (3.514s)
[814.557826] Starting dynamic subtest: hangcheck
[832.289620] Dynamic subtest hangcheck: SUCCESS (17.760s)
[832.319598] Starting dynamic subtest: execlists
[836.282253] Dynamic subtest execlists: SUCCESS (3.988s)
[836.312408] Starting dynamic subtest: ring_submission
[840.253738] Dynamic subtest ring_submission: SUCCESS (3.967s)
[840.282774] Starting dynamic subtest: perf
[844.381644] Dynamic subtest perf: SUCCESS (4.124s)
[844.413062] Starting dynamic subtest: slpc
[856.440148] Dynamic subtest slpc: SUCCESS (12.053s)
[856.469530] Starting dynamic subtest: guc
[862.333708] Dynamic subtest guc: SUCCESS (5.890s)
[862.363543] Starting dynamic subtest: guc_multi_lrc
[866.293428] Dynamic subtest guc_multi_lrc: SUCCESS (3.955s)
[866.336869] Starting dynamic subtest: guc_hang
[870.937904] Dynamic subtest guc_hang: SUCCESS (4.641s)
[870.964435] Starting dynamic subtest: late_gt_pm
[874.899939] Dynamic subtest late_gt_pm: SUCCESS (3.958s)
[874.903698] Subtest live: SUCCESS (302.335s)
[875.168313] [066/142] (143s left) kms_psr (psr2_basic)
[878.422802] Starting subtest: psr2_basic
[880.340635] Subtest psr2_basic: SUCCESS (1.917s)
[881.318507] [067/142] (137s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[881.745346] Starting subtest: plane-upscale-with-rotation-factor-0-25
[881.754357] Starting dynamic subtest: pipe-A-eDP-1
[882.711896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.960s)
[882.759296] Starting dynamic subtest: pipe-B-eDP-1
[884.946602] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.223s)
[884.994079] Starting dynamic subtest: pipe-C-eDP-1
[887.182915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.226s)
[887.228993] Starting dynamic subtest: pipe-D-eDP-1
[889.435257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[889.438801] Subtest plane-upscale-with-rotation-factor-0-25: SUCCESS (7.693s)
[891.241725] [068/142] (127s left) gem_exec_balancer (full-pulse)
[891.685301] Starting subtest: full-pulse
[900.187899] Subtest full-pulse: SUCCESS (8.502s)
[901.209208] [069/142] (118s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[902.767524] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[905.874493] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.107s)
[907.298152] [070/142] (112s left) kms_vblank (pipe-a-wait-busy)
[907.777282] Starting subtest: pipe-A-wait-busy
[909.855664] Subtest pipe-A-wait-busy: SUCCESS (2.077s)
[910.789683] [071/142] (108s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[911.300253] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[911.307064] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[911.466352] [072/142] (108s left) i915_pm_backlight (fade-with-suspend)
[911.942823] Starting subtest: fade-with-suspend
[928.918662] Starting dynamic subtest: eDP-1
[931.674069] Dynamic subtest eDP-1: SUCCESS (2.755s)
[931.676811] Subtest fade-with-suspend: SUCCESS (19.734s)
[932.662964] [073/142] ( 86s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[933.162821] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[941.886858] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (8.726s)
[942.085519] [074/142] ( 77s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[942.598284] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[942.602770] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[943.558990] [075/142] ( 76s left) prime_self_import (basic-with_fd_dup)
[943.932710] Starting subtest: basic-with_fd_dup
[943.950089] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[944.129881] [076/142] ( 75s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[944.599261] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[944.606308] Starting dynamic subtest: pipe-A-default-mode
[946.050266] Dynamic subtest pipe-A-default-mode: SKIP (1.440s)
[946.057397] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.454s)
[946.271144] [077/142] ( 73s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[946.649835] Starting subtest: multi-wait-all-for-submit-signaled
[946.652844] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.004s)
[946.799183] [078/142] ( 73s left) kms_universal_plane (universal-plane-pipe-b-functional)
[947.299648] Starting subtest: universal-plane-pipe-B-functional
[954.527751] Subtest universal-plane-pipe-B-functional: SUCCESS (7.235s)
[955.476593] [079/142] ( 64s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[956.025778] Starting subtest: y-tiled-16bpp-rotate-270
[956.032490] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[956.183814] [080/142] ( 64s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[956.694395] Starting subtest: fbc-rgb565-draw-blt
[968.462092] Subtest fbc-rgb565-draw-blt: SUCCESS (11.773s)
[968.805232] [081/142] ( 51s left) v3d/v3d_job_submission (threaded-job-submission)
[969.273392] Subtest threaded-job-submission: SKIP (0.000s)
[969.411683] [082/142] ( 50s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[970.685605] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[970.866099] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.180s)
[972.014426] [083/142] ( 48s left) gem_exec_reloc (basic-gtt-read)
[972.420487] Subtest basic-gtt-read: SKIP (0.000s)
[972.553431] [084/142] ( 48s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[973.067753] Starting subtest: psr-rgb565-draw-pwrite
[987.195801] Subtest psr-rgb565-draw-pwrite: SUCCESS (14.129s)
[987.504406] [085/142] ( 33s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[988.403303] Starting subtest: cursor-rapid-movement-128x128
[988.439749] Starting dynamic subtest: pipe-A-eDP-1
[989.702622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.265s)
[989.913129] Starting dynamic subtest: pipe-D-eDP-1
[992.513587] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.645s)
[992.517225] Subtest cursor-rapid-movement-128x128: SUCCESS (4.108s)
[993.606310] [086/142] ( 27s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[995.053736] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[995.062878] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[995.981299] [087/142] ( 24s left) gem_mmap_gtt (big-bo-tiledx)
[996.348692] Subtest big-bo-tiledX: SKIP (0.000s)
[996.472114] [088/142] ( 24s left) gem_exec_fence (syncobj-timeline-signal)
[998.608511] Starting subtest: syncobj-timeline-signal
[998.630218] Subtest syncobj-timeline-signal: SUCCESS (0.023s)
[998.908694] [089/142] ( 22s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[999.286169] Starting subtest: invalid-single-wait-all-unsubmitted
[999.289565] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[999.456731] [090/142] ( 21s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[999.963118] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[999.968972] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[1000.137111] [091/142] ( 21s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[1002.773198] Starting subtest: dpms-mode-unset-non-lpsp
[1006.362948] Subtest dpms-mode-unset-non-lpsp: SKIP (3.586s)
[1007.294374] [092/142] ( 13s left) kms_psr (sprite_render)
[1007.786122] Starting subtest: sprite_render
[1010.199447] Subtest sprite_render: SUCCESS (2.409s)
[1011.146819] [093/142] ( 10s left) kms_atomic (crtc-invalid-params)
[1011.958098] Starting subtest: crtc-invalid-params
[1012.093261] Subtest crtc-invalid-params: SUCCESS (0.136s)
[1013.490599] [094/142] (  7s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[1013.966130] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[1013.975748] Starting dynamic subtest: pipe-A-default-mode
[1015.479177] Dynamic subtest pipe-A-default-mode: SKIP (1.494s)
[1015.485895] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.508s)
[1015.764710] [095/142] (  5s left) api_intel_bb (blit-noreloc-purge-cache)
[1016.139415] Starting subtest: blit-noreloc-purge-cache
[1016.177534] Subtest blit-noreloc-purge-cache: SUCCESS (0.041s)
[1016.344447] [096/142] (  5s left) gem_exec_fence (basic-busy-all)
[1016.758198] Starting subtest: basic-busy-all
[1016.851804] Subtest basic-busy-all: SUCCESS (0.093s)
[1018.737898] [097/142] (  3s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[1019.117190] Starting subtest: yf-tiled-ccs-to-yf-tiled
[1019.123448] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[1019.381323] [098/142] (  2s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[1019.926726] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[1029.374968] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (9.454s)
[1029.662189] Overall timeout time exceeded, stopping.
[1029.663682] Closing watchdogs
Done.