[58.048443] Initializing watchdogs
[58.048487]   /dev/watchdog0
[58.062262] [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]
[58.066510] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.068698] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.072176] [001/133] (960s left) gem_create (create-ext-placement-all)
[58.271780] Starting subtest: create-ext-placement-all
[58.274412] Subtest create-ext-placement-all: SUCCESS (0.000s)
[58.406599] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[58.477268] Starting subtest: map-fixed-invalidate-overlap
[58.481668] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[58.629572] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[58.692907] Starting subtest: fresh-buffer
[60.844547] Subtest fresh-buffer: SUCCESS (2.154s)
[61.008341] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[61.071042] Starting subtest: mmap-boundaries
[61.073197] Starting dynamic subtest: smem0
[61.355196] Dynamic subtest smem0: SUCCESS (0.285s)
[61.357904] Subtest mmap-boundaries: SUCCESS (0.285s)
[61.529126] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[61.653615] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[69.072111] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.428s)
[69.246508] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[69.337805] Starting subtest: atomic-plane-damage
[69.412032] Starting dynamic subtest: pipe-A-eDP-1
[69.929587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[69.932094] Subtest atomic-plane-damage: SUCCESS (0.593s)
[70.817677] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.918374] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.921112] Starting dynamic subtest: pipe-A-eDP-1
[70.984782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[70.993680] Starting dynamic subtest: pipe-B-eDP-1
[71.046814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[71.055934] Starting dynamic subtest: pipe-C-eDP-1
[71.112168] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[71.121216] Starting dynamic subtest: pipe-D-eDP-1
[71.171257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[71.173597] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.253s)
[73.479169] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[73.580430] Starting subtest: psr-rgb101010-draw-mmap-wc
[80.533810] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.957s)
[80.672592] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.742912] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.747599] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.942221] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[81.006258] Starting subtest: wait-all-complex
[81.218758] Subtest wait-all-complex: SUCCESS (0.213s)
[81.315650] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[81.446679] Starting subtest: create-valid-protected-context
[81.449161] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.593212] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.659723] Starting subtest: basic-wb-rw-default
[87.107254] Subtest basic-wb-rw-default: SUCCESS (5.449s)
[87.314314] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[87.415104] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[87.417464] Starting dynamic subtest: pipe-A-eDP-1
[87.438523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.448123] Starting dynamic subtest: pipe-B-eDP-1
[87.467511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.474671] Starting dynamic subtest: pipe-C-eDP-1
[87.493826] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.501479] Starting dynamic subtest: pipe-D-eDP-1
[87.521686] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.523708] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.677121] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.779803] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.913544] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.137s)
[95.069810] [015/133] (924s left) kms_cursor_edge_walk (256x256-top-bottom)
[95.163297] Starting subtest: 256x256-top-bottom
[95.165684] Starting dynamic subtest: pipe-A-eDP-1
[98.610842] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[98.618321] Starting dynamic subtest: pipe-D-eDP-1
[101.725764] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[101.728109] Subtest 256x256-top-bottom: SUCCESS (6.561s)
[102.573373] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.647340] Starting subtest: force-load-detect
[102.651967] Subtest force-load-detect: SKIP (0.000s)
[102.781392] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.836951] Starting subtest: invalid-signal-zero-handles
[102.839220] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.962244] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.920520] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.922883] Starting dynamic subtest: pipe-A-eDP-1
[108.707439] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[108.716410] Starting dynamic subtest: pipe-B-eDP-1
[109.840863] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[109.845200] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.919s)
[111.059716] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[111.161408] Starting subtest: fbcpsr-rgb565-draw-render
[118.181963] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.023s)
[118.340099] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[118.443892] Starting subtest: primary-4-tiled-reflect-x-0
[125.383049] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.940s)
[126.650622] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.719201] Starting subtest: clone-exclusive-crtc
[126.725645] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.827156] [022/133] (892s left) kms_addfb_basic (too-high)
[126.935744] Starting subtest: too-high
[126.937913] Subtest too-high: SUCCESS (0.000s)
[127.037605] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[127.084744] Starting subtest: busy-accuracy-2
[127.086599] Starting dynamic subtest: rcs0
[130.128224] Dynamic subtest rcs0: SUCCESS (3.043s)
[130.138445] Starting dynamic subtest: bcs0
[133.185388] Dynamic subtest bcs0: SUCCESS (3.055s)
[133.195636] Starting dynamic subtest: vcs0
[136.228870] Dynamic subtest vcs0: SUCCESS (3.042s)
[136.236941] Starting dynamic subtest: vcs1
[139.274117] Dynamic subtest vcs1: SUCCESS (3.043s)
[139.284347] Starting dynamic subtest: vecs0
[142.321338] Dynamic subtest vecs0: SUCCESS (3.045s)
[142.331278] Starting dynamic subtest: ccs0
[145.379481] Dynamic subtest ccs0: SUCCESS (3.057s)
[145.381882] Subtest busy-accuracy-2: SUCCESS (18.295s)
[145.513353] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.613715] Starting subtest: pr-primary-mmap-gtt
[145.617633] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.706989] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.811309] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.815342] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.931212] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[146.020777] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[146.025145] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.143912] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.247736] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.249937] Starting dynamic subtest: pipe-A-default-mode
[148.977477] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[148.979761] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.729s)
[149.844480] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.887261] Starting subtest: idle
[149.889436] Starting dynamic subtest: rcs0
[150.464883] Dynamic subtest rcs0: SUCCESS (0.578s)
[150.475931] Starting dynamic subtest: bcs0
[150.972101] Dynamic subtest bcs0: SUCCESS (0.504s)
[150.982759] Starting dynamic subtest: vcs0
[151.477337] Dynamic subtest vcs0: SUCCESS (0.503s)
[151.487909] Starting dynamic subtest: vcs1
[151.983840] Dynamic subtest vcs1: SUCCESS (0.504s)
[151.994425] Starting dynamic subtest: vecs0
[152.488783] Dynamic subtest vecs0: SUCCESS (0.503s)
[152.500155] Starting dynamic subtest: ccs0
[152.994372] Dynamic subtest ccs0: SUCCESS (0.504s)
[152.997252] Subtest idle: SUCCESS (3.107s)
[153.093894] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[153.199346] Starting subtest: master-drop-set-shared-fd
[153.221104] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[153.256965] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[153.367235] Subtest ctm-negative: SKIP (0.000s)
[153.407760] [031/133] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.471604] Starting subtest: multi-wait-for-submit-available-submitted
[153.473867] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.588236] [032/133] (866s left) syncobj_timeline (invalid-signal-illegal-point)
[153.648120] Starting subtest: invalid-signal-illegal-point
[153.650347] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.779208] [033/133] (865s left) gem_mmap (bad-offset)
[153.833721] Subtest bad-offset: SKIP (0.000s)
[153.904133] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.976412] Starting subtest: gt-error-state-capture
[153.978768] Starting dynamic subtest: rcs0
[165.875955] Dynamic subtest rcs0: SUCCESS (11.899s)
[165.887715] Starting dynamic subtest: bcs0
[177.911052] Dynamic subtest bcs0: SUCCESS (12.032s)
[177.922339] Starting dynamic subtest: vcs0
[189.811282] Dynamic subtest vcs0: SUCCESS (11.899s)
[189.822718] Starting dynamic subtest: vcs1
[200.818763] Dynamic subtest vcs1: SUCCESS (11.005s)
[200.830052] Starting dynamic subtest: vecs0
[211.827196] Dynamic subtest vecs0: SUCCESS (11.006s)
[211.840523] Starting dynamic subtest: ccs0
[222.836457] Dynamic subtest ccs0: SUCCESS (11.006s)
[222.839483] Subtest gt-error-state-capture: SUCCESS (68.858s)
[222.940888] [035/133] (796s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[223.037656] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[223.039835] Starting dynamic subtest: pipe-A-eDP-1
[223.048627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.057552] Starting dynamic subtest: pipe-B-eDP-1
[223.066437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.076644] Starting dynamic subtest: pipe-C-eDP-1
[223.084936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.093036] Starting dynamic subtest: pipe-D-eDP-1
[223.101172] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.105508] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[225.291086] [036/133] (794s left) gem_exec_whisper (basic-fds)
[225.354914] Starting subtest: basic-fds
[232.964952] Subtest basic-fds: SUCCESS (7.607s)
[233.172309] [037/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[233.273229] Starting subtest: psr-1p-primscrn-cur-indfb-move
[240.652702] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.382s)
[240.817815] [038/133] (779s left) gem_exec_schedule (preempt-user)
[240.896668] Starting subtest: preempt-user
[240.898571] Starting dynamic subtest: rcs0
[240.912472] Dynamic subtest rcs0: SUCCESS (0.023s)
[240.922066] Starting dynamic subtest: bcs0
[240.932508] Dynamic subtest bcs0: SUCCESS (0.020s)
[240.941868] Starting dynamic subtest: vcs0
[240.954068] Dynamic subtest vcs0: SUCCESS (0.021s)
[240.963544] Starting dynamic subtest: vcs1
[240.974446] Dynamic subtest vcs1: SUCCESS (0.020s)
[240.983773] Starting dynamic subtest: vecs0
[240.994783] Dynamic subtest vecs0: SUCCESS (0.020s)
[241.004081] Starting dynamic subtest: ccs0
[241.019722] Dynamic subtest ccs0: SUCCESS (0.024s)
[241.022021] Subtest preempt-user: SUCCESS (0.130s)
[243.025470] [039/133] (776s left) kms_psr (psr2-primary-mmap-cpu)
[243.136179] Starting subtest: psr2-primary-mmap-cpu
[243.138422] Starting dynamic subtest: eDP-1
[244.888298] Dynamic subtest eDP-1: SUCCESS (1.751s)
[244.890228] Subtest psr2-primary-mmap-cpu: SUCCESS (1.753s)
[245.777267] [040/133] (774s left) gem_ctx_param (invalid-size-set)
[245.835912] Starting subtest: invalid-size-set
[245.838247] Subtest invalid-size-set: SUCCESS (0.001s)
[245.966034] [041/133] (774s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[246.073873] Starting subtest: bad-aux-stride-y-tiled-ccs
[246.076104] Starting dynamic subtest: pipe-A-eDP-1
[246.098019] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.107851] Starting dynamic subtest: pipe-B-eDP-1
[246.128801] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.136520] Starting dynamic subtest: pipe-C-eDP-1
[246.157759] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.165424] Starting dynamic subtest: pipe-D-eDP-1
[246.187468] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.191824] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[248.348157] [042/133] (771s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[248.451845] Starting subtest: blocking-absolute-wf_vblank-interruptible
[248.456429] Starting dynamic subtest: A-eDP1
[257.184638] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[257.193091] Starting dynamic subtest: B-eDP1
[265.918745] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[265.927511] Starting dynamic subtest: C-eDP1
[274.637404] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[274.647735] Starting dynamic subtest: D-eDP1
[283.371254] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[283.373666] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.920s)
[284.613330] [043/133] (735s left) kms_psr2_su (page_flip-nv12)
[284.665961] Subtest page_flip-NV12: SKIP (0.000s)
[284.745641] [044/133] (735s left) gem_exec_balancer (sliced)
[284.806504] Starting subtest: sliced
[284.810608] Subtest sliced: SKIP (0.000s)
[285.159897] [045/133] (735s left) kms_plane_lowres (tiling-x)
[285.253179] Starting subtest: tiling-x
[285.255454] Starting dynamic subtest: pipe-A-eDP-1
[285.259812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.557650] Starting dynamic subtest: pipe-B-eDP-1
[285.562063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.570495] Starting dynamic subtest: pipe-C-eDP-1
[285.574914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.583092] Starting dynamic subtest: pipe-D-eDP-1
[285.587522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.591778] Subtest tiling-x: SKIP (0.305s)
[286.449656] [046/133] (733s left) kms_vblank (query-busy-hang)
[286.539298] Starting subtest: query-busy-hang
[286.541589] Starting dynamic subtest: pipe-A-eDP-1
[312.672949] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.128s)
[312.692278] Starting dynamic subtest: pipe-D-eDP-1
[337.692011] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[337.695440] Subtest query-busy-hang: SUCCESS (51.150s)
[338.524526] [047/133] (681s left) gem_exec_balancer (hang)
[338.786871] Starting subtest: hang
[340.913974] Subtest hang: SUCCESS (2.127s)
[341.091607] [048/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[341.199372] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[341.203756] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.315083] [049/133] (679s left) kms_flip (bo-too-big)
[341.415410] Starting subtest: bo-too-big
[341.417634] Starting dynamic subtest: A-eDP1
[342.758618] Dynamic subtest A-eDP1: SUCCESS (1.343s)
[342.766848] Starting dynamic subtest: B-eDP1
[344.094639] Dynamic subtest B-eDP1: SUCCESS (1.335s)
[344.105656] Starting dynamic subtest: C-eDP1
[345.426837] Dynamic subtest C-eDP1: SUCCESS (1.331s)
[345.443220] Starting dynamic subtest: D-eDP1
[346.757097] Dynamic subtest D-eDP1: SUCCESS (1.327s)
[346.759549] Subtest bo-too-big: SUCCESS (5.345s)
[347.978313] [050/133] (672s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[348.046556] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[348.051290] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[348.251067] [051/133] (672s left) kms_cursor_legacy (single-bo)
[348.363925] Starting subtest: single-bo
[348.366166] Starting dynamic subtest: pipe-A
[353.744979] Dynamic subtest pipe-A: SUCCESS (5.378s)
[353.756422] Starting dynamic subtest: pipe-B
[359.128258] Dynamic subtest pipe-B: SUCCESS (5.380s)
[359.139128] Starting dynamic subtest: pipe-C
[364.510055] Dynamic subtest pipe-C: SUCCESS (5.379s)
[364.520718] Starting dynamic subtest: pipe-D
[369.892025] Dynamic subtest pipe-D: SUCCESS (5.378s)
[369.903071] Starting dynamic subtest: all-pipes
[375.279990] Dynamic subtest all-pipes: SUCCESS (5.385s)
[375.282576] Subtest single-bo: SUCCESS (26.914s)
[375.446745] [052/133] (645s left) kms_pm_rpm (basic-pci-d3-state)
[377.091974] Starting subtest: basic-pci-d3-state
[378.547186] Subtest basic-pci-d3-state: SUCCESS (1.458s)
[378.652166] [053/133] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[378.765653] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[383.181205] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.421s)
[384.411809] [054/133] (636s left) kms_pm_rpm (legacy-planes)
[385.936226] Starting subtest: legacy-planes
[385.939057] Starting dynamic subtest: plane-63
[394.224618] Dynamic subtest plane-63: SUCCESS (8.287s)
[394.236099] Starting dynamic subtest: plane-93
[402.804808] Dynamic subtest plane-93: SUCCESS (8.578s)
[402.816539] Starting dynamic subtest: plane-123
[411.386353] Dynamic subtest plane-123: SUCCESS (8.578s)
[411.398268] Starting dynamic subtest: plane-133
[419.990535] Dynamic subtest plane-133: SUCCESS (8.603s)
[419.993459] Subtest legacy-planes: SUCCESS (34.056s)
[420.395307] [055/133] (600s left) prime_self_import (basic-with_one_bo)
[420.435684] Starting subtest: basic-with_one_bo
[420.457752] Subtest basic-with_one_bo: SUCCESS (0.024s)
[420.599569] [056/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[420.699647] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[420.703833] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[420.836435] [057/133] (599s left) kms_flip (modeset-vs-vblank-race)
[420.933020] Starting subtest: modeset-vs-vblank-race
[420.935277] Starting dynamic subtest: A-eDP1
[425.589757] Dynamic subtest A-eDP1: SUCCESS (4.656s)
[425.601450] Starting dynamic subtest: B-eDP1
[430.329658] Dynamic subtest B-eDP1: SUCCESS (4.738s)
[430.342241] Starting dynamic subtest: C-eDP1
[435.030313] Dynamic subtest C-eDP1: SUCCESS (4.699s)
[435.043696] Starting dynamic subtest: D-eDP1
[439.572830] Dynamic subtest D-eDP1: SUCCESS (4.540s)
[439.578881] Subtest modeset-vs-vblank-race: SUCCESS (18.646s)
[440.850217] [058/133] (579s left) gem_lmem_swapping (heavy-verify-random-ccs)
[440.898192] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[440.933537] [059/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[441.029679] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[441.034055] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[441.145487] [060/133] (579s left) kms_chamelium_color (gamma)
[441.236291] Subtest gamma: SKIP (0.000s)
[441.303739] [061/133] (579s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[441.426420] Starting subtest: cursorB-vs-flipA-varying-size
[441.430898] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[441.594957] [062/133] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[441.687823] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[446.060363] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.376s)
[447.282705] [063/133] (573s left) dumb_buffer (map-valid)
[447.330499] Starting subtest: map-valid
[447.332404] Subtest map-valid: SUCCESS (0.000s)
[447.486526] [064/133] (573s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[447.594443] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[447.596671] Starting dynamic subtest: pipe-A-default-mode
[447.897349] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[447.901939] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.303s)
[448.705235] [065/133] (572s left) perf (i915-ref-count)
[448.813345] Starting subtest: i915-ref-count
[448.871913] Subtest i915-ref-count: SUCCESS (0.062s)
[448.933388] [066/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[449.040868] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[449.045213] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.162976] [067/133] (571s left) gem_softpin (noreloc-interruptible)
[449.223582] Starting subtest: noreloc-interruptible
[454.615987] Subtest noreloc-interruptible: SUCCESS (5.391s)
[454.754714] [068/133] (566s left) kms_psr (fbc-psr2-primary-render)
[454.854902] Starting subtest: fbc-psr2-primary-render
[454.857212] Starting dynamic subtest: eDP-1
[454.861267] Dynamic subtest eDP-1: SKIP (0.000s)
[454.865326] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[454.949442] [069/133] (566s left) kms_lease (atomic-implicit-crtc)
[455.047261] Starting subtest: atomic-implicit-crtc
[455.049654] Starting dynamic subtest: pipe-A-eDP-1
[455.061182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[455.070662] Starting dynamic subtest: pipe-B-eDP-1
[455.082064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[455.092091] Starting dynamic subtest: pipe-C-eDP-1
[455.102804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[455.111035] Starting dynamic subtest: pipe-D-eDP-1
[455.122134] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[455.124272] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[455.216812] [070/133] (566s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[455.312159] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[455.683086] Starting dynamic subtest: pipe-A-eDP-1
[458.446648] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.764s)
[458.809074] Starting dynamic subtest: pipe-B-eDP-1
[461.578591] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[461.938932] Starting dynamic subtest: pipe-C-eDP-1
[464.715997] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[465.102837] Starting dynamic subtest: pipe-D-eDP-1
[467.843587] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[467.846252] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.532s)
[469.051020] [071/133] (552s left) gem_exec_reloc (basic-wc-read-active)
[469.109711] Subtest basic-wc-read-active: SKIP (0.000s)
[469.199902] [072/133] (552s left) gem_readwrite (new-obj)
[469.263615] Subtest new-obj: SKIP (0.000s)
[469.325483] [073/133] (552s left) gem_mmap_gtt (basic-short)
[469.381167] Subtest basic-short: SKIP (0.000s)
[469.448658] [074/133] (551s left) kms_plane_multiple (tiling-yf)
[469.544906] Starting subtest: tiling-yf
[469.548801] Subtest tiling-yf: SKIP (0.000s)
[469.641312] [075/133] (551s left) kms_content_protection (dp-mst-type-0-hdcp14)
[469.801844] Starting subtest: dp-mst-type-0-hdcp14
[469.806196] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[469.965624] [076/133] (551s left) gem_ctx_shared (q-in-order)
[470.038476] Starting subtest: Q-in-order
[470.040129] Starting dynamic subtest: rcs0
[470.187642] Dynamic subtest rcs0: SUCCESS (0.150s)
[470.206754] Starting dynamic subtest: vcs0
[470.260748] Dynamic subtest vcs0: SUCCESS (0.073s)
[470.276797] Starting dynamic subtest: vcs1
[470.337870] Dynamic subtest vcs1: SUCCESS (0.076s)
[470.354157] Starting dynamic subtest: vecs0
[470.412050] Dynamic subtest vecs0: SUCCESS (0.073s)
[470.427649] Starting dynamic subtest: ccs0
[470.499550] Dynamic subtest ccs0: SUCCESS (0.086s)
[470.501679] Subtest Q-in-order: SUCCESS (0.463s)
[472.033840] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[472.037067] [077/133] (549s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.086603] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.194246] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[472.294053] [078/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[472.396757] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[479.116040] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.721s)
[479.289815] [079/133] (542s left) kms_big_fb (linear-8bpp-rotate-270)
[479.392655] Starting subtest: linear-8bpp-rotate-270
[479.415253] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[479.575498] [080/133] (542s left) api_intel_allocator (standalone)
[479.636752] Starting subtest: standalone
[479.650283] Subtest standalone: SUCCESS (0.016s)
[479.836820] [081/133] (541s left) core_auth (getclient-master-drop)
[479.872640] Starting subtest: getclient-master-drop
[479.899030] Subtest getclient-master-drop: SUCCESS (0.030s)
[480.044365] [082/133] (541s left) kms_psr (fbc-psr2-basic)
[480.138154] Starting subtest: fbc-psr2-basic
[480.139811] Starting dynamic subtest: eDP-1
[480.143297] Dynamic subtest eDP-1: SKIP (0.000s)
[480.147428] Subtest fbc-psr2-basic: SKIP (0.001s)
[480.235289] [083/133] (541s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[480.386464] Starting subtest: cursor-rapid-movement-32x32
[480.430799] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[480.758998] [084/133] (541s left) gem_exec_schedule (noreorder-priority)
[480.952966] Starting subtest: noreorder-priority
[480.955633] Starting dynamic subtest: rcs0
[482.090441] Dynamic subtest rcs0: SUCCESS (1.138s)
[482.103867] Starting dynamic subtest: vcs0
[483.907605] Dynamic subtest vcs0: SUCCESS (1.814s)
[483.922872] Starting dynamic subtest: vcs1
[485.954238] Dynamic subtest vcs1: SUCCESS (2.044s)
[485.966201] Starting dynamic subtest: vecs0
[487.910159] Dynamic subtest vecs0: SUCCESS (1.953s)
[487.922055] Starting dynamic subtest: ccs0
[489.072833] Dynamic subtest ccs0: SUCCESS (1.161s)
[489.075281] Subtest noreorder-priority: SUCCESS (8.123s)
[489.302790] [085/133] (532s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[489.418769] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[489.420983] Starting dynamic subtest: pipe-A-eDP-1
[489.445060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.455909] Starting dynamic subtest: pipe-B-eDP-1
[489.479831] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.493176] Starting dynamic subtest: pipe-C-eDP-1
[489.516847] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.529331] Starting dynamic subtest: pipe-D-eDP-1
[489.554786] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.559319] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[491.725626] [086/133] (530s left) core_auth (many-magics)
[491.784658] Starting subtest: many-magics
[492.667308] Subtest many-magics: SUCCESS (0.886s)
[492.908393] [087/133] (529s left) i915_suspend (fence-restore-tiled2untiled)
[492.972943] Starting subtest: fence-restore-tiled2untiled
[492.977377] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[493.107891] [088/133] (528s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[493.202289] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[493.204573] Starting dynamic subtest: pipe-A
[493.222339] Dynamic subtest pipe-A: SKIP (0.017s)
[493.237827] Starting dynamic subtest: pipe-B
[493.253045] Dynamic subtest pipe-B: SKIP (0.030s)
[493.262197] Starting dynamic subtest: pipe-C
[493.282673] Dynamic subtest pipe-C: SKIP (0.029s)
[493.291429] Starting dynamic subtest: pipe-D
[493.312081] Dynamic subtest pipe-D: SKIP (0.029s)
[493.315970] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.108s)
[493.446241] [089/133] (528s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[493.553668] Starting subtest: y-tiled-64bpp-rotate-0
[493.558125] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[493.694221] [090/133] (528s left) gem_ctx_persistence (saturated-hostile)
[493.774293] Starting subtest: saturated-hostile
[493.776646] Starting dynamic subtest: rcs0
[494.637125] Dynamic subtest rcs0: SUCCESS (0.862s)
[494.648954] Starting dynamic subtest: bcs0
[495.453028] Dynamic subtest bcs0: SUCCESS (0.815s)
[495.464769] Starting dynamic subtest: vcs0
[496.256084] Dynamic subtest vcs0: SUCCESS (0.801s)
[496.267612] Starting dynamic subtest: vcs1
[497.058386] Dynamic subtest vcs1: SUCCESS (0.800s)
[497.070222] Starting dynamic subtest: vecs0
[497.851136] Dynamic subtest vecs0: SUCCESS (0.791s)
[497.862424] Starting dynamic subtest: ccs0
[498.690390] Dynamic subtest ccs0: SUCCESS (0.837s)
[498.692890] Subtest saturated-hostile: SUCCESS (4.917s)
[498.797406] [091/133] (523s left) kms_prop_blob (invalid-get-prop)
[498.860558] Starting subtest: invalid-get-prop
[498.862649] Subtest invalid-get-prop: SUCCESS (0.000s)
[499.000018] [092/133] (523s left) gem_mmap_gtt (basic-write)
[499.052234] Subtest basic-write: SKIP (0.000s)
[499.115654] [093/133] (523s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[499.232887] Starting subtest: cursorA-vs-flipA-varying-size
[510.371613] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.137s)
[511.261298] [094/133] (510s left) gem_linear_blits (interruptible)
[511.676467] Starting subtest: interruptible
[515.907872] Subtest interruptible: SUCCESS (4.231s)
[516.065045] [095/133] (506s left) gem_exec_params (sol-reset-invalid)
[516.162239] Starting subtest: sol-reset-invalid
[516.167446] Subtest sol-reset-invalid: SUCCESS (0.003s)
[517.981615] [096/133] (504s left) kms_color_pipeline (plane-lut1d)
[518.088856] Starting subtest: plane-lut1d
[518.101638] Starting dynamic subtest: pipe-A-eDP-1
[518.840807] Dynamic subtest pipe-A-eDP-1: FAIL (0.358s)
[519.516117] Starting dynamic subtest: pipe-B-eDP-1
[520.345591] Dynamic subtest pipe-B-eDP-1: FAIL (0.325s)
[520.942224] Starting dynamic subtest: pipe-C-eDP-1
[521.776063] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[522.267770] Starting dynamic subtest: pipe-D-eDP-1
[523.137078] Dynamic subtest pipe-D-eDP-1: FAIL (0.291s)
[523.139109] Subtest plane-lut1d: FAIL (4.763s)
[523.684679] [097/133] (498s left) gem_wait (busy)
[523.758780] Starting subtest: busy
[523.761089] Starting dynamic subtest: all-engines
[524.886478] Dynamic subtest all-engines: SUCCESS (1.125s)
[524.898922] Starting dynamic subtest: rcs0
[525.428207] Dynamic subtest rcs0: SUCCESS (0.540s)
[525.440480] Starting dynamic subtest: bcs0
[525.967971] Dynamic subtest bcs0: SUCCESS (0.538s)
[525.979045] Starting dynamic subtest: vcs0
[527.893360] Dynamic subtest vcs0: SUCCESS (1.923s)
[527.905536] Starting dynamic subtest: vcs1
[529.877550] Dynamic subtest vcs1: SUCCESS (1.982s)
[529.889865] Starting dynamic subtest: vecs0
[531.925474] Dynamic subtest vecs0: SUCCESS (2.045s)
[531.937805] Starting dynamic subtest: ccs0
[532.466485] Dynamic subtest ccs0: SUCCESS (0.540s)
[532.469046] Subtest busy: SUCCESS (8.708s)
[532.687557] [098/133] (489s left) sriov_basic (enable-vfs-autoprobe-on)
[532.733392] Starting subtest: enable-vfs-autoprobe-on
[532.735245] Starting dynamic subtest: numvfs-1
[532.807877] Dynamic subtest numvfs-1: FAIL (0.005s)
[532.817792] Starting dynamic subtest: numvfs-2
[532.891956] Dynamic subtest numvfs-2: FAIL (0.003s)
[532.902166] Starting dynamic subtest: numvfs-3
[532.975217] Dynamic subtest numvfs-3: FAIL (0.003s)
[532.985875] Starting dynamic subtest: numvfs-4
[533.058090] Dynamic subtest numvfs-4: FAIL (0.003s)
[533.068546] Starting dynamic subtest: numvfs-5
[533.142664] Dynamic subtest numvfs-5: FAIL (0.003s)
[533.153436] Starting dynamic subtest: numvfs-6
[533.226543] Dynamic subtest numvfs-6: FAIL (0.004s)
[533.237073] Starting dynamic subtest: numvfs-7
[533.311453] Dynamic subtest numvfs-7: FAIL (0.004s)
[533.321679] Starting dynamic subtest: numvfs-random
[533.394091] Dynamic subtest numvfs-random: FAIL (0.003s)
[533.404585] Starting dynamic subtest: numvfs-all
[533.477648] Dynamic subtest numvfs-all: FAIL (0.514s)
[533.479687] Subtest enable-vfs-autoprobe-on: FAIL (0.551s)
[533.518670] [099/133] (488s left) kms_chamelium_frames (vga-frame-dump)
[533.895706] Subtest vga-frame-dump: SKIP (0.000s)
[534.669890] [100/133] (487s left) gem_eio (throttle)
[534.871863] Starting subtest: throttle
[535.124879] Subtest throttle: SUCCESS (0.252s)
[535.299617] [101/133] (487s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[535.395407] Starting subtest: psr-abgr161616f-draw-mmap-wc
[535.399362] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[535.526204] [102/133] (487s left) gem_softpin (allocator-nopin)
[535.589729] Starting subtest: allocator-nopin
[535.700783] Subtest allocator-nopin: SUCCESS (0.110s)
[535.858711] [103/133] (486s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[535.967267] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[536.669114] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s)
[536.855562] [104/133] (485s left) kms_flip (busy-flip)
[536.958462] Starting subtest: busy-flip
[536.960799] Starting dynamic subtest: A-eDP1
[538.609696] Dynamic subtest A-eDP1: SUCCESS (1.650s)
[538.624284] Starting dynamic subtest: B-eDP1
[540.349271] Dynamic subtest B-eDP1: SUCCESS (1.737s)
[540.361718] Starting dynamic subtest: C-eDP1
[542.074328] Dynamic subtest C-eDP1: SUCCESS (1.723s)
[542.084648] Starting dynamic subtest: D-eDP1
[543.700689] Dynamic subtest D-eDP1: SUCCESS (1.625s)
[543.703069] Subtest busy-flip: SUCCESS (6.746s)
[544.983428] [105/133] (477s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[545.079933] Starting subtest: x-tiled-16bpp-rotate-270
[545.100160] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[545.297151] [106/133] (477s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[545.392787] Starting subtest: fbcpsr-abgr161616f-draw-render
[545.396898] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[545.510559] [107/133] (477s left) kms_getfb (getfb2-accept-nv12)
[545.604982] Starting subtest: getfb2-accept-nv12
[545.607332] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[545.740630] [108/133] (477s left) gem_ctx_exec (basic-nohangcheck)
[545.800346] Starting subtest: basic-nohangcheck
[546.057099] Subtest basic-nohangcheck: SUCCESS (0.258s)
[546.215612] [109/133] (476s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[546.340597] Starting subtest: short-flip-before-cursor-atomic-transitions
[547.306932] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.964s)
[548.121421] [110/133] (474s left) kms_cursor_crc (cursor-offscreen-256x256)
[548.358967] Starting subtest: cursor-offscreen-256x256
[548.364479] Starting dynamic subtest: pipe-A-eDP-1
[550.309227] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[550.336394] Starting dynamic subtest: pipe-D-eDP-1
[552.900455] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[552.902879] Subtest cursor-offscreen-256x256: SUCCESS (4.543s)
[553.791721] [111/133] (469s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[553.898700] Starting subtest: 4-tiled-8bpp-rotate-0
[555.076847] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.179s)
[555.238210] [112/133] (467s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[555.305034] Subtest writes-after-reads: SKIP (0.000s)
[555.380899] [113/133] (467s left) kms_frontbuffer_tracking (psr-slowdraw)
[555.496186] Starting subtest: psr-slowdraw
[580.606178] Subtest psr-slowdraw: SUCCESS (25.110s)
[580.781321] [114/133] (442s left) i915_pm_rc6_residency (rc6-idle)
[580.850583] Starting subtest: rc6-idle
[580.873410] Starting dynamic subtest: gt0-rcs0
[605.139430] Dynamic subtest gt0-rcs0: SUCCESS (24.265s)
[605.151039] Starting dynamic subtest: gt0-bcs0
[629.414450] Dynamic subtest gt0-bcs0: SUCCESS (24.272s)
[629.426185] Starting dynamic subtest: gt0-ccs0
[653.772046] Dynamic subtest gt0-ccs0: SUCCESS (24.355s)
[653.784736] Starting dynamic subtest: gt1-vcs0
[659.947930] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[659.959715] Starting dynamic subtest: gt1-vecs0
[666.120666] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[666.123548] Subtest rc6-idle: SUCCESS (85.269s)
[666.224605] [115/133] (356s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[666.331167] Starting subtest: fbc-modesetfrombusy
[670.147539] Subtest fbc-modesetfrombusy: SUCCESS (3.819s)
[671.344994] [116/133] (351s left) kms_psr (psr-cursor-render)
[671.440372] Starting subtest: psr-cursor-render
[671.442634] Starting dynamic subtest: eDP-1
[673.117063] Dynamic subtest eDP-1: SUCCESS (1.677s)
[673.119400] Subtest psr-cursor-render: SUCCESS (1.678s)
[674.001232] [117/133] (349s left) gem_exec_parallel (engines)
[674.065321] Starting subtest: engines
[674.067536] Starting dynamic subtest: basic
[675.860938] Dynamic subtest basic: SUCCESS (1.794s)
[675.872313] Starting dynamic subtest: contexts
[680.397471] Dynamic subtest contexts: SUCCESS (4.533s)
[680.409905] Starting dynamic subtest: fds
[684.292101] Dynamic subtest fds: SUCCESS (3.891s)
[684.304203] Starting dynamic subtest: userptr
[685.971510] Dynamic subtest userptr: SUCCESS (1.676s)
[685.974317] Subtest engines: SUCCESS (11.904s)
[686.186428] [118/133] (337s left) prime_busy (after)
[686.251748] Starting subtest: after
[686.256726] Starting dynamic subtest: rcs0
[686.309709] Dynamic subtest rcs0: SUCCESS (0.054s)
[686.320894] Starting dynamic subtest: bcs0
[686.389463] Dynamic subtest bcs0: SUCCESS (0.078s)
[686.400134] Starting dynamic subtest: vcs0
[686.431255] Dynamic subtest vcs0: SUCCESS (0.041s)
[686.441019] Starting dynamic subtest: vcs1
[686.471655] Dynamic subtest vcs1: SUCCESS (0.040s)
[686.481105] Starting dynamic subtest: vecs0
[686.513523] Dynamic subtest vecs0: SUCCESS (0.041s)
[686.522780] Starting dynamic subtest: ccs0
[686.556174] Dynamic subtest ccs0: SUCCESS (0.042s)
[686.665354] Subtest after: SUCCESS (0.412s)
[686.768868] [119/133] (336s left) gem_partial_pwrite_pread (write-display)
[686.833408] Subtest write-display: SKIP (0.000s)
[686.923094] [120/133] (336s left) gem_tiled_blits (basic)
[686.985867] Subtest basic: SKIP (0.000s)
[687.067141] [121/133] (336s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[687.167451] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[695.642006] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.478s)
[695.795400] [122/133] (327s left) sysfs_defaults (readonly)
[695.865208] Starting subtest: readonly
[695.867562] Starting dynamic subtest: vecs0
[695.869798] Dynamic subtest vecs0: SUCCESS (0.000s)
[695.880434] Starting dynamic subtest: ccs0
[695.882597] Dynamic subtest ccs0: SUCCESS (0.000s)
[695.891216] Starting dynamic subtest: vcs0
[695.893438] Dynamic subtest vcs0: SUCCESS (0.000s)
[695.902131] Starting dynamic subtest: bcs0
[695.904239] Dynamic subtest bcs0: SUCCESS (0.000s)
[695.913242] Starting dynamic subtest: rcs0
[695.915441] Dynamic subtest rcs0: SUCCESS (0.000s)
[695.924289] Starting dynamic subtest: vcs1
[695.926461] Dynamic subtest vcs1: SUCCESS (0.000s)
[695.928591] Subtest readonly: SUCCESS (0.006s)
[696.014902] [123/133] (327s left) kms_dsc (dsc-with-formats)
[696.111317] Starting subtest: dsc-with-formats
[696.151652] Subtest dsc-with-formats: SKIP (0.002s)
[696.210191] [124/133] (327s left) prime_mmap (test_reprime)
[696.274564] Starting subtest: test_reprime
[696.276442] Starting dynamic subtest: test_reprime-smem
[696.302982] Dynamic subtest test_reprime-smem: SUCCESS (0.029s)
[696.305329] Subtest test_reprime: SUCCESS (0.030s)
[696.426489] [125/133] (327s left) gem_exec_params (rsvd2-dirt)
[696.489802] Starting subtest: rsvd2-dirt
[696.494490] Subtest rsvd2-dirt: SKIP (0.000s)
[696.626185] [126/133] (327s left) kms_lease (lessee-list)
[696.724510] Starting subtest: lessee-list
[696.726449] Starting dynamic subtest: pipe-A-eDP-1
[696.728303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[696.742428] Starting dynamic subtest: pipe-B-eDP-1
[696.744307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[696.755519] Starting dynamic subtest: pipe-C-eDP-1
[696.757313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[696.766176] Starting dynamic subtest: pipe-D-eDP-1
[696.767912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[696.769701] Subtest lessee-list: SUCCESS (0.008s)
[696.861904] [127/133] (326s left) kms_vrr (flip-dpms)
[696.960076] Starting subtest: flip-dpms
[696.965894] Subtest flip-dpms: SKIP (0.000s)
[697.059201] [128/133] (326s left) kms_frontbuffer_tracking (fbc-1p-rte)
[697.159088] Starting subtest: fbc-1p-rte
[702.621679] Subtest fbc-1p-rte: SUCCESS (5.473s)
[703.861187] [129/133] (319s left) gen9_exec_parse (batch-zero-length)
[703.925899] Subtest batch-zero-length: SKIP (0.000s)
[704.019954] [130/133] (319s left) prime_mmap (test_aperture_limit)
[704.078118] Starting subtest: test_aperture_limit
[704.080183] Starting dynamic subtest: test_aperture_limit-smem
[704.084428] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[704.088476] Subtest test_aperture_limit: SKIP (0.008s)
[704.216143] [131/133] (319s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[704.318119] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[704.322250] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[704.454456] [132/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[704.553449] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[704.557536] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[704.664587] [133/133] (319s left) gem_exec_fence (long-history)
[705.117011] Starting subtest: long-history
[712.660761] Subtest long-history: SUCCESS (7.545s)
[713.418268] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_pipe_control_store_loop
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_force_connector_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: core_setmaster
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr2_su
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_plane_lowres
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: dumb_buffer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_readwrite
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: core_auth
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_linear_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rc6_residency
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: gem_tiled_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: kms_dsc
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.