[45.981795] Initializing watchdogs
[45.981875]   /dev/watchdog0
[45.988102] [001/142] (960s left) gem_userptr_blits (sd-probe)
[46.071268] Starting subtest: sd-probe
[46.072804] Subtest sd-probe: SKIP (0.000s)
[46.190485] [002/142] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[48.180707] Starting subtest: 4-tiled-32bpp-rotate-270
[48.182605] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[48.254596] [003/142] (958s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[50.556965] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[50.558699] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[50.737326] [004/142] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[52.719389] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[52.721087] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[52.803375] [005/142] (953s left) kms_fbcon_fbt (psr)
[52.875466] Starting subtest: psr
[52.877131] Subtest psr: SKIP (0.000s)
[52.950225] [006/142] (953s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[55.347167] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[57.202453] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (1.855s)
[57.380310] [007/142] (949s left) kms_flip (flip-vs-suspend)
[58.403265] Starting subtest: flip-vs-suspend
[58.409375] Starting dynamic subtest: A-HDMI-A1
[100.146550] Dynamic subtest A-HDMI-A1: SUCCESS (17.790s)
[100.153599] Starting dynamic subtest: B-HDMI-A1
[142.133936] Dynamic subtest B-HDMI-A1: SUCCESS (17.377s)
[142.141280] Starting dynamic subtest: C-HDMI-A1
[184.102530] Dynamic subtest C-HDMI-A1: SUCCESS (17.301s)
[184.109590] Starting dynamic subtest: D-HDMI-A1
[226.112462] Dynamic subtest D-HDMI-A1: SUCCESS (17.307s)
[226.116733] Subtest flip-vs-suspend: SUCCESS (69.788s)
[233.267418] [008/142] (878s left) gem_fence_thrash (bo-copy)
[233.335331] Starting subtest: bo-copy
[233.339377] Subtest bo-copy: SKIP (0.002s)
[233.359945] [009/142] (878s left) gem_mmap_offset (blt-coherency)
[233.427373] Starting subtest: blt-coherency
[233.447323] Subtest blt-coherency: SUCCESS (0.020s)
[233.550141] [010/142] (877s left) kms_flip (dpms-off-confusion-interruptible)
[234.583365] Starting subtest: dpms-off-confusion-interruptible
[234.590512] Starting dynamic subtest: A-HDMI-A1
[242.328065] Dynamic subtest A-HDMI-A1: SUCCESS (7.737s)
[242.334339] Starting dynamic subtest: B-HDMI-A1
[250.005273] Dynamic subtest B-HDMI-A1: SUCCESS (7.677s)
[250.011859] Starting dynamic subtest: C-HDMI-A1
[257.677213] Dynamic subtest C-HDMI-A1: SUCCESS (7.671s)
[257.683759] Starting dynamic subtest: D-HDMI-A1
[265.342363] Dynamic subtest D-HDMI-A1: SUCCESS (7.664s)
[265.346912] Subtest dpms-off-confusion-interruptible: SUCCESS (30.763s)
[265.482921] [011/142] (846s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[267.471712] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[267.964319] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.493s)
[268.099208] [012/142] (843s left) gem_exec_flush (basic-batch-kernel-default-uc)
[268.172161] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[268.223934] [013/142] (843s left) syncobj_wait (single-wait-signaled)
[268.294182] Starting subtest: single-wait-signaled
[268.295094] Subtest single-wait-signaled: SUCCESS (0.000s)
[268.348025] [014/142] (843s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs)
[270.572832] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs
[270.574598] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[270.849783] [015/142] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[272.834009] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[272.835945] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[272.916438] [016/142] (838s left) gem_mmap_gtt (basic-write-read-distinct)
[272.985344] Subtest basic-write-read-distinct: SKIP (0.000s)
[273.009795] [017/142] (838s left) gem_ctx_create (basic)
[273.087187] Starting subtest: basic
[273.088168] Subtest basic: SUCCESS (0.000s)
[273.300302] [018/142] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[275.282157] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[275.284170] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[275.348746] [019/142] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[277.328882] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[277.330866] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[277.415437] [020/142] (834s left) kms_display_modes (mst-extended-mode-negative)
[279.391599] Starting subtest: mst-extended-mode-negative
[279.394309] Subtest mst-extended-mode-negative: SKIP (0.000s)
[279.425458] [021/142] (832s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[281.457790] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[281.514810] [022/142] (830s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_mc_ccs)
[283.649399] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs
[283.651272] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[284.032849] [023/142] (827s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[286.018744] Starting subtest: fbc-rgb565-draw-render
[290.081982] Subtest fbc-rgb565-draw-render: SUCCESS (4.066s)
[290.198571] [024/142] (821s left) drm_fdinfo (virtual-busy-idle)
[290.273849] Subtest virtual-busy-idle: SKIP (0.000s)
[290.308516] [025/142] (821s left) kms_busy (basic-hang)
[292.293137] Starting subtest: basic-hang
[292.296067] Starting dynamic subtest: flip-pipe-A
[293.287854] Dynamic subtest flip-pipe-A: SUCCESS (0.992s)
[293.295311] Starting dynamic subtest: modeset-pipe-A
[294.394787] Dynamic subtest modeset-pipe-A: SUCCESS (1.105s)
[294.412743] Starting dynamic subtest: flip-pipe-D
[295.904771] Dynamic subtest flip-pipe-D: SUCCESS (1.498s)
[295.911682] Starting dynamic subtest: modeset-pipe-D
[297.599356] Dynamic subtest modeset-pipe-D: SUCCESS (1.694s)
[297.600408] Subtest basic-hang: SUCCESS (5.307s)
[297.754292] [026/142] (814s left) i915_pm_dc (dc5-psr)
[300.736052] Starting subtest: dc5-psr
[300.738056] Subtest dc5-psr: SKIP (0.000s)
[300.986494] [027/142] (810s left) kms_plane_alpha_blend (coverage-7efc)
[302.965645] Starting subtest: coverage-7efc
[303.193138] Starting dynamic subtest: pipe-A-HDMI-A-1
[303.608943] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.415s)
[303.632233] Starting dynamic subtest: pipe-D-HDMI-A-1
[304.129076] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.504s)
[304.130061] Subtest coverage-7efc: SUCCESS (1.165s)
[304.275548] [028/142] (807s left) kms_cdclk (mode-transition)
[304.346399] Subtest mode-transition: SKIP (0.000s)
[304.368902] [029/142] (807s left) perf_pmu (idle)
[304.440407] Starting subtest: idle
[304.441298] Starting dynamic subtest: rcs0
[304.986927] Dynamic subtest rcs0: SUCCESS (0.543s)
[304.994179] Starting dynamic subtest: bcs0
[305.497482] Dynamic subtest bcs0: SUCCESS (0.509s)
[305.504590] Starting dynamic subtest: vcs0
[306.010841] Dynamic subtest vcs0: SUCCESS (0.510s)
[306.017814] Starting dynamic subtest: vcs1
[306.519430] Dynamic subtest vcs1: SUCCESS (0.510s)
[306.526289] Starting dynamic subtest: vecs0
[307.031578] Dynamic subtest vecs0: SUCCESS (0.511s)
[307.032464] Subtest idle: SUCCESS (2.589s)
[307.092600] [030/142] (804s left) feature_discovery (psr1)
[309.071825] Starting subtest: psr1
[309.073761] Subtest psr1: SKIP (0.000s)
[309.141947] [031/142] (802s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[311.118406] Starting subtest: flip-vs-cursor-toggle
[320.810452] Subtest flip-vs-cursor-toggle: SUCCESS (9.694s)
[320.948150] [032/142] (790s left) gem_exec_reloc (basic-cpu-read-active)
[321.022872] Subtest basic-cpu-read-active: SKIP (0.000s)
[321.074116] [033/142] (790s left) gem_lmem_swapping (verify-random)
[324.060405] Starting subtest: verify-random
[324.062816] Starting dynamic subtest: lmem0
[332.838119] Dynamic subtest lmem0: SUCCESS (8.773s)
[332.839219] Subtest verify-random: SUCCESS (8.775s)
[335.151473] [034/142] (776s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[340.151362] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[340.152348] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.264109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.112s)
[340.272708] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.386728] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.120s)
[340.395175] Starting dynamic subtest: pipe-C-HDMI-A-1
[340.510113] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.121s)
[340.518558] Starting dynamic subtest: pipe-D-HDMI-A-1
[340.632451] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.120s)
[340.633402] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.484s)
[341.685235] [035/142] (770s left) gem_exec_balancer (parallel-contexts)
[341.992271] Starting subtest: parallel-contexts
[345.209519] Subtest parallel-contexts: SUCCESS (3.214s)
[345.472904] [036/142] (766s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_mc_ccs)
[347.798464] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs
[347.800151] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[347.964704] [037/142] (764s left) gem_exec_reloc (basic-wc-gtt-active)
[348.038801] Subtest basic-wc-gtt-active: SKIP (0.000s)
[348.107580] [038/142] (763s left) kms_cursor_crc (cursor-onscreen-64x64)
[350.169215] Starting subtest: cursor-onscreen-64x64
[350.176228] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.900909] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.724s)
[352.931870] Starting dynamic subtest: pipe-D-HDMI-A-1
[356.204967] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.284s)
[356.205873] Subtest cursor-onscreen-64x64: SUCCESS (6.036s)
[356.599124] [039/142] (755s left) kms_selftest (drm_damage)
[356.668183] Starting subtest: drm_damage
[356.671379] Subtest drm_damage: SKIP (0.001s)
[356.714220] [040/142] (755s left) gem_exec_whisper (basic-contexts-forked)
[356.793826] Starting subtest: basic-contexts-forked
[379.071172] Subtest basic-contexts-forked: SUCCESS (22.273s)
[379.261332] [041/142] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[381.245175] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[381.247055] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[381.327435] [042/142] (730s left) kms_ccs (pipe-b-crc-primary-basic-yf_tiled_ccs)
[383.462432] Starting subtest: pipe-B-crc-primary-basic-yf_tiled_ccs
[383.464207] Subtest pipe-B-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[383.826467] [043/142] (728s left) gem_vm_create (isolation)
[383.898786] Starting subtest: isolation
[383.908570] Subtest isolation: SUCCESS (0.010s)
[384.009814] [044/142] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[385.990415] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[385.992517] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[386.076381] [045/142] (726s left) kms_vblank (pipe-d-wait-idle-hang)
[388.056344] Starting subtest: pipe-D-wait-idle-hang
[402.792620] Subtest pipe-D-wait-idle-hang: SUCCESS (14.737s)
[402.908579] [046/142] (709s left) gem_ctx_isolation (preservation-reset)
[403.095678] Starting subtest: preservation-reset
[403.096643] Starting dynamic subtest: rcs0
[403.614524] Dynamic subtest rcs0: SUCCESS (0.518s)
[403.622585] Starting dynamic subtest: bcs0
[404.257527] Dynamic subtest bcs0: SUCCESS (0.642s)
[404.265506] Starting dynamic subtest: vcs0
[404.856513] Dynamic subtest vcs0: SUCCESS (0.598s)
[404.864765] Starting dynamic subtest: vcs1
[405.465733] Dynamic subtest vcs1: SUCCESS (0.608s)
[405.473826] Starting dynamic subtest: vecs0
[406.035073] Dynamic subtest vecs0: SUCCESS (0.568s)
[406.036031] Subtest preservation-reset: SUCCESS (2.940s)
[406.224517] [047/142] (705s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[406.294801] Starting subtest: wait-all-for-submit-delayed-submit
[406.404484] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[406.491377] [048/142] (705s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[408.465362] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[408.467355] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[408.542021] [049/142] (703s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[411.133006] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[411.190772] [050/142] (700s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[413.173871] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[413.175866] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.257530] [051/142] (698s left) kms_flip (2x-plain-flip)
[414.285556] Starting subtest: 2x-plain-flip
[414.316123] Subtest 2x-plain-flip: SKIP (0.031s)
[414.391683] [052/142] (697s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[414.461464] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[414.462339] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[414.523347] [053/142] (697s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[414.591478] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[414.697235] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[414.776174] [054/142] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[416.759938] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[416.761683] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[416.856741] [055/142] (695s left) kms_atomic (atomic-invalid-params)
[419.054483] Starting subtest: atomic-invalid-params
[419.155814] Subtest atomic-invalid-params: SUCCESS (0.100s)
[419.335591] [056/142] (692s left) perf (mi-rpc)
[419.479733] Starting subtest: mi-rpc
[419.481390] Subtest mi-rpc: SKIP (0.000s)
[419.517332] [057/142] (692s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[421.794147] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[421.795139] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[422.018272] [058/142] (690s left) v3d/v3d_perfmon (create-perfmon-exceed)
[422.118484] Subtest create-perfmon-exceed: SKIP (0.000s)
[422.169318] [059/142] (690s left) gem_ctx_sseu (engines)
[422.241899] Subtest engines: SKIP (0.000s)
[422.279086] [060/142] (690s left) i915_suspend (basic-s3-without-i915)
[422.345454] Starting subtest: basic-s3-without-i915
[445.517654] Subtest basic-s3-without-i915: SUCCESS (11.365s)
[450.489525] [061/142] (676s left) syncobj_timeline (single-wait-all-available-submitted)
[450.561155] Starting subtest: single-wait-all-available-submitted
[450.562132] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[450.631703] [062/142] (676s left) gem_exec_params (readonly)
[450.708198] Starting subtest: readonly
[450.712682] Subtest readonly: SUCCESS (0.004s)
[450.797974] [063/142] (676s left) gem_exec_schedule (noreorder)
[450.996606] Starting subtest: noreorder
[450.997542] Starting dynamic subtest: rcs0
[451.052391] Dynamic subtest rcs0: SUCCESS (0.058s)
[451.060778] Starting dynamic subtest: bcs0
[451.089383] Dynamic subtest bcs0: SUCCESS (0.036s)
[451.099616] Starting dynamic subtest: vcs0
[451.134439] Dynamic subtest vcs0: SUCCESS (0.044s)
[451.148758] Starting dynamic subtest: vcs1
[451.170879] Dynamic subtest vcs1: SUCCESS (0.034s)
[451.187137] Starting dynamic subtest: vecs0
[451.221546] Dynamic subtest vecs0: SUCCESS (0.049s)
[451.222645] Subtest noreorder: SUCCESS (0.229s)
[451.448772] [064/142] (675s left) gen9_exec_parse (secure-batches)
[451.521395] Subtest secure-batches: SKIP (0.000s)
[451.558020] [065/142] (675s left) syncobj_wait (wait-all-snapshot)
[451.627651] Starting subtest: wait-all-snapshot
[451.708930] Subtest wait-all-snapshot: SUCCESS (0.082s)
[451.798014] [066/142] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[453.773278] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[453.775307] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[453.848020] [067/142] (673s left) gem_exec_reloc (basic-gtt-read-active)
[453.921494] Subtest basic-gtt-read-active: SKIP (0.000s)
[453.974454] [068/142] (673s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[455.955932] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[457.194388] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (1.239s)
[457.332936] [069/142] (669s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[459.315822] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[459.317647] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[459.399585] [070/142] (667s left) kms_invalid_mode (bad-hsync-start)
[461.378696] Starting subtest: bad-hsync-start
[461.379621] Starting dynamic subtest: HDMI-A-1-pipe-A
[461.440931] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.061s)
[461.449868] Starting dynamic subtest: HDMI-A-1-pipe-B
[461.468052] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.024s)
[461.478466] Starting dynamic subtest: HDMI-A-1-pipe-C
[461.496061] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.024s)
[461.508645] Starting dynamic subtest: HDMI-A-1-pipe-D
[461.524695] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.024s)
[461.525679] Subtest bad-hsync-start: SUCCESS (0.147s)
[461.632112] [071/142] (665s left) vgem_basic (mmap)
[461.747996] Starting subtest: mmap
[461.756293] Subtest mmap: SUCCESS (0.009s)
[461.798448] [072/142] (665s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[464.003065] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[464.007336] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.003s)
[464.311235] [073/142] (663s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[466.303913] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[466.305665] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[466.394503] [074/142] (660s left) kms_color (ctm-blue-to-red)
[468.376240] Starting subtest: ctm-blue-to-red
[468.377121] Starting dynamic subtest: pipe-A
[469.414315] Dynamic subtest pipe-A: SUCCESS (1.039s)
[469.421718] Starting dynamic subtest: pipe-B
[470.250089] Dynamic subtest pipe-B: SUCCESS (0.834s)
[470.262672] Starting dynamic subtest: pipe-C
[471.469201] Dynamic subtest pipe-C: SUCCESS (1.218s)
[471.478877] Starting dynamic subtest: pipe-D
[473.071898] Dynamic subtest pipe-D: SUCCESS (1.602s)
[473.072968] Subtest ctm-blue-to-red: SUCCESS (4.698s)
[473.192920] [075/142] (654s left) kms_getfb (getfb2-handle-closed)
[473.264480] Starting subtest: getfb2-handle-closed
[473.265398] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[473.359133] [076/142] (654s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[475.386587] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[475.388457] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[475.876304] [077/142] (651s left) kms_psr (psr2_cursor_mmap_cpu)
[475.946177] Subtest psr2_cursor_mmap_cpu: SKIP (0.000s)
[475.968818] [078/142] (651s left) sysfs_timeslice_duration (idempotent)
[476.041641] Starting subtest: idempotent
[476.042602] Starting dynamic subtest: vecs0
[476.043546] Dynamic subtest vecs0: SUCCESS (0.000s)
[476.051105] Starting dynamic subtest: vcs0
[476.051981] Dynamic subtest vcs0: SUCCESS (0.000s)
[476.059133] Starting dynamic subtest: bcs0
[476.060029] Dynamic subtest bcs0: SUCCESS (0.000s)
[476.067096] Starting dynamic subtest: rcs0
[476.068006] Dynamic subtest rcs0: SUCCESS (0.000s)
[476.075107] Starting dynamic subtest: vcs1
[476.075986] Dynamic subtest vcs1: SUCCESS (0.000s)
[476.076837] Subtest idempotent: SUCCESS (0.008s)
[476.125907] [079/142] (651s left) kms_force_connector_basic (force-connector-state)
[476.279920] Starting subtest: force-connector-state
[480.140723] Subtest force-connector-state: SUCCESS (3.861s)
[482.368734] [080/142] (645s left) gem_exec_schedule (u-fairslice)
[482.449868] Starting subtest: u-fairslice
[482.450761] Starting dynamic subtest: rcs0
[484.477853] Dynamic subtest rcs0: SUCCESS (2.028s)
[484.485561] Starting dynamic subtest: bcs0
[486.495732] Dynamic subtest bcs0: SUCCESS (2.017s)
[486.503401] Starting dynamic subtest: vcs0
[488.512972] Dynamic subtest vcs0: SUCCESS (2.015s)
[488.520726] Starting dynamic subtest: vcs1
[490.529506] Dynamic subtest vcs1: SUCCESS (2.016s)
[490.537223] Starting dynamic subtest: vecs0
[492.547571] Dynamic subtest vecs0: SUCCESS (2.017s)
[492.548429] Subtest u-fairslice: SUCCESS (10.098s)
[492.866932] [081/142] (634s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[495.140233] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[495.141941] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[495.381913] [082/142] (632s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[497.361981] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[497.363041] Starting dynamic subtest: pipe-A-valid-mode
[497.406366] Dynamic subtest pipe-A-valid-mode: SKIP (0.041s)
[497.408220] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.043s)
[497.497226] [083/142] (630s left) perf (low-oa-exponent-permissions)
[497.624016] Starting subtest: low-oa-exponent-permissions
[497.678624] Subtest low-oa-exponent-permissions: SUCCESS (0.055s)
[497.713544] [084/142] (629s left) debugfs_test (basic-hwmon)
[497.787793] Starting subtest: basic-hwmon
[497.799153] Subtest basic-hwmon: SUCCESS (0.011s)
[499.780865] [085/142] (627s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[499.856467] Starting subtest: mixed-tiled-to-y-tiled-ccs
[499.857307] Starting dynamic subtest: smem
[499.951839] Dynamic subtest smem: SUCCESS (0.095s)
[499.959801] Starting dynamic subtest: lmem0
[500.899289] Dynamic subtest lmem0: SUCCESS (0.943s)
[500.900249] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.040s)
[501.097976] [086/142] (626s left) kms_big_fb (linear-addfb)
[503.086550] Starting subtest: linear-addfb
[503.087438] Subtest linear-addfb: SUCCESS (0.000s)
[503.179792] [087/142] (624s left) kms_lease (master-vs-lease)
[505.155360] Starting subtest: master-vs-lease
[505.156344] Subtest master-vs-lease: SUCCESS (0.001s)
[505.213412] [088/142] (622s left) kms_setmode (invalid-clone-single-crtc)
[505.282993] Starting subtest: invalid-clone-single-crtc
[505.285443] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[505.346382] [089/142] (622s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[507.326604] Starting subtest: primary-x-tiled-reflect-x-180
[516.708082] Subtest primary-x-tiled-reflect-x-180: SUCCESS (9.384s)
[516.892247] [090/142] (610s left) gem_eio (create-ext)
[517.111858] Starting subtest: create-ext
[517.413711] Subtest create-ext: SUCCESS (0.302s)
[519.500889] [091/142] (608s left) gem_sync (basic-store-each)
[519.579530] Starting subtest: basic-store-each
[522.317274] Subtest basic-store-each: SUCCESS (2.737s)
[522.524757] [092/142] (605s left) kms_atomic_transition (plane-all-transition-nonblocking)
[524.503749] Starting subtest: plane-all-transition-nonblocking
[524.506150] Starting dynamic subtest: pipe-A-HDMI-A-1
[528.320802] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.816s)
[528.388974] Starting dynamic subtest: pipe-B-HDMI-A-1
[532.269010] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.887s)
[532.309720] Subtest plane-all-transition-nonblocking: SUCCESS (7.807s)
[532.424778] [093/142] (595s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[534.416828] Starting subtest: yf-tiled-16bpp-rotate-180
[534.418505] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[534.508899] [094/142] (593s left) gem_ctx_param (invalid-param-set)
[534.577129] Starting subtest: invalid-param-set
[534.578023] Subtest invalid-param-set: SUCCESS (0.000s)
[534.641577] [095/142] (593s left) gem_ctx_param (get-priority-new-ctx)
[534.708966] Starting subtest: get-priority-new-ctx
[534.709790] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[534.774605] [096/142] (592s left) gem_fence_thrash (bo-write-verify-threaded-none)
[534.841840] Starting subtest: bo-write-verify-threaded-none
[534.845624] Subtest bo-write-verify-threaded-none: SKIP (0.002s)
[534.884659] [097/142] (592s left) gem_ctx_bad_destroy (double-destroy)
[534.954196] Starting subtest: double-destroy
[534.955144] Subtest double-destroy: SUCCESS (0.000s)
[535.024226] [098/142] (592s left) gem_userptr_blits (create-destroy-sync)
[535.106918] Starting subtest: create-destroy-sync
[540.140723] Subtest create-destroy-sync: SUCCESS (5.031s)
[540.239696] [099/142] (587s left) gem_basic (create-close)
[540.309041] Starting subtest: create-close
[540.310811] Subtest create-close: SUCCESS (0.000s)
[540.389934] [100/142] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[542.377805] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[542.379503] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[542.456685] [101/142] (585s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[544.442545] Starting subtest: fbc-rgb101010-draw-pwrite
[548.269780] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.830s)
[548.389540] [102/142] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[550.378028] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[550.379624] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[550.455423] [103/142] (577s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[552.446876] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[553.535960] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.089s)
[553.655350] [104/142] (574s left) kms_rotation_crc (bad-tiling)
[555.632795] Starting subtest: bad-tiling
[558.809224] Subtest bad-tiling: SUCCESS (3.177s)
[558.951129] [105/142] (568s left) gem_create (create-ext-cpu-access-sanity-check)
[559.139937] Starting subtest: create-ext-cpu-access-sanity-check
[559.143293] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.006s)
[559.233603] [106/142] (568s left) i915_pm_rpm (system-suspend-modeset)
[564.216507] Starting subtest: system-suspend-modeset
[592.584225] Subtest system-suspend-modeset: SUCCESS (16.445s)
[594.618302] [107/142] (546s left) kms_properties (invalid-properties-legacy)
[596.599865] Starting subtest: invalid-properties-legacy
[597.102349] Subtest invalid-properties-legacy: SUCCESS (0.500s)
[597.160660] [108/142] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[599.142231] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[599.144244] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[599.226506] [109/142] (541s left) kms_content_protection (srm)
[601.254591] Starting subtest: srm
[601.528120] Subtest srm: SKIP (0.272s)
[601.686144] [110/142] (539s left) vc4/vc4_wait_bo (unused-bo-1ns)
[601.800733] Subtest unused-bo-1ns: SKIP (0.000s)
[601.851828] [111/142] (538s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[603.841558] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[607.680990] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.843s)
[607.800886] [112/142] (533s left) gem_eio (wait-wedge-10ms)
[608.019757] Starting subtest: wait-wedge-10ms
[609.895862] Subtest wait-wedge-10ms: SUCCESS (1.877s)
[611.977327] [113/142] (528s left) kms_cursor_crc (cursor-sliding-128x42)
[614.096566] Starting subtest: cursor-sliding-128x42
[614.101857] Starting dynamic subtest: pipe-A-HDMI-A-1
[618.203541] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.102s)
[618.233127] Starting dynamic subtest: pipe-D-HDMI-A-1
[622.871813] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.648s)
[622.872742] Subtest cursor-sliding-128x42: SUCCESS (8.778s)
[623.163968] [114/142] (517s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[623.236244] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[623.341008] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[623.395694] [115/142] (517s left) gem_lmem_swapping (massive-random)
[626.189106] Starting subtest: massive-random
[626.189890] Starting dynamic subtest: lmem0
[626.583277] Dynamic subtest lmem0: SUCCESS (0.394s)
[626.584051] Subtest massive-random: SUCCESS (0.395s)
[629.131934] [116/142] (511s left) gem_exec_flush (basic-wb-rw-default)
[630.635468] Subtest basic-wb-rw-default: SKIP (0.000s)
[632.529000] [117/142] (508s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[632.619737] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[632.670582] [118/142] (508s left) gem_ctx_persistence (engines-mixed-process)
[632.753977] Starting subtest: engines-mixed-process
[632.754846] Starting dynamic subtest: rcs0
[633.914097] Dynamic subtest rcs0: SUCCESS (1.159s)
[633.924087] Starting dynamic subtest: bcs0
[635.966272] Dynamic subtest bcs0: SUCCESS (2.051s)
[635.976588] Starting dynamic subtest: vcs0
[637.938083] Dynamic subtest vcs0: SUCCESS (1.970s)
[637.947838] Starting dynamic subtest: vcs1
[639.925177] Dynamic subtest vcs1: SUCCESS (1.986s)
[639.936859] Starting dynamic subtest: vecs0
[641.918241] Dynamic subtest vecs0: SUCCESS (1.992s)
[641.919337] Subtest engines-mixed-process: SUCCESS (9.165s)
[641.985991] [119/142] (499s left) api_intel_bb (crc32)
[642.054528] Starting subtest: crc32
[642.056164] Subtest crc32: SKIP (0.000s)
[642.135500] [120/142] (498s left) gem_exec_fair (basic-deadline)
[642.213975] Subtest basic-deadline: SKIP (0.000s)
[642.263625] [121/142] (498s left) gem_exec_fence (syncobj-timeline-export)
[642.895548] Starting subtest: syncobj-timeline-export
[642.912275] Subtest syncobj-timeline-export: SUCCESS (0.020s)
[643.126008] [122/142] (497s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[645.105168] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[645.107509] Starting dynamic subtest: pipe-A-HDMI-A-1
[645.151218] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.043s)
[645.161265] Starting dynamic subtest: pipe-B-HDMI-A-1
[645.187721] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.034s)
[645.197968] Starting dynamic subtest: pipe-C-HDMI-A-1
[645.224299] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.033s)
[645.234173] Starting dynamic subtest: pipe-D-HDMI-A-1
[645.260428] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.033s)
[645.262092] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.155s)
[645.369831] [123/142] (495s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[647.347751] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[647.348681] Starting dynamic subtest: pipe-A-valid-mode
[648.007148] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.659s)
[648.008213] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.662s)
[648.144859] [124/142] (492s left) kms_chamelium_frames (hdmi-crc-fast)
[650.167624] Subtest hdmi-crc-fast: SKIP (0.000s)
[650.230215] [125/142] (490s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[650.299552] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[650.300355] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[650.367159] [126/142] (490s left) v3d/v3d_submit_csd (job-perfmon)
[650.481952] Subtest job-perfmon: SKIP (0.000s)
[650.533284] [127/142] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[652.511568] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[652.513426] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[652.600372] [128/142] (488s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[654.642754] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[654.644421] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[655.095085] [129/142] (486s left) v3d/v3d_wait_bo (used-bo)
[655.211188] Subtest used-bo: SKIP (0.000s)
[655.263334] [130/142] (485s left) i915_pm_rpm (fences)
[660.022002] Starting subtest: fences
[660.024036] Subtest fences: SKIP (0.000s)
[661.162122] [131/142] (480s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[663.150715] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[663.152796] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[663.245318] [132/142] (477s left) kms_prime (basic-crc-vgem)
[665.539322] Subtest basic-crc-vgem: SKIP (0.000s)
[665.611047] [133/142] (475s left) prime_vgem (basic-blt)
[665.698674] Starting subtest: basic-blt
[665.735879] Subtest basic-blt: SUCCESS (0.037s)
[665.844169] [134/142] (475s left) api_intel_allocator (reloc-allocator)
[665.913563] Starting subtest: reloc-allocator
[665.914505] Starting dynamic subtest: basic
[665.927368] Dynamic subtest basic: SUCCESS (0.014s)
[665.937641] Starting dynamic subtest: parallel-one
[665.938495] Dynamic subtest parallel-one: SUCCESS (0.006s)
[665.946884] Starting dynamic subtest: print
[665.947679] Dynamic subtest print: SUCCESS (0.000s)
[665.955787] Starting dynamic subtest: reuse
[665.956627] Dynamic subtest reuse: SUCCESS (0.000s)
[665.965152] Starting dynamic subtest: fork-reopen-allocator
[665.965961] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[665.966756] Subtest reloc-allocator: SUCCESS (0.043s)
[666.044660] [135/142] (475s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[668.017025] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[699.182837] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.166s)
[699.304533] [136/142] (441s left) kms_vblank (pipe-b-query-busy-hang)
[701.282701] Starting subtest: pipe-B-query-busy-hang
[715.536556] Subtest pipe-B-query-busy-hang: SUCCESS (14.253s)
[715.662931] [137/142] (425s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[715.737811] Starting subtest: y-tiled-to-vebox-y-tiled
[715.738810] Starting dynamic subtest: smem
[715.814979] Dynamic subtest smem: SUCCESS (0.076s)
[715.825048] Starting dynamic subtest: lmem0
[716.568294] Dynamic subtest lmem0: SUCCESS (0.749s)
[716.569258] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.828s)
[716.779952] [138/142] (424s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[718.834209] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[718.839331] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[719.276299] [139/142] (422s left) kms_vblank (pipe-b-wait-idle)
[721.248243] Starting subtest: pipe-B-wait-idle
[723.876296] Subtest pipe-B-wait-idle: SUCCESS (2.628s)
[723.981489] [140/142] (417s left) syncobj_basic (test-valid-cycle)
[724.049734] Starting subtest: test-valid-cycle
[724.050578] Subtest test-valid-cycle: SUCCESS (0.000s)
[724.114445] [141/142] (417s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[726.091301] Starting subtest: pipe-A-wait-forked-busy-hang
[740.515417] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.425s)
[740.635910] [142/142] (400s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs)
[742.788858] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs
[742.792064] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[743.135931] Closing watchdogs
Done.