[88.962378] Initializing watchdogs
[88.962460]   /dev/watchdog0
[88.992837] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[89.008425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[89.013189] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.016362] [001/131] (960s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[91.048252] Starting subtest: x-tiled-16bpp-rotate-180
[92.908486] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.868s)
[93.189148] [002/131] (956s left) kms_dp_aux_dev
[94.542627] [003/131] (955s left) kms_atomic (plane-overlay-legacy)
[96.529558] Starting subtest: plane-overlay-legacy
[96.531213] Starting dynamic subtest: pipe-A-HDMI-A-4
[96.989748] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.447s)
[96.991158] Subtest plane-overlay-legacy: SUCCESS (0.449s)
[97.227968] [004/131] (952s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[97.277608] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[97.279260] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[97.434496] [005/131] (952s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[99.424218] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[135.044212] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (35.621s)
[135.270532] [006/131] (914s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[137.289322] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[137.290665] Starting dynamic subtest: pipe-A
[137.445671] Dynamic subtest pipe-A: SUCCESS (0.157s)
[137.453985] Starting dynamic subtest: pipe-B
[137.585839] Dynamic subtest pipe-B: SUCCESS (0.140s)
[137.594745] Starting dynamic subtest: pipe-C
[137.726937] Dynamic subtest pipe-C: SUCCESS (0.141s)
[137.735854] Starting dynamic subtest: pipe-D
[137.867913] Dynamic subtest pipe-D: SUCCESS (0.141s)
[137.869395] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.579s)
[138.051424] [007/131] (911s left) kms_invalid_mode (int-max-clock)
[140.040648] Starting subtest: int-max-clock
[140.042159] Starting dynamic subtest: pipe-A-HDMI-A-4
[140.080725] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.041s)
[140.089444] Starting dynamic subtest: pipe-B-HDMI-A-4
[140.090955] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[140.099287] Starting dynamic subtest: pipe-C-HDMI-A-4
[140.100946] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[140.109215] Starting dynamic subtest: pipe-D-HDMI-A-4
[140.110990] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[140.112583] Subtest int-max-clock: SUCCESS (0.050s)
[140.308470] [008/131] (909s left) gem_flink_basic (flink-lifetime)
[140.390422] Starting subtest: flink-lifetime
[140.394170] Subtest flink-lifetime: SUCCESS (0.003s)
[140.580069] [009/131] (909s left) drm_read (short-buffer-block)
[142.643152] Starting subtest: short-buffer-block
[142.644763] Subtest short-buffer-block: SUCCESS (0.000s)
[142.918138] [010/131] (907s left) gem_workarounds (reset-fd)
[142.994934] Starting subtest: reset-fd
[143.158656] Subtest reset-fd: SUCCESS (0.160s)
[143.354308] [011/131] (906s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[143.409592] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[143.413296] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[143.552906] [012/131] (906s left) kms_writeback (writeback-check-output)
[145.548170] Subtest writeback-check-output: SKIP (0.000s)
[145.616228] [013/131] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[147.610742] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[147.614175] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[147.860904] [014/131] (902s left) gem_vm_create (isolation)
[147.913156] Starting subtest: isolation
[147.924441] Subtest isolation: SUCCESS (0.011s)
[148.144567] [015/131] (902s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[150.137726] Starting subtest: cursorA-vs-flipA-atomic-transitions
[161.066890] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.929s)
[161.292531] [016/131] (889s left) gem_mmap_offset (clear-via-pagefault)
[161.347673] Starting subtest: clear-via-pagefault
[161.349194] Starting dynamic subtest: lmem0
[184.520950] Dynamic subtest lmem0: SUCCESS (23.167s)
[184.530334] Starting dynamic subtest: smem0
[210.860249] Dynamic subtest smem0: SUCCESS (26.340s)
[210.861955] Subtest clear-via-pagefault: SUCCESS (49.509s)
[211.086674] [017/131] (839s left) perf (polling)
[211.225824] Starting subtest: polling
[211.227144] Starting dynamic subtest: 0-rcs0
[221.272618] Dynamic subtest 0-rcs0: SUCCESS (10.044s)
[221.273920] Subtest polling: SUCCESS (10.045s)
[221.335248] [018/131] (829s left) kms_cursor_crc (cursor-onscreen-128x42)
[223.520887] Starting subtest: cursor-onscreen-128x42
[223.528351] Starting dynamic subtest: pipe-A-HDMI-A-4
[226.021453] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.492s)
[226.066347] Starting dynamic subtest: pipe-D-HDMI-A-4
[228.748474] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.689s)
[228.750208] Subtest cursor-onscreen-128x42: SUCCESS (5.226s)
[229.199063] [019/131] (821s left) gem_exec_fence (basic-wait)
[229.376174] Starting subtest: basic-wait
[229.377608] Starting dynamic subtest: rcs0
[229.500039] Dynamic subtest rcs0: SUCCESS (0.125s)
[229.511995] Starting dynamic subtest: bcs0
[229.553677] Dynamic subtest bcs0: SUCCESS (0.052s)
[229.578361] Starting dynamic subtest: vcs0
[229.611240] Dynamic subtest vcs0: SUCCESS (0.055s)
[229.646151] Starting dynamic subtest: vcs1
[229.672249] Dynamic subtest vcs1: SUCCESS (0.059s)
[229.681208] Starting dynamic subtest: vecs0
[229.723518] Dynamic subtest vecs0: SUCCESS (0.050s)
[229.725126] Subtest basic-wait: SUCCESS (0.349s)
[230.425233] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[230.428312] [020/131] (820s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[232.423648] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[232.426566] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[232.684545] [021/131] (818s left) gem_ctx_bad_destroy (invalid-default-ctx)
[232.731821] Starting subtest: invalid-default-ctx
[232.733401] Subtest invalid-default-ctx: SUCCESS (0.000s)
[232.944786] [022/131] (818s left) kms_flip (dpms-vs-vblank-race)
[234.933704] Starting subtest: dpms-vs-vblank-race
[234.941311] Starting dynamic subtest: A-HDMI-A4
[237.929557] Dynamic subtest A-HDMI-A4: SUCCESS (2.988s)
[237.939281] Starting dynamic subtest: B-HDMI-A4
[240.948887] Dynamic subtest B-HDMI-A4: SUCCESS (3.018s)
[240.958674] Starting dynamic subtest: C-HDMI-A4
[243.964516] Dynamic subtest C-HDMI-A4: SUCCESS (3.014s)
[243.974389] Starting dynamic subtest: D-HDMI-A4
[246.982761] Dynamic subtest D-HDMI-A4: SUCCESS (3.016s)
[246.984419] Subtest dpms-vs-vblank-race: SUCCESS (12.050s)
[247.226341] [023/131] (804s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[247.294904] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[247.296510] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[247.453964] [024/131] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[249.449288] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[249.452754] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[249.687893] [025/131] (801s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[251.683364] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[251.686833] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[251.921568] [026/131] (799s left) core_getversion (all-cards)
[251.968039] Starting subtest: all-cards
[251.992104] Subtest all-cards: SUCCESS (0.027s)
[252.062218] [027/131] (799s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[254.058143] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[254.061453] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[254.313203] [028/131] (797s left) kms_lease (page-flip-implicit-plane)
[256.302761] Starting subtest: page-flip-implicit-plane
[256.304357] Starting dynamic subtest: pipe-A-HDMI-A-4
[256.702838] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.400s)
[256.715121] Starting dynamic subtest: pipe-B-HDMI-A-4
[256.966294] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.261s)
[256.977920] Starting dynamic subtest: pipe-C-HDMI-A-4
[257.219338] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.249s)
[257.231941] Starting dynamic subtest: pipe-D-HDMI-A-4
[257.476776] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.255s)
[257.478356] Subtest page-flip-implicit-plane: SUCCESS (1.177s)
[257.751864] [029/131] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[259.749572] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[259.752792] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.013281] [030/131] (792s left) kms_cursor_edge_walk (256x256-top-edge)
[262.004504] Starting subtest: 256x256-top-edge
[262.006103] Starting dynamic subtest: pipe-A-HDMI-A-4
[265.319560] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.314s)
[265.329706] Starting dynamic subtest: pipe-D-HDMI-A-4
[268.551999] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.229s)
[268.553531] Subtest 256x256-top-edge: SUCCESS (6.549s)
[268.796435] [031/131] (783s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[270.806609] Starting subtest: 4-tiled-8bpp-rotate-180
[270.809502] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[271.036088] [032/131] (781s left) gem_userptr_blits (sync-unmap-cycles)
[271.099030] Starting subtest: sync-unmap-cycles
[276.468258] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[276.700550] [033/131] (775s left) kms_pm_rpm (modeset-lpsp-stress)
[280.982716] Starting subtest: modeset-lpsp-stress
[282.220798] Subtest modeset-lpsp-stress: SKIP (1.238s)
[283.587895] [034/131] (769s left) kms_psr (pr-basic)
[285.586333] Subtest pr-basic: SKIP (0.000s)
[285.659387] [035/131] (767s left) perf_pmu (faulting-read)
[285.712651] Starting subtest: faulting-read
[285.714153] Starting dynamic subtest: fixed
[285.715694] Dynamic subtest fixed: SUCCESS (0.001s)
[285.717154] Subtest faulting-read: SUCCESS (0.003s)
[285.932595] [036/131] (766s left) gem_userptr_blits (process-exit)
[285.997798] Starting subtest: process-exit
[286.007617] Subtest process-exit: SUCCESS (0.012s)
[286.240324] [037/131] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[288.248877] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[288.251913] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.457788] [038/131] (764s left) kms_psr (pr-primary-blt)
[290.478478] Subtest pr-primary-blt: SKIP (0.000s)
[290.559090] [039/131] (762s left) kms_psr (fbc-pr-cursor-plane-onoff)
[292.550038] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[292.626368] [040/131] (760s left) syncobj_eventfd (invalid-illegal-handle)
[292.674487] Starting subtest: invalid-illegal-handle
[292.675986] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[292.812621] [041/131] (760s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[294.806486] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[294.836224] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.019s)
[295.046937] [042/131] (758s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[297.042443] Starting subtest: psr-shrfb-scaledprimary
[297.045104] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[297.267812] [043/131] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[299.262787] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[299.266092] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[299.439493] [044/131] (754s left) gem_render_copy (yf-tiled)
[299.513285] Starting subtest: yf-tiled
[299.515046] Starting dynamic subtest: smem
[299.605718] Dynamic subtest smem: SUCCESS (0.091s)
[299.617028] Starting dynamic subtest: lmem0
[300.372783] Dynamic subtest lmem0: SUCCESS (0.762s)
[300.374761] Subtest yf-tiled: SUCCESS (0.857s)
[300.677456] [045/131] (753s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[302.675113] Starting subtest: extended-pageflip-modeset-hang-oldfb
[302.676852] Starting dynamic subtest: pipe-A
[310.421299] Dynamic subtest pipe-A: SUCCESS (7.745s)
[310.434659] Starting dynamic subtest: pipe-D
[318.137674] Dynamic subtest pipe-D: SUCCESS (7.712s)
[318.139178] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.467s)
[318.430954] [046/131] (735s left) gem_exec_reloc (basic-cpu-noreloc)
[318.488223] Subtest basic-cpu-noreloc: SKIP (0.000s)
[318.627707] [047/131] (735s left) kms_chamelium_color (gamma)
[320.617182] Subtest gamma: SKIP (0.000s)
[320.788194] [048/131] (733s left) gem_exec_balancer (parallel)
[321.238114] Starting subtest: parallel
[323.378847] Subtest parallel: SUCCESS (2.141s)
[323.519237] [049/131] (730s left) gen9_exec_parse (valid-registers)
[323.581514] Subtest valid-registers: SKIP (0.000s)
[323.657893] [050/131] (730s left) gem_exec_fence (nb-await)
[323.877179] Starting subtest: nb-await
[323.878911] Starting dynamic subtest: rcs0
[323.968829] Dynamic subtest rcs0: SUCCESS (0.093s)
[323.985175] Starting dynamic subtest: bcs0
[324.036248] Dynamic subtest bcs0: SUCCESS (0.065s)
[324.057784] Starting dynamic subtest: vcs0
[324.110543] Dynamic subtest vcs0: SUCCESS (0.068s)
[324.134586] Starting dynamic subtest: vcs1
[324.185195] Dynamic subtest vcs1: SUCCESS (0.071s)
[324.207635] Starting dynamic subtest: vecs0
[324.258929] Dynamic subtest vecs0: SUCCESS (0.067s)
[324.260608] Subtest nb-await: SUCCESS (0.386s)
[324.986681] [051/131] (729s left) kms_sequence (queue-idle)
[326.976961] Starting subtest: queue-idle
[326.978443] Starting dynamic subtest: pipe-A-HDMI-A-4
[329.369341] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.392s)
[329.383118] Starting dynamic subtest: pipe-B-HDMI-A-4
[331.582293] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.209s)
[331.593880] Starting dynamic subtest: pipe-C-HDMI-A-4
[333.796995] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.214s)
[333.810188] Starting dynamic subtest: pipe-D-HDMI-A-4
[336.021759] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.222s)
[336.023268] Subtest queue-idle: SUCCESS (9.047s)
[336.265421] [052/131] (718s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[338.257320] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[338.331766] [053/131] (716s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[340.320982] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[340.322396] Starting dynamic subtest: pipe-A-HDMI-A-4
[340.327719] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[340.338378] Starting dynamic subtest: pipe-B-HDMI-A-4
[340.343677] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[340.354151] Starting dynamic subtest: pipe-C-HDMI-A-4
[340.359627] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[340.370289] Starting dynamic subtest: pipe-D-HDMI-A-4
[340.376235] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[340.379189] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[340.652898] [054/131] (714s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[342.660802] Starting subtest: yf-tiled-32bpp-rotate-180
[342.663832] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[342.913620] [055/131] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[344.909443] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[344.912184] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[345.135604] [056/131] (709s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[345.185344] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[345.186801] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[345.353604] [057/131] (709s left) core_auth (getclient-master-drop)
[345.398243] Starting subtest: getclient-master-drop
[345.401185] Subtest getclient-master-drop: SUCCESS (0.004s)
[345.586590] [058/131] (709s left) kms_rotation_crc (sprite-rotation-270)
[347.573879] Starting subtest: sprite-rotation-270
[354.446028] Subtest sprite-rotation-270: SUCCESS (6.871s)
[354.742260] [059/131] (700s left) gem_create (busy-create)
[354.796866] Starting subtest: busy-create
[354.798573] Starting dynamic subtest: lmem0
[387.096187] Dynamic subtest lmem0: SUCCESS (32.298s)
[387.108771] Starting dynamic subtest: smem0
[419.368973] Dynamic subtest smem0: SUCCESS (32.271s)
[419.370897] Subtest busy-create: SUCCESS (64.573s)
[419.704481] [060/131] (635s left) prime_vgem (fence-wait)
[419.791254] Starting subtest: fence-wait
[419.792765] Starting dynamic subtest: rcs0
[420.859440] Dynamic subtest rcs0: SUCCESS (1.063s)
[420.870738] Starting dynamic subtest: bcs0
[421.952335] Dynamic subtest bcs0: SUCCESS (1.088s)
[421.963653] Starting dynamic subtest: vcs0
[423.001892] Dynamic subtest vcs0: SUCCESS (1.045s)
[423.013312] Starting dynamic subtest: vcs1
[424.049988] Dynamic subtest vcs1: SUCCESS (1.043s)
[424.061204] Starting dynamic subtest: vecs0
[425.094566] Dynamic subtest vecs0: SUCCESS (1.039s)
[425.096180] Subtest fence-wait: SUCCESS (5.303s)
[425.249639] [061/131] (630s left) gem_exec_params (invalid-bsd1-flag-on-render)
[425.302500] Starting subtest: invalid-bsd1-flag-on-render
[425.304190] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[425.485887] [062/131] (630s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[427.473464] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[427.474925] Starting dynamic subtest: pipe-A-HDMI-A-4
[427.489608] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[427.501052] Starting dynamic subtest: pipe-B-HDMI-A-4
[427.516131] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[427.526876] Starting dynamic subtest: pipe-C-HDMI-A-4
[427.542050] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[427.553115] Starting dynamic subtest: pipe-D-HDMI-A-4
[427.569165] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[427.572341] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.011s)
[427.740736] [063/131] (627s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[429.740675] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[429.821325] [064/131] (625s left) gem_exec_schedule (semaphore-resolve)
[429.886781] Starting subtest: semaphore-resolve
[429.950780] Subtest semaphore-resolve: SUCCESS (0.064s)
[430.466946] [065/131] (625s left) kms_vblank (wait-forked-hang)
[432.454151] Starting subtest: wait-forked-hang
[432.458627] Starting dynamic subtest: pipe-A-HDMI-A-4
[458.471992] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.007s)
[458.486231] Starting dynamic subtest: pipe-D-HDMI-A-4
[483.474610] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.005s)
[483.476137] Subtest wait-forked-hang: SUCCESS (51.022s)
[483.727638] [066/131] (572s left) kms_feature_discovery (display-3x)
[485.720375] Starting subtest: display-3x
[485.723411] Subtest display-3x: SKIP (0.000s)
[485.969949] [067/131] (570s left) kms_dp_linktrain_fallback (dsc-fallback)
[487.962448] Starting subtest: dsc-fallback
[487.967046] Subtest dsc-fallback: SKIP (0.000s)
[488.170449] [068/131] (567s left) gem_exec_schedule (u-submit-golden-slice)
[488.236812] Starting subtest: u-submit-golden-slice
[488.238443] Starting dynamic subtest: rcs0
[488.298795] Dynamic subtest rcs0: SUCCESS (0.063s)
[488.310155] Starting dynamic subtest: bcs0
[488.341764] Dynamic subtest bcs0: SUCCESS (0.041s)
[488.353648] Starting dynamic subtest: vcs0
[488.386128] Dynamic subtest vcs0: SUCCESS (0.043s)
[488.398118] Starting dynamic subtest: vcs1
[488.429890] Dynamic subtest vcs1: SUCCESS (0.042s)
[488.441500] Starting dynamic subtest: vecs0
[488.474783] Dynamic subtest vecs0: SUCCESS (0.043s)
[488.476696] Subtest u-submit-golden-slice: SUCCESS (0.241s)
[488.965678] [069/131] (567s left) kms_big_fb (linear-16bpp-rotate-180)
[490.974781] Starting subtest: linear-16bpp-rotate-180
[492.965142] Subtest linear-16bpp-rotate-180: SUCCESS (1.987s)
[493.187961] [070/131] (563s left) gem_exec_fence (syncobj-unused-fence)
[493.574368] Starting subtest: syncobj-unused-fence
[493.592659] Subtest syncobj-unused-fence: SUCCESS (0.020s)
[494.102253] [071/131] (562s left) kms_chamelium_edid (dp-edid-resolution-list)
[496.139751] Subtest dp-edid-resolution-list: SKIP (0.000s)
[496.255405] [072/131] (560s left) i915_module_load (reload-no-display)
[496.301918] Starting subtest: reload-no-display
[502.243946] Subtest reload-no-display: SUCCESS (5.940s)
[502.286095] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[502.287252] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[502.299880] [073/131] (554s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[508.177506] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[508.293199] [FACT kms_chamelium_hpd (vga-hpd-for-each-pipe)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[508.296416] [FACT kms_chamelium_hpd (vga-hpd-for-each-pipe)] new: kernel.kmod_is_loaded.i915: true
[508.300866] [074/131] (548s left) vgem_basic (second-client)
[508.353234] Starting subtest: second-client
[508.386720] Subtest second-client: SUCCESS (0.033s)
[508.576569] [075/131] (548s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[510.570136] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[512.809952] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.241s)
[513.078847] [076/131] (543s left) kms_psr (psr-cursor-mmap-cpu)
[515.069336] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[515.147296] [077/131] (541s left) gem_softpin (invalid)
[515.205480] Starting subtest: invalid
[515.223906] Subtest invalid: SUCCESS (0.018s)
[515.495150] [078/131] (541s left) syncobj_wait (invalid-signal-illegal-handle)
[515.543271] Starting subtest: invalid-signal-illegal-handle
[515.544791] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[515.715721] [079/131] (541s left) kms_pm_dc (dc6-dpms)
[518.711663] Starting subtest: dc6-dpms
[518.716376] Subtest dc6-dpms: SKIP (0.000s)
[518.908956] [080/131] (538s left) kms_scaling_modes (scaling-mode-center)
[520.901189] Starting subtest: scaling-mode-center
[520.909441] Subtest scaling-mode-center: SKIP (0.002s)
[521.117661] [081/131] (536s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[521.220897] Starting subtest: map-fixed-invalidate-overlap-busy
[521.224038] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[521.463274] [082/131] (536s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[523.453454] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[523.454902] Starting dynamic subtest: pipe-A-valid-mode
[525.895432] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.441s)
[525.896883] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (2.444s)
[526.161926] [083/131] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[528.159669] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[528.162500] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[528.457946] [084/131] (529s left) kms_getfb (getfb-handle-closed)
[530.449062] Starting subtest: getfb-handle-closed
[530.450445] Subtest getfb-handle-closed: SUCCESS (0.000s)
[530.695965] [085/131] (527s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[532.694126] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[532.697684] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[532.939326] [086/131] (525s left) kms_legacy_colorkey (invalid-plane)
[534.926313] Starting subtest: invalid-plane
[534.928047] Starting dynamic subtest: zero-id
[534.929858] Dynamic subtest zero-id: SUCCESS (0.000s)
[534.940509] Starting dynamic subtest: outrange-id
[534.942205] Dynamic subtest outrange-id: SUCCESS (0.000s)
[534.944104] Subtest invalid-plane: SUCCESS (0.003s)
[535.137818] [087/131] (523s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[537.133498] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[537.136651] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[537.399642] [088/131] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[539.397973] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[539.400976] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[539.638959] [089/131] (518s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[539.714930] Starting subtest: yf-tiled-to-vebox-yf-tiled
[539.720108] Starting dynamic subtest: smem
[539.794482] Dynamic subtest smem: SUCCESS (0.089s)
[539.806286] Starting dynamic subtest: lmem0
[540.546121] Dynamic subtest lmem0: SUCCESS (0.755s)
[540.547794] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.846s)
[540.855490] [090/131] (517s left) api_intel_bb (blit-reloc-keep-cache)
[540.904895] Starting subtest: blit-reloc-keep-cache
[540.908738] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[541.120632] [091/131] (517s left) prime_mmap (test_invalid_sync_flags)
[541.169345] Starting subtest: test_invalid_sync_flags
[541.171269] Starting dynamic subtest: test_invalid_sync_flags-smem
[541.172976] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[541.183952] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[541.185961] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[541.187960] Subtest test_invalid_sync_flags: SUCCESS (0.003s)
[541.354566] [092/131] (517s left) sysfs_preempt_timeout (invalid)
[541.407742] Starting subtest: invalid
[541.409150] Starting dynamic subtest: vecs0
[541.410486] Dynamic subtest vecs0: SUCCESS (0.001s)
[541.420803] Starting dynamic subtest: vcs0
[541.422305] Dynamic subtest vcs0: SUCCESS (0.001s)
[541.432749] Starting dynamic subtest: bcs0
[541.434220] Dynamic subtest bcs0: SUCCESS (0.001s)
[541.444242] Starting dynamic subtest: rcs0
[541.445801] Dynamic subtest rcs0: SUCCESS (0.000s)
[541.455906] Starting dynamic subtest: vcs1
[541.457316] Dynamic subtest vcs1: SUCCESS (0.000s)
[541.458781] Subtest invalid: SUCCESS (0.011s)
[541.542210] [093/131] (517s left) gem_ctx_persistence (legacy-engines-hostile)
[541.594208] Starting subtest: legacy-engines-hostile
[541.595643] Starting dynamic subtest: render
[541.670695] Dynamic subtest render: SUCCESS (0.075s)
[541.689562] Starting dynamic subtest: bsd1
[541.770979] Dynamic subtest bsd1: SUCCESS (0.097s)
[541.812378] Starting dynamic subtest: bsd2
[541.814056] Dynamic subtest bsd2: SUCCESS (0.034s)
[541.830358] Starting dynamic subtest: blt
[541.930054] Dynamic subtest blt: SUCCESS (0.113s)
[541.944515] Starting dynamic subtest: vebox
[542.000898] Dynamic subtest vebox: SUCCESS (0.066s)
[542.009688] Subtest legacy-engines-hostile: SUCCESS (0.409s)
[542.265772] [094/131] (516s left) gem_pread (self)
[542.314890] Subtest self: SKIP (0.000s)
[542.405660] [095/131] (516s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[544.395173] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[544.398180] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[544.670765] [096/131] (514s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[544.721188] Starting subtest: etime-multi-wait-all-submitted-signaled
[544.825845] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[545.019012] [097/131] (514s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[545.069460] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[545.155218] [098/131] (514s left) prime_self_import (export-vs-gem_close-race)
[545.201638] Starting subtest: export-vs-gem_close-race
[550.236127] Subtest export-vs-gem_close-race: SUCCESS (5.034s)
[550.432188] [099/131] (509s left) gem_partial_pwrite_pread (reads-snoop)
[550.486131] Subtest reads-snoop: SKIP (0.000s)
[550.622969] [100/131] (509s left) gem_exec_schedule (implicit-read-write)
[550.683392] Starting subtest: implicit-read-write
[550.684823] Starting dynamic subtest: rcs0
[550.888462] Dynamic subtest rcs0: SUCCESS (0.201s)
[550.898852] Starting dynamic subtest: bcs0
[551.025917] Dynamic subtest bcs0: SUCCESS (0.139s)
[551.036591] Starting dynamic subtest: vcs0
[551.167759] Dynamic subtest vcs0: SUCCESS (0.140s)
[551.178270] Starting dynamic subtest: vcs1
[551.317758] Dynamic subtest vcs1: SUCCESS (0.149s)
[551.328198] Starting dynamic subtest: vecs0
[551.471721] Dynamic subtest vecs0: SUCCESS (0.152s)
[551.473588] Subtest implicit-read-write: SUCCESS (0.789s)
[551.998266] [101/131] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[553.995200] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[553.998887] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[554.214564] [102/131] (505s left) gem_exec_whisper (basic-queues-priority)
[554.273195] Starting subtest: basic-queues-priority
[568.467173] Subtest basic-queues-priority: SUCCESS (14.189s)
[568.780371] [103/131] (491s left) vgem_basic (sysfs)
[568.843276] Starting subtest: sysfs
[568.844722] Subtest sysfs: SUCCESS (0.000s)
[569.011451] [104/131] (491s left) kms_flip (2x-flip-vs-panning-vs-hang)
[571.000194] Starting subtest: 2x-flip-vs-panning-vs-hang
[571.019641] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.019s)
[571.263430] [105/131] (488s left) gen7_exec_parse (load-register-reg)
[571.317141] Subtest load-register-reg: SKIP (0.000s)
[571.435598] [106/131] (488s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[573.424316] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[574.463975] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.041s)
[574.715215] [107/131] (485s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[576.715686] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[576.717327] Starting dynamic subtest: pipe-A-HDMI-A-4
[576.759816] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[576.770915] Starting dynamic subtest: pipe-B-HDMI-A-4
[576.815896] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[576.827117] Starting dynamic subtest: pipe-C-HDMI-A-4
[576.870925] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[576.881708] Starting dynamic subtest: pipe-D-HDMI-A-4
[576.921748] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[576.924831] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.022s)
[577.000289] [108/131] (483s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[579.010719] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[579.013533] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[579.237269] [109/131] (481s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[581.233868] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[581.236581] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[581.509959] [110/131] (479s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[583.508877] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[583.581393] [111/131] (477s left) gem_mmap_wc (fault-concurrent)
[583.632811] Subtest fault-concurrent: SKIP (0.000s)
[583.714774] [112/131] (477s left) kms_cursor_crc (cursor-random-32x32)
[585.797918] Starting subtest: cursor-random-32x32
[585.853294] Subtest cursor-random-32x32: SKIP (0.051s)
[586.308148] [113/131] (474s left) gem_busy (busy)
[586.368876] Starting subtest: busy
[586.370515] Starting dynamic subtest: all-engines
[586.427233] Dynamic subtest all-engines: SUCCESS (0.060s)
[586.440232] Starting dynamic subtest: rcs0
[586.496981] Dynamic subtest rcs0: SUCCESS (0.068s)
[586.508012] Starting dynamic subtest: bcs0
[586.547879] Dynamic subtest bcs0: SUCCESS (0.049s)
[586.578818] Starting dynamic subtest: vcs0
[586.591580] Dynamic subtest vcs0: SUCCESS (0.041s)
[586.623583] Starting dynamic subtest: vcs1
[586.636665] Dynamic subtest vcs1: SUCCESS (0.041s)
[586.663342] Starting dynamic subtest: vecs0
[586.679489] Dynamic subtest vecs0: SUCCESS (0.038s)
[586.681429] Subtest busy: SUCCESS (0.312s)
[587.219636] [114/131] (473s left) kms_plane_multiple (tiling-none)
[589.206287] Starting subtest: tiling-none
[589.207999] Starting dynamic subtest: pipe-A-HDMI-A-4
[590.081393] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.872s)
[590.092585] Starting dynamic subtest: pipe-B-HDMI-A-4
[590.806656] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.723s)
[590.817672] Starting dynamic subtest: pipe-C-HDMI-A-4
[591.546543] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.738s)
[591.557736] Starting dynamic subtest: pipe-D-HDMI-A-4
[592.310663] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.761s)
[592.312162] Subtest tiling-none: SUCCESS (3.104s)
[592.585442] [115/131] (468s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[594.577781] Starting subtest: 2x-long-flip-vs-cursor-legacy
[594.580895] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[594.792526] [116/131] (466s left) sw_sync (sync_merge_same)
[594.839320] Starting subtest: sync_merge_same
[594.841142] Subtest sync_merge_same: SUCCESS (0.000s)
[594.959735] [117/131] (466s left) syncobj_timeline (wait-any-snapshot)
[595.008387] Starting subtest: wait-any-snapshot
[595.090984] Subtest wait-any-snapshot: SUCCESS (0.082s)
[595.291991] [118/131] (466s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[597.279808] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[597.281446] Starting dynamic subtest: pipe-A-HDMI-A-4
[597.297412] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[597.308876] Starting dynamic subtest: pipe-B-HDMI-A-4
[597.325515] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[597.336363] Starting dynamic subtest: pipe-C-HDMI-A-4
[597.353311] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[597.364427] Starting dynamic subtest: pipe-D-HDMI-A-4
[597.389655] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[597.392483] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[597.570303] [119/131] (464s left) i915_query (engine-info)
[597.619490] Starting subtest: engine-info
[597.623212] Subtest engine-info: SUCCESS (0.005s)
[597.823247] [120/131] (463s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[599.819611] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[599.822460] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[600.064483] [121/131] (461s left) gem_eio (create)
[600.278457] Starting subtest: create
[600.574694] Subtest create: SUCCESS (0.296s)
[602.726681] [122/131] (459s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[604.714987] Starting subtest: async-flip-with-page-flip-events-linear
[604.970541] Starting dynamic subtest: pipe-A-HDMI-A-4
[607.274941] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.300s)
[607.463437] Starting dynamic subtest: pipe-B-HDMI-A-4
[609.516820] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.059s)
[609.735097] Starting dynamic subtest: pipe-C-HDMI-A-4
[611.790795] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.063s)
[611.966913] Starting dynamic subtest: pipe-D-HDMI-A-4
[614.023658] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.063s)
[614.025847] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.310s)
[614.459198] [123/131] (447s left) i915_pm_rpm (gem-mmap-type)
[619.035296] Starting subtest: gem-mmap-type
[619.038142] Starting dynamic subtest: fixed-lmem0
[621.934056] Dynamic subtest fixed-lmem0: SUCCESS (2.901s)
[621.946795] Starting dynamic subtest: fixed-smem0
[624.649335] Dynamic subtest fixed-smem0: SUCCESS (2.713s)
[624.651147] Subtest gem-mmap-type: SUCCESS (5.621s)
[625.837489] [124/131] (436s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[627.836198] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[627.837604] Starting dynamic subtest: pipe-A
[628.612624] Dynamic subtest pipe-A: SUCCESS (0.778s)
[628.625944] Starting dynamic subtest: pipe-B
[629.370643] Dynamic subtest pipe-B: SUCCESS (0.756s)
[629.391578] Starting dynamic subtest: pipe-C
[630.162129] Dynamic subtest pipe-C: SUCCESS (0.789s)
[630.181444] Starting dynamic subtest: pipe-D
[630.935481] Dynamic subtest pipe-D: SUCCESS (0.772s)
[630.937062] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.103s)
[631.201654] [125/131] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[633.196966] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[633.199968] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[633.449611] [126/131] (429s left) kms_flip (busy-flip)
[635.427012] Starting subtest: busy-flip
[635.435375] Starting dynamic subtest: A-HDMI-A4
[636.170810] Dynamic subtest A-HDMI-A4: SUCCESS (0.735s)
[636.192989] Starting dynamic subtest: B-HDMI-A4
[636.900412] Dynamic subtest B-HDMI-A4: SUCCESS (0.727s)
[636.916783] Starting dynamic subtest: C-HDMI-A4
[637.587232] Dynamic subtest C-HDMI-A4: SUCCESS (0.683s)
[637.610391] Starting dynamic subtest: D-HDMI-A4
[638.267772] Dynamic subtest D-HDMI-A4: SUCCESS (0.673s)
[638.269224] Subtest busy-flip: SUCCESS (2.842s)
[638.513516] [127/131] (424s left) gem_softpin (allocator-basic)
[638.565026] Starting subtest: allocator-basic
[638.847566] Subtest allocator-basic: SUCCESS (0.279s)
[639.065981] [128/131] (423s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[641.071365] Starting subtest: y-tiled-8bpp-rotate-180
[642.745839] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.670s)
[642.966927] [129/131] (419s left) gem_close (basic)
[643.020261] Starting subtest: basic
[643.021872] Subtest basic: SUCCESS (0.000s)
[643.199440] [130/131] (419s left) gem_ctx_isolation (nonpriv)
[643.256989] Starting subtest: nonpriv
[643.258765] Starting dynamic subtest: rcs0
[644.278855] Dynamic subtest rcs0: SUCCESS (1.021s)
[644.291357] Starting dynamic subtest: bcs0
[645.360332] Dynamic subtest bcs0: SUCCESS (1.080s)
[645.372537] Starting dynamic subtest: vcs0
[646.460459] Dynamic subtest vcs0: SUCCESS (1.099s)
[646.472899] Starting dynamic subtest: vcs1
[647.514950] Dynamic subtest vcs1: SUCCESS (1.053s)
[647.527131] Starting dynamic subtest: vecs0
[648.597156] Dynamic subtest vecs0: SUCCESS (1.081s)
[648.598775] Subtest nonpriv: SUCCESS (5.341s)
[648.947158] [131/131] (413s left) kms_concurrent (multi-plane-atomic-lowres)
[650.939287] Starting subtest: multi-plane-atomic-lowres
[650.940723] Starting dynamic subtest: pipe-A-HDMI-A-4
[651.311685] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.370s)
[651.313356] Subtest multi-plane-atomic-lowres: SUCCESS (0.373s)
[651.606828] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_dp_aux_dev
results: parsing output: 2/ for test: kms_atomic
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: gem_flink_basic
results: parsing output: 8/ for test: drm_read
results: parsing output: 9/ for test: gem_workarounds
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_writeback
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_vm_create
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_mmap_offset
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_ctx_bad_destroy
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: core_getversion
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: syncobj_eventfd
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_sequence
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: core_auth
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: gem_create
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_feature_discovery
results: parsing output: 66/ for test: kms_dp_linktrain_fallback
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_chamelium_edid
results: parsing output: 71/ for test: i915_module_load
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_pm_dc
results: parsing output: 79/ for test: kms_scaling_modes
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_getfb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_legacy_colorkey
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: sysfs_preempt_timeout
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: gem_pread
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: prime_self_import
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gen7_exec_parse
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_mmap_wc
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: gem_busy
results: parsing output: 113/ for test: kms_plane_multiple
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_pm_rpm
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_close
results: parsing output: 129/ for test: gem_ctx_isolation
results: parsing output: 130/ for test: kms_concurrent
Done.