[57.411335] Initializing watchdogs
[57.411379]   /dev/watchdog0
[57.425208] [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]
[57.429314] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.431478] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.434566] [001/133] (960s left) gem_create (create-ext-placement-all)
[57.620569] Starting subtest: create-ext-placement-all
[57.623089] Subtest create-ext-placement-all: SUCCESS (0.000s)
[57.759919] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[57.838109] Starting subtest: map-fixed-invalidate-overlap
[57.842561] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[57.971557] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[58.037822] Starting subtest: fresh-buffer
[60.178974] Subtest fresh-buffer: SUCCESS (2.154s)
[60.325931] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[60.387710] Starting subtest: mmap-boundaries
[60.390173] Starting dynamic subtest: smem0
[60.662977] Dynamic subtest smem0: SUCCESS (0.279s)
[60.665642] Subtest mmap-boundaries: SUCCESS (0.280s)
[60.794841] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[60.898878] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[68.458734] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.588s)
[68.624066] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[68.721291] Starting subtest: atomic-plane-damage
[68.796120] Starting dynamic subtest: pipe-A-eDP-1
[69.317853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.522s)
[69.320056] Subtest atomic-plane-damage: SUCCESS (0.597s)
[70.155519] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.255201] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.257602] Starting dynamic subtest: pipe-A-eDP-1
[70.313628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[70.322320] Starting dynamic subtest: pipe-B-eDP-1
[70.373874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[70.382256] Starting dynamic subtest: pipe-C-eDP-1
[70.435751] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[70.444063] Starting dynamic subtest: pipe-D-eDP-1
[70.500318] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[70.502734] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.248s)
[72.809047] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[72.903197] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.966692] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.070s)
[80.112725] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.169807] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.174317] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.376437] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[80.438786] Starting subtest: wait-all-complex
[80.650808] Subtest wait-all-complex: SUCCESS (0.213s)
[80.742953] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[80.887817] Starting subtest: create-valid-protected-context
[80.890559] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.012771] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.094900] Starting subtest: basic-wb-rw-default
[86.548408] Subtest basic-wb-rw-default: SUCCESS (5.454s)
[86.761706] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[86.865863] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[86.868279] Starting dynamic subtest: pipe-A-eDP-1
[86.889353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[86.900318] Starting dynamic subtest: pipe-B-eDP-1
[86.920203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.931617] Starting dynamic subtest: pipe-C-eDP-1
[86.952110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.961534] Starting dynamic subtest: pipe-D-eDP-1
[86.981710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.984231] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.100897] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.214652] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.316495] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.107s)
[94.504683] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[94.604658] Starting subtest: 256x256-top-bottom
[94.606859] Starting dynamic subtest: pipe-A-eDP-1
[98.034496] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[98.043859] Starting dynamic subtest: pipe-D-eDP-1
[101.176400] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[101.178315] Subtest 256x256-top-bottom: SUCCESS (6.571s)
[101.999396] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.089021] Starting subtest: force-load-detect
[102.093692] Subtest force-load-detect: SKIP (0.000s)
[102.220661] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.292638] Starting subtest: invalid-signal-zero-handles
[102.294512] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.432864] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.363479] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.365768] Starting dynamic subtest: pipe-A-eDP-1
[108.153635] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[108.162701] Starting dynamic subtest: pipe-B-eDP-1
[109.286642] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[109.290938] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.921s)
[110.504241] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[110.602724] Starting subtest: fbcpsr-rgb565-draw-render
[117.644479] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.043s)
[117.831561] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.923293] Starting subtest: primary-4-tiled-reflect-x-0
[125.008171] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.085s)
[126.279060] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.336867] Starting subtest: clone-exclusive-crtc
[126.343199] Subtest clone-exclusive-crtc: SKIP (0.001s)
[126.467752] [022/133] (892s left) kms_addfb_basic (too-high)
[126.555806] Starting subtest: too-high
[126.557712] Subtest too-high: SUCCESS (0.000s)
[126.679848] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[126.724471] Starting subtest: busy-accuracy-2
[126.726792] Starting dynamic subtest: rcs0
[129.765338] Dynamic subtest rcs0: SUCCESS (3.039s)
[129.775740] Starting dynamic subtest: bcs0
[132.828923] Dynamic subtest bcs0: SUCCESS (3.062s)
[132.837986] Starting dynamic subtest: vcs0
[135.875613] Dynamic subtest vcs0: SUCCESS (3.045s)
[135.886398] Starting dynamic subtest: vcs1
[138.921493] Dynamic subtest vcs1: SUCCESS (3.045s)
[138.931882] Starting dynamic subtest: vecs0
[141.967576] Dynamic subtest vecs0: SUCCESS (3.044s)
[141.978156] Starting dynamic subtest: ccs0
[145.030451] Dynamic subtest ccs0: SUCCESS (3.061s)
[145.032787] Subtest busy-accuracy-2: SUCCESS (18.305s)
[145.187028] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.289942] Starting subtest: pr-primary-mmap-gtt
[145.294332] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.387985] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.495552] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.500073] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.637590] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.737572] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.742111] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.896293] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[145.984183] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[145.986486] Starting dynamic subtest: pipe-A-default-mode
[148.708062] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[148.710401] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.725s)
[149.558086] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.606312] Starting subtest: idle
[149.608281] Starting dynamic subtest: rcs0
[150.177668] Dynamic subtest rcs0: SUCCESS (0.573s)
[150.188376] Starting dynamic subtest: bcs0
[150.709229] Dynamic subtest bcs0: SUCCESS (0.528s)
[150.718105] Starting dynamic subtest: vcs0
[151.218678] Dynamic subtest vcs0: SUCCESS (0.503s)
[151.226498] Starting dynamic subtest: vcs1
[151.720895] Dynamic subtest vcs1: SUCCESS (0.504s)
[151.730792] Starting dynamic subtest: vecs0
[152.227830] Dynamic subtest vecs0: SUCCESS (0.505s)
[152.239208] Starting dynamic subtest: ccs0
[152.732326] Dynamic subtest ccs0: SUCCESS (0.503s)
[152.735078] Subtest idle: SUCCESS (3.127s)
[152.830424] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[152.928612] Starting subtest: master-drop-set-shared-fd
[152.948418] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[152.983087] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[153.086087] Subtest ctm-negative: SKIP (0.000s)
[153.125084] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.181044] Starting subtest: multi-wait-for-submit-available-submitted
[153.183380] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.316159] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[153.365043] Starting subtest: invalid-signal-illegal-point
[153.366942] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.499216] [033/133] (865s left) gem_mmap (bad-offset)
[153.554162] Subtest bad-offset: SKIP (0.000s)
[153.610070] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.672306] Starting subtest: gt-error-state-capture
[153.674177] Starting dynamic subtest: rcs0
[164.917788] Dynamic subtest rcs0: SUCCESS (11.243s)
[164.927849] Starting dynamic subtest: bcs0
[176.819769] Dynamic subtest bcs0: SUCCESS (11.900s)
[176.832910] Starting dynamic subtest: vcs0
[188.851928] Dynamic subtest vcs0: SUCCESS (12.030s)
[188.865040] Starting dynamic subtest: vcs1
[200.819356] Dynamic subtest vcs1: SUCCESS (11.965s)
[200.833646] Starting dynamic subtest: vecs0
[211.829080] Dynamic subtest vecs0: SUCCESS (11.008s)
[211.840651] Starting dynamic subtest: ccs0
[223.859831] Dynamic subtest ccs0: SUCCESS (12.027s)
[223.862772] Subtest gt-error-state-capture: SUCCESS (70.185s)
[224.039564] [035/133] (795s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[224.138286] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[224.140616] Starting dynamic subtest: pipe-A-eDP-1
[224.150368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.159736] Starting dynamic subtest: pipe-B-eDP-1
[224.168707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.177794] Starting dynamic subtest: pipe-C-eDP-1
[224.186751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.194661] Starting dynamic subtest: pipe-D-eDP-1
[224.203426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.207839] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[226.432292] [036/133] (792s left) gem_exec_whisper (basic-fds)
[226.495936] Starting subtest: basic-fds
[233.910692] Subtest basic-fds: SUCCESS (7.412s)
[234.116224] [037/133] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[234.235119] Starting subtest: psr-1p-primscrn-cur-indfb-move
[241.602171] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.369s)
[241.772376] [038/133] (777s left) gem_exec_schedule (preempt-user)
[241.854045] Starting subtest: preempt-user
[241.856289] Starting dynamic subtest: rcs0
[241.871475] Dynamic subtest rcs0: SUCCESS (0.027s)
[241.880303] Starting dynamic subtest: bcs0
[241.891611] Dynamic subtest bcs0: SUCCESS (0.020s)
[241.900497] Starting dynamic subtest: vcs0
[241.912790] Dynamic subtest vcs0: SUCCESS (0.020s)
[241.925801] Starting dynamic subtest: vcs1
[241.935174] Dynamic subtest vcs1: SUCCESS (0.022s)
[241.944255] Starting dynamic subtest: vecs0
[241.954248] Dynamic subtest vecs0: SUCCESS (0.018s)
[241.963360] Starting dynamic subtest: ccs0
[241.976195] Dynamic subtest ccs0: SUCCESS (0.021s)
[241.978425] Subtest preempt-user: SUCCESS (0.133s)
[244.056509] [039/133] (775s left) kms_psr (psr2-primary-mmap-cpu)
[244.159873] Starting subtest: psr2-primary-mmap-cpu
[244.162149] Starting dynamic subtest: eDP-1
[245.833261] Dynamic subtest eDP-1: SUCCESS (1.673s)
[245.835253] Subtest psr2-primary-mmap-cpu: SUCCESS (1.674s)
[246.723181] [040/133] (772s left) gem_ctx_param (invalid-size-set)
[246.781605] Starting subtest: invalid-size-set
[246.783829] Subtest invalid-size-set: SUCCESS (0.002s)
[246.921988] [041/133] (772s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[247.013106] Starting subtest: bad-aux-stride-y-tiled-ccs
[247.015381] Starting dynamic subtest: pipe-A-eDP-1
[247.038304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.047447] Starting dynamic subtest: pipe-B-eDP-1
[247.068376] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.076169] Starting dynamic subtest: pipe-C-eDP-1
[247.096377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.103942] Starting dynamic subtest: pipe-D-eDP-1
[247.126125] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.130478] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[249.290770] [042/133] (770s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[249.393901] Starting subtest: blocking-absolute-wf_vblank-interruptible
[249.396354] Starting dynamic subtest: A-eDP1
[258.127925] Dynamic subtest A-eDP1: SUCCESS (8.734s)
[258.138514] Starting dynamic subtest: B-eDP1
[266.852234] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[266.861223] Starting dynamic subtest: C-eDP1
[275.577868] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[275.588127] Starting dynamic subtest: D-eDP1
[284.304714] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[284.309403] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.916s)
[285.545685] [043/133] (733s left) kms_psr2_su (page_flip-nv12)
[285.614867] Subtest page_flip-NV12: SKIP (0.000s)
[285.674460] [044/133] (733s left) gem_exec_balancer (sliced)
[285.741848] Starting subtest: sliced
[285.746433] Subtest sliced: SKIP (0.000s)
[286.060422] [045/133] (733s left) kms_plane_lowres (tiling-x)
[286.162789] Starting subtest: tiling-x
[286.165152] Starting dynamic subtest: pipe-A-eDP-1
[286.169633] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.466771] Starting dynamic subtest: pipe-B-eDP-1
[286.471149] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.479631] Starting dynamic subtest: pipe-C-eDP-1
[286.484042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.492444] Starting dynamic subtest: pipe-D-eDP-1
[286.496905] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.500631] Subtest tiling-x: SKIP (0.304s)
[287.287100] [046/133] (732s left) kms_vblank (query-busy-hang)
[287.384356] Starting subtest: query-busy-hang
[287.386620] Starting dynamic subtest: pipe-A-eDP-1
[313.744797] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.355s)
[313.757856] Starting dynamic subtest: pipe-D-eDP-1
[328.671793] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.922s)
[328.673709] Subtest query-busy-hang: SUCCESS (41.284s)
[329.549838] [047/133] (690s left) gem_exec_balancer (hang)
[329.806046] Starting subtest: hang
[331.947083] Subtest hang: SUCCESS (2.135s)
[332.092854] [048/133] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[332.204268] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[332.208227] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[332.315490] [049/133] (687s left) kms_flip (bo-too-big)
[332.418259] Starting subtest: bo-too-big
[332.424452] Starting dynamic subtest: A-eDP1
[333.691660] Dynamic subtest A-eDP1: SUCCESS (1.269s)
[333.702889] Starting dynamic subtest: B-eDP1
[335.024804] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[335.036101] Starting dynamic subtest: C-eDP1
[336.355531] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[336.364263] Starting dynamic subtest: D-eDP1
[337.679074] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[337.681516] Subtest bo-too-big: SUCCESS (5.263s)
[338.913500] [050/133] (680s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[338.978933] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[338.983400] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[339.183245] [051/133] (680s left) kms_cursor_legacy (single-bo)
[339.307229] Starting subtest: single-bo
[339.309099] Starting dynamic subtest: pipe-A
[344.688690] Dynamic subtest pipe-A: SUCCESS (5.379s)
[344.699239] Starting dynamic subtest: pipe-B
[350.070274] Dynamic subtest pipe-B: SUCCESS (5.379s)
[350.080330] Starting dynamic subtest: pipe-C
[355.453736] Dynamic subtest pipe-C: SUCCESS (5.380s)
[355.464352] Starting dynamic subtest: pipe-D
[360.835042] Dynamic subtest pipe-D: SUCCESS (5.379s)
[360.846075] Starting dynamic subtest: all-pipes
[366.224076] Dynamic subtest all-pipes: SUCCESS (5.386s)
[366.226338] Subtest single-bo: SUCCESS (26.915s)
[366.391271] [052/133] (653s left) kms_pm_rpm (basic-pci-d3-state)
[368.020676] Starting subtest: basic-pci-d3-state
[369.484859] Subtest basic-pci-d3-state: SUCCESS (1.466s)
[369.594845] [053/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[369.703206] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[374.095670] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.395s)
[375.258089] [054/133] (644s left) kms_pm_rpm (legacy-planes)
[377.076939] Starting subtest: legacy-planes
[377.079451] Starting dynamic subtest: plane-63
[385.668442] Dynamic subtest plane-63: SUCCESS (8.594s)
[385.680563] Starting dynamic subtest: plane-93
[394.298919] Dynamic subtest plane-93: SUCCESS (8.627s)
[394.320473] Starting dynamic subtest: plane-123
[402.914563] Dynamic subtest plane-123: SUCCESS (8.611s)
[402.925980] Starting dynamic subtest: plane-133
[411.183052] Dynamic subtest plane-133: SUCCESS (8.265s)
[411.185879] Subtest legacy-planes: SUCCESS (34.110s)
[411.571271] [055/133] (608s left) prime_self_import (basic-with_one_bo)
[411.610344] Starting subtest: basic-with_one_bo
[411.635450] Subtest basic-with_one_bo: SUCCESS (0.027s)
[411.774611] [056/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[411.874678] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[411.879049] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[412.001421] [057/133] (608s left) kms_flip (modeset-vs-vblank-race)
[412.097771] Starting subtest: modeset-vs-vblank-race
[412.100153] Starting dynamic subtest: A-eDP1
[416.783750] Dynamic subtest A-eDP1: SUCCESS (4.688s)
[416.795208] Starting dynamic subtest: B-eDP1
[421.506836] Dynamic subtest B-eDP1: SUCCESS (4.720s)
[421.520090] Starting dynamic subtest: C-eDP1
[426.119391] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[426.130544] Starting dynamic subtest: D-eDP1
[430.674491] Dynamic subtest D-eDP1: SUCCESS (4.553s)
[430.676683] Subtest modeset-vs-vblank-race: SUCCESS (18.583s)
[431.875209] [058/133] (588s left) gem_lmem_swapping (heavy-verify-random-ccs)
[431.921531] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[431.970803] [059/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[432.087528] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[432.091615] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[432.233097] [060/133] (587s left) kms_chamelium_color (gamma)
[432.333324] Subtest gamma: SKIP (0.000s)
[432.384478] [061/133] (587s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[432.510015] Starting subtest: cursorB-vs-flipA-varying-size
[432.514519] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[432.675420] [062/133] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[432.787959] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[437.201452] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.418s)
[438.390046] [063/133] (581s left) dumb_buffer (map-valid)
[438.454674] Starting subtest: map-valid
[438.457092] Subtest map-valid: SUCCESS (0.000s)
[438.591629] [064/133] (581s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[438.691341] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[438.693596] Starting dynamic subtest: pipe-A-default-mode
[439.005060] Dynamic subtest pipe-A-default-mode: SKIP (0.313s)
[439.009699] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.314s)
[439.810938] [065/133] (580s left) perf (i915-ref-count)
[439.906218] Starting subtest: i915-ref-count
[439.980165] Subtest i915-ref-count: SUCCESS (0.074s)
[440.064854] [066/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[440.162046] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[440.166274] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.317907] [067/133] (580s left) gem_softpin (noreloc-interruptible)
[440.383251] Starting subtest: noreloc-interruptible
[445.779810] Subtest noreloc-interruptible: SUCCESS (5.394s)
[445.938792] [068/133] (574s left) kms_psr (fbc-psr2-primary-render)
[446.038869] Starting subtest: fbc-psr2-primary-render
[446.041123] Starting dynamic subtest: eDP-1
[446.045256] Dynamic subtest eDP-1: SKIP (0.000s)
[446.049474] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[446.132823] [069/133] (574s left) kms_lease (atomic-implicit-crtc)
[446.231081] Starting subtest: atomic-implicit-crtc
[446.233392] Starting dynamic subtest: pipe-A-eDP-1
[446.244593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[446.253690] Starting dynamic subtest: pipe-B-eDP-1
[446.264822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[446.273714] Starting dynamic subtest: pipe-C-eDP-1
[446.284188] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[446.292620] Starting dynamic subtest: pipe-D-eDP-1
[446.303245] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[446.305397] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[446.399107] [070/133] (574s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[446.495413] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[446.870402] Starting dynamic subtest: pipe-A-eDP-1
[449.661540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.789s)
[450.021493] Starting dynamic subtest: pipe-B-eDP-1
[452.791323] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[453.153173] Starting dynamic subtest: pipe-C-eDP-1
[455.912470] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[456.289567] Starting dynamic subtest: pipe-D-eDP-1
[459.042839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[459.045432] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.548s)
[460.251485] [071/133] (560s left) gem_exec_reloc (basic-wc-read-active)
[460.326693] Subtest basic-wc-read-active: SKIP (0.000s)
[460.402686] [072/133] (560s left) gem_readwrite (new-obj)
[460.456059] Subtest new-obj: SKIP (0.000s)
[460.526412] [073/133] (560s left) gem_mmap_gtt (basic-short)
[460.583818] Subtest basic-short: SKIP (0.000s)
[460.651894] [074/133] (560s left) kms_plane_multiple (tiling-yf)
[460.750636] Starting subtest: tiling-yf
[460.754960] Subtest tiling-yf: SKIP (0.000s)
[460.843948] [075/133] (559s left) kms_content_protection (dp-mst-type-0-hdcp14)
[460.989728] Starting subtest: dp-mst-type-0-hdcp14
[460.994210] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[461.155569] [076/133] (559s left) gem_ctx_shared (q-in-order)
[461.218284] Starting subtest: Q-in-order
[461.220220] Starting dynamic subtest: rcs0
[461.364634] Dynamic subtest rcs0: SUCCESS (0.145s)
[461.380284] Starting dynamic subtest: vcs0
[461.441765] Dynamic subtest vcs0: SUCCESS (0.076s)
[461.457261] Starting dynamic subtest: vcs1
[461.515505] Dynamic subtest vcs1: SUCCESS (0.073s)
[461.531607] Starting dynamic subtest: vecs0
[461.591580] Dynamic subtest vecs0: SUCCESS (0.075s)
[461.607096] Starting dynamic subtest: ccs0
[461.678596] Dynamic subtest ccs0: SUCCESS (0.086s)
[461.680777] Subtest Q-in-order: SUCCESS (0.460s)
[463.072085] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[463.076275] [077/133] (557s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[463.139430] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[463.240297] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[463.342488] [078/133] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[463.446232] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[470.042032] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.597s)
[470.193439] [079/133] (550s left) kms_big_fb (linear-8bpp-rotate-270)
[470.290813] Starting subtest: linear-8bpp-rotate-270
[470.312856] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[470.464654] [080/133] (550s left) api_intel_allocator (standalone)
[470.531136] Starting subtest: standalone
[470.546642] Subtest standalone: SUCCESS (0.018s)
[470.711378] [081/133] (550s left) core_auth (getclient-master-drop)
[470.752642] Starting subtest: getclient-master-drop
[470.776709] Subtest getclient-master-drop: SUCCESS (0.024s)
[470.940298] [082/133] (550s left) kms_psr (fbc-psr2-basic)
[471.055319] Starting subtest: fbc-psr2-basic
[471.057368] Starting dynamic subtest: eDP-1
[471.061353] Dynamic subtest eDP-1: SKIP (0.000s)
[471.065049] Subtest fbc-psr2-basic: SKIP (0.003s)
[471.158638] [083/133] (550s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[471.315553] Starting subtest: cursor-rapid-movement-32x32
[471.363805] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[471.687811] [084/133] (549s left) gem_exec_schedule (noreorder-priority)
[471.878584] Starting subtest: noreorder-priority
[471.881246] Starting dynamic subtest: rcs0
[473.017328] Dynamic subtest rcs0: SUCCESS (1.139s)
[473.028922] Starting dynamic subtest: vcs0
[474.931340] Dynamic subtest vcs0: SUCCESS (1.911s)
[474.944634] Starting dynamic subtest: vcs1
[476.902356] Dynamic subtest vcs1: SUCCESS (1.969s)
[476.914530] Starting dynamic subtest: vecs0
[478.959567] Dynamic subtest vecs0: SUCCESS (2.054s)
[478.971695] Starting dynamic subtest: ccs0
[480.114121] Dynamic subtest ccs0: SUCCESS (1.154s)
[480.116609] Subtest noreorder-priority: SUCCESS (8.238s)
[480.325820] [085/133] (540s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[480.422353] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[480.424600] Starting dynamic subtest: pipe-A-eDP-1
[480.448510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.459628] Starting dynamic subtest: pipe-B-eDP-1
[480.482466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.490645] Starting dynamic subtest: pipe-C-eDP-1
[480.513727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.521632] Starting dynamic subtest: pipe-D-eDP-1
[480.545196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.549469] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[482.680078] [086/133] (538s left) core_auth (many-magics)
[482.744184] Starting subtest: many-magics
[483.707919] Subtest many-magics: SUCCESS (0.966s)
[483.942142] [087/133] (537s left) i915_suspend (fence-restore-tiled2untiled)
[484.007144] Starting subtest: fence-restore-tiled2untiled
[484.011361] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[484.148493] [088/133] (537s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[484.251853] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[484.254146] Starting dynamic subtest: pipe-A
[484.273183] Dynamic subtest pipe-A: SKIP (0.018s)
[484.282386] Starting dynamic subtest: pipe-B
[484.306891] Dynamic subtest pipe-B: SKIP (0.033s)
[484.315556] Starting dynamic subtest: pipe-C
[484.338287] Dynamic subtest pipe-C: SKIP (0.031s)
[484.347617] Starting dynamic subtest: pipe-D
[484.369609] Dynamic subtest pipe-D: SKIP (0.030s)
[484.373387] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[484.492800] [089/133] (536s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[484.588286] Starting subtest: y-tiled-64bpp-rotate-0
[484.592187] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[484.703868] [090/133] (536s left) gem_ctx_persistence (saturated-hostile)
[484.761771] Starting subtest: saturated-hostile
[484.764084] Starting dynamic subtest: rcs0
[485.573073] Dynamic subtest rcs0: SUCCESS (0.810s)
[485.585453] Starting dynamic subtest: bcs0
[486.383274] Dynamic subtest bcs0: SUCCESS (0.809s)
[486.395179] Starting dynamic subtest: vcs0
[487.195227] Dynamic subtest vcs0: SUCCESS (0.809s)
[487.206998] Starting dynamic subtest: vcs1
[488.007233] Dynamic subtest vcs1: SUCCESS (0.810s)
[488.018645] Starting dynamic subtest: vecs0
[488.835907] Dynamic subtest vecs0: SUCCESS (0.827s)
[488.846277] Starting dynamic subtest: ccs0
[489.685567] Dynamic subtest ccs0: SUCCESS (0.848s)
[489.688351] Subtest saturated-hostile: SUCCESS (4.924s)
[489.788510] [091/133] (531s left) kms_prop_blob (invalid-get-prop)
[489.847683] Starting subtest: invalid-get-prop
[489.850089] Subtest invalid-get-prop: SUCCESS (0.000s)
[489.973882] [092/133] (531s left) gem_mmap_gtt (basic-write)
[490.029292] Subtest basic-write: SKIP (0.000s)
[490.096795] [093/133] (531s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[490.222279] Starting subtest: cursorA-vs-flipA-varying-size
[501.339438] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.116s)
[502.213434] [094/133] (519s left) gem_linear_blits (interruptible)
[502.606400] Starting subtest: interruptible
[506.728709] Subtest interruptible: SUCCESS (4.121s)
[507.082216] [095/133] (514s left) gem_exec_params (sol-reset-invalid)
[507.185311] Starting subtest: sol-reset-invalid
[507.191228] Subtest sol-reset-invalid: SUCCESS (0.003s)
[508.966951] [096/133] (512s left) kms_color_pipeline (plane-lut1d)
[509.081621] Starting subtest: plane-lut1d
[509.094714] Starting dynamic subtest: pipe-A-eDP-1
[509.833759] Dynamic subtest pipe-A-eDP-1: FAIL (0.353s)
[510.563696] Starting dynamic subtest: pipe-B-eDP-1
[511.403377] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s)
[511.999062] Starting dynamic subtest: pipe-C-eDP-1
[512.804566] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[513.325490] Starting dynamic subtest: pipe-D-eDP-1
[514.164211] Dynamic subtest pipe-D-eDP-1: FAIL (0.264s)
[514.166438] Subtest plane-lut1d: FAIL (4.818s)
[514.722861] [097/133] (507s left) gem_wait (busy)
[514.792523] Starting subtest: busy
[514.794756] Starting dynamic subtest: all-engines
[515.925452] Dynamic subtest all-engines: SUCCESS (1.130s)
[515.937882] Starting dynamic subtest: rcs0
[516.466151] Dynamic subtest rcs0: SUCCESS (0.540s)
[516.477411] Starting dynamic subtest: bcs0
[517.006057] Dynamic subtest bcs0: SUCCESS (0.538s)
[517.017938] Starting dynamic subtest: vcs0
[518.933136] Dynamic subtest vcs0: SUCCESS (1.925s)
[518.946074] Starting dynamic subtest: vcs1
[520.917578] Dynamic subtest vcs1: SUCCESS (1.981s)
[520.930360] Starting dynamic subtest: vecs0
[522.901048] Dynamic subtest vecs0: SUCCESS (1.981s)
[522.913481] Starting dynamic subtest: ccs0
[523.443089] Dynamic subtest ccs0: SUCCESS (0.541s)
[523.445585] Subtest busy: SUCCESS (8.650s)
[523.665168] [098/133] (498s left) sriov_basic (enable-vfs-autoprobe-on)
[523.731623] Starting subtest: enable-vfs-autoprobe-on
[523.734159] Starting dynamic subtest: numvfs-1
[523.806997] Dynamic subtest numvfs-1: FAIL (0.007s)
[523.816063] Starting dynamic subtest: numvfs-2
[523.890366] Dynamic subtest numvfs-2: FAIL (0.004s)
[523.902074] Starting dynamic subtest: numvfs-3
[523.976067] Dynamic subtest numvfs-3: FAIL (0.003s)
[523.986819] Starting dynamic subtest: numvfs-4
[524.059802] Dynamic subtest numvfs-4: FAIL (0.003s)
[524.070372] Starting dynamic subtest: numvfs-5
[524.143145] Dynamic subtest numvfs-5: FAIL (0.003s)
[524.153082] Starting dynamic subtest: numvfs-6
[524.225606] Dynamic subtest numvfs-6: FAIL (0.003s)
[524.236661] Starting dynamic subtest: numvfs-7
[524.309318] Dynamic subtest numvfs-7: FAIL (0.003s)
[524.318057] Starting dynamic subtest: numvfs-random
[524.390748] Dynamic subtest numvfs-random: FAIL (0.003s)
[524.400843] Starting dynamic subtest: numvfs-all
[524.474195] Dynamic subtest numvfs-all: FAIL (0.515s)
[524.476556] Subtest enable-vfs-autoprobe-on: FAIL (0.552s)
[524.514773] [099/133] (497s left) kms_chamelium_frames (vga-frame-dump)
[524.907169] Subtest vga-frame-dump: SKIP (0.000s)
[525.703953] [100/133] (496s left) gem_eio (throttle)
[525.909730] Starting subtest: throttle
[526.180545] Subtest throttle: SUCCESS (0.272s)
[526.347846] [101/133] (495s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[526.455088] Starting subtest: psr-abgr161616f-draw-mmap-wc
[526.459219] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[526.587373] [102/133] (495s left) gem_softpin (allocator-nopin)
[526.646522] Starting subtest: allocator-nopin
[526.746402] Subtest allocator-nopin: SUCCESS (0.099s)
[526.889946] [103/133] (495s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[527.000532] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[527.680838] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[527.856537] [104/133] (494s left) kms_flip (busy-flip)
[527.953309] Starting subtest: busy-flip
[527.955634] Starting dynamic subtest: A-eDP1
[529.637375] Dynamic subtest A-eDP1: SUCCESS (1.683s)
[529.653006] Starting dynamic subtest: B-eDP1
[531.291760] Dynamic subtest B-eDP1: SUCCESS (1.652s)
[531.308382] Starting dynamic subtest: C-eDP1
[532.927124] Dynamic subtest C-eDP1: SUCCESS (1.632s)
[532.939149] Starting dynamic subtest: D-eDP1
[534.555224] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[534.557764] Subtest busy-flip: SUCCESS (6.605s)
[535.836951] [105/133] (486s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[535.939137] Starting subtest: x-tiled-16bpp-rotate-270
[535.958637] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[536.096033] [106/133] (486s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[536.189121] Starting subtest: fbcpsr-abgr161616f-draw-render
[536.193274] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[536.327763] [107/133] (485s left) kms_getfb (getfb2-accept-nv12)
[536.430309] Starting subtest: getfb2-accept-nv12
[536.432643] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[536.556203] [108/133] (485s left) gem_ctx_exec (basic-nohangcheck)
[536.619208] Starting subtest: basic-nohangcheck
[536.881915] Subtest basic-nohangcheck: SUCCESS (0.265s)
[537.043217] [109/133] (485s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[537.183321] Starting subtest: short-flip-before-cursor-atomic-transitions
[538.176706] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.991s)
[539.065676] [110/133] (483s left) kms_cursor_crc (cursor-offscreen-256x256)
[539.309737] Starting subtest: cursor-offscreen-256x256
[539.314583] Starting dynamic subtest: pipe-A-eDP-1
[541.255584] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[541.284050] Starting dynamic subtest: pipe-D-eDP-1
[543.845691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[543.847861] Subtest cursor-offscreen-256x256: SUCCESS (4.533s)
[544.733397] [111/133] (477s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[544.853442] Starting subtest: 4-tiled-8bpp-rotate-0
[546.056930] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[546.213504] [112/133] (476s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[546.266285] Subtest writes-after-reads: SKIP (0.000s)
[546.331875] [113/133] (476s left) kms_frontbuffer_tracking (psr-slowdraw)
[546.434352] Starting subtest: psr-slowdraw
[571.646444] Subtest psr-slowdraw: SUCCESS (25.212s)
[571.795570] [114/133] (450s left) i915_pm_rc6_residency (rc6-idle)
[571.862152] Starting subtest: rc6-idle
[571.899726] Starting dynamic subtest: gt0-rcs0
[596.108362] Dynamic subtest gt0-rcs0: SUCCESS (24.209s)
[596.119273] Starting dynamic subtest: gt0-bcs0
[620.538259] Dynamic subtest gt0-bcs0: SUCCESS (24.428s)
[620.550786] Starting dynamic subtest: gt0-ccs0
[644.890256] Dynamic subtest gt0-ccs0: SUCCESS (24.350s)
[644.901733] Starting dynamic subtest: gt1-vcs0
[651.064847] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[651.077075] Starting dynamic subtest: gt1-vecs0
[657.236635] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[657.239688] Subtest rc6-idle: SUCCESS (85.378s)
[657.342324] [115/133] (365s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[657.448776] Starting subtest: fbc-modesetfrombusy
[661.255439] Subtest fbc-modesetfrombusy: SUCCESS (3.811s)
[662.456927] [116/133] (360s left) kms_psr (psr-cursor-render)
[662.551904] Starting subtest: psr-cursor-render
[662.554114] Starting dynamic subtest: eDP-1
[664.326244] Dynamic subtest eDP-1: SUCCESS (1.773s)
[664.328523] Subtest psr-cursor-render: SUCCESS (1.774s)
[665.222251] [117/133] (357s left) gem_exec_parallel (engines)
[665.297908] Starting subtest: engines
[665.300428] Starting dynamic subtest: basic
[666.960288] Dynamic subtest basic: SUCCESS (1.661s)
[666.972913] Starting dynamic subtest: contexts
[671.374417] Dynamic subtest contexts: SUCCESS (4.413s)
[671.387072] Starting dynamic subtest: fds
[675.141247] Dynamic subtest fds: SUCCESS (3.765s)
[675.154063] Starting dynamic subtest: userptr
[676.910305] Dynamic subtest userptr: SUCCESS (1.765s)
[676.917051] Subtest engines: SUCCESS (11.610s)
[677.125899] [118/133] (345s left) prime_busy (after)
[677.186570] Starting subtest: after
[677.188895] Starting dynamic subtest: rcs0
[677.229323] Dynamic subtest rcs0: SUCCESS (0.042s)
[677.238674] Starting dynamic subtest: bcs0
[677.306709] Dynamic subtest bcs0: SUCCESS (0.076s)
[677.317081] Starting dynamic subtest: vcs0
[677.348602] Dynamic subtest vcs0: SUCCESS (0.041s)
[677.358383] Starting dynamic subtest: vcs1
[677.389808] Dynamic subtest vcs1: SUCCESS (0.040s)
[677.399805] Starting dynamic subtest: vecs0
[677.431348] Dynamic subtest vecs0: SUCCESS (0.041s)
[677.441665] Starting dynamic subtest: ccs0
[677.474419] Dynamic subtest ccs0: SUCCESS (0.042s)
[677.584019] Subtest after: SUCCESS (0.398s)
[677.682492] [119/133] (344s left) gem_partial_pwrite_pread (write-display)
[677.732846] Subtest write-display: SKIP (0.000s)
[677.820420] [120/133] (344s left) gem_tiled_blits (basic)
[677.881484] Subtest basic: SKIP (0.000s)
[677.960937] [121/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[678.059819] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[686.661017] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.601s)
[686.801259] [122/133] (335s left) sysfs_defaults (readonly)
[686.863105] Starting subtest: readonly
[686.865496] Starting dynamic subtest: vecs0
[686.867912] Dynamic subtest vecs0: SUCCESS (0.000s)
[686.879236] Starting dynamic subtest: ccs0
[686.881136] Dynamic subtest ccs0: SUCCESS (0.000s)
[686.889827] Starting dynamic subtest: vcs0
[686.891790] Dynamic subtest vcs0: SUCCESS (0.000s)
[686.900415] Starting dynamic subtest: bcs0
[686.902371] Dynamic subtest bcs0: SUCCESS (0.000s)
[686.912073] Starting dynamic subtest: rcs0
[686.914733] Dynamic subtest rcs0: SUCCESS (0.000s)
[686.930057] Starting dynamic subtest: vcs1
[686.932115] Dynamic subtest vcs1: SUCCESS (0.000s)
[686.934129] Subtest readonly: SUCCESS (0.006s)
[686.997680] [123/133] (335s left) kms_dsc (dsc-with-formats)
[687.097232] Starting subtest: dsc-with-formats
[687.137630] Subtest dsc-with-formats: SKIP (0.001s)
[687.193905] [124/133] (335s left) prime_mmap (test_reprime)
[687.260639] Starting subtest: test_reprime
[687.262663] Starting dynamic subtest: test_reprime-smem
[687.292129] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[687.294616] Subtest test_reprime: SUCCESS (0.035s)
[687.415545] [125/133] (335s left) gem_exec_params (rsvd2-dirt)
[687.475567] Starting subtest: rsvd2-dirt
[687.480315] Subtest rsvd2-dirt: SKIP (0.000s)
[687.598800] [126/133] (335s left) kms_lease (lessee-list)
[687.696550] Starting subtest: lessee-list
[687.698515] Starting dynamic subtest: pipe-A-eDP-1
[687.700676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[687.710517] Starting dynamic subtest: pipe-B-eDP-1
[687.712454] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[687.721185] Starting dynamic subtest: pipe-C-eDP-1
[687.722996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[687.731713] Starting dynamic subtest: pipe-D-eDP-1
[687.733687] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[687.735706] Subtest lessee-list: SUCCESS (0.008s)
[687.833157] [127/133] (335s left) kms_vrr (flip-dpms)
[687.934526] Starting subtest: flip-dpms
[687.939917] Subtest flip-dpms: SKIP (0.000s)
[688.032577] [128/133] (335s left) kms_frontbuffer_tracking (fbc-1p-rte)
[688.137955] Starting subtest: fbc-1p-rte
[693.618025] Subtest fbc-1p-rte: SUCCESS (5.483s)
[694.830317] [129/133] (328s left) gen9_exec_parse (batch-zero-length)
[694.893469] Subtest batch-zero-length: SKIP (0.000s)
[694.983317] [130/133] (328s left) prime_mmap (test_aperture_limit)
[695.051280] Starting subtest: test_aperture_limit
[695.053276] Starting dynamic subtest: test_aperture_limit-smem
[695.060635] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[695.064699] Subtest test_aperture_limit: SKIP (0.008s)
[695.201154] [131/133] (327s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[695.303403] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[695.308046] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[695.439905] [132/133] (327s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[695.526991] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[695.531199] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[695.643444] [133/133] (327s left) gem_exec_fence (long-history)
[696.102502] Starting subtest: long-history
[703.611617] Subtest long-history: SUCCESS (7.509s)
[704.750709] 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.