[61.467941] Initializing watchdogs
[61.467990]   /dev/watchdog0
[61.482682] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.487216] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.489547] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.492813] [001/133] (960s left) sw_sync (timeline_closed)
[61.551089] Starting subtest: timeline_closed
[61.553746] Subtest timeline_closed: SUCCESS (0.000s)
[61.611963] [002/133] (960s left) gem_busy (close-race)
[61.672447] Starting subtest: close-race
[84.913581] Subtest close-race: SUCCESS (23.263s)
[85.265799] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[85.273584] [003/133] (936s left) i915_query (query-topology-garbage-items)
[85.373757] Starting subtest: query-topology-garbage-items
[85.376115] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[85.478206] [004/133] (936s left) gem_userptr_blits (dmabuf-unsync)
[85.546897] Subtest dmabuf-unsync: SKIP (0.000s)
[85.660317] [005/133] (936s left) perf (gen8-unprivileged-single-ctx-counters)
[85.807250] Starting subtest: gen8-unprivileged-single-ctx-counters
[85.811267] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[85.855844] [006/133] (936s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[85.951215] Starting subtest: flip-vs-dpms-off-vs-modeset
[85.953215] Starting dynamic subtest: A-eDP1
[89.597864] Dynamic subtest A-eDP1: SUCCESS (3.646s)
[89.607469] Starting dynamic subtest: B-eDP1
[92.829750] Dynamic subtest B-eDP1: SUCCESS (3.230s)
[92.838700] Starting dynamic subtest: C-eDP1
[96.039869] Dynamic subtest C-eDP1: SUCCESS (3.207s)
[96.048524] Starting dynamic subtest: D-eDP1
[99.135050] Dynamic subtest D-eDP1: SUCCESS (3.092s)
[99.137044] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.181s)
[99.942066] [007/133] (922s left) kms_feature_discovery (chamelium)
[100.048227] Starting subtest: chamelium
[100.052742] Subtest chamelium: SKIP (0.000s)
[100.132590] [008/133] (922s left) kms_atomic_transition (plane-all-modeset-transition)
[100.222845] Starting subtest: plane-all-modeset-transition
[100.227140] Subtest plane-all-modeset-transition: SKIP (0.000s)
[100.307591] [009/133] (922s left) gem_tiled_partial_pwrite_pread (reads)
[100.365930] Subtest reads: SKIP (0.000s)
[100.446857] [010/133] (921s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[100.526799] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[100.531036] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[100.605306] [011/133] (921s left) gem_mmap_offset (oob-read)
[100.650276] Starting subtest: oob-read
[100.652488] Subtest oob-read: SUCCESS (0.000s)
[100.745675] [012/133] (921s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[100.847102] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[100.849396] Starting dynamic subtest: pipe-A-eDP-1
[100.874604] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.884926] Starting dynamic subtest: pipe-B-eDP-1
[100.904578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.911636] Starting dynamic subtest: pipe-C-eDP-1
[100.930783] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.938032] Starting dynamic subtest: pipe-D-eDP-1
[100.957862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.961432] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.100396] [013/133] (919s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[103.152908] Starting subtest: multi-wait-available-submitted-signaled
[103.155215] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[103.250286] [014/133] (919s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[103.345193] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[103.349510] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[103.419174] [015/133] (919s left) gem_mmap_wc (read)
[103.477837] Subtest read: SKIP (0.000s)
[103.540980] [016/133] (919s left) kms_big_fb (linear-16bpp-rotate-180)
[103.646539] Starting subtest: linear-16bpp-rotate-180
[104.980416] Subtest linear-16bpp-rotate-180: SUCCESS (1.335s)
[105.090369] [017/133] (917s left) kms_psr (fbc-psr2-sprite-render)
[105.180465] Starting subtest: fbc-psr2-sprite-render
[105.182387] Starting dynamic subtest: eDP-1
[105.185854] Dynamic subtest eDP-1: SKIP (0.000s)
[105.189452] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[105.250869] [018/133] (917s left) gem_eio (in-flight-external)
[105.481216] Starting subtest: in-flight-external
[106.968824] Subtest in-flight-external: SUCCESS (1.486s)
[107.081593] [019/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[107.331554] Starting subtest: cursor-rapid-movement-256x256
[107.336376] Starting dynamic subtest: pipe-A-eDP-1
[107.875721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[107.902484] Starting dynamic subtest: pipe-D-eDP-1
[109.115958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[109.118442] Subtest cursor-rapid-movement-256x256: SUCCESS (1.784s)
[109.957935] [020/133] (912s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[110.057456] Starting subtest: extended-modeset-hang-oldfb-with-reset
[110.059778] Starting dynamic subtest: pipe-A
[121.835679] Dynamic subtest pipe-A: SUCCESS (11.776s)
[121.846084] Starting dynamic subtest: pipe-D
[134.110921] Dynamic subtest pipe-D: SUCCESS (12.272s)
[134.113411] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.051s)
[134.916530] [021/133] (887s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[135.016299] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[135.018523] Starting dynamic subtest: pipe-A-eDP-1
[135.916098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.894s)
[135.926148] Starting dynamic subtest: pipe-B-eDP-1
[137.491798] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.573s)
[137.502745] Starting dynamic subtest: pipe-C-eDP-1
[139.069486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.576s)
[139.079719] Starting dynamic subtest: pipe-D-eDP-1
[140.572230] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[140.574176] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.548s)
[141.751079] [022/133] (881s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[141.865786] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[141.869903] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[141.986839] [023/133] (880s left) kms_big_fb (yf-tiled-addfb)
[142.092236] Starting subtest: yf-tiled-addfb
[142.096635] Subtest yf-tiled-addfb: SKIP (0.000s)
[142.189043] [024/133] (880s left) gem_close_race (multigpu-basic-threads)
[142.255090] Starting subtest: multigpu-basic-threads
[142.259717] Subtest multigpu-basic-threads: SKIP (0.000s)
[142.488356] [025/133] (880s left) api_intel_allocator (two-level-inception-interruptible)
[142.551203] Starting subtest: two-level-inception-interruptible
[148.011510] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[148.081737] [026/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[148.193750] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[155.653386] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.462s)
[155.776708] [027/133] (867s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[155.862315] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[155.864527] Starting dynamic subtest: pipe-A-eDP-1
[155.886902] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[155.899646] Starting dynamic subtest: pipe-B-eDP-1
[155.921124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.929533] Starting dynamic subtest: pipe-C-eDP-1
[155.950234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.958487] Starting dynamic subtest: pipe-D-eDP-1
[155.980515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.984631] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[158.106273] [028/133] (865s left) gem_mmap_wc (copy)
[158.160922] Subtest copy: SKIP (0.000s)
[158.222988] [029/133] (864s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[158.348159] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[158.352591] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[158.505731] [030/133] (864s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[158.609300] Starting subtest: x-tiled-16bpp-rotate-90
[158.629890] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[158.756742] [031/133] (864s left) kms_cursor_crc (cursor-sliding-256x85)
[159.014761] Starting subtest: cursor-sliding-256x85
[159.063215] Subtest cursor-sliding-256x85: SKIP (0.044s)
[159.255756] [032/133] (864s left) gem_exec_fence (syncobj-invalid-flags)
[159.705915] Starting subtest: syncobj-invalid-flags
[159.708745] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[160.996059] [033/133] (862s left) kms_flip (dpms-vs-vblank-race-interruptible)
[161.098267] Starting subtest: dpms-vs-vblank-race-interruptible
[161.100585] Starting dynamic subtest: A-eDP1
[164.890092] Dynamic subtest A-eDP1: SUCCESS (3.788s)
[164.899514] Starting dynamic subtest: B-eDP1
[168.397416] Dynamic subtest B-eDP1: SUCCESS (3.505s)
[168.407469] Starting dynamic subtest: C-eDP1
[173.040561] Dynamic subtest C-eDP1: SUCCESS (4.640s)
[173.050748] Starting dynamic subtest: D-eDP1
[177.687575] Dynamic subtest D-eDP1: SUCCESS (4.648s)
[177.689907] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.590s)
[178.558323] [034/133] (844s left) kms_addfb_basic (basic-y-tiled-legacy)
[178.628621] Starting subtest: basic-y-tiled-legacy
[178.632951] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[178.770726] [035/133] (844s left) gem_lmem_swapping (heavy-verify-multi)
[178.813727] Subtest heavy-verify-multi: SKIP (0.000s)
[178.852830] [036/133] (844s left) api_intel_bb (misplaced-blitter)
[178.916377] Starting subtest: misplaced-blitter
[178.922031] Subtest misplaced-blitter: SUCCESS (0.008s)
[179.043447] [037/133] (844s left) kms_vblank (query-idle-hang)
[179.141411] Starting subtest: query-idle-hang
[179.143368] Starting dynamic subtest: pipe-A-eDP-1
[205.667647] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.523s)
[205.684404] Starting dynamic subtest: pipe-D-eDP-1
[230.678258] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.006s)
[230.680548] Subtest query-idle-hang: SUCCESS (51.533s)
[231.522764] [038/133] (792s left) kms_fbcon_fbt (psr-suspend)
[231.599457] Starting subtest: psr-suspend
[281.272637] Subtest psr-suspend: SUCCESS (20.061s)
[281.318111] [039/133] (742s left) kms_cursor_crc (cursor-offscreen-128x42)
[281.559910] Starting subtest: cursor-offscreen-128x42
[281.607403] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[281.838524] [040/133] (741s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[281.928945] Starting subtest: bad-pixel-format-y-tiled-ccs
[281.931813] Starting dynamic subtest: pipe-A-eDP-1
[281.958851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.969228] Starting dynamic subtest: pipe-B-eDP-1
[281.993720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.003060] Starting dynamic subtest: pipe-C-eDP-1
[282.028022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.037146] Starting dynamic subtest: pipe-D-eDP-1
[282.063138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.068266] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[284.227052] [041/133] (739s left) kms_atomic_interruptible (universal-setplane-cursor)
[284.339015] Starting subtest: universal-setplane-cursor
[284.341755] Starting dynamic subtest: pipe-A-eDP-1
[291.750485] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.456s)
[291.753246] Subtest universal-setplane-cursor: SUCCESS (7.457s)
[292.561795] [042/133] (731s left) gem_lmem_swapping (verify-ccs)
[292.610526] Subtest verify-ccs: SKIP (0.000s)
[292.661653] [043/133] (731s left) gem_workarounds (reset-context)
[292.723871] Starting subtest: reset-context
[292.883019] Subtest reset-context: SUCCESS (0.160s)
[293.009358] [044/133] (730s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[293.397921] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[294.179204] [045/133] (729s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[294.240536] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[294.243302] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[294.349552] [046/133] (729s left) gem_exec_reloc (basic-write-wc-noreloc)
[294.406982] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[294.506660] [047/133] (729s left) gem_userptr_blits (coherency-unsync)
[294.571357] Subtest coherency-unsync: SKIP (0.000s)
[294.688549] [048/133] (729s left) kms_universal_plane (universal-plane-functional)
[294.785661] Starting subtest: universal-plane-functional
[294.787658] Starting dynamic subtest: pipe-A-eDP-1
[298.769904] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.993s)
[298.780149] Starting dynamic subtest: pipe-B-eDP-1
[303.380198] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.616s)
[303.391790] Starting dynamic subtest: pipe-C-eDP-1
[307.720119] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.343s)
[307.730719] Starting dynamic subtest: pipe-D-eDP-1
[312.102871] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.381s)
[312.105747] Subtest universal-plane-functional: SUCCESS (17.338s)
[312.970736] [049/133] (711s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[313.077465] Starting subtest: 4-tiled-32bpp-rotate-180
[314.511828] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.434s)
[314.646243] [050/133] (709s left) gem_ctx_persistence (engines-persistence)
[314.706926] Starting subtest: engines-persistence
[314.709354] Starting dynamic subtest: rcs0
[315.513488] Dynamic subtest rcs0: SUCCESS (0.805s)
[315.527702] Starting dynamic subtest: bcs0
[316.294170] Dynamic subtest bcs0: SUCCESS (0.778s)
[316.306601] Starting dynamic subtest: vcs0
[317.044449] Dynamic subtest vcs0: SUCCESS (0.749s)
[317.056005] Starting dynamic subtest: vcs1
[317.812399] Dynamic subtest vcs1: SUCCESS (0.765s)
[317.825470] Starting dynamic subtest: vecs0
[318.581477] Dynamic subtest vecs0: SUCCESS (0.767s)
[318.599157] Starting dynamic subtest: ccs0
[319.329717] Dynamic subtest ccs0: SUCCESS (0.746s)
[319.332572] Subtest engines-persistence: SUCCESS (4.621s)
[319.449079] [051/133] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[319.560685] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[326.509878] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.951s)
[326.651465] [052/133] (697s left) kms_color (ctm-negative)
[326.745212] Starting subtest: ctm-negative
[326.747675] Starting dynamic subtest: pipe-A-eDP-1
[327.456329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[327.466479] Starting dynamic subtest: pipe-B-eDP-1
[328.937540] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.481s)
[328.946995] Starting dynamic subtest: pipe-C-eDP-1
[330.283965] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[330.293868] Starting dynamic subtest: pipe-D-eDP-1
[331.611118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[331.613957] Subtest ctm-negative: SUCCESS (4.867s)
[332.408485] [053/133] (691s left) gem_exec_capture (capture)
[332.465358] Starting subtest: capture
[332.467456] Starting dynamic subtest: rcs0-smem
[333.298897] Dynamic subtest rcs0-smem: SUCCESS (0.833s)
[333.309787] Starting dynamic subtest: bcs0-smem
[334.620838] Dynamic subtest bcs0-smem: SUCCESS (1.320s)
[334.631030] Starting dynamic subtest: vcs0-smem
[335.432641] Dynamic subtest vcs0-smem: SUCCESS (0.811s)
[335.443121] Starting dynamic subtest: vcs1-smem
[336.751206] Dynamic subtest vcs1-smem: SUCCESS (1.319s)
[336.761818] Starting dynamic subtest: vecs0-smem
[337.640760] Dynamic subtest vecs0-smem: FAIL (0.828s)
[337.650446] Starting dynamic subtest: ccs0-smem
[338.896401] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[338.899071] Subtest capture: FAIL (6.433s)
[339.007663] [054/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[339.117940] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[339.123204] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[339.226480] [055/133] (685s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[339.290033] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[339.295919] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[339.473958] [056/133] (684s left) perf (blocking)
[339.564051] Starting subtest: blocking
[339.567031] Starting dynamic subtest: 0-rcs0
[349.649451] Dynamic subtest 0-rcs0: SUCCESS (10.034s)
[349.661591] Starting dynamic subtest: 1-vcs0
[359.619747] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[359.622777] Subtest blocking: SUCCESS (20.061s)
[359.675676] [057/133] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[359.776133] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[359.781563] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[359.882917] [058/133] (664s left) gem_exec_whisper (basic-normal)
[359.945702] Starting subtest: basic-normal
[365.202165] Subtest basic-normal: SUCCESS (5.237s)
[365.387534] [059/133] (659s left) prime_busy (before-wait)
[365.447039] Starting subtest: before-wait
[365.449824] Starting dynamic subtest: rcs0
[365.484461] Dynamic subtest rcs0: SUCCESS (0.037s)
[365.496626] Starting dynamic subtest: bcs0
[365.539746] Dynamic subtest bcs0: SUCCESS (0.054s)
[365.551355] Starting dynamic subtest: vcs0
[365.582462] Dynamic subtest vcs0: SUCCESS (0.042s)
[365.593160] Starting dynamic subtest: vcs1
[365.627208] Dynamic subtest vcs1: SUCCESS (0.044s)
[365.637919] Starting dynamic subtest: vecs0
[365.672013] Dynamic subtest vecs0: SUCCESS (0.044s)
[365.683174] Starting dynamic subtest: ccs0
[365.716868] Dynamic subtest ccs0: SUCCESS (0.044s)
[365.825267] Subtest before-wait: SUCCESS (0.380s)
[365.904060] [060/133] (658s left) gem_exec_balancer (bonded-sync)
[365.970862] Starting subtest: bonded-sync
[365.975898] Subtest bonded-sync: SKIP (0.000s)
[366.279172] [061/133] (658s left) gem_mmap_wc (write-read)
[366.334287] Subtest write-read: SKIP (0.000s)
[366.397841] [062/133] (658s left) sysfs_preempt_timeout (timeout)
[366.459025] Starting subtest: timeout
[366.461918] Starting dynamic subtest: vecs0
[375.732537] Dynamic subtest vecs0: SUCCESS (9.271s)
[375.745372] Starting dynamic subtest: ccs0
[377.050905] Dynamic subtest ccs0: SUCCESS (1.316s)
[377.063696] Starting dynamic subtest: vcs0
[386.684885] Dynamic subtest vcs0: SUCCESS (9.628s)
[386.697619] Starting dynamic subtest: bcs0
[387.988808] Dynamic subtest bcs0: SUCCESS (1.303s)
[388.000756] Starting dynamic subtest: rcs0
[389.245185] Dynamic subtest rcs0: SUCCESS (1.255s)
[389.257642] Starting dynamic subtest: vcs1
[398.708690] Dynamic subtest vcs1: SUCCESS (9.460s)
[398.711768] Subtest timeout: SUCCESS (32.241s)
[398.793394] [063/133] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[398.893930] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[398.898910] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[398.995403] [064/133] (625s left) gem_spin_batch (spin-each)
[399.066103] Starting subtest: spin-each
[402.339058] Subtest spin-each: SUCCESS (3.264s)
[402.770444] [065/133] (621s left) dmabuf_sync_file (export-multiwait)
[402.832993] Starting subtest: export-multiwait
[402.836152] Subtest export-multiwait: SUCCESS (0.002s)
[402.897790] [066/133] (621s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[402.953911] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[402.956392] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[403.056622] [067/133] (621s left) gem_pread (exhaustion)
[403.116544] Subtest exhaustion: SKIP (0.000s)
[403.175372] [068/133] (621s left) kms_chamelium_hpd (vga-hpd-fast)
[403.557211] Subtest vga-hpd-fast: SKIP (0.000s)
[404.413564] [069/133] (620s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[404.506059] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[412.006757] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.505s)
[412.132520] [070/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[412.238160] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[412.243014] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[412.336749] [071/133] (612s left) kms_vrr (flipline)
[412.432780] Starting subtest: flipline
[412.440125] Subtest flipline: SKIP (0.000s)
[412.504848] [072/133] (612s left) kms_setmode (invalid-clone-exclusive-crtc)
[412.564017] Starting subtest: invalid-clone-exclusive-crtc
[412.571724] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[412.654673] [073/133] (612s left) i915_hangman (detector)
[412.715110] Starting subtest: detector
[412.718109] Starting dynamic subtest: rcs0
[424.666115] Dynamic subtest rcs0: SUCCESS (11.953s)
[424.678284] Starting dynamic subtest: bcs0
[436.697296] Dynamic subtest bcs0: SUCCESS (12.030s)
[436.709622] Starting dynamic subtest: vcs0
[448.601238] Dynamic subtest vcs0: SUCCESS (11.902s)
[448.613818] Starting dynamic subtest: vcs1
[458.650000] Dynamic subtest vcs1: SUCCESS (10.047s)
[458.663161] Starting dynamic subtest: vecs0
[470.617287] Dynamic subtest vecs0: SUCCESS (11.967s)
[470.630144] Starting dynamic subtest: ccs0
[481.624856] Dynamic subtest ccs0: SUCCESS (11.007s)
[481.627577] Subtest detector: SUCCESS (68.923s)
[481.722789] [074/133] (543s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[481.825303] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[481.829969] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[481.911522] [075/133] (543s left) gem_exec_reloc (basic-wc-noreloc)
[481.973546] Subtest basic-wc-noreloc: SKIP (0.000s)
[482.043607] [076/133] (543s left) i915_query (query-topology-matches-eu-total)
[482.102989] Starting subtest: query-topology-matches-eu-total
[482.105886] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[482.192141] [077/133] (543s left) kms_setmode (invalid-clone-single-crtc)
[482.247973] Starting subtest: invalid-clone-single-crtc
[482.255605] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[482.348893] [078/133] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[482.446983] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[482.451165] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[482.529045] [079/133] (542s left) kms_atomic (atomic-invalid-params)
[482.632592] Starting subtest: atomic-invalid-params
[482.634877] Starting dynamic subtest: pipe-A-eDP-1
[483.038425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[483.040763] Subtest atomic-invalid-params: SUCCESS (0.406s)
[483.872862] [080/133] (541s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[483.966017] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[483.971030] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[484.037307] [081/133] (541s left) prime_mmap (test_aperture_limit)
[484.084251] Starting subtest: test_aperture_limit
[484.086508] Starting dynamic subtest: test_aperture_limit-smem
[484.094131] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[484.099033] Subtest test_aperture_limit: SKIP (0.008s)
[484.167694] [082/133] (541s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[484.234680] Starting subtest: map-fixed-invalidate-overlap-busy
[484.239302] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[484.350767] [083/133] (541s left) kms_psr (fbc-psr2-cursor-plane-move)
[484.435877] Starting subtest: fbc-psr2-cursor-plane-move
[484.438532] Starting dynamic subtest: eDP-1
[484.443688] Dynamic subtest eDP-1: SKIP (0.000s)
[484.448922] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[484.514423] [084/133] (541s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[484.596809] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[484.599360] Starting dynamic subtest: pipe-A-eDP-1
[485.109154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[485.120194] Starting dynamic subtest: pipe-B-eDP-1
[486.578896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[486.590949] Starting dynamic subtest: pipe-C-eDP-1
[487.991787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.414s)
[488.002908] Starting dynamic subtest: pipe-D-eDP-1
[489.429030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s)
[489.431959] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.805s)
[490.574168] [085/133] (535s left) gem_exec_schedule (submit-early-slice)
[490.658676] Starting subtest: submit-early-slice
[490.661433] Starting dynamic subtest: rcs0
[490.692806] Dynamic subtest rcs0: SUCCESS (0.046s)
[490.703912] Starting dynamic subtest: bcs0
[490.738452] Dynamic subtest bcs0: SUCCESS (0.045s)
[490.748265] Starting dynamic subtest: vcs0
[490.785644] Dynamic subtest vcs0: SUCCESS (0.046s)
[490.797004] Starting dynamic subtest: vcs1
[490.831741] Dynamic subtest vcs1: SUCCESS (0.045s)
[490.841842] Starting dynamic subtest: vecs0
[490.875062] Dynamic subtest vecs0: SUCCESS (0.043s)
[490.889410] Starting dynamic subtest: ccs0
[490.922679] Dynamic subtest ccs0: SUCCESS (0.046s)
[490.925304] Subtest submit-early-slice: SUCCESS (0.278s)
[492.826893] [086/133] (532s left) gem_exec_fence (syncobj-unused-fence)
[493.286859] Starting subtest: syncobj-unused-fence
[493.294880] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[494.804831] [087/133] (530s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[494.901360] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[498.860400] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.964s)
[499.990041] [088/133] (525s left) gem_wait (write-wait)
[500.055164] Starting subtest: write-wait
[500.058042] Starting dynamic subtest: all-engines
[501.143915] Dynamic subtest all-engines: SUCCESS (1.089s)
[501.161187] Starting dynamic subtest: rcs0
[502.205078] Dynamic subtest rcs0: SUCCESS (1.058s)
[502.228150] Starting dynamic subtest: bcs0
[503.271552] Dynamic subtest bcs0: SUCCESS (1.063s)
[503.289689] Starting dynamic subtest: vcs0
[504.332402] Dynamic subtest vcs0: SUCCESS (1.057s)
[504.350168] Starting dynamic subtest: vcs1
[505.394270] Dynamic subtest vcs1: SUCCESS (1.059s)
[505.411839] Starting dynamic subtest: vecs0
[506.457124] Dynamic subtest vecs0: SUCCESS (1.059s)
[506.474702] Starting dynamic subtest: ccs0
[507.522511] Dynamic subtest ccs0: SUCCESS (1.062s)
[507.525484] Subtest write-wait: SUCCESS (7.467s)
[507.724574] [089/133] (518s left) kms_getfb (getfb-handle-valid)
[507.830945] Starting subtest: getfb-handle-valid
[507.833816] Subtest getfb-handle-valid: SUCCESS (0.000s)
[507.937531] [090/133] (517s left) kms_psr (pr-cursor-mmap-gtt)
[508.026154] Starting subtest: pr-cursor-mmap-gtt
[508.031685] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[508.124492] [091/133] (517s left) syncobj_wait (wait-for-submit-complex)
[508.181006] Starting subtest: wait-for-submit-complex
[508.241385] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[508.330048] [092/133] (517s left) gem_basic (multigpu-create-close)
[508.384172] Starting subtest: multigpu-create-close
[508.389693] Subtest multigpu-create-close: SKIP (0.000s)
[508.513670] [093/133] (517s left) kms_pm_rpm (pc8-residency)
[510.059289] Starting subtest: pc8-residency
[510.064202] Subtest pc8-residency: SKIP (0.000s)
[510.821077] [094/133] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[510.923472] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[514.489158] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.569s)
[515.624064] [095/133] (510s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[515.730153] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[516.442115] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.715s)
[516.606627] [096/133] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[516.700030] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[516.704577] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[516.803212] [097/133] (509s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[516.896802] Starting subtest: compare-crc-sanitycheck-xr24
[516.899192] Starting dynamic subtest: pipe-A-eDP-1
[517.570934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[517.581490] Starting dynamic subtest: pipe-B-eDP-1
[518.927170] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[518.938262] Starting dynamic subtest: pipe-C-eDP-1
[520.204845] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.273s)
[520.215674] Starting dynamic subtest: pipe-D-eDP-1
[521.451970] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[521.454382] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.554s)
[522.263421] [098/133] (503s left) gem_render_copy (yf-tiled-ccs-to-linear)
[522.327620] Starting subtest: yf-tiled-ccs-to-linear
[522.332290] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[522.518004] [099/133] (503s left) kms_pm_backlight (fade-with-dpms)
[522.612970] Starting subtest: fade-with-dpms
[524.742006] Starting dynamic subtest: eDP-1
[527.227539] Dynamic subtest eDP-1: SUCCESS (2.487s)
[527.230271] Subtest fade-with-dpms: SUCCESS (4.615s)
[528.035903] [100/133] (498s left) i915_pm_rpm (gem-pread)
[529.869569] Starting subtest: gem-pread
[531.949350] Subtest gem-pread: SUCCESS (2.082s)
[532.049315] [101/133] (494s left) i915_drm_fdinfo (virtual-busy)
[532.094315] Starting subtest: virtual-busy
[532.099697] Subtest virtual-busy: SKIP (0.000s)
[532.162046] [102/133] (494s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[532.271719] Starting subtest: pr-cursor-plane-update-sf
[532.276432] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[532.341193] [103/133] (494s left) kms_lease (cursor-implicit-plane)
[532.441833] Starting subtest: cursor-implicit-plane
[532.443912] Starting dynamic subtest: pipe-A-eDP-1
[532.903441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[532.914885] Starting dynamic subtest: pipe-B-eDP-1
[534.034746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[534.049047] Starting dynamic subtest: pipe-C-eDP-1
[535.148704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[535.159942] Starting dynamic subtest: pipe-D-eDP-1
[536.277151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[536.279887] Subtest cursor-implicit-plane: SUCCESS (3.836s)
[537.134656] [104/133] (489s left) syncobj_timeline (wait-any-complex)
[537.192424] Starting subtest: wait-any-complex
[537.253796] Subtest wait-any-complex: SUCCESS (0.063s)
[537.343679] [105/133] (489s left) gem_ctx_persistence (legacy-engines-mixed-process)
[537.396927] Starting subtest: legacy-engines-mixed-process
[537.399119] Starting dynamic subtest: render
[538.685387] Dynamic subtest render: SUCCESS (1.290s)
[538.697787] Starting dynamic subtest: bsd1
[540.674327] Dynamic subtest bsd1: SUCCESS (1.987s)
[540.686567] Starting dynamic subtest: bsd2
[542.720121] Dynamic subtest bsd2: SUCCESS (2.044s)
[542.732989] Starting dynamic subtest: blt
[544.641904] Dynamic subtest blt: SUCCESS (1.920s)
[544.654808] Starting dynamic subtest: vebox
[546.696815] Dynamic subtest vebox: SUCCESS (2.053s)
[546.699966] Subtest legacy-engines-mixed-process: SUCCESS (9.302s)
[546.778659] [106/133] (479s left) kms_flip (plain-flip-ts-check)
[546.887301] Starting subtest: plain-flip-ts-check
[546.889872] Starting dynamic subtest: A-eDP1
[555.769684] Dynamic subtest A-eDP1: SUCCESS (8.850s)
[555.782645] Starting dynamic subtest: B-eDP1
[564.603446] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[564.613874] Starting dynamic subtest: C-eDP1
[573.444673] Dynamic subtest C-eDP1: SUCCESS (8.827s)
[573.455914] Starting dynamic subtest: D-eDP1
[582.273576] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[582.276171] Subtest plain-flip-ts-check: SUCCESS (35.349s)
[583.433959] [107/133] (443s left) kms_invalid_mode (bad-vsync-start)
[583.530011] Starting subtest: bad-vsync-start
[583.532886] Starting dynamic subtest: pipe-A-eDP-1
[583.815629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[583.834910] Starting dynamic subtest: pipe-B-eDP-1
[583.837324] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[583.846996] Starting dynamic subtest: pipe-C-eDP-1
[583.849619] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[583.859559] Starting dynamic subtest: pipe-D-eDP-1
[583.861925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[583.864456] Subtest bad-vsync-start: SUCCESS (0.293s)
[584.671638] [108/133] (441s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[584.801359] Starting subtest: basic-flip-before-cursor-varying-size
[585.732027] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[586.575476] [109/133] (440s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[586.689992] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[595.875118] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.186s)
[596.729355] [110/133] (430s left) gem_softpin (overlap)
[596.796683] Starting subtest: overlap
[597.734175] Subtest overlap: SUCCESS (0.939s)
[597.869370] [111/133] (428s left) kms_psr (psr2-sprite-mmap-gtt)
[597.960543] Starting subtest: psr2-sprite-mmap-gtt
[597.962880] Starting dynamic subtest: eDP-1
[599.406754] Dynamic subtest eDP-1: SKIP (1.443s)
[599.412039] Subtest psr2-sprite-mmap-gtt: SKIP (1.445s)
[599.563770] [112/133] (427s left) kms_frontbuffer_tracking (psr-suspend)
[599.684048] Starting subtest: psr-suspend
[637.749430] Subtest psr-suspend: SUCCESS (7.908s)
[637.872049] [113/133] (389s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[637.977574] Starting subtest: psr2-cursor-plane-update-sf
[637.980353] Starting dynamic subtest: pipe-A-eDP-1
[638.539884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[638.552842] Starting dynamic subtest: pipe-B-eDP-1
[639.810879] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[639.813836] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.877s)
[640.662529] [114/133] (386s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[640.758071] Starting subtest: y-tiled-16bpp-rotate-270
[640.762317] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[640.845250] [115/133] (386s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[640.897486] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[641.004252] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.109s)
[641.088482] [116/133] (385s left) kms_flip (modeset-vs-vblank-race)
[641.179606] Starting subtest: modeset-vs-vblank-race
[641.182427] Starting dynamic subtest: A-eDP1
[645.834909] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[645.847237] Starting dynamic subtest: B-eDP1
[650.552375] Dynamic subtest B-eDP1: SUCCESS (4.743s)
[650.568967] Starting dynamic subtest: C-eDP1
[655.156531] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[655.170676] Starting dynamic subtest: D-eDP1
[659.758311] Dynamic subtest D-eDP1: SUCCESS (4.608s)
[659.764335] Subtest modeset-vs-vblank-race: SUCCESS (18.694s)
[660.935476] [117/133] (366s left) gem_exec_schedule (smoketest-all)
[661.010536] Starting subtest: smoketest-all
[693.387243] Subtest smoketest-all: SUCCESS (32.336s)
[694.937222] [118/133] (332s left) gem_mmap_gtt (basic-small-copy-odd)
[694.997249] Subtest basic-small-copy-odd: SKIP (0.000s)
[695.057754] [119/133] (332s left) gen9_exec_parse (bb-start-cmd)
[695.120686] Subtest bb-start-cmd: SKIP (0.000s)
[695.196841] [120/133] (331s left) gem_mmap_gtt (basic)
[695.251426] Subtest basic: SKIP (0.000s)
[695.309354] [121/133] (331s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[695.356412] Starting subtest: etime-single-wait-available-unsubmitted
[695.460871] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[695.541194] [122/133] (331s left) gem_exec_alignment (forked)
[695.614853] Starting subtest: forked
[734.935734] Subtest forked: SUCCESS (39.280s)
[734.984993] [123/133] (292s left) kms_getfb (getfb2-handle-zero)
[735.137422] Starting subtest: getfb2-handle-zero
[735.140429] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[735.241066] [124/133] (292s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[735.332990] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[735.335245] Starting dynamic subtest: pipe-A
[735.356516] Dynamic subtest pipe-A: SKIP (0.019s)
[735.367118] Starting dynamic subtest: pipe-B
[735.388948] Dynamic subtest pipe-B: SKIP (0.033s)
[735.399370] Starting dynamic subtest: pipe-C
[735.423248] Dynamic subtest pipe-C: SKIP (0.033s)
[735.433245] Starting dynamic subtest: pipe-D
[735.455191] Dynamic subtest pipe-D: SKIP (0.033s)
[735.460155] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[735.553025] [125/133] (291s left) kms_content_protection (uevent)
[735.706414] Starting subtest: uevent
[735.711612] Subtest uevent: SKIP (0.000s)
[735.822945] [126/133] (291s left) kms_plane_multiple (2x-tiling-x)
[735.922275] Starting subtest: 2x-tiling-x
[735.926374] Subtest 2x-tiling-x: SKIP (0.000s)
[736.001005] [127/133] (291s left) gem_exec_schedule (preempt-contexts)
[736.080048] Starting subtest: preempt-contexts
[736.082230] Starting dynamic subtest: rcs0
[736.155336] Dynamic subtest rcs0: SUCCESS (0.077s)
[736.166227] Starting dynamic subtest: bcs0
[736.226904] Dynamic subtest bcs0: SUCCESS (0.072s)
[736.236979] Starting dynamic subtest: vcs0
[736.276059] Dynamic subtest vcs0: SUCCESS (0.049s)
[736.286441] Starting dynamic subtest: vcs1
[736.326171] Dynamic subtest vcs1: SUCCESS (0.049s)
[736.336246] Starting dynamic subtest: vecs0
[736.377315] Dynamic subtest vecs0: SUCCESS (0.048s)
[736.389952] Starting dynamic subtest: ccs0
[736.420855] Dynamic subtest ccs0: SUCCESS (0.045s)
[736.422666] Subtest preempt-contexts: SUCCESS (0.345s)
[738.005956] [128/133] (289s left) perf_pmu (most-busy-check-all)
[738.055662] Starting subtest: most-busy-check-all
[738.058009] Starting dynamic subtest: rcs0
[739.889105] Dynamic subtest rcs0: SUCCESS (1.834s)
[739.907485] Starting dynamic subtest: bcs0
[741.873472] Dynamic subtest bcs0: SUCCESS (1.980s)
[741.887979] Starting dynamic subtest: vcs0
[743.920491] Dynamic subtest vcs0: SUCCESS (2.043s)
[743.934480] Starting dynamic subtest: vcs1
[745.905281] Dynamic subtest vcs1: SUCCESS (1.981s)
[745.919713] Starting dynamic subtest: vecs0
[747.889101] Dynamic subtest vecs0: SUCCESS (1.980s)
[747.902795] Starting dynamic subtest: ccs0
[749.873350] Dynamic subtest ccs0: SUCCESS (1.980s)
[749.876545] Subtest most-busy-check-all: SUCCESS (11.817s)
[749.988206] [129/133] (277s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[750.092634] Starting subtest: multiplane-rotation-cropping-top
[767.585294] Subtest multiplane-rotation-cropping-top: SUCCESS (17.493s)
[767.695520] [130/133] (259s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[767.799435] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[767.803924] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[767.895047] [131/133] (259s left) syncobj_wait (signal)
[767.965804] Starting subtest: signal
[767.968226] Subtest signal: SUCCESS (0.000s)
[768.089140] [132/133] (259s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[768.181138] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[768.185997] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[768.257048] [133/133] (259s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[768.347440] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[775.093521] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.748s)
[775.203025] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: kms_chamelium_edid
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_universal_plane
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_color
results: parsing output: 52/ for test: gem_exec_capture
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: prime_busy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: sysfs_preempt_timeout
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: dmabuf_sync_file
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_pread
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vrr
results: parsing output: 71/ for test: kms_setmode
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: i915_query
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: prime_mmap
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_pipe_crc_basic
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_alignment
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.