[59.714987] Initializing watchdogs
[59.715047]   /dev/watchdog0
[59.728454] [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]
[59.732677] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.734889] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.738212] [001/132] (960s left) gem_sync (basic-all)
[59.846812] Starting subtest: basic-all
[62.944212] Subtest basic-all: SUCCESS (3.089s)
[63.137371] [002/132] (957s left) gem_mmap_gtt (zero-extend)
[63.195452] Subtest zero-extend: SKIP (0.000s)
[63.249583] [003/132] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[63.354178] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[63.358297] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[63.472607] [004/132] (956s left) prime_self_import (basic-with_two_bos)
[63.511917] Starting subtest: basic-with_two_bos
[63.536480] Subtest basic-with_two_bos: SUCCESS (0.024s)
[63.648208] [005/132] (956s left) gem_readwrite (read-bad-handle)
[63.710114] Subtest read-bad-handle: SKIP (0.000s)
[63.766223] [006/132] (956s left) gem_exec_parallel (fds)
[63.823776] Starting subtest: fds
[63.825879] Starting dynamic subtest: rcs0
[66.546400] Dynamic subtest rcs0: SUCCESS (2.713s)
[66.554844] Starting dynamic subtest: bcs0
[70.259711] Dynamic subtest bcs0: SUCCESS (3.704s)
[70.267096] Starting dynamic subtest: vcs0
[74.146251] Dynamic subtest vcs0: SUCCESS (3.881s)
[74.154191] Starting dynamic subtest: vcs1
[78.133827] Dynamic subtest vcs1: SUCCESS (3.984s)
[78.142333] Starting dynamic subtest: vecs0
[82.187337] Dynamic subtest vecs0: SUCCESS (4.049s)
[82.196920] Starting dynamic subtest: ccs0
[85.801530] Dynamic subtest ccs0: SUCCESS (3.610s)
[85.803771] Subtest fds: SUCCESS (21.945s)
[85.996883] [007/132] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[86.099305] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[86.103610] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[86.192743] [008/132] (934s left) gem_exec_schedule (u-fairslice)
[86.271746] Starting subtest: u-fairslice
[86.273819] Starting dynamic subtest: rcs0
[88.285719] Dynamic subtest rcs0: SUCCESS (2.019s)
[88.302839] Starting dynamic subtest: bcs0
[90.303074] Dynamic subtest bcs0: SUCCESS (2.016s)
[90.321199] Starting dynamic subtest: vcs0
[92.324141] Dynamic subtest vcs0: SUCCESS (2.019s)
[92.341668] Starting dynamic subtest: vcs1
[94.339487] Dynamic subtest vcs1: SUCCESS (2.013s)
[94.351355] Starting dynamic subtest: vecs0
[96.360044] Dynamic subtest vecs0: SUCCESS (2.020s)
[96.371647] Starting dynamic subtest: ccs0
[98.385222] Dynamic subtest ccs0: SUCCESS (2.023s)
[98.387751] Subtest u-fairslice: SUCCESS (12.115s)
[98.692753] [009/132] (921s left) kms_plane_multiple (2x-tiling-yf)
[98.803096] Starting subtest: 2x-tiling-yf
[98.807310] Subtest 2x-tiling-yf: SKIP (0.000s)
[98.870831] [010/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[98.966338] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[98.970520] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[99.060814] [011/132] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[99.163734] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[99.168021] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[99.266965] [012/132] (921s left) gem_lmem_swapping (basic)
[99.310209] Subtest basic: SKIP (0.000s)
[99.351611] [013/132] (921s left) gem_mmap_wc (bad-size)
[99.409785] Subtest bad-size: SKIP (0.000s)
[99.471290] [014/132] (921s left) kms_psr (pr-sprite-plane-onoff)
[99.561788] Starting subtest: pr-sprite-plane-onoff
[99.565959] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[99.641461] [015/132] (921s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[99.745932] Starting subtest: 4-tiled-16bpp-rotate-0
[101.127159] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.380s)
[101.268694] [016/132] (919s left) syncobj_timeline (etime-single-wait-submitted)
[101.326213] Starting subtest: etime-single-wait-submitted
[101.435499] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[101.509910] [017/132] (919s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[101.626415] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[102.716242] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[102.821708] [018/132] (918s left) kms_plane (plane-position-hole-dpms)
[102.904093] Starting subtest: plane-position-hole-dpms
[103.428737] Starting dynamic subtest: pipe-A-plane-1
[105.812697] Dynamic subtest pipe-A-plane-1: SUCCESS (2.385s)
[105.822201] Starting dynamic subtest: pipe-A-plane-2
[108.196747] Dynamic subtest pipe-A-plane-2: SUCCESS (2.381s)
[108.205827] Starting dynamic subtest: pipe-A-plane-3
[110.541775] Dynamic subtest pipe-A-plane-3: SUCCESS (2.345s)
[110.550856] Starting dynamic subtest: pipe-A-plane-4
[112.904600] Dynamic subtest pipe-A-plane-4: SUCCESS (2.361s)
[112.913262] Starting dynamic subtest: pipe-A-plane-5
[112.928132] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[114.055370] Starting dynamic subtest: pipe-B-plane-1
[116.406840] Dynamic subtest pipe-B-plane-1: SUCCESS (2.361s)
[116.414504] Starting dynamic subtest: pipe-B-plane-2
[118.765064] Dynamic subtest pipe-B-plane-2: SUCCESS (2.355s)
[118.775407] Starting dynamic subtest: pipe-B-plane-3
[121.159365] Dynamic subtest pipe-B-plane-3: SUCCESS (2.394s)
[121.167651] Starting dynamic subtest: pipe-B-plane-4
[123.522874] Dynamic subtest pipe-B-plane-4: SUCCESS (2.365s)
[123.536344] Starting dynamic subtest: pipe-B-plane-5
[123.548169] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[123.550457] Subtest plane-position-hole-dpms: SUCCESS (20.638s)
[124.411490] [019/132] (896s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[124.467819] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[124.570839] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[124.644846] [020/132] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[124.747387] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[124.751592] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[124.825991] [021/132] (896s left) gem_mmap_wc (set-cache-level)
[124.883610] Subtest set-cache-level: SKIP (0.000s)
[124.939233] [022/132] (896s left) kms_vblank (query-busy-hang)
[125.024045] Starting subtest: query-busy-hang
[125.025880] Starting dynamic subtest: pipe-A-eDP-1
[151.637319] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.610s)
[151.650740] Starting dynamic subtest: pipe-D-eDP-1
[176.655193] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[176.657480] Subtest query-busy-hang: SUCCESS (51.629s)
[177.460563] [023/132] (843s left) gem_partial_pwrite_pread (write-display)
[177.525599] Subtest write-display: SKIP (0.000s)
[177.597313] [024/132] (843s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[177.699732] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[181.920779] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.224s)
[183.080938] [025/132] (838s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[183.180651] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[183.185064] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[183.262346] [026/132] (837s left) gem_ccs (block-multicopy-compressed)
[183.324048] Starting subtest: block-multicopy-compressed
[183.328154] Subtest block-multicopy-compressed: SKIP (0.000s)
[183.443084] [027/132] (837s left) kms_flip (wf_vblank-ts-check-interruptible)
[183.542835] Starting subtest: wf_vblank-ts-check-interruptible
[183.545192] Starting dynamic subtest: A-eDP1
[192.404855] Dynamic subtest A-eDP1: SUCCESS (8.860s)
[192.414258] Starting dynamic subtest: B-eDP1
[201.330481] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[201.341339] Starting dynamic subtest: C-eDP1
[210.246172] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[210.255667] Starting dynamic subtest: D-eDP1
[219.172975] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[219.175435] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.630s)
[220.400792] [028/132] (800s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[220.498534] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[220.501044] Starting dynamic subtest: pipe-A
[220.834138] Dynamic subtest pipe-A: SUCCESS (0.338s)
[220.841565] Starting dynamic subtest: pipe-B
[222.201196] Dynamic subtest pipe-B: SUCCESS (1.366s)
[222.210017] Starting dynamic subtest: pipe-C
[223.634626] Dynamic subtest pipe-C: SUCCESS (1.432s)
[223.647428] Starting dynamic subtest: pipe-D
[225.069461] Dynamic subtest pipe-D: SUCCESS (1.432s)
[225.071979] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.574s)
[226.236641] [029/132] (795s left) kms_flip (2x-busy-flip)
[226.322292] Starting subtest: 2x-busy-flip
[226.332449] Subtest 2x-busy-flip: SKIP (0.010s)
[226.408729] [030/132] (794s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[226.505168] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[226.507457] Starting dynamic subtest: pipe-A-eDP-1
[226.530342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[226.539153] Starting dynamic subtest: pipe-B-eDP-1
[226.560838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[226.567869] Starting dynamic subtest: pipe-C-eDP-1
[226.589818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[226.597218] Starting dynamic subtest: pipe-D-eDP-1
[226.619256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.623744] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[228.790534] [031/132] (792s left) kms_chamelium_frames (dp-crc-fast)
[229.165421] Subtest dp-crc-fast: SKIP (0.000s)
[230.001055] [032/132] (791s left) kms_big_fb (linear-8bpp-rotate-270)
[230.101512] Starting subtest: linear-8bpp-rotate-270
[230.123983] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[230.236348] [033/132] (791s left) gem_madvise (dontneed-before-pwrite)
[230.277662] Starting subtest: dontneed-before-pwrite
[230.300655] Subtest dontneed-before-pwrite: SKIP (0.021s)
[230.373838] [034/132] (791s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[230.468784] Starting subtest: primary-4-tiled-reflect-x-0
[237.453302] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.987s)
[238.669400] [035/132] (782s left) kms_flip (absolute-wf_vblank)
[238.780679] Starting subtest: absolute-wf_vblank
[238.782906] Starting dynamic subtest: A-eDP1
[247.523452] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[247.534694] Starting dynamic subtest: B-eDP1
[256.247348] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[256.257406] Starting dynamic subtest: C-eDP1
[264.972207] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[264.980616] Starting dynamic subtest: D-eDP1
[273.708071] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[273.712721] Subtest absolute-wf_vblank: SUCCESS (34.932s)
[274.915087] [036/132] (746s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[274.998265] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[275.000573] Starting dynamic subtest: pipe-A-default-mode
[276.167878] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[276.172250] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.170s)
[276.296686] [037/132] (745s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[276.402985] Starting subtest: async-flip-with-page-flip-events-linear
[276.809827] Starting dynamic subtest: pipe-A-eDP-1
[279.517671] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.706s)
[279.885471] Starting dynamic subtest: pipe-B-eDP-1
[282.647181] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[283.012900] Starting dynamic subtest: pipe-C-eDP-1
[285.773046] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[286.134266] Starting dynamic subtest: pipe-D-eDP-1
[288.907026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[288.909330] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.505s)
[290.099908] [038/132] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[290.194675] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[290.199068] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[290.299336] [039/132] (731s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[290.399766] Starting subtest: fbc-pr-cursor-plane-update-sf
[290.404301] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[290.462895] [040/132] (731s left) gem_softpin (full)
[290.518388] Starting subtest: full
[290.526674] Subtest full: SUCCESS (0.008s)
[290.664661] [041/132] (731s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[290.759082] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[290.761324] Starting dynamic subtest: pipe-A-eDP-1
[291.615222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[291.623541] Starting dynamic subtest: pipe-B-eDP-1
[293.113121] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[293.121454] Starting dynamic subtest: pipe-C-eDP-1
[294.675359] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.561s)
[294.683078] Starting dynamic subtest: pipe-D-eDP-1
[296.135052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[296.137020] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.368s)
[297.311780] [042/132] (724s left) kms_cursor_crc (cursor-offscreen-128x42)
[297.506582] Starting subtest: cursor-offscreen-128x42
[297.553785] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[297.736489] [043/132] (724s left) kms_color_pipeline (plane-ctm3x4)
[297.832892] Starting subtest: plane-ctm3x4
[297.979265] Starting dynamic subtest: pipe-A-plane-0
[298.279638] Dynamic subtest pipe-A-plane-0: FAIL (0.141s)
[298.289261] Starting dynamic subtest: pipe-A-plane-1
[298.467918] Dynamic subtest pipe-A-plane-1: FAIL (0.144s)
[298.477593] Starting dynamic subtest: pipe-A-plane-2
[298.684950] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[299.665372] Starting dynamic subtest: pipe-B-plane-0
[300.054525] Dynamic subtest pipe-B-plane-0: FAIL (0.130s)
[300.064904] Starting dynamic subtest: pipe-B-plane-1
[300.363707] Dynamic subtest pipe-B-plane-1: FAIL (0.133s)
[300.372586] Starting dynamic subtest: pipe-B-plane-2
[300.664057] Dynamic subtest pipe-B-plane-2: FAIL (0.604s)
[301.741649] Starting dynamic subtest: pipe-C-plane-0
[302.191556] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[302.201044] Starting dynamic subtest: pipe-C-plane-1
[302.584701] Dynamic subtest pipe-C-plane-1: FAIL (0.579s)
[302.594063] Starting dynamic subtest: pipe-C-plane-2
[302.937167] Dynamic subtest pipe-C-plane-2: FAIL (0.120s)
[303.789325] Starting dynamic subtest: pipe-D-plane-0
[304.332285] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[304.341827] Starting dynamic subtest: pipe-D-plane-1
[304.794043] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[304.802977] Starting dynamic subtest: pipe-D-plane-2
[305.212766] Dynamic subtest pipe-D-plane-2: FAIL (0.531s)
[305.329497] Subtest plane-ctm3x4: FAIL (7.497s)
[306.154186] [044/132] (715s left) gem_mmap (bad-size)
[306.215872] Subtest bad-size: SKIP (0.000s)
[306.273281] [045/132] (715s left) prime_vgem (basic-fence-mmap)
[306.432162] Starting subtest: basic-fence-mmap
[306.437149] Subtest basic-fence-mmap: SKIP (0.000s)
[306.541808] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[306.545393] [046/132] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[306.639382] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[306.643752] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.746255] [047/132] (715s left) kms_frontbuffer_tracking (psr-suspend)
[306.836085] Starting subtest: psr-suspend
[344.776764] Subtest psr-suspend: SUCCESS (7.990s)
[344.893623] [048/132] (677s left) gem_exec_params (cliprects-invalid)
[344.952916] Starting subtest: cliprects-invalid
[344.955322] Subtest cliprects-invalid: SUCCESS (0.000s)
[345.047819] [049/132] (677s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[345.158101] Starting subtest: stress-xrgb8888-xtiled
[351.280513] Subtest stress-xrgb8888-xtiled: SUCCESS (5.959s)
[351.337971] [050/132] (670s left) prime_self_import (reimport-vs-gem_close-race)
[351.375065] Starting subtest: reimport-vs-gem_close-race
[356.433641] Subtest reimport-vs-gem_close-race: SUCCESS (4.990s)
[356.549916] [051/132] (665s left) gem_mmap_gtt (hang)
[356.609480] Subtest hang: SKIP (0.000s)
[356.669329] [052/132] (665s left) gem_ctx_param (invalid-ctx-get)
[356.732520] Starting subtest: invalid-ctx-get
[356.734815] Subtest invalid-ctx-get: SUCCESS (0.000s)
[356.805868] [053/132] (665s left) syncobj_timeline (single-wait-signaled)
[356.865515] Starting subtest: single-wait-signaled
[356.867746] Subtest single-wait-signaled: SUCCESS (0.000s)
[356.965418] [054/132] (665s left) gem_exec_balancer (parallel)
[357.216001] Starting subtest: parallel
[358.154737] Subtest parallel: SUCCESS (0.932s)
[358.865538] [055/132] (663s left) kms_psr (fbc-psr-cursor-plane-move)
[358.966967] Starting subtest: fbc-psr-cursor-plane-move
[358.969207] Starting dynamic subtest: eDP-1
[358.973453] Dynamic subtest eDP-1: SKIP (0.000s)
[358.977783] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[359.040096] [056/132] (663s left) gem_ctx_engines (execute-one)
[359.098895] Starting subtest: execute-one
[361.436674] Subtest execute-one: SUCCESS (2.324s)
[361.865925] [057/132] (660s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[361.982883] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[361.987525] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[362.079710] [058/132] (660s left) syncobj_eventfd (timeline-wait)
[362.139642] Starting subtest: timeline-wait
[362.149053] Subtest timeline-wait: SUCCESS (0.011s)
[362.236574] [059/132] (660s left) gem_exec_fence (submit-chain)
[362.420894] Starting subtest: submit-chain
[362.439608] Subtest submit-chain: SUCCESS (0.018s)
[363.875822] [060/132] (658s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[363.932007] Starting subtest: map-fixed-invalidate-overlap-busy
[363.936619] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[364.054019] [061/132] (658s left) kms_fbcon_fbt (psr-suspend)
[364.101743] Starting subtest: psr-suspend
[413.289187] Subtest psr-suspend: SUCCESS (19.473s)
[413.378590] [062/132] (609s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[413.439372] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[413.441623] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[413.534684] [063/132] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[413.637142] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[421.138040] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.377s)
[421.238886] [064/132] (601s left) kms_chamelium_color (ctm-blue-to-red)
[421.336436] Subtest ctm-blue-to-red: SKIP (0.000s)
[421.381085] [065/132] (601s left) core_setmaster (master-drop-set-user)
[421.457332] Starting subtest: master-drop-set-user
[421.472397] Subtest master-drop-set-user: SUCCESS (0.015s)
[421.510511] [066/132] (601s left) syncobj_wait (wait-all-complex)
[421.563710] Starting subtest: wait-all-complex
[421.780741] Subtest wait-all-complex: SUCCESS (0.215s)
[421.870221] [067/132] (600s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[421.934344] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[421.936357] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[422.032601] [068/132] (600s left) gem_exec_parallel (userptr)
[422.092726] Starting subtest: userptr
[422.094980] Starting dynamic subtest: rcs0
[423.525222] Dynamic subtest rcs0: SUCCESS (1.423s)
[423.535799] Starting dynamic subtest: bcs0
[424.987574] Dynamic subtest bcs0: SUCCESS (1.451s)
[424.997782] Starting dynamic subtest: vcs0
[427.075990] Dynamic subtest vcs0: SUCCESS (2.074s)
[427.085929] Starting dynamic subtest: vcs1
[429.060695] Dynamic subtest vcs1: SUCCESS (1.973s)
[429.072976] Starting dynamic subtest: vecs0
[431.044100] Dynamic subtest vecs0: SUCCESS (1.974s)
[431.056076] Starting dynamic subtest: ccs0
[432.536822] Dynamic subtest ccs0: SUCCESS (1.487s)
[432.539432] Subtest userptr: SUCCESS (10.394s)
[432.723716] [069/132] (590s left) kms_pm_rpm (pm-tiling)
[434.255293] Starting subtest: pm-tiling
[434.260055] Subtest pm-tiling: SKIP (0.000s)
[434.986394] [070/132] (587s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[435.083895] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[435.086208] Starting dynamic subtest: pipe-A-eDP-1
[435.168465] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[435.178198] Starting dynamic subtest: pipe-B-eDP-1
[436.366277] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[436.370798] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.284s)
[437.563714] [071/132] (585s left) kms_psr (psr2-cursor-mmap-gtt)
[437.654733] Starting subtest: psr2-cursor-mmap-gtt
[437.656999] Starting dynamic subtest: eDP-1
[439.339378] Dynamic subtest eDP-1: SUCCESS (1.684s)
[439.341704] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.685s)
[440.123927] [072/132] (582s left) i915_pm_rps (waitboost)
[440.185382] Starting subtest: waitboost
[446.271919] Subtest waitboost: SUCCESS (6.084s)
[446.396209] [073/132] (576s left) gem_ctx_persistence (hang)
[446.461772] Starting subtest: hang
[446.466450] Subtest hang: SKIP (0.000s)
[446.562982] [074/132] (576s left) kms_psr (fbc-psr2-sprite-blt)
[446.657448] Starting subtest: fbc-psr2-sprite-blt
[446.659704] Starting dynamic subtest: eDP-1
[446.663940] Dynamic subtest eDP-1: SKIP (0.000s)
[446.668201] Subtest fbc-psr2-sprite-blt: SKIP (0.002s)
[446.733428] [075/132] (576s left) kms_lease (empty-lease)
[446.822668] Starting subtest: empty-lease
[446.824968] Starting dynamic subtest: pipe-A-eDP-1
[446.827321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[446.841273] Starting dynamic subtest: pipe-B-eDP-1
[446.843292] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[446.853123] Starting dynamic subtest: pipe-C-eDP-1
[446.854968] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[446.863834] Starting dynamic subtest: pipe-D-eDP-1
[446.865700] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[446.867577] Subtest empty-lease: SUCCESS (0.009s)
[446.941438] [076/132] (576s left) syncobj_wait (wait-all-for-submit-complex)
[447.002929] Starting subtest: wait-all-for-submit-complex
[447.216056] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[447.294550] [077/132] (575s left) api_intel_bb (reset-bb)
[447.348314] Starting subtest: reset-bb
[447.354599] Subtest reset-bb: SUCCESS (0.007s)
[447.472741] [078/132] (575s left) kms_chamelium_hpd (hdmi-hpd-storm)
[447.861293] Subtest hdmi-hpd-storm: SKIP (0.000s)
[448.641798] [079/132] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[448.742903] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[448.747057] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[448.846618] [080/132] (574s left) gem_exec_schedule (u-submit-late-slice)
[448.914330] Starting subtest: u-submit-late-slice
[448.916629] Starting dynamic subtest: rcs0
[448.944294] Dynamic subtest rcs0: SUCCESS (0.038s)
[448.956204] Starting dynamic subtest: bcs0
[448.973434] Dynamic subtest bcs0: SUCCESS (0.028s)
[448.986136] Starting dynamic subtest: vcs0
[449.003339] Dynamic subtest vcs0: SUCCESS (0.029s)
[449.013391] Starting dynamic subtest: vcs1
[449.032317] Dynamic subtest vcs1: SUCCESS (0.028s)
[449.042171] Starting dynamic subtest: vecs0
[449.071514] Dynamic subtest vecs0: SUCCESS (0.038s)
[449.081793] Starting dynamic subtest: ccs0
[449.102145] Dynamic subtest ccs0: SUCCESS (0.030s)
[449.104453] Subtest u-submit-late-slice: SUCCESS (0.197s)
[450.248918] [081/132] (573s left) kms_invalid_mode (int-max-clock)
[450.332665] Starting subtest: int-max-clock
[450.335063] Starting dynamic subtest: pipe-A-eDP-1
[450.623678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[450.633971] Starting dynamic subtest: pipe-B-eDP-1
[450.636181] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[450.646900] Starting dynamic subtest: pipe-C-eDP-1
[450.649019] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[450.657066] Starting dynamic subtest: pipe-D-eDP-1
[450.658904] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[450.660800] Subtest int-max-clock: SUCCESS (0.298s)
[451.494788] [082/132] (572s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[451.563876] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[451.634543] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[451.675539] [083/132] (571s left) gem_exec_suspend (basic-s3)
[451.748317] Starting subtest: basic-S3
[451.750669] Starting dynamic subtest: smem
[471.093297] Dynamic subtest smem: SUCCESS (6.240s)
[471.096204] Subtest basic-S3: SUCCESS (6.242s)
[471.292527] [084/132] (552s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[471.427454] Starting subtest: verify-pxp-key-change-after-suspend-resume
[478.635302] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.036s)
[478.744215] [085/132] (544s left) gem_exec_schedule (pi-common)
[478.926121] Starting subtest: pi-common
[478.928042] Starting dynamic subtest: rcs0
[478.969956] Dynamic subtest rcs0: SUCCESS (0.045s)
[478.979147] Starting dynamic subtest: bcs0
[479.018311] Dynamic subtest bcs0: SUCCESS (0.047s)
[479.028136] Starting dynamic subtest: vcs0
[479.058386] Dynamic subtest vcs0: SUCCESS (0.038s)
[479.067725] Starting dynamic subtest: vcs1
[479.096181] Dynamic subtest vcs1: SUCCESS (0.036s)
[479.105159] Starting dynamic subtest: vecs0
[479.129372] Dynamic subtest vecs0: SUCCESS (0.032s)
[479.138424] Starting dynamic subtest: ccs0
[479.158787] Dynamic subtest ccs0: SUCCESS (0.028s)
[479.161109] Subtest pi-common: SUCCESS (0.232s)
[479.396600] [086/132] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[479.499026] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[479.503281] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[479.615309] [087/132] (544s left) gem_exec_balancer (parallel-contexts)
[479.878013] Starting subtest: parallel-contexts
[482.577822] Subtest parallel-contexts: SUCCESS (2.672s)
[483.281516] [088/132] (540s left) i915_hangman (gt-engine-error)
[483.351006] Starting subtest: gt-engine-error
[483.352815] Starting dynamic subtest: rcs0
[485.075692] Dynamic subtest rcs0: SUCCESS (1.712s)
[485.087512] Starting dynamic subtest: bcs0
[487.060552] Dynamic subtest bcs0: SUCCESS (1.970s)
[487.073670] Starting dynamic subtest: vcs0
[489.044949] Dynamic subtest vcs0: SUCCESS (1.972s)
[489.056213] Starting dynamic subtest: vcs1
[491.091280] Dynamic subtest vcs1: SUCCESS (2.036s)
[491.103831] Starting dynamic subtest: vecs0
[493.075765] Dynamic subtest vecs0: SUCCESS (1.976s)
[493.088044] Starting dynamic subtest: ccs0
[495.122982] Dynamic subtest ccs0: SUCCESS (2.039s)
[495.125970] Subtest gt-engine-error: SUCCESS (11.723s)
[495.206726] [089/132] (528s left) kms_cursor_crc (cursor-random-512x512)
[495.517258] Starting subtest: cursor-random-512x512
[495.522103] Subtest cursor-random-512x512: SKIP (0.001s)
[495.679586] [090/132] (528s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[495.761648] Starting subtest: fb-8bpc-vs-panel-6bpc
[495.763947] Starting dynamic subtest: pipe-A-eDP-1
[497.223340] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.458s)
[497.225268] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.459s)
[498.111988] [091/132] (525s left) perf_pmu (busy-start)
[498.158845] Starting subtest: busy-start
[498.161184] Starting dynamic subtest: rcs0
[500.706489] Dynamic subtest rcs0: SUCCESS (2.545s)
[500.718783] Starting dynamic subtest: bcs0
[503.255263] Dynamic subtest bcs0: SUCCESS (2.544s)
[503.267630] Starting dynamic subtest: vcs0
[507.124191] Dynamic subtest vcs0: SUCCESS (3.862s)
[507.136581] Starting dynamic subtest: vcs1
[511.156581] Dynamic subtest vcs1: SUCCESS (4.027s)
[511.168738] Starting dynamic subtest: vecs0
[515.124378] Dynamic subtest vecs0: SUCCESS (3.965s)
[515.136190] Starting dynamic subtest: ccs0
[517.673700] Dynamic subtest ccs0: SUCCESS (2.548s)
[517.676314] Subtest busy-start: SUCCESS (19.505s)
[517.798098] [092/132] (506s left) gem_fence_thrash (bo-write-verify-threaded-x)
[517.836294] Starting subtest: bo-write-verify-threaded-x
[517.865771] Subtest bo-write-verify-threaded-x: SKIP (0.026s)
[517.922926] [093/132] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[518.020356] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[518.024740] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[518.114283] [094/132] (505s left) kms_flip (2x-plain-flip-interruptible)
[518.216045] Starting subtest: 2x-plain-flip-interruptible
[518.227340] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[518.319766] [095/132] (505s left) gem_exec_reloc (basic-cpu-wc-active)
[518.384422] Subtest basic-cpu-wc-active: SKIP (0.000s)
[518.457300] [096/132] (505s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[518.554113] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[518.556390] Starting dynamic subtest: pipe-A-eDP-1
[518.615630] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[518.627737] Starting dynamic subtest: pipe-B-eDP-1
[518.680474] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[518.690641] Starting dynamic subtest: pipe-C-eDP-1
[518.738422] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[518.748457] Starting dynamic subtest: pipe-D-eDP-1
[518.795226] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[518.799284] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[520.856466] [097/132] (503s left) kms_vrr (lobf)
[520.964650] Starting subtest: lobf
[520.968834] Subtest lobf: SKIP (0.000s)
[521.036695] [098/132] (503s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[521.136947] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[521.141160] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.244939] [099/132] (503s left) kms_busy (extended-modeset-hang-oldfb)
[521.351539] Starting subtest: extended-modeset-hang-oldfb
[521.353721] Starting dynamic subtest: pipe-A
[532.945633] Dynamic subtest pipe-A: SUCCESS (11.591s)
[532.957477] Starting dynamic subtest: pipe-D
[545.223013] Dynamic subtest pipe-D: SUCCESS (12.271s)
[545.225492] Subtest extended-modeset-hang-oldfb: SUCCESS (23.867s)
[546.019846] [100/132] (478s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[546.080075] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[546.084501] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[546.279230] [101/132] (478s left) sw_sync (sync_multi_producer_single_consumer)
[546.318274] Starting subtest: sync_multi_producer_single_consumer
[547.392119] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[547.453735] [102/132] (476s left) kms_content_protection (dp-mst-type-1)
[547.592982] Starting subtest: dp-mst-type-1
[547.597345] Subtest dp-mst-type-1: SKIP (0.000s)
[547.726929] [103/132] (476s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[547.828850] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[551.430181] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.603s)
[552.625365] [104/132] (471s left) gem_ctx_isolation (preservation-reset)
[552.798419] Starting subtest: preservation-reset
[552.800996] Starting dynamic subtest: rcs0
[553.036999] Dynamic subtest rcs0: SUCCESS (0.242s)
[553.047197] Starting dynamic subtest: bcs0
[553.321327] Dynamic subtest bcs0: SUCCESS (0.283s)
[553.334486] Starting dynamic subtest: vcs0
[553.622816] Dynamic subtest vcs0: SUCCESS (0.301s)
[553.633404] Starting dynamic subtest: vcs1
[555.405404] Dynamic subtest vcs1: SUCCESS (1.781s)
[555.416304] Starting dynamic subtest: vecs0
[557.377991] Dynamic subtest vecs0: SUCCESS (1.971s)
[557.390922] Starting dynamic subtest: ccs0
[559.451089] Dynamic subtest ccs0: SUCCESS (2.071s)
[559.453609] Subtest preservation-reset: SUCCESS (6.656s)
[559.579966] [105/132] (464s left) gem_userptr_blits (probe)
[559.646974] Starting subtest: probe
[559.720450] Subtest probe: SUCCESS (0.073s)
[559.867051] [106/132] (464s left) kms_rotation_crc (exhaust-fences)
[559.957627] Starting subtest: exhaust-fences
[559.961554] Subtest exhaust-fences: SKIP (0.000s)
[560.033009] [107/132] (464s left) kms_feature_discovery (display-4x)
[560.126283] Starting subtest: display-4x
[560.130194] Subtest display-4x: SKIP (0.000s)
[560.216397] [108/132] (464s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[560.315149] Starting subtest: psr-farfromfence-mmap-gtt
[560.318816] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[560.402635] [109/132] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[560.510415] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[567.046946] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.535s)
[567.193731] [110/132] (457s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[567.298249] Starting subtest: y-tiled-64bpp-rotate-0
[567.302689] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[567.412539] [111/132] (457s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[567.530010] Starting subtest: cursorA-vs-flipB-legacy
[567.534463] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[567.677994] [112/132] (457s left) kms_pm_lpsp (screens-disabled)
[568.775578] Starting subtest: screens-disabled
[568.780133] Subtest screens-disabled: SKIP (0.000s)
[568.847771] [113/132] (456s left) syncobj_wait (reset-signaled)
[568.910490] Starting subtest: reset-signaled
[568.912805] Subtest reset-signaled: SUCCESS (0.000s)
[569.025305] [114/132] (455s left) i915_drm_fdinfo (memory-info-resident)
[569.068117] Starting subtest: memory-info-resident
[569.070513] Starting dynamic subtest: smem0
[571.779494] Dynamic subtest smem0: SUCCESS (2.710s)
[571.781731] Subtest memory-info-resident: SUCCESS (2.711s)
[571.858731] [115/132] (453s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[571.912765] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[571.914797] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[572.008632] [116/132] (452s left) i915_pm_rpm (gem-evict-pwrite)
[574.229485] Starting subtest: gem-evict-pwrite
[574.234278] Subtest gem-evict-pwrite: SKIP (0.000s)
[574.615296] [117/132] (450s left) gem_eio (in-flight-internal-immediate)
[574.815722] Starting subtest: in-flight-internal-immediate
[576.178054] Subtest in-flight-internal-immediate: SUCCESS (1.362s)
[576.325072] [118/132] (448s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[576.416181] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[576.420214] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[576.489764] [119/132] (448s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[576.579257] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[576.581443] Starting dynamic subtest: pipe-A-eDP-1
[592.414561] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.420s)
[592.425227] Starting dynamic subtest: pipe-B-eDP-1
[609.431159] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.428s)
[609.442277] Starting dynamic subtest: pipe-C-eDP-1
[626.385930] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.283s)
[626.397253] Starting dynamic subtest: pipe-D-eDP-1
[643.386588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.327s)
[643.388847] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.466s)
[644.572697] [120/132] (380s left) vgem_basic (dmabuf-mmap)
[644.625564] Starting subtest: dmabuf-mmap
[644.650616] Subtest dmabuf-mmap: SUCCESS (0.027s)
[644.710716] [121/132] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[644.807817] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[644.812002] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[644.914609] [122/132] (380s left) gem_exec_async (forked-writes)
[644.969121] Starting subtest: forked-writes
[644.971515] Starting dynamic subtest: rcs0
[644.998896] Dynamic subtest rcs0: SUCCESS (0.028s)
[645.011151] Starting dynamic subtest: bcs0
[645.024375] Dynamic subtest bcs0: SUCCESS (0.024s)
[645.035178] Starting dynamic subtest: vcs0
[645.047307] Dynamic subtest vcs0: SUCCESS (0.021s)
[645.058116] Starting dynamic subtest: vcs1
[645.073697] Dynamic subtest vcs1: SUCCESS (0.024s)
[645.087202] Starting dynamic subtest: vecs0
[645.097760] Dynamic subtest vecs0: SUCCESS (0.022s)
[645.108252] Starting dynamic subtest: ccs0
[645.121002] Dynamic subtest ccs0: SUCCESS (0.021s)
[645.123439] Subtest forked-writes: SUCCESS (0.147s)
[645.343116] [123/132] (379s left) gem_exec_alignment (single)
[645.397388] Starting subtest: single
[645.402499] Subtest single: SUCCESS (0.002s)
[645.510486] [124/132] (379s left) api_intel_allocator (reserve-simple)
[645.566104] Starting subtest: reserve-simple
[645.568497] Subtest reserve-simple: SUCCESS (0.003s)
[645.696180] [125/132] (379s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[645.763824] Starting subtest: multi-wait-for-submit-available-signaled
[645.766143] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[645.858928] [126/132] (379s left) gen7_exec_parse (batch-without-end)
[645.917574] Subtest batch-without-end: SKIP (0.000s)
[645.991407] [127/132] (379s left) kms_vblank (wait-forked-busy-hang)
[646.081747] Starting subtest: wait-forked-busy-hang
[646.084180] Starting dynamic subtest: pipe-A-eDP-1
[672.997658] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.676s)
[673.012785] Starting dynamic subtest: pipe-D-eDP-1
[697.946749] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.939s)
[697.948733] Subtest wait-forked-busy-hang: SUCCESS (51.619s)
[698.754816] [128/132] (326s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[698.853330] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[699.832392] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[699.966862] [129/132] (325s left) gen3_render_mixed_blits
[700.078112] [130/132] (325s left) kms_psr (fbc-pr-primary-mmap-gtt)
[700.163181] Starting subtest: fbc-pr-primary-mmap-gtt
[700.166741] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[700.238864] [131/132] (325s left) kms_cursor_crc (cursor-suspend)
[700.353514] Starting subtest: cursor-suspend
[700.355553] Starting dynamic subtest: pipe-A-eDP-1
[732.681095] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.131s)
[732.692887] Starting dynamic subtest: pipe-D-eDP-1
[766.706084] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.747s)
[766.709028] Subtest cursor-suspend: SUCCESS (6.880s)
[767.580946] [132/132] (258s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[767.686564] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[768.735749] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[768.874334] Closing watchdogs
results: parsing output: 0/ for test: gem_sync
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_self_import
results: parsing output: 4/ for test: gem_readwrite
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pipe_stress
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_fbcon_fbt
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_parallel
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_dither
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_pm_lpsp
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_async
results: parsing output: 122/ for test: gem_exec_alignment
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gen3_render_mixed_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
Done.