[47.231529] Initializing watchdogs [47.231710] /dev/watchdog0 [47.246270] [001/142] (960s left) gem_mmap_gtt (cpuset-big-copy-odd) [47.414428] Starting subtest: cpuset-big-copy-odd [66.608864] Subtest cpuset-big-copy-odd: SUCCESS (19.194s) [66.743729] [002/142] (941s left) gem_partial_pwrite_pread (write) [66.998681] Starting subtest: write [80.590894] Subtest write: SUCCESS (13.592s) [80.688791] [003/142] (927s left) vc4/vc4_purgeable_bo (free-purged-bo) [82.082649] Subtest free-purged-bo: SKIP (0.000s) [82.294837] [004/142] (925s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [82.547310] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [82.553689] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.001s) [82.627482] [005/142] (925s left) kms_psr (psr2_primary_page_flip) [82.780209] Subtest psr2_primary_page_flip: SKIP (0.000s) [82.823794] [006/142] (925s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [83.064631] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [83.070931] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [83.144219] [007/142] (924s left) kms_addfb_basic (addfb25-y-tiled-legacy) [83.373423] Starting subtest: addfb25-y-tiled-legacy [83.376689] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [83.461027] [008/142] (924s left) drm_fdinfo (virtual-busy-hang) [83.617369] Starting subtest: virtual-busy-hang [87.785478] Subtest virtual-busy-hang: SUCCESS (4.168s) [87.872554] [009/142] (920s left) kms_psr (primary_render) [88.021303] Subtest primary_render: SKIP (0.000s) [88.064564] [010/142] (920s left) kms_cdclk (mode-transition) [88.231465] Subtest mode-transition: SKIP (0.000s) [88.279829] [011/142] (919s left) syncobj_wait (multi-wait-submitted) [88.431191] Starting subtest: multi-wait-submitted [88.536791] Subtest multi-wait-submitted: SUCCESS (0.109s) [88.620389] [012/142] (919s left) gen9_exec_parse (basic-rejected) [88.783255] Starting subtest: basic-rejected [88.786998] Subtest basic-rejected: SUCCESS (0.002s) [88.994495] [013/142] (919s left) gem_ctx_shared (q-out-order) [89.157021] Starting subtest: Q-out-order [89.160758] Starting dynamic subtest: rcs0 [89.300730] Dynamic subtest rcs0: SUCCESS (0.141s) [89.323051] Starting dynamic subtest: bcs0 [89.390428] Dynamic subtest bcs0: SUCCESS (0.087s) [89.413427] Starting dynamic subtest: vcs0 [89.478390] Dynamic subtest vcs0: SUCCESS (0.072s) [89.492783] Starting dynamic subtest: vecs0 [89.537793] Dynamic subtest vecs0: SUCCESS (0.071s) [89.541103] Subtest Q-out-order: SUCCESS (0.376s) [89.746497] [014/142] (918s left) gem_exec_balancer (full-pulse) [89.911477] Starting subtest: full-pulse [92.960021] Subtest full-pulse: SUCCESS (3.047s) [95.981336] [015/142] (912s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [96.212238] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [96.215644] Starting dynamic subtest: pipe-A-valid-mode [97.163933] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.948s) [97.167856] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.950s) [97.416633] [016/142] (910s left) tools_test (tools_test) [97.581555] Starting subtest: tools_test [97.857819] Subtest tools_test: SUCCESS (0.292s) [97.927984] [017/142] (910s left) gem_ctx_persistence (engines-cleanup) [98.083763] Starting subtest: engines-cleanup [98.087301] Starting dynamic subtest: rcs0 [98.109154] Dynamic subtest rcs0: SUCCESS (0.025s) [98.130905] Starting dynamic subtest: bcs0 [98.143987] Dynamic subtest bcs0: SUCCESS (0.032s) [98.163923] Starting dynamic subtest: vcs0 [98.178410] Dynamic subtest vcs0: SUCCESS (0.027s) [98.196251] Starting dynamic subtest: vecs0 [98.199462] Dynamic subtest vecs0: SUCCESS (0.022s) [98.202695] Subtest engines-cleanup: SUCCESS (0.107s) [98.283480] [018/142] (910s left) gem_userptr_blits (userfault) [98.453628] Starting subtest: userfault [98.457170] Subtest userfault: SUCCESS (0.007s) [98.596972] [019/142] (909s left) kms_flip (flip-vs-expired-vblank) [98.815552] Starting subtest: flip-vs-expired-vblank [98.819128] Starting dynamic subtest: A-HDMI-A1 [104.651173] Dynamic subtest A-HDMI-A1: SUCCESS (5.837s) [104.673071] Starting dynamic subtest: B-HDMI-A1 [110.051859] Dynamic subtest B-HDMI-A1: SUCCESS (5.397s) [110.075042] Starting dynamic subtest: C-HDMI-A1 [115.438319] Dynamic subtest C-HDMI-A1: SUCCESS (5.388s) [115.457433] Starting dynamic subtest: A-HDMI-A2 [120.854062] Dynamic subtest A-HDMI-A2: SUCCESS (5.410s) [120.875675] Starting dynamic subtest: B-HDMI-A2 [126.227221] Dynamic subtest B-HDMI-A2: SUCCESS (5.372s) [126.246992] Starting dynamic subtest: C-HDMI-A2 [131.631595] Dynamic subtest C-HDMI-A2: SUCCESS (5.397s) [131.634902] Subtest flip-vs-expired-vblank: SUCCESS (32.822s) [132.030806] [020/142] (876s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [132.267473] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [143.811694] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.465s) [144.238672] [021/142] (864s left) kms_cursor_crc (cursor-random-64x64) [144.788966] Starting subtest: cursor-random-64x64 [144.855128] Starting dynamic subtest: pipe-A-HDMI-A-1 [149.086130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.260s) [149.150585] Starting dynamic subtest: pipe-C-HDMI-A-1 [153.225319] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.193s) [153.228466] Subtest cursor-random-64x64: SUCCESS (8.545s) [153.537954] [022/142] (855s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [153.795126] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [155.242644] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.449s) [155.550959] [023/142] (853s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [155.783738] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [155.786835] Starting dynamic subtest: pipe-A-valid-mode [156.196190] Dynamic subtest pipe-A-valid-mode: SKIP (0.406s) [156.204491] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.411s) [156.445628] [024/142] (852s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [156.690560] Starting subtest: basic-flip-after-cursor-legacy [158.110289] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.419s) [158.360121] [025/142] (850s left) gem_lmem_swapping (parallel-random-verify-ccs) [158.523695] Subtest parallel-random-verify-ccs: SKIP (0.000s) [158.578835] [026/142] (850s left) kms_vblank (pipe-c-wait-busy-hang) [158.818244] Starting subtest: pipe-C-wait-busy-hang [173.432481] Subtest pipe-C-wait-busy-hang: SUCCESS (14.611s) [173.697787] [027/142] (835s left) syncobj_timeline (signal-point-0) [173.852472] Starting subtest: signal-point-0 [173.855870] Subtest signal-point-0: SUCCESS (0.001s) [173.941874] [028/142] (835s left) i915_pm_rps (reset) [174.097960] Starting subtest: reset [177.661810] Subtest reset: SUCCESS (3.562s) [177.749420] [029/142] (831s left) kms_atomic_transition (modeset-transition-fencing) [177.992229] Starting subtest: modeset-transition-fencing [177.995603] Starting dynamic subtest: 1x-outputs [183.035522] Dynamic subtest 1x-outputs: SUCCESS (5.043s) [183.340997] Starting dynamic subtest: 2x-outputs [202.026730] Dynamic subtest 2x-outputs: SUCCESS (18.713s) [202.563106] Subtest modeset-transition-fencing: SUCCESS (24.567s) [202.861911] [030/142] (806s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs) [203.572145] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs [203.578581] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s) [203.994106] [031/142] (805s left) gem_exec_balancer (parallel-keep-in-fence) [207.105645] Subtest parallel-keep-in-fence: SKIP (0.000s) [207.193978] [032/142] (801s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [207.453364] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [207.466599] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s) [207.543916] [033/142] (801s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [208.240460] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [208.251446] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.008s) [208.642590] [034/142] (800s left) gem_set_tiling_vs_blt (tiled-to-untiled) [208.812063] Starting subtest: tiled-to-untiled [208.922241] Subtest tiled-to-untiled: SUCCESS (0.109s) [209.020091] [035/142] (800s left) prime_self_import (reimport-vs-gem_close-race) [209.165729] Starting subtest: reimport-vs-gem_close-race [214.185842] Subtest reimport-vs-gem_close-race: SUCCESS (5.018s) [214.274197] [036/142] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [214.541426] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [217.017672] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.484s) [217.258240] [037/142] (792s left) kms_flip (plain-flip-fb-recreate-interruptible) [217.825551] Starting subtest: plain-flip-fb-recreate-interruptible [217.890616] Starting dynamic subtest: A-HDMI-A1 [223.601052] Dynamic subtest A-HDMI-A1: SUCCESS (5.903s) [223.624640] Starting dynamic subtest: B-HDMI-A1 [229.337432] Dynamic subtest B-HDMI-A1: SUCCESS (5.732s) [229.362579] Starting dynamic subtest: C-HDMI-A1 [235.069502] Dynamic subtest C-HDMI-A1: SUCCESS (5.727s) [235.094558] Starting dynamic subtest: A-HDMI-A2 [240.761914] Dynamic subtest A-HDMI-A2: SUCCESS (5.684s) [240.787833] Starting dynamic subtest: B-HDMI-A2 [246.449510] Dynamic subtest B-HDMI-A2: SUCCESS (5.688s) [246.475403] Starting dynamic subtest: C-HDMI-A2 [252.155093] Dynamic subtest C-HDMI-A2: SUCCESS (5.690s) [252.160888] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (34.466s) [252.564208] [038/142] (756s left) perf_pmu (busy-idle) [252.758481] Starting subtest: busy-idle [252.761920] Starting dynamic subtest: rcs0 [253.504605] Dynamic subtest rcs0: SUCCESS (0.625s) [253.570787] Starting dynamic subtest: bcs0 [254.139989] Dynamic subtest bcs0: SUCCESS (0.628s) [254.208211] Starting dynamic subtest: vcs0 [254.646951] Dynamic subtest vcs0: SUCCESS (0.627s) [254.662211] Starting dynamic subtest: vecs0 [255.276526] Dynamic subtest vecs0: SUCCESS (0.625s) [255.280261] Subtest busy-idle: SUCCESS (2.514s) [255.362688] [039/142] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [255.616484] Starting subtest: fbc-2p-primscrn-cur-indfb-move [258.460119] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (2.850s) [258.629541] [040/142] (750s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [258.886721] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [261.459974] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.583s) [261.697985] [041/142] (747s left) gem_exec_gttfill (engines) [261.875744] Starting subtest: engines [261.878929] Starting dynamic subtest: rcs0 [288.567373] Dynamic subtest rcs0: SUCCESS (26.694s) [288.590115] Starting dynamic subtest: bcs0 [317.150598] Dynamic subtest bcs0: SUCCESS (28.581s) [317.170982] Starting dynamic subtest: vcs0 [343.648095] Dynamic subtest vcs0: SUCCESS (26.495s) [343.695052] Starting dynamic subtest: vecs0 [369.565976] Dynamic subtest vecs0: SUCCESS (25.915s) [369.569546] Subtest engines: SUCCESS (107.695s) [369.769387] [042/142] (639s left) gem_exec_fence (syncobj-import) [370.431130] Starting subtest: syncobj-import [370.438654] Subtest syncobj-import: SUCCESS (0.007s) [370.766517] [043/142] (638s left) gem_userptr_blits (access-control) [370.975193] Starting subtest: access-control [370.982709] Subtest access-control: SKIP (0.000s) [371.066210] [044/142] (638s left) gem_exec_reloc (basic-wc-cpu) [371.225225] Starting subtest: basic-wc-cpu [371.238387] Subtest basic-wc-cpu: SUCCESS (0.016s) [371.433143] [045/142] (638s left) core_setmaster (master-drop-set-shared-fd) [373.317884] Starting subtest: master-drop-set-shared-fd [373.359995] Subtest master-drop-set-shared-fd: SUCCESS (0.045s) [373.395424] [046/142] (636s left) gem_eio (throttle) [373.568470] Starting subtest: throttle [373.605164] Subtest throttle: SUCCESS (0.042s) [373.799151] [047/142] (635s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [374.068108] Starting subtest: fbcpsr-rgb101010-draw-render [374.074581] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [374.149153] [048/142] (635s left) kms_vblank (pipe-a-wait-idle) [374.394535] Starting subtest: pipe-A-wait-idle [379.491479] Subtest pipe-A-wait-idle: SUCCESS (5.098s) [379.815345] [049/142] (629s left) gem_ringfill (engines-basic) [380.213259] Starting subtest: engines-basic [380.216471] Starting dynamic subtest: rcs0 [380.232139] Dynamic subtest rcs0: SUCCESS (0.016s) [380.256066] Starting dynamic subtest: bcs0 [380.259995] Dynamic subtest bcs0: SUCCESS (0.027s) [380.279854] Starting dynamic subtest: vcs0 [380.283262] Dynamic subtest vcs0: SUCCESS (0.015s) [380.300701] Starting dynamic subtest: vecs0 [380.304114] Dynamic subtest vecs0: SUCCESS (0.018s) [380.307487] Subtest engines-basic: SUCCESS (0.084s) [380.389370] [050/142] (629s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [380.635275] Starting subtest: flip-vs-cursor-varying-size [396.291379] Subtest flip-vs-cursor-varying-size: SUCCESS (15.656s) [396.537076] [051/142] (613s left) syncobj_wait (single-wait-signaled) [396.692944] Starting subtest: single-wait-signaled [396.696498] Subtest single-wait-signaled: SUCCESS (0.001s) [396.779442] [052/142] (613s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [397.025113] Starting subtest: 2x-long-cursor-vs-flip-legacy [439.340196] Subtest 2x-long-cursor-vs-flip-legacy: SUCCESS (42.313s) [439.651838] [053/142] (570s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [439.914741] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [439.920822] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [439.996732] [054/142] (570s left) api_intel_allocator (default-alignment) [440.155300] Starting subtest: default-alignment [440.158593] Subtest default-alignment: SUCCESS (0.003s) [440.247917] [055/142] (569s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs) [440.962525] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs [440.972031] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s) [441.311738] [056/142] (568s left) syncobj_timeline (invalid-signal-one-illegal-handle) [441.847570] Starting subtest: invalid-signal-one-illegal-handle [441.917081] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [442.228096] [057/142] (568s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs) [443.092262] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs [443.098865] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.001s) [443.518391] [058/142] (566s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [444.321892] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [444.328316] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.002s) [444.632584] [059/142] (565s left) kms_flip (nonblocking-read) [444.863505] Starting subtest: nonblocking-read [444.866588] Subtest nonblocking-read: SUCCESS (0.000s) [444.977189] [060/142] (565s left) kms_cursor_crc (cursor-offscreen-128x42) [445.240866] Starting subtest: cursor-offscreen-128x42 [445.301269] Starting dynamic subtest: pipe-A-HDMI-A-1 [448.116838] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.819s) [448.218264] Starting dynamic subtest: pipe-C-HDMI-A-1 [451.088202] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.894s) [451.092238] Subtest cursor-offscreen-128x42: SUCCESS (5.852s) [451.377406] [061/142] (559s left) gem_exec_store (cachelines) [451.556517] Starting subtest: cachelines [451.560201] Starting dynamic subtest: rcs0 [451.588542] Dynamic subtest rcs0: SUCCESS (0.031s) [451.613829] Starting dynamic subtest: bcs0 [451.625350] Dynamic subtest bcs0: SUCCESS (0.028s) [451.656710] Starting dynamic subtest: vcs0 [451.660065] Dynamic subtest vcs0: SUCCESS (0.024s) [451.675749] Starting dynamic subtest: vecs0 [451.679089] Dynamic subtest vecs0: SUCCESS (0.016s) [451.682322] Subtest cachelines: SUCCESS (0.107s) [451.858497] [062/142] (558s left) gem_exec_fair (basic-deadline) [452.041969] Starting subtest: basic-deadline [454.630607] Subtest basic-deadline: FAIL (2.282s) [454.662271] [063/142] (555s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [455.330157] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [455.595268] [064/142] (554s left) kms_lease (possible-crtcs-filtering) [455.848050] Starting subtest: possible-crtcs-filtering [455.881461] Subtest possible-crtcs-filtering: SUCCESS (0.042s) [455.982917] [065/142] (554s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc) [456.687936] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc [456.696763] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s) [457.124773] [066/142] (553s left) kms_3d [463.196648] [067/142] (547s left) gem_madvise (dontneed-before-exec) [463.349230] Starting subtest: dontneed-before-exec [463.360222] Subtest dontneed-before-exec: SUCCESS (0.009s) [463.451881] [068/142] (547s left) i915_pm_rpm (system-suspend) [465.476231] Starting subtest: system-suspend [482.545990] Subtest system-suspend: SUCCESS (1.354s) [489.836766] [069/142] (543s left) api_intel_bb (blit-noreloc-purge-cache) [489.995403] Starting subtest: blit-noreloc-purge-cache [490.007241] Subtest blit-noreloc-purge-cache: SUCCESS (0.014s) [490.113082] [070/142] (543s left) prime_self_import (basic-llseek-bad) [490.258743] Starting subtest: basic-llseek-bad [490.265479] Subtest basic-llseek-bad: SUCCESS (0.004s) [490.364941] [071/142] (542s left) gem_exec_flush (basic-wb-set-default) [490.532474] Starting subtest: basic-wb-set-default [495.942243] Subtest basic-wb-set-default: SUCCESS (5.411s) [496.146944] [072/142] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [496.401671] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [498.438371] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.046s) [498.595543] [073/142] (534s left) kms_invalid_mode (bad-hsync-end) [498.845834] Starting subtest: bad-hsync-end [498.850027] Starting dynamic subtest: HDMI-A-1-pipe-A [499.303617] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.456s) [499.339756] Starting dynamic subtest: HDMI-A-2-pipe-A [499.348967] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.034s) [499.380304] Starting dynamic subtest: HDMI-A-1-pipe-B [499.389761] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.038s) [499.425690] Starting dynamic subtest: HDMI-A-2-pipe-B [499.436069] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.037s) [499.468043] Starting dynamic subtest: HDMI-A-1-pipe-C [499.477267] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.039s) [499.511224] Starting dynamic subtest: HDMI-A-2-pipe-C [499.520591] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (0.038s) [499.523812] Subtest bad-hsync-end: SUCCESS (0.678s) [499.808643] [074/142] (533s left) gem_basic (create-fd-close) [499.966058] Starting subtest: create-fd-close [499.971871] Subtest create-fd-close: SUCCESS (0.000s) [500.058013] [075/142] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [500.317243] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [500.323514] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [500.408798] [076/142] (533s left) sysfs_heartbeat_interval (mixed) [500.570961] Starting subtest: mixed [500.574166] Starting dynamic subtest: vecs0 [505.818754] Dynamic subtest vecs0: SUCCESS (5.239s) [505.844252] Starting dynamic subtest: vcs0 [511.023055] Dynamic subtest vcs0: SUCCESS (5.202s) [511.042264] Starting dynamic subtest: bcs0 [516.214533] Dynamic subtest bcs0: SUCCESS (5.192s) [516.240354] Starting dynamic subtest: rcs0 [521.429695] Dynamic subtest rcs0: SUCCESS (5.213s) [521.433063] Subtest mixed: SUCCESS (20.859s) [521.527506] [077/142] (512s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [521.778877] Starting subtest: fbc-rgb101010-draw-pwrite [524.732094] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.963s) [524.957625] [078/142] (508s left) kms_prime (d3hot) [525.241522] Subtest D3hot: SKIP (0.000s) [525.342672] [079/142] (508s left) kms_busy (extended-pageflip-hang-oldfb) [525.597561] Starting subtest: extended-pageflip-hang-oldfb [525.605792] Starting dynamic subtest: pipe-A [526.309310] Dynamic subtest pipe-A: SUCCESS (0.701s) [526.354395] Starting dynamic subtest: pipe-C [526.761785] Dynamic subtest pipe-C: SUCCESS (0.439s) [526.770951] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.171s) [527.089194] [080/142] (506s left) gem_exec_schedule (preempt-contexts) [527.275200] Starting subtest: preempt-contexts [527.278347] Starting dynamic subtest: rcs0 [527.382291] Dynamic subtest rcs0: SUCCESS (0.102s) [527.412216] Starting dynamic subtest: bcs0 [527.493379] Dynamic subtest bcs0: SUCCESS (0.112s) [527.524859] Starting dynamic subtest: vcs0 [527.587819] Dynamic subtest vcs0: SUCCESS (0.092s) [527.620238] Starting dynamic subtest: vecs0 [527.682155] Dynamic subtest vecs0: SUCCESS (0.092s) [527.685325] Subtest preempt-contexts: SUCCESS (0.409s) [528.016597] [081/142] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [528.285327] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [528.292340] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [528.372216] [082/142] (505s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [528.619626] Starting subtest: plane-use-after-nonblocking-unbind-fencing [528.622938] Starting dynamic subtest: pipe-A-HDMI-A-1 [529.064165] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.437s) [529.342118] Starting dynamic subtest: pipe-A-HDMI-A-2 [529.877540] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.559s) [530.156346] Starting dynamic subtest: pipe-B-HDMI-A-1 [530.681267] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.547s) [530.942842] Starting dynamic subtest: pipe-B-HDMI-A-2 [531.458729] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.537s) [531.697676] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (3.076s) [532.008265] [083/142] (501s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [532.850362] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [533.098413] [084/142] (500s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [533.251780] Starting subtest: invalid-multi-wait-all-unsubmitted [533.255368] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [533.347491] [085/142] (500s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [533.506801] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [533.510072] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [533.598521] [086/142] (500s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [533.848095] Starting subtest: planes-downscale-factor-0-75-unity-scaling [533.851397] Starting dynamic subtest: pipe-A-HDMI-A-1 [534.160322] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.308s) [534.191380] Starting dynamic subtest: pipe-B-HDMI-A-1 [534.507435] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.341s) [534.543711] Starting dynamic subtest: pipe-C-HDMI-A-1 [534.884503] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.368s) [534.887591] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (1.037s) [535.375338] [087/142] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [535.646727] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [535.652238] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [535.741904] [088/142] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [536.016085] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [536.022180] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [536.092487] [089/142] (497s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [536.772627] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [537.046675] [090/142] (497s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs) [537.844773] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs [537.851015] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.001s) [538.189233] [091/142] (495s left) kms_cursor_legacy (torture-move) [538.421793] Starting subtest: torture-move [538.424865] Starting dynamic subtest: pipe-A [547.375467] Dynamic subtest pipe-A: SUCCESS (8.950s) [547.405386] Starting dynamic subtest: pipe-B [558.274210] Dynamic subtest pipe-B: SUCCESS (10.897s) [558.304329] Starting dynamic subtest: pipe-C [563.991290] Dynamic subtest pipe-C: SUCCESS (5.714s) [564.022207] Starting dynamic subtest: all-pipes [569.730021] Dynamic subtest all-pipes: SUCCESS (5.735s) [569.733918] Subtest torture-move: SUCCESS (31.305s) [569.823780] [092/142] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [570.080436] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [570.086639] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [570.172802] [093/142] (464s left) kms_frontbuffer_tracking (fbc-badstride) [570.431327] Starting subtest: fbc-badstride [578.661057] Subtest fbc-badstride: SUCCESS (8.231s) [578.895733] [094/142] (455s left) prime_busy (before-wait) [579.060931] Starting subtest: before-wait [579.075758] Starting dynamic subtest: rcs0 [579.089766] Dynamic subtest rcs0: SUCCESS (0.013s) [579.125244] Starting dynamic subtest: bcs0 [579.128412] Dynamic subtest bcs0: SUCCESS (0.020s) [579.160094] Starting dynamic subtest: vcs0 [579.163524] Dynamic subtest vcs0: SUCCESS (0.014s) [579.181660] Starting dynamic subtest: vecs0 [579.185187] Dynamic subtest vecs0: SUCCESS (0.014s) [579.278399] Subtest before-wait: SUCCESS (0.202s) [579.356867] [095/142] (454s left) gem_mmap_wc (pf-nonblock) [579.509822] Starting subtest: pf-nonblock [579.517998] Subtest pf-nonblock: SUCCESS (0.006s) [579.610985] [096/142] (454s left) fbdev (pan) [579.762775] Starting subtest: pan [579.803183] Subtest pan: SUCCESS (0.044s) [579.895163] [097/142] (454s left) v3d/v3d_submit_cl (bad-flag) [580.103080] Subtest bad-flag: SKIP (0.000s) [580.176678] [098/142] (454s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [580.436346] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [580.442784] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [580.527168] [099/142] (453s left) i915_pm_rc6_residency (rc6-idle) [580.683867] Starting subtest: rc6-idle [580.695874] Starting dynamic subtest: rcs0 [592.948125] Dynamic subtest rcs0: SUCCESS (12.253s) [592.967000] Starting dynamic subtest: bcs0 [605.200252] Dynamic subtest bcs0: SUCCESS (12.250s) [605.219740] Starting dynamic subtest: vcs0 [617.450363] Dynamic subtest vcs0: SUCCESS (12.248s) [617.469900] Starting dynamic subtest: vecs0 [629.701824] Dynamic subtest vecs0: SUCCESS (12.248s) [629.705572] Subtest rc6-idle: SUCCESS (49.021s) [629.977786] [100/142] (404s left) v3d/v3d_submit_csd (bad-extension) [630.189332] Subtest bad-extension: SKIP (0.000s) [630.260826] [101/142] (404s left) perf (invalid-oa-metric-set-id) [630.531056] Starting subtest: invalid-oa-metric-set-id [630.553062] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s) [630.604898] [102/142] (403s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [630.861399] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [632.601060] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.739s) [632.829752] [103/142] (401s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [633.094669] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [633.100654] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [633.194654] [104/142] (401s left) kms_cursor_edge_walk (128x128-left-edge) [633.442705] Starting subtest: 128x128-left-edge [633.450289] Starting dynamic subtest: pipe-A-HDMI-A-1 [637.503603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.055s) [637.545329] Starting dynamic subtest: pipe-C-HDMI-A-1 [641.038036] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.522s) [641.042236] Subtest 128x128-left-edge: SUCCESS (7.594s) [641.301497] [105/142] (393s left) i915_pm_dc (dc5-dpms) [642.551807] Starting subtest: dc5-dpms [644.521232] Subtest dc5-dpms: SUCCESS (1.962s) [644.746565] [106/142] (389s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [645.006404] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [645.012894] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [645.094841] [107/142] (389s left) syncobj_timeline (etime-single-wait-all-submitted) [645.249126] Starting subtest: etime-single-wait-all-submitted [645.356020] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [645.443918] [108/142] (389s left) kms_color (ctm-signed) [645.676958] Starting subtest: ctm-signed [645.680204] Starting dynamic subtest: pipe-A [646.610226] Dynamic subtest pipe-A: SUCCESS (0.931s) [646.648887] Starting dynamic subtest: pipe-B [647.556199] Dynamic subtest pipe-B: SUCCESS (0.939s) [647.587131] Starting dynamic subtest: pipe-C [648.591376] Dynamic subtest pipe-C: SUCCESS (1.029s) [648.595114] Subtest ctm-signed: SUCCESS (2.920s) [648.872651] [109/142] (385s left) v3d/v3d_wait_bo (used-bo) [649.085406] Subtest used-bo: SKIP (0.000s) [649.155038] [110/142] (385s left) kms_draw_crc (fill-fb) [649.401929] Starting subtest: fill-fb [650.029760] Subtest fill-fb: SUCCESS (0.628s) [650.238100] [111/142] (384s left) gen9_exec_parse (bb-large) [650.415506] Starting subtest: bb-large [694.536445] Subtest bb-large: SUCCESS (44.121s) [694.790093] [112/142] (340s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [695.154266] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [697.464522] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SUCCESS (2.319s) [697.624342] [113/142] (337s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [697.802363] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [697.805859] Starting dynamic subtest: smem [698.209702] Dynamic subtest smem: SUCCESS (0.405s) [698.213106] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.408s) [698.423705] [114/142] (336s left) gem_ctx_param (invalid-get-ringsize) [698.577902] Starting subtest: invalid-get-ringsize [698.581314] Subtest invalid-get-ringsize: SUCCESS (0.000s) [698.671384] [115/142] (336s left) kms_scaling_modes (scaling-mode-center) [698.910920] Starting subtest: scaling-mode-center [698.916857] Subtest scaling-mode-center: SKIP (0.005s) [699.004204] [116/142] (336s left) kms_vblank (pipe-d-ts-continuation-modeset) [699.254089] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s) [699.338021] [117/142] (335s left) gem_mmap (big-bo) [699.504744] Starting subtest: big-bo [699.908365] Subtest big-bo: SUCCESS (0.287s) [701.163398] [118/142] (334s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [701.818630] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [701.960539] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s) [702.211847] [119/142] (333s left) kms_addfb_basic (bad-pitch-63) [702.815945] Starting subtest: bad-pitch-63 [702.886909] Subtest bad-pitch-63: SUCCESS (0.000s) [703.069756] [120/142] (332s left) gem_eio (in-flight-external) [703.264880] Starting subtest: in-flight-external [703.358691] Subtest in-flight-external: SUCCESS (0.102s) [703.555081] [121/142] (332s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [703.831110] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [703.837941] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [703.920995] [122/142] (331s left) gem_blits (basic) [704.081229] Starting subtest: basic [713.641004] Subtest basic: SUCCESS (9.560s) [713.738721] [123/142] (321s left) gem_exec_reloc (basic-wc-noreloc) [713.901094] Starting subtest: basic-wc-noreloc [713.907225] Subtest basic-wc-noreloc: SUCCESS (0.008s) [714.087541] [124/142] (321s left) gem_exec_schedule (thriceslice) [714.274123] Starting subtest: thriceslice [714.277573] Starting dynamic subtest: rcs0 [714.289916] Dynamic subtest rcs0: SUCCESS (0.018s) [714.337654] Starting dynamic subtest: bcs0 [714.341585] Dynamic subtest bcs0: SUCCESS (0.032s) [714.384222] Starting dynamic subtest: vcs0 [714.387469] Dynamic subtest vcs0: SUCCESS (0.020s) [714.406363] Starting dynamic subtest: vecs0 [714.409617] Dynamic subtest vecs0: SUCCESS (0.018s) [714.412842] Subtest thriceslice: SUCCESS (0.108s) [714.722291] [125/142] (321s left) vc4/vc4_wait_bo (unused-bo-0ns) [714.936939] Subtest unused-bo-0ns: SKIP (0.000s) [715.005931] [126/142] (320s left) perf_pmu (semaphore-busy) [715.162572] Starting subtest: semaphore-busy [715.165978] Starting dynamic subtest: rcs0 [716.701582] Dynamic subtest rcs0: SUCCESS (1.536s) [716.721033] Starting dynamic subtest: bcs0 [718.254499] Dynamic subtest bcs0: SUCCESS (1.550s) [718.273978] Starting dynamic subtest: vcs0 [719.794266] Dynamic subtest vcs0: SUCCESS (1.537s) [719.814763] Starting dynamic subtest: vecs0 [721.333528] Dynamic subtest vecs0: SUCCESS (1.533s) [721.336798] Subtest semaphore-busy: SUCCESS (6.169s) [721.419978] [127/142] (314s left) gem_exec_await (wide-all) [721.720114] Starting subtest: wide-all [743.511322] Subtest wide-all: SUCCESS (21.785s) [743.808123] [128/142] (292s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_mc_ccs) [744.735173] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s) [744.994270] [129/142] (290s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [745.825120] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s) [746.115863] [130/142] (289s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [746.379122] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [749.540489] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.163s) [749.760363] [131/142] (286s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs) [750.499837] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs [750.967323] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.463s) [751.785084] [132/142] (284s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [752.570935] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [752.577154] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [752.923120] [133/142] (283s left) gem_sync (basic-all) [753.107517] Starting subtest: basic-all [756.182946] Subtest basic-all: SUCCESS (3.079s) [756.389629] [134/142] (279s left) kms_addfb_basic (bo-too-small-due-to-tiling) [756.625308] Starting subtest: bo-too-small-due-to-tiling [756.628756] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [756.731032] [135/142] (279s left) gem_softpin (noreloc-s3) [756.899356] Starting subtest: noreloc-S3 [778.569270] Subtest noreloc-S3: SUCCESS (5.476s) [780.250208] [136/142] (273s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs) [781.019242] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs [782.007910] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.989s) [782.628436] [137/142] (271s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [782.786374] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [782.840332] [138/142] (271s left) kms_pipe_crc_basic (read-crc-frame-sequence) [783.080925] Starting subtest: read-crc-frame-sequence [783.084181] Starting dynamic subtest: pipe-A-HDMI-A-1 [784.039411] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.953s) [784.072251] Starting dynamic subtest: pipe-B-HDMI-A-2 [784.994258] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.951s) [785.032675] Starting dynamic subtest: pipe-C-HDMI-A-1 [786.104878] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.103s) [786.108859] Subtest read-crc-frame-sequence: SUCCESS (3.027s) [786.402837] [139/142] (267s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5) [786.645590] Starting subtest: plane-downscale-with-pixel-format-factor-0-5 [786.649016] Starting dynamic subtest: pipe-A-HDMI-A-1 [790.160508] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.512s) [790.187410] Starting dynamic subtest: pipe-B-HDMI-A-1 [793.522973] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.348s) [793.560757] Starting dynamic subtest: pipe-C-HDMI-A-1 [794.013132] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.482s) [794.016540] Subtest plane-downscale-with-pixel-format-factor-0-5: SUCCESS (7.369s) [794.422653] [140/142] (259s left) gem_pwrite (basic-exhaustion) [794.584026] Starting subtest: basic-exhaustion [818.468407] Subtest basic-exhaustion: SUCCESS (23.888s) [818.573087] [141/142] (235s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs) [819.328553] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s) [819.550232] [142/142] (234s left) kms_vblank (invalid) [819.794156] Starting subtest: invalid [820.425924] Subtest invalid: SUCCESS (0.628s) [820.689907] Closing watchdogs Done.