[58.583925] Initializing watchdogs
[58.583977]   /dev/watchdog0
[58.598725] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.603165] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.605738] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.611166] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[58.728179] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[58.732484] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.811594] [002/133] (960s left) kms_atomic_transition (plane-all-modeset-transition)
[58.897824] Starting subtest: plane-all-modeset-transition
[58.902675] Subtest plane-all-modeset-transition: SKIP (0.000s)
[58.984023] [003/133] (960s left) gen3_render_mixed_blits
[59.107596] [004/133] (960s left) gem_sync (basic-store-all)
[59.180663] Starting subtest: basic-store-all
[61.935711] Subtest basic-store-all: SUCCESS (2.779s)
[62.137456] [005/133] (957s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[62.193743] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[62.195965] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[62.291198] [006/133] (957s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[62.397424] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[63.706524] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.724s)
[63.740912] [007/133] (955s left) i915_query (query-topology-known-pci-ids)
[63.806199] Starting subtest: query-topology-known-pci-ids
[63.809677] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[63.902270] [008/133] (955s left) kms_draw_crc (draw-method-render)
[63.999566] Starting subtest: draw-method-render
[64.001453] Starting dynamic subtest: xrgb8888-untiled
[64.274768] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[64.282096] Starting dynamic subtest: rgb565-untiled
[64.496525] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[64.503567] Starting dynamic subtest: xrgb2101010-untiled
[64.729142] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[64.737067] Starting dynamic subtest: xbgr16161616f-untiled
[64.961906] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[64.972963] Starting dynamic subtest: xrgb8888-xtiled
[65.095047] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[65.104078] Starting dynamic subtest: rgb565-xtiled
[65.217426] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[65.224948] Starting dynamic subtest: xrgb2101010-xtiled
[65.338380] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[65.345327] Starting dynamic subtest: xbgr16161616f-xtiled
[65.471668] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[65.478824] Starting dynamic subtest: xrgb8888-4tiled
[65.593068] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[65.600922] Starting dynamic subtest: rgb565-4tiled
[65.715350] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[65.722394] Starting dynamic subtest: xrgb2101010-4tiled
[65.837148] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[65.851819] Starting dynamic subtest: xbgr16161616f-4tiled
[65.970132] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[65.972165] Subtest draw-method-render: SUCCESS (1.978s)
[66.052122] [009/133] (953s left) gem_exec_schedule (submit-late-slice)
[66.121691] Starting subtest: submit-late-slice
[66.123671] Starting dynamic subtest: rcs0
[66.161945] Dynamic subtest rcs0: SUCCESS (0.044s)
[66.170916] Starting dynamic subtest: bcs0
[66.197066] Dynamic subtest bcs0: SUCCESS (0.035s)
[66.204307] Starting dynamic subtest: vcs0
[66.229564] Dynamic subtest vcs0: SUCCESS (0.032s)
[66.237205] Starting dynamic subtest: vcs1
[66.265219] Dynamic subtest vcs1: SUCCESS (0.035s)
[66.272205] Starting dynamic subtest: vecs0
[66.298207] Dynamic subtest vecs0: SUCCESS (0.033s)
[66.305546] Starting dynamic subtest: ccs0
[66.334473] Dynamic subtest ccs0: SUCCESS (0.036s)
[66.336775] Subtest submit-late-slice: SUCCESS (0.218s)
[68.117168] [010/133] (951s left) kms_getfb (getfb2-into-addfb2)
[68.213982] Starting subtest: getfb2-into-addfb2
[68.216151] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[68.310400] [011/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[68.415633] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[68.420217] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.517585] [012/133] (951s left) i915_drm_fdinfo (basics)
[68.563499] Starting subtest: basics
[68.565496] Subtest basics: SUCCESS (0.000s)
[68.654257] [013/133] (950s left) kms_psr (psr2-primary-page-flip)
[68.749564] Starting subtest: psr2-primary-page-flip
[68.752207] Starting dynamic subtest: eDP-1
[70.421271] Dynamic subtest eDP-1: SUCCESS (1.676s)
[70.423584] Subtest psr2-primary-page-flip: SUCCESS (1.677s)
[71.288969] [014/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[71.389804] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[78.190578] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.810s)
[78.325663] [015/133] (941s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[78.386262] Starting subtest: multi-wait-for-submit-unsubmitted
[78.490336] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[78.564951] [016/133] (941s left) kms_flip (flip-vs-suspend)
[78.663821] Starting subtest: flip-vs-suspend
[78.666040] Starting dynamic subtest: A-eDP1
[112.260317] Dynamic subtest A-eDP1: SUCCESS (4.347s)
[112.269622] Starting dynamic subtest: B-eDP1
[146.278880] Dynamic subtest B-eDP1: SUCCESS (4.208s)
[146.288187] Starting dynamic subtest: C-eDP1
[181.267918] Dynamic subtest C-eDP1: SUCCESS (4.198s)
[181.281402] Starting dynamic subtest: D-eDP1
[215.267981] Dynamic subtest D-eDP1: SUCCESS (4.185s)
[215.269848] Subtest flip-vs-suspend: SUCCESS (16.947s)
[226.555327] [017/133] (803s left) gem_mmap_gtt (cpuset-basic-small-copy)
[226.615133] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[226.676923] [018/133] (803s left) gem_tiled_partial_pwrite_pread (reads)
[226.738800] Subtest reads: SKIP (0.000s)
[226.802441] [019/133] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[226.902299] Starting subtest: compare-crc-sanitycheck-nv12
[226.904254] Starting dynamic subtest: pipe-A-eDP-1
[227.593907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[227.603284] Starting dynamic subtest: pipe-B-eDP-1
[228.854279] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s)
[228.875417] Starting dynamic subtest: pipe-C-eDP-1
[230.096220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.269s)
[230.105293] Starting dynamic subtest: pipe-D-eDP-1
[231.357262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[231.359565] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.573s)
[232.150435] [020/133] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[232.254465] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[232.258527] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[232.355788] [021/133] (797s left) gem_exec_flush (basic-wb-ro-default)
[232.412085] Starting subtest: basic-wb-ro-default
[237.808299] Subtest basic-wb-ro-default: SUCCESS (5.461s)
[238.018721] [022/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[238.122393] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[238.742721] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[238.900935] [023/133] (791s left) api_intel_allocator (gem-pool)
[238.947830] Starting subtest: gem-pool
[238.953268] Subtest gem-pool: SUCCESS (0.008s)
[239.091966] [024/133] (790s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[239.229376] Starting subtest: cursor-rapid-movement-32x32
[239.281243] Subtest cursor-rapid-movement-32x32: SKIP (0.048s)
[239.545168] [025/133] (790s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[239.643636] Starting subtest: psr2-plane-move-sf-dmg-area
[239.645588] Starting dynamic subtest: pipe-A-eDP-1
[244.193302] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.577s)
[244.201302] Starting dynamic subtest: pipe-B-eDP-1
[249.522762] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.343s)
[249.525057] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.922s)
[250.382969] [026/133] (779s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[250.511927] Starting subtest: 2x-cursor-vs-flip-atomic
[250.516477] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[250.655276] [027/133] (779s left) kms_plane_scaling (planes-upscale-factor-0-25)
[250.748648] Starting subtest: planes-upscale-factor-0-25
[250.750962] Starting dynamic subtest: pipe-A
[250.808570] Dynamic subtest pipe-A: SUCCESS (0.062s)
[250.818904] Starting dynamic subtest: pipe-B
[251.919695] Dynamic subtest pipe-B: SUCCESS (1.112s)
[251.930103] Starting dynamic subtest: pipe-C
[253.024626] Dynamic subtest pipe-C: SUCCESS (1.106s)
[253.032924] Starting dynamic subtest: pipe-D
[254.158549] Dynamic subtest pipe-D: SUCCESS (1.135s)
[254.160836] Subtest planes-upscale-factor-0-25: SUCCESS (3.419s)
[255.317626] [028/133] (774s left) gem_readwrite (write-bad-handle)
[255.367269] Subtest write-bad-handle: SKIP (0.000s)
[255.423793] [029/133] (774s left) gem_spin_batch (legacy-resubmit)
[255.485234] Starting subtest: legacy-resubmit
[255.487342] Starting dynamic subtest: default
[255.489528] Dynamic subtest default: SUCCESS (0.006s)
[255.501960] Starting dynamic subtest: render
[255.504338] Dynamic subtest render: SUCCESS (0.001s)
[255.514006] Starting dynamic subtest: bsd
[255.515870] Dynamic subtest bsd: SUCCESS (0.002s)
[255.523225] Starting dynamic subtest: bsd1
[255.525128] Dynamic subtest bsd1: SUCCESS (0.001s)
[255.532495] Starting dynamic subtest: bsd2
[255.534318] Dynamic subtest bsd2: SUCCESS (0.002s)
[255.541487] Starting dynamic subtest: blt
[255.543360] Dynamic subtest blt: SUCCESS (0.002s)
[255.550587] Starting dynamic subtest: vebox
[255.552459] Dynamic subtest vebox: SUCCESS (0.002s)
[255.554369] Subtest legacy-resubmit: SUCCESS (0.021s)
[255.734265] [030/133] (774s left) gem_exec_reloc (basic-gtt-cpu)
[255.795367] Subtest basic-gtt-cpu: SKIP (0.000s)
[255.905633] [031/133] (774s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[255.952143] Starting subtest: single-wait-all-for-submit-available-signaled
[255.954269] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[256.035879] [032/133] (774s left) gem_mmap_wc (write-wc-read-gtt)
[256.097005] Subtest write-wc-read-gtt: SKIP (0.000s)
[256.145938] [033/133] (774s left) gem_ctx_create (basic-files)
[256.212628] Starting subtest: basic-files
[258.220575] Subtest basic-files: SUCCESS (2.007s)
[259.637933] [034/133] (770s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[259.757260] Starting subtest: 4-tiled-64bpp-rotate-180
[261.281525] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.523s)
[261.454314] [035/133] (769s left) kms_cursor_crc (cursor-sliding-32x32)
[261.623684] Starting subtest: cursor-sliding-32x32
[261.671563] Subtest cursor-sliding-32x32: SKIP (0.043s)
[261.965677] [036/133] (768s left) core_setmaster_vs_auth
[262.108483] [037/133] (768s left) gem_exec_schedule (lateslice)
[262.188699] Starting subtest: lateslice
[262.190290] Starting dynamic subtest: rcs0
[262.203234] Dynamic subtest rcs0: SUCCESS (0.022s)
[262.211688] Starting dynamic subtest: bcs0
[262.221987] Dynamic subtest bcs0: SUCCESS (0.018s)
[262.229583] Starting dynamic subtest: vcs0
[262.240966] Dynamic subtest vcs0: SUCCESS (0.018s)
[262.248894] Starting dynamic subtest: vcs1
[262.261416] Dynamic subtest vcs1: SUCCESS (0.019s)
[262.277468] Starting dynamic subtest: vecs0
[262.281378] Dynamic subtest vecs0: SUCCESS (0.017s)
[262.288921] Starting dynamic subtest: ccs0
[262.296867] Dynamic subtest ccs0: SUCCESS (0.017s)
[262.298785] Subtest lateslice: SUCCESS (0.116s)
[263.629717] [038/133] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[263.722957] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[273.104719] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.382s)
[273.241774] [039/133] (757s left) gem_mmap_offset (close-race)
[273.301906] Starting subtest: close-race
[293.412612] Subtest close-race: SUCCESS (20.113s)
[293.549621] [040/133] (737s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[293.658715] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[293.662852] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[293.738256] [041/133] (737s left) gem_exec_fence (keep-in-fence)
[293.921543] Starting subtest: keep-in-fence
[293.924194] Starting dynamic subtest: rcs0
[293.976277] Dynamic subtest rcs0: SUCCESS (0.055s)
[293.987161] Starting dynamic subtest: bcs0
[294.029175] Dynamic subtest bcs0: SUCCESS (0.051s)
[294.039469] Starting dynamic subtest: vcs0
[295.554986] Dynamic subtest vcs0: SUCCESS (1.523s)
[295.566614] Starting dynamic subtest: vcs1
[297.539121] Dynamic subtest vcs1: SUCCESS (1.982s)
[297.550603] Starting dynamic subtest: vecs0
[299.586856] Dynamic subtest vecs0: SUCCESS (2.046s)
[299.598295] Starting dynamic subtest: ccs0
[299.812561] Dynamic subtest ccs0: SUCCESS (0.224s)
[299.815367] Subtest keep-in-fence: SUCCESS (5.894s)
[301.572575] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[301.576974] [042/133] (729s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[301.643587] Starting subtest: y-tiled-ccs-to-y-tiled
[301.648240] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[301.845299] [043/133] (728s left) gem_softpin (noreloc)
[301.897292] Starting subtest: noreloc
[307.282825] Subtest noreloc: SUCCESS (5.385s)
[307.434699] [044/133] (723s left) gem_ctx_persistence (legacy-engines-mixed)
[307.505954] Starting subtest: legacy-engines-mixed
[307.508194] Starting dynamic subtest: render
[307.594136] Dynamic subtest render: SUCCESS (0.090s)
[307.605570] Starting dynamic subtest: bsd1
[307.642212] Dynamic subtest bsd1: SUCCESS (0.046s)
[307.652695] Starting dynamic subtest: bsd2
[307.704530] Dynamic subtest bsd2: SUCCESS (0.060s)
[307.716046] Starting dynamic subtest: blt
[307.757293] Dynamic subtest blt: SUCCESS (0.051s)
[307.767770] Starting dynamic subtest: vebox
[307.812253] Dynamic subtest vebox: SUCCESS (0.053s)
[307.815170] Subtest legacy-engines-mixed: SUCCESS (0.310s)
[307.909854] [045/133] (723s left) gem_exec_gttfill (basic)
[307.978385] Starting subtest: basic
[311.182738] Subtest basic: SUCCESS (3.205s)
[311.373949] [046/133] (719s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[311.518642] Starting subtest: psr-rgb565-draw-mmap-cpu
[318.371638] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.858s)
[318.474273] [047/133] (712s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[318.571424] Starting subtest: fbc-psr2-primary-mmap-gtt
[318.573594] Starting dynamic subtest: eDP-1
[318.577493] Dynamic subtest eDP-1: SKIP (0.000s)
[318.581523] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[318.646495] [048/133] (712s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[318.743065] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[318.747453] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[318.830097] [049/133] (712s left) syncobj_timeline (invalid-wait-illegal-handle)
[318.896979] Starting subtest: invalid-wait-illegal-handle
[318.899399] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[319.009597] [050/133] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[319.105778] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[326.175683] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.071s)
[326.299953] [051/133] (704s left) kms_prime (basic-crc-vgem)
[326.392969] Starting subtest: basic-crc-vgem
[326.395093] Starting dynamic subtest: second-to-first
[327.418805] Dynamic subtest second-to-first: SUCCESS (1.029s)
[327.420594] Subtest basic-crc-vgem: SUCCESS (1.030s)
[327.551042] [052/133] (703s left) api_intel_bb (intel-bb-blit-y)
[327.607946] Starting subtest: intel-bb-blit-y
[331.345136] Subtest intel-bb-blit-y: SUCCESS (3.735s)
[331.471297] [053/133] (699s left) i915_hangman (hangcheck-unterminated)
[331.537538] Starting subtest: hangcheck-unterminated
[342.496553] Subtest hangcheck-unterminated: SUCCESS (10.956s)
[342.622227] [054/133] (688s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[342.743392] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[342.829966] [055/133] (688s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[342.943119] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[347.550826] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.610s)
[348.661256] [056/133] (682s left) kms_vrr (seamless-rr-switch-drrs)
[348.752674] Starting subtest: seamless-rr-switch-drrs
[348.758867] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[348.835718] [057/133] (682s left) perf_pmu (idle-no-semaphores)
[348.885347] Starting subtest: idle-no-semaphores
[348.887801] Starting dynamic subtest: rcs0
[349.427824] Dynamic subtest rcs0: SUCCESS (0.542s)
[349.440690] Starting dynamic subtest: bcs0
[349.947092] Dynamic subtest bcs0: SUCCESS (0.516s)
[349.959245] Starting dynamic subtest: vcs0
[350.471902] Dynamic subtest vcs0: SUCCESS (0.521s)
[350.484071] Starting dynamic subtest: vcs1
[350.999589] Dynamic subtest vcs1: SUCCESS (0.525s)
[351.012030] Starting dynamic subtest: vecs0
[351.522901] Dynamic subtest vecs0: SUCCESS (0.520s)
[351.533452] Starting dynamic subtest: ccs0
[352.048968] Dynamic subtest ccs0: SUCCESS (0.523s)
[352.051601] Subtest idle-no-semaphores: SUCCESS (3.166s)
[352.142271] [058/133] (679s left) syncobj_wait (multi-wait-all-submitted-signaled)
[352.195179] Starting subtest: multi-wait-all-submitted-signaled
[352.302440] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[352.385806] [059/133] (679s left) gem_vm_create (invalid-destroy)
[352.441161] Starting subtest: invalid-destroy
[352.443445] Subtest invalid-destroy: SUCCESS (0.002s)
[352.543427] [060/133] (679s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[352.671554] Starting subtest: 2x-flip-vs-cursor-legacy
[352.675831] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[352.817814] [061/133] (678s left) gem_ctx_freq (sysfs)
[352.876267] Starting subtest: sysfs
[352.878587] Starting dynamic subtest: gt0
[358.381524] Dynamic subtest gt0: SUCCESS (5.504s)
[358.393446] Starting dynamic subtest: gt1
[399.553843] Dynamic subtest gt1: SUCCESS (41.175s)
[399.556717] Subtest sysfs: SUCCESS (46.682s)
[399.663759] [062/133] (632s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[399.763525] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[399.768019] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[399.833959] [063/133] (631s left) kms_psr (pr-dpms)
[399.924620] Starting subtest: pr-dpms
[399.929078] Subtest pr-dpms: SKIP (0.000s)
[399.998611] [064/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[400.089296] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[400.093462] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[400.180751] [065/133] (631s left) gem_close_race (basic-process)
[400.248337] Starting subtest: basic-process
[400.300488] Subtest basic-process: SUCCESS (0.051s)
[400.499405] [066/133] (631s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[400.597476] Starting subtest: x-tiled-64bpp-rotate-0
[402.175352] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.579s)
[402.352421] [067/133] (629s left) kms_atomic_transition (modeset-transition-fencing)
[402.454798] Starting subtest: modeset-transition-fencing
[402.457083] Starting dynamic subtest: 1x-outputs
[413.282574] Dynamic subtest 1x-outputs: SUCCESS (10.829s)
[413.285346] Subtest modeset-transition-fencing: SUCCESS (10.831s)
[414.152739] [068/133] (617s left) gem_cs_tlb (engines)
[414.217580] Starting subtest: engines
[414.219918] Starting dynamic subtest: rcs0
[416.372243] Dynamic subtest rcs0: SUCCESS (2.152s)
[416.383816] Starting dynamic subtest: bcs0
[418.525444] Dynamic subtest bcs0: SUCCESS (2.151s)
[418.537980] Starting dynamic subtest: vcs0
[420.678855] Dynamic subtest vcs0: SUCCESS (2.153s)
[420.688511] Starting dynamic subtest: vcs1
[422.832096] Dynamic subtest vcs1: SUCCESS (2.153s)
[422.842198] Starting dynamic subtest: vecs0
[424.983586] Dynamic subtest vecs0: SUCCESS (2.151s)
[424.993256] Starting dynamic subtest: ccs0
[427.142576] Dynamic subtest ccs0: SUCCESS (2.158s)
[427.144840] Subtest engines: SUCCESS (12.926s)
[427.273263] [069/133] (604s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[427.372544] Starting subtest: bad-aux-stride-y-tiled-ccs
[427.374815] Starting dynamic subtest: pipe-A-eDP-1
[427.397314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.409019] Starting dynamic subtest: pipe-B-eDP-1
[427.430901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.439822] Starting dynamic subtest: pipe-C-eDP-1
[427.461868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.471050] Starting dynamic subtest: pipe-D-eDP-1
[427.493036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.497140] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[429.630310] [070/133] (602s left) kms_busy (extended-pageflip-hang-oldfb)
[429.739681] Starting subtest: extended-pageflip-hang-oldfb
[429.742038] Starting dynamic subtest: pipe-A
[430.150699] Dynamic subtest pipe-A: SUCCESS (0.411s)
[430.161155] Starting dynamic subtest: pipe-D
[431.247835] Dynamic subtest pipe-D: SUCCESS (1.096s)
[431.250220] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.512s)
[432.099271] [071/133] (599s left) kms_addfb_basic (invalid-set-prop)
[432.166106] Starting subtest: invalid-set-prop
[432.168080] Subtest invalid-set-prop: SUCCESS (0.000s)
[432.298822] [072/133] (599s left) kms_plane_multiple (tiling-none)
[432.388624] Starting subtest: tiling-none
[432.390883] Starting dynamic subtest: pipe-A-eDP-1
[436.142010] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.754s)
[436.152547] Starting dynamic subtest: pipe-B-eDP-1
[440.669283] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.528s)
[440.679874] Starting dynamic subtest: pipe-C-eDP-1
[445.003349] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[445.013482] Starting dynamic subtest: pipe-D-eDP-1
[449.349596] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s)
[449.351905] Subtest tiling-none: SUCCESS (16.965s)
[450.161918] [073/133] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[450.267095] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[450.271484] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[450.377032] [074/133] (581s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[450.471924] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[450.474142] Starting dynamic subtest: pipe-A-default-mode
[453.235572] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[453.237878] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.762s)
[454.048672] [075/133] (578s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[454.148889] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[454.151234] Starting dynamic subtest: pipe-A-eDP-1
[454.174339] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[454.186874] Starting dynamic subtest: pipe-B-eDP-1
[454.208886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[454.217567] Starting dynamic subtest: pipe-C-eDP-1
[454.239047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[454.247781] Starting dynamic subtest: pipe-D-eDP-1
[454.269644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[454.274018] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[456.419112] [076/133] (575s left) sriov_basic (enable-vfs-autoprobe-off)
[456.478258] Starting subtest: enable-vfs-autoprobe-off
[456.480292] Starting dynamic subtest: numvfs-1
[456.559707] Dynamic subtest numvfs-1: FAIL (0.029s)
[456.571260] Starting dynamic subtest: numvfs-2
[456.643382] Dynamic subtest numvfs-2: FAIL (0.004s)
[456.654126] Starting dynamic subtest: numvfs-3
[456.725763] Dynamic subtest numvfs-3: FAIL (0.004s)
[456.736437] Starting dynamic subtest: numvfs-4
[456.807937] Dynamic subtest numvfs-4: FAIL (0.003s)
[456.819399] Starting dynamic subtest: numvfs-5
[456.891646] Dynamic subtest numvfs-5: FAIL (0.004s)
[456.902132] Starting dynamic subtest: numvfs-6
[456.975035] Dynamic subtest numvfs-6: FAIL (0.004s)
[456.986370] Starting dynamic subtest: numvfs-7
[457.058437] Dynamic subtest numvfs-7: FAIL (0.004s)
[457.069428] Starting dynamic subtest: numvfs-random
[457.140988] Dynamic subtest numvfs-random: FAIL (0.004s)
[457.152219] Starting dynamic subtest: numvfs-all
[457.224383] Dynamic subtest numvfs-all: FAIL (0.512s)
[457.226439] Subtest enable-vfs-autoprobe-off: FAIL (0.575s)
[457.268585] [077/133] (575s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[457.369607] Starting subtest: 2x-plain-flip-ts-check-interruptible
[457.382676] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[457.470346] [078/133] (574s left) core_getversion (all-cards)
[457.508533] Starting subtest: all-cards
[457.513760] Subtest all-cards: SUCCESS (0.010s)
[457.557433] [079/133] (574s left) syncobj_basic (bad-destroy-pad)
[457.613842] Starting subtest: bad-destroy-pad
[457.615827] Subtest bad-destroy-pad: SUCCESS (0.000s)
[457.704393] [080/133] (574s left) i915_suspend (forcewake)
[457.758972] Starting subtest: forcewake
[490.268070] Subtest forcewake: SUCCESS (3.043s)
[497.354773] [081/133] (542s left) kms_universal_plane (universal-plane-sanity)
[497.460136] Starting subtest: universal-plane-sanity
[497.462279] Starting dynamic subtest: pipe-A-eDP-1
[498.059659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[498.070256] Starting dynamic subtest: pipe-B-eDP-1
[499.264840] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[499.275084] Starting dynamic subtest: pipe-C-eDP-1
[500.466236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[500.476381] Starting dynamic subtest: pipe-D-eDP-1
[501.690981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[501.693393] Subtest universal-plane-sanity: SUCCESS (4.231s)
[502.554199] [082/133] (537s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[502.663671] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[502.666040] Starting dynamic subtest: pipe-A-eDP-1
[502.689361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[502.704438] Starting dynamic subtest: pipe-B-eDP-1
[502.726129] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[502.737824] Starting dynamic subtest: pipe-C-eDP-1
[502.758358] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[502.767949] Starting dynamic subtest: pipe-D-eDP-1
[502.789001] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[502.792911] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[504.860105] [083/133] (534s left) kms_chamelium_frames (dp-crc-single)
[505.236121] Subtest dp-crc-single: SKIP (0.000s)
[506.032526] [084/133] (533s left) gem_exec_balancer (persistence)
[506.298185] Starting subtest: persistence
[507.194218] Subtest persistence: SUCCESS (0.916s)
[507.321594] [085/133] (532s left) kms_vblank (query-idle-hang)
[507.410405] Starting subtest: query-idle-hang
[507.412637] Starting dynamic subtest: pipe-A-eDP-1
[533.830446] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.584s)
[533.849363] Starting dynamic subtest: pipe-D-eDP-1
[558.805299] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s)
[558.807539] Subtest query-idle-hang: SUCCESS (51.556s)
[559.619569] [086/133] (480s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[559.692977] Starting subtest: y-tiled-ccs-to-yf-tiled
[559.697564] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[559.879015] [087/133] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[559.988287] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[559.992671] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[560.090510] [088/133] (479s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[560.196364] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[567.534249] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.344s)
[567.648040] [089/133] (472s left) sw_sync (timeline_closed_signaled)
[567.690021] Starting subtest: timeline_closed_signaled
[567.691996] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[567.747845] [090/133] (472s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[567.856570] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[567.859036] Starting dynamic subtest: pipe-A-eDP-1
[567.882921] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.904071] Starting dynamic subtest: pipe-B-eDP-1
[567.926568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.946148] Starting dynamic subtest: pipe-C-eDP-1
[567.968983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.990528] Starting dynamic subtest: pipe-D-eDP-1
[568.014216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.018557] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[570.135943] [091/133] (469s left) gem_pxp (reject-modify-context-protection-off-2)
[570.262901] Starting subtest: reject-modify-context-protection-off-2
[570.265731] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[570.366857] [092/133] (469s left) gem_mmap_gtt (hang)
[570.432777] Subtest hang: SKIP (0.000s)
[570.500515] [093/133] (469s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[570.607703] Starting subtest: drrs-dirtyfb-ioctl
[570.621071] Subtest drrs-dirtyfb-ioctl: SKIP (0.002s)
[570.729117] [094/133] (469s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[570.843822] Starting subtest: basic-flip-before-cursor-legacy
[571.759444] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[572.569548] [095/133] (467s left) kms_psr (fbc-psr-cursor-render)
[572.667491] Starting subtest: fbc-psr-cursor-render
[572.669767] Starting dynamic subtest: eDP-1
[572.673826] Dynamic subtest eDP-1: SKIP (0.000s)
[572.677930] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[572.744929] [096/133] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[572.847998] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[577.126132] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.284s)
[578.262804] [097/133] (461s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[578.361048] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[578.363396] Starting dynamic subtest: pipe-A-eDP-1
[578.389076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.400177] Starting dynamic subtest: pipe-B-eDP-1
[578.424107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.433678] Starting dynamic subtest: pipe-C-eDP-1
[578.457533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.466569] Starting dynamic subtest: pipe-D-eDP-1
[578.491257] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.496224] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[580.528746] [098/133] (459s left) kms_color (ctm-signed)
[580.618401] Starting subtest: ctm-signed
[580.620500] Starting dynamic subtest: pipe-A-eDP-1
[582.751095] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[582.761219] Starting dynamic subtest: pipe-B-eDP-1
[585.604173] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.855s)
[585.616007] Starting dynamic subtest: pipe-C-eDP-1
[588.311720] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.707s)
[588.321808] Starting dynamic subtest: pipe-D-eDP-1
[590.971652] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.658s)
[590.973504] Subtest ctm-signed: SUCCESS (10.356s)
[591.808614] [099/133] (448s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[591.909261] Starting subtest: fbc-farfromfence-mmap-gtt
[591.913670] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[592.029406] [100/133] (448s left) gem_exec_whisper (basic-queues-all)
[592.105774] Starting subtest: basic-queues-all
[599.786241] Subtest basic-queues-all: SUCCESS (7.684s)
[599.975217] [101/133] (440s left) syncobj_timeline (etime-single-wait-all-submitted)
[600.036192] Starting subtest: etime-single-wait-all-submitted
[600.136531] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[600.216200] [102/133] (440s left) kms_cursor_crc (cursor-onscreen-64x21)
[600.409467] Starting subtest: cursor-onscreen-64x21
[600.454652] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[600.699569] [103/133] (439s left) kms_content_protection (dp-mst-type-1)
[600.845234] Starting subtest: dp-mst-type-1
[600.849811] Subtest dp-mst-type-1: SKIP (0.000s)
[600.978538] [104/133] (439s left) kms_joiner (basic-force-big-joiner)
[601.075727] Starting subtest: basic-force-big-joiner
[601.079083] Subtest basic-force-big-joiner: SKIP (0.000s)
[601.144523] [105/133] (439s left) kms_flip (2x-plain-flip-ts-check)
[601.244669] Starting subtest: 2x-plain-flip-ts-check
[601.256247] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[601.357724] [106/133] (439s left) perf (sysctl-defaults)
[601.444132] Starting subtest: sysctl-defaults
[601.446132] Subtest sysctl-defaults: SUCCESS (0.000s)
[601.546441] [107/133] (439s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[601.663332] Starting subtest: cursorA-vs-flipB-atomic
[601.666984] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[601.811462] [108/133] (438s left) kms_chamelium_hpd (dp-hpd-fast)
[602.200331] Subtest dp-hpd-fast: SKIP (0.000s)
[603.015412] [109/133] (437s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[603.109067] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[603.113012] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[603.196924] [110/133] (437s left) kms_lease (lease-invalid-connector)
[603.293192] Starting subtest: lease-invalid-connector
[603.295372] Starting dynamic subtest: pipe-A-eDP-1
[603.297571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[603.307387] Starting dynamic subtest: pipe-B-eDP-1
[603.309518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[603.318443] Starting dynamic subtest: pipe-C-eDP-1
[603.320651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[603.329569] Starting dynamic subtest: pipe-D-eDP-1
[603.331686] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[603.333784] Subtest lease-invalid-connector: SUCCESS (0.004s)
[603.372429] [111/133] (437s left) kms_rotation_crc (multiplane-rotation)
[603.468543] Starting subtest: multiplane-rotation
[620.820566] Subtest multiplane-rotation: SUCCESS (17.349s)
[620.942230] [112/133] (419s left) gen7_exec_parse (oacontrol-tracking)
[621.017686] Subtest oacontrol-tracking: SKIP (0.000s)
[621.089677] [113/133] (419s left) gem_flink_basic (bad-flink)
[621.146743] Starting subtest: bad-flink
[621.148356] Subtest bad-flink: SUCCESS (0.000s)
[621.245290] [114/133] (419s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[621.343905] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[621.347211] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[621.422062] [115/133] (419s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[621.527086] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[628.258704] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.732s)
[628.363473] [116/133] (412s left) gem_ctx_create (basic)
[628.430773] Starting subtest: basic
[628.433126] Subtest basic: SUCCESS (0.000s)
[628.619100] [117/133] (412s left) gem_exec_reloc (basic-concurrent0)
[628.674908] Subtest basic-concurrent0: SKIP (0.000s)
[628.750791] [118/133] (412s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[628.840541] Starting subtest: primary-yf-tiled-reflect-x-90
[628.844693] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[628.913152] [119/133] (412s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[629.012036] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[629.016638] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[629.107468] [120/133] (412s left) gem_exec_params (rel-constants-invalid-ring)
[629.158797] Starting subtest: rel-constants-invalid-ring
[629.161068] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[629.274451] [121/133] (411s left) gem_bad_reloc (negative-reloc-lut)
[629.337138] Subtest negative-reloc-lut: SKIP (0.000s)
[629.413231] [122/133] (411s left) gem_exec_suspend (basic-s0)
[629.471151] Starting subtest: basic-S0
[629.473489] Starting dynamic subtest: smem
[649.738536] Dynamic subtest smem: SUCCESS (6.508s)
[649.741161] Subtest basic-S0: SUCCESS (6.510s)
[655.940604] [123/133] (391s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[656.054683] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[656.056900] Starting dynamic subtest: pipe-A
[657.195298] Dynamic subtest pipe-A: SUCCESS (1.173s)
[657.204554] Starting dynamic subtest: pipe-B
[659.459849] Dynamic subtest pipe-B: SUCCESS (2.327s)
[659.469222] Starting dynamic subtest: pipe-C
[660.617880] Dynamic subtest pipe-C: SUCCESS (1.182s)
[660.629572] Starting dynamic subtest: pipe-D
[661.828664] Dynamic subtest pipe-D: SUCCESS (1.232s)
[661.830803] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.919s)
[663.023272] [124/133] (384s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[663.082945] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[663.190875] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.110s)
[663.265500] [125/133] (384s left) gem_ctx_param (set-priority-range)
[663.323028] Starting subtest: set-priority-range
[663.337522] Subtest set-priority-range: SUCCESS (0.015s)
[663.435062] [126/133] (384s left) gem_ctx_sseu (engines)
[663.504314] Subtest engines: SKIP (0.000s)
[663.573470] [127/133] (383s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[663.669108] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[663.673400] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[663.767411] [128/133] (383s left) sysfs_heartbeat_interval (idempotent)
[663.821791] Starting subtest: idempotent
[663.824105] Starting dynamic subtest: vecs0
[663.826353] Dynamic subtest vecs0: SUCCESS (0.001s)
[663.837138] Starting dynamic subtest: ccs0
[663.839295] Dynamic subtest ccs0: SUCCESS (0.001s)
[663.848410] Starting dynamic subtest: vcs0
[663.850511] Dynamic subtest vcs0: SUCCESS (0.000s)
[663.859735] Starting dynamic subtest: bcs0
[663.861870] Dynamic subtest bcs0: SUCCESS (0.001s)
[663.871083] Starting dynamic subtest: rcs0
[663.873239] Dynamic subtest rcs0: SUCCESS (0.000s)
[663.882320] Starting dynamic subtest: vcs1
[663.884147] Dynamic subtest vcs1: SUCCESS (0.000s)
[663.886045] Subtest idempotent: SUCCESS (0.008s)
[663.939887] [129/133] (383s left) i915_pm_rpm (system-suspend-devices)
[665.867385] Starting subtest: system-suspend-devices
[673.519669] Subtest system-suspend-devices: SUCCESS (7.703s)
[679.929709] [130/133] (373s left) kms_pm_dc (dc5-retention-flops)
[681.053887] Starting subtest: dc5-retention-flops
[681.058106] Subtest dc5-retention-flops: SKIP (0.000s)
[681.131345] [131/133] (372s left) gem_shrink (reclaim)
[681.203361] Starting subtest: reclaim
[683.664233] Subtest reclaim: SUCCESS (2.461s)
[683.812801] [132/133] (369s left) gem_exec_balancer (busy)
[683.864397] Starting subtest: busy
[685.784710] Subtest busy: SUCCESS (1.919s)
[686.102081] [133/133] (367s left) prime_mmap (test_forked_cpu_write)
[686.150444] Starting subtest: test_forked_cpu_write
[686.152655] Starting dynamic subtest: test_forked_cpu_write-smem
[686.159317] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[686.162159] Subtest test_forked_cpu_write: SUCCESS (0.012s)
[686.273029] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_atomic_transition
results: parsing output: 2/ for test: gen3_render_mixed_blits
results: parsing output: 3/ for test: gem_sync
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: i915_query
results: parsing output: 7/ for test: kms_draw_crc
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_getfb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 18/ for test: kms_pipe_crc_basic
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_flush
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: gem_readwrite
results: parsing output: 28/ for test: gem_spin_batch
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: gem_ctx_create
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: core_setmaster_vs_auth
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_offset
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_prime
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_vrr
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: gem_vm_create
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_ctx_freq
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: gem_cs_tlb
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_plane_multiple
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: sriov_basic
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: core_getversion
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: i915_suspend
results: parsing output: 80/ for test: kms_universal_plane
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_dirtyfb
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_lease
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: gen7_exec_parse
results: parsing output: 112/ for test: gem_flink_basic
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ctx_create
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_rotation_crc
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: gem_bad_reloc
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: gem_ctx_sseu
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: sysfs_heartbeat_interval
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: kms_pm_dc
results: parsing output: 130/ for test: gem_shrink
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: prime_mmap
Done.