[33.566961] Initializing watchdogs [33.567017] /dev/watchdog0 [33.571201] [001/138] (960s left) gem_eio (in-flight-immediate) [33.616568] Starting subtest: in-flight-immediate [35.462343] Subtest in-flight-immediate: SUCCESS (1.846s) [35.590405] [002/138] (958s left) kms_ccs (pipe-d-bad-rotation-90-yf-tiled-ccs) [35.736246] Subtest pipe-D-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s) [35.832473] [003/138] (958s left) gem_mmap_gtt (flink-race) [35.879656] Starting subtest: flink-race [55.949583] Subtest flink-race: SUCCESS (20.070s) [56.063263] [004/138] (938s left) perf (mi-rpc) [56.210545] Starting subtest: mi-rpc [56.211908] Subtest mi-rpc: SKIP (0.000s) [56.234398] [005/138] (937s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [56.369215] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [56.678384] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.309s) [56.833791] [006/138] (937s left) i915_pm_rps (thresholds-idle) [56.875666] Starting subtest: thresholds-idle [56.876747] Starting dynamic subtest: gt0 [67.221716] Dynamic subtest gt0: SUCCESS (10.345s) [67.222952] Subtest thresholds-idle: SUCCESS (10.346s) [67.279141] [007/138] (926s left) kms_psr (basic) [67.322732] Subtest basic: SKIP (0.000s) [67.344312] [008/138] (926s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [67.424300] Starting subtest: 2x-cursor-vs-flip-legacy [67.425826] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [67.499241] [009/138] (926s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [67.653461] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [67.751296] [010/138] (926s left) gem_exec_endless (dispatch) [67.802596] Starting subtest: dispatch [67.803329] Starting dynamic subtest: rcs0 [67.805373] Dynamic subtest rcs0: SUCCESS (0.002s) [67.809165] Starting dynamic subtest: bcs0 [67.810535] Dynamic subtest bcs0: SUCCESS (0.002s) [67.814162] Starting dynamic subtest: vcs0 [67.815484] Dynamic subtest vcs0: SUCCESS (0.002s) [67.818914] Starting dynamic subtest: vecs0 [67.820243] Dynamic subtest vecs0: SUCCESS (0.002s) [67.820924] Subtest dispatch: SUCCESS (0.008s) [67.923666] [011/138] (926s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [68.004227] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [68.005049] Starting dynamic subtest: pipe-A-valid-mode [68.054296] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s) [68.055827] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.050s) [68.154246] [012/138] (926s left) kms_flip (flip-vs-suspend) [68.228200] Starting subtest: flip-vs-suspend [68.229166] Starting dynamic subtest: A-HDMI-A2 [102.182965] Dynamic subtest A-HDMI-A2: SUCCESS (33.954s) [102.187164] Starting dynamic subtest: B-HDMI-A2 [136.365017] Dynamic subtest B-HDMI-A2: SUCCESS (34.182s) [136.365788] Subtest flip-vs-suspend: SUCCESS (68.139s) [140.524964] [013/138] (857s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [140.604769] Starting subtest: fbc-shrfb-scaledprimary [143.958087] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.355s) [144.115497] [014/138] (854s left) kms_plane (plane-panning-top-left) [144.193479] Starting subtest: plane-panning-top-left [144.194209] Starting dynamic subtest: pipe-A [144.705306] Dynamic subtest pipe-A: SUCCESS (0.511s) [144.713987] Starting dynamic subtest: pipe-B [145.124168] Dynamic subtest pipe-B: SUCCESS (0.417s) [145.124908] Subtest plane-panning-top-left: SUCCESS (0.931s) [145.267752] [015/138] (853s left) kms_lease (atomic-implicit-crtc) [145.340487] Starting subtest: atomic-implicit-crtc [145.341223] Starting dynamic subtest: pipe-A-HDMI-A-2 [145.341954] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s) [145.346235] Starting dynamic subtest: pipe-B-HDMI-A-2 [145.346976] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s) [145.347707] Subtest atomic-implicit-crtc: SUCCESS (0.006s) [145.416522] [016/138] (852s left) v3d/v3d_perfmon (destroy-invalid-perfmon) [145.484745] Subtest destroy-invalid-perfmon: SKIP (0.000s) [145.550551] [017/138] (852s left) kms_big_fb (linear-64bpp-rotate-90) [145.634303] Starting subtest: linear-64bpp-rotate-90 [145.702681] Subtest linear-64bpp-rotate-90: SKIP (0.068s) [145.817471] [018/138] (852s left) kms_flip (2x-flip-vs-rmfb-interruptible) [145.894081] Starting subtest: 2x-flip-vs-rmfb-interruptible [145.896194] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.001s) [146.008466] [019/138] (852s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [146.047130] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [146.152546] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [146.223949] [020/138] (852s left) gem_spin_batch (engines) [146.270314] Starting subtest: engines [146.271130] Starting dynamic subtest: rcs0 [149.582348] Dynamic subtest rcs0: SUCCESS (3.310s) [149.590022] Starting dynamic subtest: bcs0 [152.893721] Dynamic subtest bcs0: SUCCESS (3.311s) [152.901748] Starting dynamic subtest: vcs0 [156.205030] Dynamic subtest vcs0: SUCCESS (3.311s) [156.213479] Starting dynamic subtest: vecs0 [159.516947] Dynamic subtest vecs0: SUCCESS (3.312s) [159.518279] Subtest engines: SUCCESS (13.245s) [159.693380] [021/138] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [159.767035] Starting subtest: fbcpsr-rgb101010-draw-render [159.768616] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [159.859272] [022/138] (838s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [159.900812] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [159.901525] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [159.969169] [023/138] (838s left) fbdev (eof) [160.018105] Starting subtest: eof [160.018854] Subtest eof: SUCCESS (0.000s) [160.082589] [024/138] (838s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [160.159478] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [160.160901] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [160.235835] [025/138] (838s left) kms_cursor_crc (cursor-offscreen-max-size) [160.311139] Starting subtest: cursor-offscreen-max-size [160.313198] Subtest cursor-offscreen-max-size: SKIP (0.000s) [160.409052] [026/138] (838s left) kms_content_protection (dp-mst-type-0) [160.490558] Starting subtest: dp-mst-type-0 [160.492027] Subtest dp-mst-type-0: SKIP (0.000s) [160.599492] [027/138] (838s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [160.720092] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [160.721489] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [160.828319] [028/138] (837s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [160.959341] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [161.058621] [029/138] (837s left) gem_exec_flush (basic-wb-ro-default) [161.105418] Starting subtest: basic-wb-ro-default [166.526984] Subtest basic-wb-ro-default: SUCCESS (5.422s) [166.716714] [030/138] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [166.826324] Starting subtest: psr-2p-primscrn-cur-indfb-move [166.827699] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [166.942948] [031/138] (831s left) syncobj_timeline (wait-any-interrupted) [166.984727] Starting subtest: wait-any-interrupted [167.085598] Subtest wait-any-interrupted: SUCCESS (0.100s) [167.164134] [032/138] (831s left) api_intel_allocator (simple-allocator) [167.209771] Starting subtest: simple-allocator [167.210490] Starting dynamic subtest: basic [167.211222] Dynamic subtest basic: SUCCESS (0.001s) [167.216582] Starting dynamic subtest: parallel-one [167.282757] Dynamic subtest parallel-one: SUCCESS (0.071s) [167.293217] Starting dynamic subtest: print [167.294181] Dynamic subtest print: SUCCESS (0.000s) [167.300174] Starting dynamic subtest: reuse [167.300878] Dynamic subtest reuse: SUCCESS (0.000s) [167.305346] Starting dynamic subtest: reserve [167.306039] Dynamic subtest reserve: SUCCESS (0.000s) [167.310378] Starting dynamic subtest: fork-reopen-allocator [167.311066] Dynamic subtest fork-reopen-allocator: SUCCESS (0.020s) [167.311724] Subtest simple-allocator: SUCCESS (0.094s) [167.369335] [033/138] (831s left) gen9_exec_parse (bb-start-cmd) [167.403821] Subtest bb-start-cmd: SKIP (0.000s) [167.434072] [034/138] (831s left) gem_ctx_persistence (smoketest) [167.473459] Starting subtest: smoketest [198.297410] Subtest smoketest: SUCCESS (30.823s) [198.383287] [035/138] (800s left) gem_exec_basic (basic) [198.430375] Starting subtest: basic [198.431085] Starting dynamic subtest: rcs0-smem [198.431784] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [198.436062] Starting dynamic subtest: bcs0-smem [198.436745] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [198.440940] Starting dynamic subtest: vcs0-smem [198.441639] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [198.445994] Starting dynamic subtest: vecs0-smem [198.446743] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [198.447436] Subtest basic: SUCCESS (0.002s) [198.629384] [036/138] (800s left) gem_ccs (block-copy-uncompressed) [198.671639] Starting subtest: block-copy-uncompressed [198.672357] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [198.688180] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s) [198.692489] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem [198.702707] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.014s) [198.703398] Subtest block-copy-uncompressed: SUCCESS (0.031s) [198.797485] [037/138] (800s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [198.867689] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [198.868374] Starting dynamic subtest: pipe-A-valid-mode [199.439721] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.572s) [199.440463] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.573s) [199.583532] [038/138] (799s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [199.656469] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [202.038333] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.384s) [202.172240] [039/138] (796s left) gem_shrink (reclaim) [202.206753] Starting subtest: reclaim [204.525011] Subtest reclaim: SUCCESS (2.318s) [204.644106] [040/138] (794s left) kms_cursor_edge_walk (64x64-top-bottom) [204.768896] Starting subtest: 64x64-top-bottom [204.769739] Starting dynamic subtest: pipe-A-HDMI-A-2 [208.446272] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.677s) [208.450671] Starting dynamic subtest: pipe-B-HDMI-A-2 [212.041268] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.594s) [212.042005] Subtest 64x64-top-bottom: SUCCESS (7.273s) [212.138345] [041/138] (786s left) kms_big_fb (4-tiled-16bpp-rotate-0) [212.210871] Starting subtest: 4-tiled-16bpp-rotate-0 [212.212246] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s) [212.315351] [042/138] (786s left) gem_ctx_param (invalid-set-ringsize) [212.360152] Starting subtest: invalid-set-ringsize [212.360886] Subtest invalid-set-ringsize: SUCCESS (0.000s) [212.447763] [043/138] (786s left) gem_readwrite (write-bad-handle) [212.490052] Subtest write-bad-handle: SKIP (0.000s) [212.518032] [044/138] (786s left) gem_softpin (allocator-basic-reserve) [212.560835] Starting subtest: allocator-basic-reserve [212.613899] Subtest allocator-basic-reserve: SUCCESS (0.053s) [212.732927] [045/138] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [212.808241] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [212.809756] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [212.897386] [046/138] (786s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs) [213.031406] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s) [213.133093] [047/138] (785s left) kms_pipe_crc_basic (suspend-read-crc) [213.208825] Starting subtest: suspend-read-crc [213.209644] Starting dynamic subtest: pipe-A-HDMI-A-2 [231.658809] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (18.449s) [231.666233] Starting dynamic subtest: pipe-B-HDMI-A-2 [249.645426] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (17.985s) [249.646246] Subtest suspend-read-crc: SUCCESS (36.438s) [251.753154] [048/138] (749s left) gem_lmem_swapping (parallel-random-verify-ccs) [251.797802] Subtest parallel-random-verify-ccs: SKIP (0.000s) [251.811850] [049/138] (749s left) gem_fenced_exec_thrash (no-spare-fences) [251.843536] Starting subtest: no-spare-fences [253.994978] Subtest no-spare-fences: SUCCESS (2.151s) [254.115381] [050/138] (747s left) i915_pm_rc6_residency (rc6-idle) [254.158469] Starting subtest: rc6-idle [254.160079] Starting dynamic subtest: rcs0 [266.369377] Dynamic subtest rcs0: SUCCESS (12.209s) [266.378744] Starting dynamic subtest: bcs0 [278.576736] Dynamic subtest bcs0: SUCCESS (12.207s) [278.583403] Starting dynamic subtest: vcs0 [290.785586] Dynamic subtest vcs0: SUCCESS (12.208s) [290.792073] Starting dynamic subtest: vecs0 [302.994571] Dynamic subtest vecs0: SUCCESS (12.209s) [302.995341] Subtest rc6-idle: SUCCESS (48.837s) [303.267564] [051/138] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [303.340913] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [303.342302] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [303.446775] [052/138] (697s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [303.525706] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [303.527098] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [303.619500] [053/138] (697s left) kms_big_fb (y-tiled-addfb-size-overflow) [303.700329] Starting subtest: y-tiled-addfb-size-overflow [303.701066] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s) [303.808593] [054/138] (697s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [303.930695] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [303.932055] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [304.038738] [055/138] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [304.115821] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [304.117160] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [304.210318] [056/138] (697s left) kms_force_connector_basic (prune-stale-modes) [304.310704] Starting subtest: prune-stale-modes [304.330525] Subtest prune-stale-modes: SUCCESS (0.021s) [304.564664] [057/138] (696s left) kms_flip (bo-too-big-interruptible) [304.635917] Starting subtest: bo-too-big-interruptible [304.637643] Starting dynamic subtest: A-HDMI-A2 [304.911023] Dynamic subtest A-HDMI-A2: SUCCESS (0.273s) [304.927495] Starting dynamic subtest: B-HDMI-A2 [305.117696] Dynamic subtest B-HDMI-A2: SUCCESS (0.203s) [305.123343] Subtest bo-too-big-interruptible: SUCCESS (0.484s) [305.288276] [058/138] (696s left) gem_exec_balancer (bonded-chain) [305.334078] Starting subtest: bonded-chain [306.093784] Subtest bonded-chain: SUCCESS (0.759s) [307.060598] [059/138] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [307.133586] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [307.134945] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [307.238727] [060/138] (694s left) gem_exec_flush (basic-uc-pro-default) [307.283425] Starting subtest: basic-uc-pro-default [312.709405] Subtest basic-uc-pro-default: SUCCESS (5.426s) [312.916503] [061/138] (688s left) kms_vblank (query-busy-hang) [313.017512] Starting subtest: query-busy-hang [313.019539] Starting dynamic subtest: pipe-A-HDMI-A-2 [327.135349] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (14.116s) [327.142454] Starting dynamic subtest: pipe-B-HDMI-A-2 [340.954901] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (13.818s) [340.955627] Subtest query-busy-hang: SUCCESS (27.937s) [341.102454] [062/138] (660s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done) [341.165337] Subtest poll-read-waits-until-write-done: SKIP (0.000s) [341.233763] [063/138] (660s left) kms_flip (flip-vs-expired-vblank-interruptible) [341.312708] Starting subtest: flip-vs-expired-vblank-interruptible [341.313448] Starting dynamic subtest: A-HDMI-A2 [356.481685] Dynamic subtest A-HDMI-A2: SUCCESS (15.168s) [356.493088] Starting dynamic subtest: B-HDMI-A2 [371.602777] Dynamic subtest B-HDMI-A2: SUCCESS (15.119s) [371.604996] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.292s) [371.746705] [064/138] (629s left) kms_pm_rpm (basic-pci-d3-state) [373.130272] Starting subtest: basic-pci-d3-state [373.444435] Subtest basic-pci-d3-state: SUCCESS (0.314s) [373.646186] [065/138] (627s left) syncobj_wait (reset-signaled) [373.683854] Starting subtest: reset-signaled [373.684538] Subtest reset-signaled: SUCCESS (0.000s) [373.756818] [066/138] (627s left) kms_big_fb (x-tiled-16bpp-rotate-0) [373.840322] Starting subtest: x-tiled-16bpp-rotate-0 [375.245134] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.404s) [375.402725] [067/138] (626s left) gem_mmap_gtt (basic-write-gtt) [375.432781] Starting subtest: basic-write-gtt [375.645072] Subtest basic-write-gtt: SUCCESS (0.213s) [375.743343] [068/138] (625s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-mc-ccs) [375.876779] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s) [375.979453] [069/138] (625s left) i915_query (query-regions-sanity-check) [376.021938] Starting subtest: query-regions-sanity-check [376.030434] Subtest query-regions-sanity-check: SUCCESS (0.009s) [376.152744] [070/138] (625s left) kms_async_flips (invalid-async-flip) [376.226890] Starting subtest: invalid-async-flip [376.385460] Starting dynamic subtest: pipe-A-HDMI-A-2 [376.440933] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.055s) [376.612064] Starting dynamic subtest: pipe-B-HDMI-A-2 [376.647094] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.040s) [376.647891] Subtest invalid-async-flip: SUCCESS (0.420s) [376.858574] [071/138] (624s left) gen7_exec_parse (load-register-reg) [376.891256] Subtest load-register-reg: SKIP (0.000s) [376.920973] [072/138] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [377.001590] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [377.003493] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [377.107633] [073/138] (624s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [377.244510] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [377.294135] [074/138] (624s left) kms_frontbuffer_tracking (psr-suspend) [377.370831] Starting subtest: psr-suspend [377.372139] Subtest psr-suspend: SKIP (0.000s) [377.471343] [075/138] (624s left) gen3_render_tiledx_blits [377.546090] [076/138] (624s left) kms_cursor_crc (cursor-onscreen-64x21) [377.616732] Starting subtest: cursor-onscreen-64x21 [377.619645] Starting dynamic subtest: pipe-A-HDMI-A-2 [380.124192] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.504s) [380.147095] Starting dynamic subtest: pipe-B-HDMI-A-2 [382.536765] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.394s) [382.537460] Subtest cursor-onscreen-64x21: SUCCESS (4.920s) [382.688307] [077/138] (619s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [382.764424] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [382.766693] Starting dynamic subtest: pipe-A-HDMI-A-2 [382.865349] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.099s) [382.882356] Starting dynamic subtest: pipe-B-HDMI-A-2 [382.982091] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.113s) [382.983341] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.219s) [383.132632] [078/138] (618s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [385.680650] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s) [385.757826] [079/138] (616s left) gem_pread (display) [385.799283] Subtest display: SKIP (0.000s) [385.849702] [080/138] (615s left) kms_getfb (getfb2-handle-closed) [385.890085] Starting subtest: getfb2-handle-closed [385.890790] Subtest getfb2-handle-closed: SUCCESS (0.000s) [385.990260] [081/138] (615s left) kms_flip (2x-flip-vs-dpms) [386.064704] Starting subtest: 2x-flip-vs-dpms [386.066050] Subtest 2x-flip-vs-dpms: SKIP (0.002s) [386.169280] [082/138] (615s left) testdisplay [390.053309] [083/138] (611s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-mc-ccs) [390.187243] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s) [390.289866] [084/138] (611s left) perf_pmu (event-wait) [390.326894] Starting subtest: event-wait [390.327595] Starting dynamic subtest: rcs0 [390.329012] Dynamic subtest rcs0: SKIP (0.000s) [390.330373] Subtest event-wait: SKIP (0.001s) [390.406034] [085/138] (611s left) gem_exec_schedule (fairslice-all) [390.449448] Starting subtest: fairslice-all [392.479264] Subtest fairslice-all: SUCCESS (2.030s) [392.788885] [086/138] (609s left) sw_sync (sync_merge_invalid) [392.821934] Starting subtest: sync_merge_invalid [392.823418] Subtest sync_merge_invalid: SUCCESS (0.001s) [392.845386] [087/138] (609s left) gem_ctx_persistence (heartbeat-stop) [392.886933] Starting subtest: heartbeat-stop [393.050364] Subtest heartbeat-stop: SUCCESS (0.163s) [393.138276] [088/138] (608s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted) [393.171329] Starting subtest: invalid-multi-wait-all-available-unsubmitted [393.172084] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s) [393.250237] [089/138] (608s left) gem_eio (banned) [393.294943] Starting subtest: banned [393.719112] Subtest banned: SUCCESS (0.425s) [393.843499] [090/138] (608s left) api_intel_allocator (fork-simple-once) [393.883998] Starting subtest: fork-simple-once [393.895482] Subtest fork-simple-once: SUCCESS (0.011s) [394.002417] [091/138] (608s left) kms_cursor_legacy (single-move) [394.074966] Starting subtest: single-move [394.075671] Starting dynamic subtest: pipe-A [399.453563] Dynamic subtest pipe-A: SUCCESS (5.378s) [399.458601] Starting dynamic subtest: pipe-B [404.831699] Dynamic subtest pipe-B: SUCCESS (5.377s) [404.836625] Starting dynamic subtest: all-pipes [410.209783] Dynamic subtest all-pipes: SUCCESS (5.378s) [410.210482] Subtest single-move: SUCCESS (16.134s) [410.275253] [092/138] (591s left) v3d/v3d_submit_csd (bad-bo) [410.352624] Subtest bad-bo: SKIP (0.000s) [410.418822] [093/138] (591s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-mtl-rc-ccs-cc) [410.549509] Subtest pipe-D-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [410.650242] [094/138] (591s left) kms_plane_scaling (2x-scaler-multi-pipe) [410.718960] Starting subtest: 2x-scaler-multi-pipe [410.720371] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [410.815253] [095/138] (591s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [410.898329] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [411.227907] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.329s) [411.383595] [096/138] (590s left) drm_fdinfo (most-busy-idle-check-all) [411.422177] Starting subtest: most-busy-idle-check-all [411.422886] Starting dynamic subtest: rcs0 [412.038224] Dynamic subtest rcs0: SUCCESS (0.615s) [412.048633] Starting dynamic subtest: bcs0 [412.655250] Dynamic subtest bcs0: SUCCESS (0.615s) [412.664105] Starting dynamic subtest: vcs0 [413.273339] Dynamic subtest vcs0: SUCCESS (0.616s) [413.283731] Starting dynamic subtest: vecs0 [413.892334] Dynamic subtest vecs0: SUCCESS (0.617s) [413.893467] Subtest most-busy-idle-check-all: SUCCESS (2.471s) [413.959209] [097/138] (588s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs) [414.031389] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs [414.032957] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s) [414.211056] [098/138] (587s left) kms_psr (psr2_sprite_blt) [414.252626] Subtest psr2_sprite_blt: SKIP (0.000s) [414.284763] [099/138] (587s left) kms_psr2_sf (primary-plane-update-sf-dmg-area) [414.326978] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s) [414.361426] [100/138] (587s left) gem_mmap_offset (pf-nonblock) [414.403633] Starting subtest: pf-nonblock [414.405294] Subtest pf-nonblock: SUCCESS (0.002s) [414.516167] [101/138] (587s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [414.581785] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [414.584027] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.001s) [414.687450] [102/138] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [414.763842] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [414.765162] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [414.857239] [103/138] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [414.936019] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [414.937370] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [415.028059] [104/138] (587s left) gem_exec_reloc (basic-wc-read) [415.066134] Subtest basic-wc-read: SKIP (0.000s) [415.126655] [105/138] (587s left) kms_getfb (getfb-addfb-different-handles) [415.158851] Starting subtest: getfb-addfb-different-handles [415.159565] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [415.256601] [106/138] (587s left) gem_reg_read (bad-register) [415.291109] Starting subtest: bad-register [415.291841] Subtest bad-register: SUCCESS (0.000s) [415.367368] [107/138] (587s left) gem_pwrite (basic-random) [415.408553] Subtest basic-random: SKIP (0.000s) [415.470125] [108/138] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [415.548266] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [415.549630] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [415.656370] [109/138] (586s left) kms_plane_scaling (planes-downscale-factor-0-5) [415.728933] Starting subtest: planes-downscale-factor-0-5 [415.729788] Starting dynamic subtest: pipe-A-HDMI-A-2 [415.873327] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.144s) [415.882568] Starting dynamic subtest: pipe-B-HDMI-A-2 [415.991150] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.113s) [415.992376] Subtest planes-downscale-factor-0-5: SUCCESS (0.264s) [416.162489] [110/138] (586s left) perf (blocking-parameterized) [416.249027] Starting subtest: blocking-parameterized [436.264393] Subtest blocking-parameterized: SUCCESS (20.015s) [436.291859] [111/138] (566s left) gem_readwrite (new-obj) [436.358831] Subtest new-obj: SKIP (0.000s) [436.415463] [112/138] (566s left) vc4/vc4_wait_bo (unused-bo-0ns) [436.488139] Subtest unused-bo-0ns: SKIP (0.000s) [436.557701] [113/138] (566s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-ccs) [436.713348] Subtest pipe-D-crc-primary-basic-y-tiled-ccs: SKIP (0.000s) [436.816333] [114/138] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [436.886861] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [436.888226] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [436.988792] [115/138] (565s left) gem_softpin (evict-active-interruptible) [437.025283] Starting subtest: evict-active-interruptible [437.029275] Subtest evict-active-interruptible: SUCCESS (0.004s) [437.151606] [116/138] (565s left) syncobj_timeline (multi-wait-available-submitted) [437.186278] Starting subtest: multi-wait-available-submitted [437.187014] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [437.273306] [117/138] (565s left) gem_exec_whisper (basic-contexts) [437.318714] Starting subtest: basic-contexts [438.763949] Subtest basic-contexts: SUCCESS (1.445s) [438.945220] [118/138] (563s left) gem_userptr_blits (input-checking) [438.989152] Starting subtest: input-checking [438.989843] Subtest input-checking: SUCCESS (0.000s) [439.114366] [119/138] (563s left) kms_selftest (drm_format) [439.152094] Starting subtest: drm_format [439.162332] Starting dynamic subtest: drm_format-drm_test_format_block_width_invalid [439.163072] Dynamic subtest drm_format-drm_test_format_block_width_invalid: SUCCESS (0.000s) [439.168209] Starting dynamic subtest: drm_format-drm_test_format_block_width_one_plane [439.168928] Dynamic subtest drm_format-drm_test_format_block_width_one_plane: SUCCESS (0.000s) [439.174456] Starting dynamic subtest: drm_format-drm_test_format_block_width_two_plane [439.175168] Dynamic subtest drm_format-drm_test_format_block_width_two_plane: SUCCESS (0.000s) [439.180098] Starting dynamic subtest: drm_format-drm_test_format_block_width_three_plane [439.180807] Dynamic subtest drm_format-drm_test_format_block_width_three_plane: SUCCESS (0.000s) [439.185671] Starting dynamic subtest: drm_format-drm_test_format_block_width_tiled [439.186353] Dynamic subtest drm_format-drm_test_format_block_width_tiled: SUCCESS (0.000s) [439.191235] Starting dynamic subtest: drm_format-drm_test_format_block_height_invalid [439.191922] Dynamic subtest drm_format-drm_test_format_block_height_invalid: SUCCESS (0.000s) [439.196706] Starting dynamic subtest: drm_format-drm_test_format_block_height_one_plane [439.197379] Dynamic subtest drm_format-drm_test_format_block_height_one_plane: SUCCESS (0.000s) [439.202272] Starting dynamic subtest: drm_format-drm_test_format_block_height_two_plane [439.202955] Dynamic subtest drm_format-drm_test_format_block_height_two_plane: SUCCESS (0.000s) [439.207767] Starting dynamic subtest: drm_format-drm_test_format_block_height_three_plane [439.208450] Dynamic subtest drm_format-drm_test_format_block_height_three_plane: SUCCESS (0.000s) [439.213366] Starting dynamic subtest: drm_format-drm_test_format_block_height_tiled [439.214051] Dynamic subtest drm_format-drm_test_format_block_height_tiled: SUCCESS (0.000s) [439.218903] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_invalid [439.219596] Dynamic subtest drm_format-drm_test_format_min_pitch_invalid: SUCCESS (0.000s) [439.225451] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_one_plane_8bpp [439.226168] Dynamic subtest drm_format-drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.000s) [439.232039] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_one_plane_16bpp [439.232750] Dynamic subtest drm_format-drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.000s) [439.238130] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_one_plane_24bpp [439.238803] Dynamic subtest drm_format-drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.000s) [439.243608] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_one_plane_32bpp [439.244281] Dynamic subtest drm_format-drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.000s) [439.249081] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_two_plane [439.249756] Dynamic subtest drm_format-drm_test_format_min_pitch_two_plane: SUCCESS (0.000s) [439.254540] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_three_plane_8bpp [439.255219] Dynamic subtest drm_format-drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.000s) [439.260076] Starting dynamic subtest: drm_format-drm_test_format_min_pitch_tiled [439.260751] Dynamic subtest drm_format-drm_test_format_min_pitch_tiled: SUCCESS (0.000s) [439.261395] Subtest drm_format: SUCCESS (0.027s) [439.320851] [120/138] (563s left) vgem_basic (dmabuf-fence) [439.364718] Starting subtest: dmabuf-fence [439.365409] Subtest dmabuf-fence: SUCCESS (0.000s) [439.425812] [121/138] (563s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-gen12-mc-ccs) [439.553279] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-gen12-mc-ccs [439.554659] Subtest pipe-A-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s) [439.672549] [122/138] (563s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [439.751337] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [441.006793] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.255s) [441.136184] [123/138] (561s left) syncobj_wait (invalid-signal-bad-pad) [441.170541] Starting subtest: invalid-signal-bad-pad [441.171301] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [441.247240] [124/138] (561s left) kms_pm_rpm (pc8-residency) [442.624230] Starting subtest: pc8-residency [442.626492] Subtest pc8-residency: SKIP (0.000s) [442.846603] [125/138] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [442.919042] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [442.920423] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [443.017570] [126/138] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [443.096967] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [443.098432] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [443.197362] [127/138] (559s left) gem_exec_schedule (timeslicing) [443.239261] Starting subtest: timeslicing [443.239999] Starting dynamic subtest: rcs0 [443.241758] Dynamic subtest rcs0: SUCCESS (0.002s) [443.246813] Starting dynamic subtest: bcs0 [443.247492] Dynamic subtest bcs0: SUCCESS (0.001s) [443.253818] Starting dynamic subtest: vcs0 [443.254578] Dynamic subtest vcs0: SUCCESS (0.001s) [443.260038] Starting dynamic subtest: vecs0 [443.260718] Dynamic subtest vecs0: SUCCESS (0.001s) [443.261382] Subtest timeslicing: SUCCESS (0.009s) [443.550385] [128/138] (559s left) kms_flip (flip-vs-fences) [443.614623] Starting subtest: flip-vs-fences [443.615328] Starting dynamic subtest: A-HDMI-A2 [458.782273] Dynamic subtest A-HDMI-A2: SUCCESS (15.167s) [458.788176] Starting dynamic subtest: B-HDMI-A2 [473.923188] Dynamic subtest B-HDMI-A2: SUCCESS (15.140s) [473.923997] Subtest flip-vs-fences: SUCCESS (30.310s) [474.086403] [129/138] (528s left) gem_exec_fence (syncobj-timeline-wait) [474.508604] Starting subtest: syncobj-timeline-wait [474.550864] Subtest syncobj-timeline-wait: SUCCESS (0.043s) [474.731511] [130/138] (528s left) device_reset (cold-reset-bound) [474.780902] Subtest cold-reset-bound: SKIP (0.000s) [474.854686] [131/138] (528s left) kms_flip (2x-dpms-vs-vblank-race) [474.923087] Starting subtest: 2x-dpms-vs-vblank-race [474.924707] Subtest 2x-dpms-vs-vblank-race: SKIP (0.002s) [475.023965] [132/138] (527s left) gem_exec_schedule (promotion) [475.064495] Starting subtest: promotion [475.065264] Starting dynamic subtest: rcs0 [475.111095] Dynamic subtest rcs0: SUCCESS (0.046s) [475.121788] Starting dynamic subtest: bcs0 [475.159905] Dynamic subtest bcs0: SUCCESS (0.047s) [475.173042] Starting dynamic subtest: vcs0 [475.212221] Dynamic subtest vcs0: SUCCESS (0.051s) [475.224810] Starting dynamic subtest: vecs0 [475.264132] Dynamic subtest vecs0: SUCCESS (0.050s) [475.266072] Subtest promotion: SUCCESS (0.200s) [475.567284] [133/138] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [475.642550] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [475.644081] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [475.745177] [134/138] (527s left) kms_ccs (pipe-b-ccs-on-another-bo-yf-tiled-ccs) [475.867328] Starting subtest: pipe-B-ccs-on-another-bo-yf-tiled-ccs [475.868820] Subtest pipe-B-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s) [475.970136] [135/138] (527s left) kms_chamelium_frames (dp-frame-dump) [476.088863] Subtest dp-frame-dump: SKIP (0.000s) [476.138666] [136/138] (526s left) perf_pmu (render-node-busy) [476.174336] Starting subtest: render-node-busy [476.175046] Starting dynamic subtest: rcs0 [476.732249] Dynamic subtest rcs0: SUCCESS (0.558s) [476.742862] Starting dynamic subtest: bcs0 [477.264252] Dynamic subtest bcs0: SUCCESS (0.530s) [477.283326] Starting dynamic subtest: vcs0 [477.801211] Dynamic subtest vcs0: SUCCESS (0.535s) [477.812531] Starting dynamic subtest: vecs0 [478.332355] Dynamic subtest vecs0: SUCCESS (0.529s) [478.333483] Subtest render-node-busy: SUCCESS (2.159s) [478.406439] [137/138] (524s left) v3d/v3d_perfmon (create-single-perfmon) [478.464911] Subtest create-single-perfmon: SKIP (0.000s) [478.534426] [138/138] (524s left) kms_ccs (pipe-a-random-ccs-data-yf-tiled-ccs) [478.643303] Starting subtest: pipe-A-random-ccs-data-yf-tiled-ccs [478.645376] Subtest pipe-A-random-ccs-data-yf-tiled-ccs: SKIP (0.000s) [478.764527] Closing watchdogs Done.