[104.942826] Initializing watchdogs
[104.942869]   /dev/watchdog0
[104.958686] [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]
[104.963152] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.965573] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.968799] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[105.089028] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[105.091217] Starting dynamic subtest: pipe-A-eDP-1
[105.954797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[105.963161] Starting dynamic subtest: pipe-B-eDP-1
[107.583072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.625s)
[107.592329] Starting dynamic subtest: pipe-C-eDP-1
[109.125991] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[109.135148] Starting dynamic subtest: pipe-D-eDP-1
[110.664148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[110.666015] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.569s)
[111.832665] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[111.921173] Starting subtest: fbc-pr-sprite-plane-move
[111.925674] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[111.988819] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[112.155837] Starting subtest: in-flight-contexts-immediate
[120.383784] Subtest in-flight-contexts-immediate: SUCCESS (8.229s)
[120.512522] [004/133] (945s left) kms_async_flips (async-flip-suspend-resume)
[120.614219] Starting subtest: async-flip-suspend-resume
[121.002668] Starting dynamic subtest: pipe-A-eDP-1
[138.968625] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[139.349391] Starting dynamic subtest: pipe-B-eDP-1
[157.954320] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.294s)
[158.331444] Starting dynamic subtest: pipe-C-eDP-1
[176.954617] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.279s)
[177.336259] Starting dynamic subtest: pipe-D-eDP-1
[195.953953] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.268s)
[195.956351] Subtest async-flip-suspend-resume: SUCCESS (14.824s)
[207.154539] [005/133] (868s left) kms_flip (modeset-vs-vblank-race)
[207.270116] Starting subtest: modeset-vs-vblank-race
[207.272373] Starting dynamic subtest: A-eDP1
[211.903936] Dynamic subtest A-eDP1: SUCCESS (4.700s)
[211.914831] Starting dynamic subtest: B-eDP1
[216.618206] Dynamic subtest B-eDP1: SUCCESS (4.749s)
[216.630100] Starting dynamic subtest: C-eDP1
[221.301584] Dynamic subtest C-eDP1: SUCCESS (4.703s)
[221.318818] Starting dynamic subtest: D-eDP1
[225.850423] Dynamic subtest D-eDP1: SUCCESS (4.558s)
[225.855479] Subtest modeset-vs-vblank-race: SUCCESS (18.723s)
[227.029215] [006/133] (848s left) kms_psr (pr-cursor-plane-move)
[227.128947] Starting subtest: pr-cursor-plane-move
[227.133279] Subtest pr-cursor-plane-move: SKIP (0.000s)
[227.211452] [007/133] (848s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[227.309756] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[234.598806] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.302s)
[234.710263] [008/133] (841s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[234.811632] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[234.815959] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[234.919150] [009/133] (840s left) kms_atomic_transition (modeset-transition-nonblocking)
[235.016343] Starting subtest: modeset-transition-nonblocking
[235.018188] Starting dynamic subtest: 1x-outputs
[245.896439] Dynamic subtest 1x-outputs: SUCCESS (10.881s)
[245.898870] Subtest modeset-transition-nonblocking: SUCCESS (10.883s)
[246.756149] [010/133] (829s left) i915_power (sanity)
[246.815239] Starting subtest: sanity
[250.852816] Subtest sanity: SUCCESS (4.030s)
[252.966220] [011/133] (822s left) gem_exec_whisper (basic-queues-all)
[253.040629] Starting subtest: basic-queues-all
[264.838856] Subtest basic-queues-all: SUCCESS (11.796s)
[265.020619] [012/133] (810s left) drm_read (empty-nonblock)
[265.172835] Starting subtest: empty-nonblock
[265.175143] Subtest empty-nonblock: SUCCESS (0.000s)
[265.305672] [013/133] (810s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[265.391553] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[265.395976] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[265.462124] [014/133] (810s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[265.560594] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[265.564581] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[265.632120] [015/133] (810s left) kms_psr (psr-sprite-plane-move)
[265.717960] Starting subtest: psr-sprite-plane-move
[265.720195] Starting dynamic subtest: eDP-1
[267.499098] Dynamic subtest eDP-1: SUCCESS (1.783s)
[267.501323] Subtest psr-sprite-plane-move: SUCCESS (1.784s)
[268.312486] [016/133] (807s left) gem_exec_create (legacy)
[268.385608] Starting subtest: legacy
[268.388078] Starting dynamic subtest: smem
[270.490398] Dynamic subtest smem: SUCCESS (2.087s)
[270.492954] Subtest legacy: SUCCESS (2.089s)
[270.687527] [017/133] (805s left) perf (blocking)
[270.829702] Starting subtest: blocking
[270.832174] Starting dynamic subtest: 0-rcs0
[280.903154] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[280.915502] Starting dynamic subtest: 1-vcs0
[290.870837] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[290.873844] Subtest blocking: SUCCESS (20.048s)
[290.919219] [018/133] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[291.035851] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[291.040043] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[291.123038] [019/133] (785s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[291.226168] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[291.228798] Starting dynamic subtest: pipe-A-eDP-1
[291.976196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[291.989703] Starting dynamic subtest: pipe-B-eDP-1
[293.750633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.774s)
[293.760541] Starting dynamic subtest: pipe-C-eDP-1
[295.579708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.829s)
[295.588973] Starting dynamic subtest: pipe-D-eDP-1
[297.435146] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.855s)
[297.436993] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.203s)
[298.646032] [020/133] (777s left) kms_lease (lease-invalid-crtc)
[298.733552] Starting subtest: lease-invalid-crtc
[298.735954] Starting dynamic subtest: pipe-A-eDP-1
[298.738269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[298.749157] Starting dynamic subtest: pipe-B-eDP-1
[298.751304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[298.760323] Starting dynamic subtest: pipe-C-eDP-1
[298.762243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[298.772836] Starting dynamic subtest: pipe-D-eDP-1
[298.774733] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[298.776677] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[298.811629] [021/133] (777s left) kms_content_protection (atomic-hdcp14)
[298.946308] Starting subtest: atomic-hdcp14
[298.950867] Subtest atomic-hdcp14: SKIP (0.000s)
[299.055970] [022/133] (777s left) gem_ctx_sseu (invalid-args)
[299.123096] Subtest invalid-args: SKIP (0.000s)
[299.198094] [023/133] (777s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[299.253788] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[299.360740] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[299.435243] [024/133] (776s left) gem_lmem_swapping (parallel-random-engines)
[299.483741] Subtest parallel-random-engines: SKIP (0.000s)
[299.521842] [025/133] (776s left) gem_softpin (evict-prime)
[299.585768] Starting subtest: evict-prime
[299.588140] Starting dynamic subtest: rcs0
[300.746799] Dynamic subtest rcs0: SUCCESS (1.162s)
[300.758647] Starting dynamic subtest: bcs0
[301.867385] Dynamic subtest bcs0: SUCCESS (1.119s)
[301.877365] Starting dynamic subtest: vcs0
[303.822515] Dynamic subtest vcs0: SUCCESS (1.952s)
[303.834890] Starting dynamic subtest: vcs1
[305.805985] Dynamic subtest vcs1: SUCCESS (1.981s)
[305.818854] Starting dynamic subtest: vecs0
[307.852083] Dynamic subtest vecs0: SUCCESS (2.043s)
[307.865229] Starting dynamic subtest: ccs0
[308.974760] Dynamic subtest ccs0: SUCCESS (1.121s)
[308.987638] Starting dynamic subtest: all
[310.793707] Dynamic subtest all: SUCCESS (1.815s)
[310.796824] Subtest evict-prime: SUCCESS (11.205s)
[310.887842] [026/133] (765s left) kms_plane_lowres (tiling-none)
[310.988650] Starting subtest: tiling-none
[310.990946] Starting dynamic subtest: pipe-A-eDP-1
[310.995263] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[311.284304] Starting dynamic subtest: pipe-B-eDP-1
[311.289003] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[311.298651] Starting dynamic subtest: pipe-C-eDP-1
[311.303299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[311.312711] Starting dynamic subtest: pipe-D-eDP-1
[311.316792] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[311.320957] Subtest tiling-none: SKIP (0.293s)
[312.084727] [027/133] (764s left) kms_draw_crc (draw-method-mmap-cpu)
[312.182852] Starting subtest: draw-method-mmap-cpu
[312.185225] Starting dynamic subtest: xrgb8888-untiled
[312.413463] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[312.423538] Starting dynamic subtest: rgb565-untiled
[312.657702] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[312.667784] Starting dynamic subtest: xrgb2101010-untiled
[312.880216] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[312.890181] Starting dynamic subtest: xbgr16161616f-untiled
[313.090888] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[313.100818] Starting dynamic subtest: xrgb8888-xtiled
[313.224398] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[313.233847] Starting dynamic subtest: rgb565-xtiled
[313.357757] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[313.367461] Starting dynamic subtest: xrgb2101010-xtiled
[313.468958] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[313.478260] Starting dynamic subtest: xbgr16161616f-xtiled
[313.591505] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[313.601173] Starting dynamic subtest: xrgb8888-4tiled
[313.735770] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[313.744861] Starting dynamic subtest: rgb565-4tiled
[313.869635] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[313.879389] Starting dynamic subtest: xrgb2101010-4tiled
[314.002259] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[314.013643] Starting dynamic subtest: xbgr16161616f-4tiled
[314.136251] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[314.138075] Subtest draw-method-mmap-cpu: SUCCESS (1.957s)
[314.237559] [028/133] (762s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[314.293160] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[314.348130] [029/133] (762s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[314.435284] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[314.437186] Starting dynamic subtest: pipe-A-eDP-1
[314.524493] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[314.534735] Starting dynamic subtest: pipe-B-eDP-1
[315.655988] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[315.660383] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.221s)
[316.866053] [030/133] (759s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[316.973885] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[316.978374] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[317.064649] [031/133] (759s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[317.165733] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[317.170172] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[317.250526] [032/133] (759s left) kms_rotation_crc (primary-rotation-180)
[317.344596] Starting subtest: primary-rotation-180
[324.290937] Subtest primary-rotation-180: SUCCESS (6.948s)
[325.523253] [033/133] (751s left) kms_pm_rpm (universal-planes-dpms)
[327.056442] Starting subtest: universal-planes-dpms
[327.058672] Starting dynamic subtest: plane-35
[335.376723] Dynamic subtest plane-35: SUCCESS (8.323s)
[335.389589] Starting dynamic subtest: plane-65
[343.696615] Dynamic subtest plane-65: SUCCESS (8.317s)
[343.709525] Starting dynamic subtest: plane-95
[352.033959] Dynamic subtest plane-95: SUCCESS (8.336s)
[352.047129] Starting dynamic subtest: plane-125
[360.633383] Dynamic subtest plane-125: SUCCESS (8.597s)
[360.646760] Starting dynamic subtest: plane-135
[368.953763] Dynamic subtest plane-135: SUCCESS (8.318s)
[368.966366] Starting dynamic subtest: plane-145
[377.551873] Dynamic subtest plane-145: SUCCESS (8.597s)
[377.554717] Subtest universal-planes-dpms: SUCCESS (50.505s)
[377.935687] [034/133] (698s left) kms_pm_lpsp (kms-lpsp)
[379.049485] Starting subtest: kms-lpsp
[379.051796] Starting dynamic subtest: pipe-A-eDP-1
[379.196024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[379.500409] Subtest kms-lpsp: SUCCESS (0.453s)
[380.362404] [035/133] (696s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[380.741176] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[381.565573] [036/133] (695s left) api_intel_allocator (two-level-inception-interruptible)
[381.620531] Starting subtest: two-level-inception-interruptible
[387.074698] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[387.149498] [037/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[387.268748] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[387.272803] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[387.362608] [038/133] (689s left) gem_userptr_blits (huge-split)
[387.449900] Starting subtest: huge-split
[387.458753] Subtest huge-split: SUCCESS (0.009s)
[387.607638] [039/133] (689s left) gem_eio (in-flight-10ms)
[387.857144] Starting subtest: in-flight-10ms
[396.816384] Subtest in-flight-10ms: SUCCESS (8.960s)
[396.973779] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[396.976826] [040/133] (680s left) perf_pmu (pmu-read)
[397.018556] Starting subtest: pmu-read
[397.020963] Subtest pmu-read: SUCCESS (0.003s)
[397.126330] [041/133] (679s left) kms_properties (plane-properties-atomic)
[397.231141] Starting subtest: plane-properties-atomic
[397.233243] Starting dynamic subtest: pipe-A-eDP-1
[397.787381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[397.797940] Starting dynamic subtest: pipe-B-eDP-1
[399.054507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.267s)
[399.064884] Starting dynamic subtest: pipe-C-eDP-1
[400.280389] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[400.291035] Starting dynamic subtest: pipe-D-eDP-1
[401.521029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[401.523416] Subtest plane-properties-atomic: SUCCESS (4.292s)
[402.308664] [042/133] (674s left) gem_ctx_exec (basic-invalid-context)
[402.364306] Starting subtest: basic-invalid-context
[402.366269] Subtest basic-invalid-context: SUCCESS (0.004s)
[402.500718] [043/133] (674s left) gem_exec_params (rel-constants-invalid)
[402.554409] Starting subtest: rel-constants-invalid
[402.556825] Subtest rel-constants-invalid: SUCCESS (0.000s)
[402.648424] [044/133] (674s left) syncobj_wait (reset-multiple-signaled)
[402.707106] Starting subtest: reset-multiple-signaled
[402.709309] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[402.800531] [045/133] (674s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[402.899083] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[402.903545] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[403.025867] [046/133] (674s left) gem_ctx_persistence (legacy-engines-mixed)
[403.078549] Starting subtest: legacy-engines-mixed
[403.080699] Starting dynamic subtest: render
[403.161008] Dynamic subtest render: SUCCESS (0.082s)
[403.175878] Starting dynamic subtest: bsd1
[403.222499] Dynamic subtest bsd1: SUCCESS (0.058s)
[403.236427] Starting dynamic subtest: bsd2
[403.283377] Dynamic subtest bsd2: SUCCESS (0.057s)
[403.297780] Starting dynamic subtest: blt
[403.342471] Dynamic subtest blt: SUCCESS (0.057s)
[403.356795] Starting dynamic subtest: vebox
[403.412225] Dynamic subtest vebox: SUCCESS (0.067s)
[403.414486] Subtest legacy-engines-mixed: SUCCESS (0.336s)
[403.518552] [047/133] (673s left) gem_pread (display)
[403.578323] Subtest display: SKIP (0.000s)
[403.640883] [048/133] (673s left) fbdev (unaligned-write)
[403.683437] Starting subtest: unaligned-write
[403.786920] Subtest unaligned-write: SUCCESS (0.101s)
[403.852067] [049/133] (673s left) syncobj_timeline (device-signal-unordered)
[403.906999] Starting subtest: device-signal-unordered
[403.909250] Subtest device-signal-unordered: SUCCESS (0.001s)
[404.049976] [050/133] (673s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[404.160090] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[411.059629] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.903s)
[411.198809] [051/133] (666s left) kms_flip (2x-flip-vs-expired-vblank)
[411.288367] Starting subtest: 2x-flip-vs-expired-vblank
[411.297599] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[411.376047] [052/133] (666s left) kms_psr (psr2-sprite-render)
[411.462308] Starting subtest: psr2-sprite-render
[411.464527] Starting dynamic subtest: eDP-1
[413.157664] Dynamic subtest eDP-1: SUCCESS (1.695s)
[413.159648] Subtest psr2-sprite-render: SUCCESS (1.696s)
[414.022489] [053/133] (663s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[414.117118] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[414.119450] Starting dynamic subtest: pipe-A-eDP-1
[420.011081] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.897s)
[420.022260] Starting dynamic subtest: pipe-B-eDP-1
[426.639966] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.629s)
[426.642221] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.529s)
[427.511733] [054/133] (650s left) drm_read (short-buffer-nonblock)
[427.662714] Starting subtest: short-buffer-nonblock
[427.665163] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[427.791471] [055/133] (649s left) gem_exec_schedule (pi-userfault)
[427.970714] Starting subtest: pi-userfault
[427.972645] Starting dynamic subtest: rcs0
[427.978291] Dynamic subtest rcs0: SUCCESS (0.011s)
[427.988799] Starting dynamic subtest: bcs0
[427.991010] Dynamic subtest bcs0: SUCCESS (0.007s)
[428.000913] Starting dynamic subtest: vcs0
[428.002740] Dynamic subtest vcs0: SUCCESS (0.008s)
[428.012857] Starting dynamic subtest: vcs1
[428.015031] Dynamic subtest vcs1: SUCCESS (0.007s)
[428.025245] Starting dynamic subtest: vecs0
[428.027377] Dynamic subtest vecs0: SUCCESS (0.009s)
[428.037181] Starting dynamic subtest: ccs0
[428.039315] Dynamic subtest ccs0: SUCCESS (0.008s)
[428.041477] Subtest pi-userfault: SUCCESS (0.056s)
[428.208427] [056/133] (649s left) i915_pm_rpm (sysfs-read)
[429.942561] Starting subtest: sysfs-read
[431.101626] Subtest sysfs-read: SUCCESS (1.155s)
[431.473224] [057/133] (646s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[431.563150] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[432.577233] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.013s)
[432.734271] [058/133] (645s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[432.835976] Starting subtest: y-tiled-64bpp-rotate-270
[432.840227] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[432.940888] [059/133] (644s left) kms_psr (fbc-psr-primary-blt)
[433.031019] Starting subtest: fbc-psr-primary-blt
[433.032895] Starting dynamic subtest: eDP-1
[433.036371] Dynamic subtest eDP-1: SKIP (0.000s)
[433.039710] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[433.104560] [060/133] (644s left) vgem_basic (dmabuf-export)
[433.159065] Starting subtest: dmabuf-export
[433.177944] Subtest dmabuf-export: SUCCESS (0.023s)
[433.274605] [061/133] (644s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[433.334979] Starting subtest: multi-wait-all-for-submit-available-signaled
[433.336881] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[433.430231] [062/133] (644s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[433.517835] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[433.530157] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[433.640975] [063/133] (644s left) syncobj_timeline (single-wait-all-available-submitted)
[433.702106] Starting subtest: single-wait-all-available-submitted
[433.704153] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[433.822820] [064/133] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[433.921090] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[433.924606] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[434.028676] [065/133] (644s left) kms_universal_plane (disable-primary-vs-flip)
[434.114032] Starting subtest: disable-primary-vs-flip
[434.115869] Starting dynamic subtest: pipe-A-eDP-1
[435.642689] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.526s)
[435.656025] Starting dynamic subtest: pipe-B-eDP-1
[437.821679] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.177s)
[437.834024] Starting dynamic subtest: pipe-C-eDP-1
[440.002343] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.177s)
[440.013129] Starting dynamic subtest: pipe-D-eDP-1
[442.173118] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[442.175495] Subtest disable-primary-vs-flip: SUCCESS (8.057s)
[442.990187] [066/133] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[443.086039] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[443.090089] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[443.195625] [067/133] (635s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[443.292974] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[443.304527] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[443.389709] [068/133] (634s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[443.488683] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[443.493082] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[443.561521] [069/133] (634s left) vgem_basic (bad-handle)
[443.603103] Starting subtest: bad-handle
[443.605421] Subtest bad-handle: SUCCESS (0.000s)
[443.663563] [070/133] (634s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[443.749691] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[443.751946] Starting dynamic subtest: pipe-A-eDP-1
[443.773410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.784363] Starting dynamic subtest: pipe-B-eDP-1
[443.804426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.814210] Starting dynamic subtest: pipe-C-eDP-1
[443.834519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[443.843807] Starting dynamic subtest: pipe-D-eDP-1
[443.864497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[443.868576] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[446.045148] [071/133] (632s left) api_intel_bb (intel-bb-blit-x)
[446.096807] Starting subtest: intel-bb-blit-x
[450.034693] Subtest intel-bb-blit-x: SUCCESS (3.937s)
[450.170048] [072/133] (628s left) kms_cursor_crc (cursor-sliding-32x10)
[450.357830] Starting subtest: cursor-sliding-32x10
[450.402951] Subtest cursor-sliding-32x10: SKIP (0.042s)
[450.664894] [073/133] (627s left) prime_self_import (export-vs-gem_close-race)
[450.702020] Starting subtest: export-vs-gem_close-race
[455.808419] Subtest export-vs-gem_close-race: SUCCESS (5.105s)
[455.886504] [074/133] (622s left) perf (non-sampling-read-error)
[455.983946] Starting subtest: non-sampling-read-error
[455.993307] Subtest non-sampling-read-error: SUCCESS (0.008s)
[456.040839] [075/133] (622s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[456.136866] Starting subtest: bad-rotation-90-y-tiled-ccs
[456.139106] Starting dynamic subtest: pipe-A-eDP-1
[456.161723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.173390] Starting dynamic subtest: pipe-B-eDP-1
[456.195169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.208234] Starting dynamic subtest: pipe-C-eDP-1
[456.230104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.240178] Starting dynamic subtest: pipe-D-eDP-1
[456.263154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.267611] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[458.385945] [076/133] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[458.484304] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[465.407727] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.926s)
[465.546734] [077/133] (613s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[465.607622] Starting subtest: invalid-bsd2-flag-on-blt
[465.610054] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[465.719717] [078/133] (613s left) kms_cursor_crc (cursor-onscreen-128x42)
[465.937978] Starting subtest: cursor-onscreen-128x42
[465.991620] Subtest cursor-onscreen-128x42: SKIP (0.049s)
[466.211492] [079/133] (612s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[466.328877] Starting subtest: modeset-atomic-cursor-hotspot
[466.333524] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[466.470388] [080/133] (612s left) gem_render_copy (linear)
[466.525022] Starting subtest: linear
[466.527038] Starting dynamic subtest: smem
[466.565474] Dynamic subtest smem: SUCCESS (0.040s)
[466.567531] Subtest linear: SUCCESS (0.041s)
[466.786773] [081/133] (612s left) prime_self_import (basic-with_one_bo_two_files)
[466.821691] Starting subtest: basic-with_one_bo_two_files
[466.844484] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[466.943941] [082/133] (611s left) kms_chamelium_edid (hdmi-edid-read)
[467.336406] Subtest hdmi-edid-read: SKIP (0.000s)
[468.137662] [083/133] (610s left) gem_exec_params (readonly)
[468.191287] Starting subtest: readonly
[468.193696] Subtest readonly: SUCCESS (0.002s)
[468.301039] [084/133] (610s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[468.385967] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[468.388219] Starting dynamic subtest: pipe-A-default-mode
[469.523610] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[469.527550] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.137s)
[469.670435] [085/133] (609s left) gem_mmap_gtt (cpuset-big-copy)
[469.732041] Subtest cpuset-big-copy: SKIP (0.000s)
[469.794449] [086/133] (609s left) sriov_basic (enable-vfs-autoprobe-on)
[469.847923] Starting subtest: enable-vfs-autoprobe-on
[469.850359] Starting dynamic subtest: numvfs-1
[469.933008] Dynamic subtest numvfs-1: FAIL (0.036s)
[469.943317] Starting dynamic subtest: numvfs-2
[470.014788] Dynamic subtest numvfs-2: FAIL (0.004s)
[470.026232] Starting dynamic subtest: numvfs-3
[470.098709] Dynamic subtest numvfs-3: FAIL (0.004s)
[470.109958] Starting dynamic subtest: numvfs-4
[470.180600] Dynamic subtest numvfs-4: FAIL (0.004s)
[470.190500] Starting dynamic subtest: numvfs-5
[470.262944] Dynamic subtest numvfs-5: FAIL (0.004s)
[470.274660] Starting dynamic subtest: numvfs-6
[470.346680] Dynamic subtest numvfs-6: FAIL (0.004s)
[470.358336] Starting dynamic subtest: numvfs-7
[470.431582] Dynamic subtest numvfs-7: FAIL (0.004s)
[470.442872] Starting dynamic subtest: numvfs-random
[470.501883] Dynamic subtest numvfs-random: FAIL (0.004s)
[470.512882] Starting dynamic subtest: numvfs-all
[470.570809] Dynamic subtest numvfs-all: FAIL (0.005s)
[470.572570] Subtest enable-vfs-autoprobe-on: FAIL (0.074s)
[470.609101] [087/133] (608s left) kms_plane_scaling (planes-downscale-factor-0-75)
[470.702101] Starting subtest: planes-downscale-factor-0-75
[470.704010] Starting dynamic subtest: pipe-A
[470.725581] Dynamic subtest pipe-A: SKIP (0.019s)
[470.735747] Starting dynamic subtest: pipe-B
[470.757159] Dynamic subtest pipe-B: SKIP (0.032s)
[470.767204] Starting dynamic subtest: pipe-C
[470.788970] Dynamic subtest pipe-C: SKIP (0.032s)
[470.798579] Starting dynamic subtest: pipe-D
[470.822065] Dynamic subtest pipe-D: SKIP (0.032s)
[470.825104] Subtest planes-downscale-factor-0-75: SKIP (0.118s)
[470.909588] [088/133] (608s left) kms_plane (plane-panning-top-left)
[470.992370] Starting subtest: plane-panning-top-left
[470.994224] Starting dynamic subtest: pipe-A
[472.658405] Dynamic subtest pipe-A: SUCCESS (1.665s)
[472.669957] Starting dynamic subtest: pipe-B
[475.051432] Dynamic subtest pipe-B: SUCCESS (2.392s)
[475.053750] Subtest plane-panning-top-left: SUCCESS (4.060s)
[475.935290] [089/133] (603s left) kms_plane_cursor (overlay)
[476.023118] Starting subtest: overlay
[476.027604] Starting dynamic subtest: pipe-A-eDP-1-size-64
[478.495474] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.473s)
[478.556794] Starting dynamic subtest: pipe-A-eDP-1-size-128
[481.074354] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[481.135774] Starting dynamic subtest: pipe-A-eDP-1-size-256
[483.608543] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.483s)
[483.959788] Starting dynamic subtest: pipe-B-eDP-1-size-64
[487.193433] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.248s)
[487.259270] Starting dynamic subtest: pipe-B-eDP-1-size-128
[489.773866] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.529s)
[489.832639] Starting dynamic subtest: pipe-B-eDP-1-size-256
[492.350213] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[492.700240] Starting dynamic subtest: pipe-C-eDP-1-size-64
[495.542747] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.853s)
[495.581530] Starting dynamic subtest: pipe-C-eDP-1-size-128
[497.774828] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[497.819545] Starting dynamic subtest: pipe-C-eDP-1-size-256
[499.986601] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[500.316352] Starting dynamic subtest: pipe-D-eDP-1-size-64
[503.164998] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.861s)
[503.203849] Starting dynamic subtest: pipe-D-eDP-1-size-128
[505.531230] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.336s)
[505.572444] Starting dynamic subtest: pipe-D-eDP-1-size-256
[507.865207] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.303s)
[508.188974] Subtest overlay: SUCCESS (32.164s)
[509.071590] [090/133] (570s left) perf_pmu (busy)
[509.118215] Starting subtest: busy
[509.120542] Starting dynamic subtest: rcs0
[509.698059] Dynamic subtest rcs0: SUCCESS (0.582s)
[509.718387] Starting dynamic subtest: bcs0
[510.273793] Dynamic subtest bcs0: SUCCESS (0.573s)
[510.284934] Starting dynamic subtest: vcs0
[511.820869] Dynamic subtest vcs0: SUCCESS (1.543s)
[511.833679] Starting dynamic subtest: vcs1
[513.868922] Dynamic subtest vcs1: SUCCESS (2.045s)
[513.882165] Starting dynamic subtest: vecs0
[515.852805] Dynamic subtest vecs0: SUCCESS (1.981s)
[515.866127] Starting dynamic subtest: ccs0
[516.423963] Dynamic subtest ccs0: SUCCESS (0.570s)
[516.426844] Subtest busy: SUCCESS (7.309s)
[516.523652] [091/133] (562s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[516.628160] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[516.640034] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[516.739374] [092/133] (562s left) kms_frontbuffer_tracking (fbc-stridechange)
[516.844569] Starting subtest: fbc-stridechange
[520.153823] Subtest fbc-stridechange: SUCCESS (3.314s)
[521.281599] [093/133] (558s left) gem_pread (bench)
[521.347995] Subtest bench: SKIP (0.000s)
[521.421812] [094/133] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[521.526633] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[528.397460] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.874s)
[528.512474] [095/133] (550s left) syncobj_basic (bad-fd-to-handle)
[528.572718] Starting subtest: bad-fd-to-handle
[528.574559] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[528.683882] [096/133] (550s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[528.735936] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[528.738178] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[528.827984] [097/133] (550s left) perf (mi-rpc)
[528.927343] Starting subtest: mi-rpc
[528.931736] Subtest mi-rpc: SKIP (0.000s)
[528.973617] [098/133] (550s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[529.066998] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[529.071038] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[529.166022] [099/133] (550s left) kms_vblank (ts-continuation-modeset-rpm)
[529.264949] Starting subtest: ts-continuation-modeset-rpm
[529.267007] Starting dynamic subtest: pipe-A-eDP-1
[531.770505] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.507s)
[531.786629] Starting dynamic subtest: pipe-D-eDP-1
[534.029679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[534.032130] Subtest ts-continuation-modeset-rpm: SUCCESS (4.768s)
[534.846290] [100/133] (544s left) perf (non-system-wide-paranoid)
[534.958939] Starting subtest: non-system-wide-paranoid
[534.985527] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[535.030132] [101/133] (544s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[535.123471] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[535.125752] Starting dynamic subtest: pipe-A-eDP-1
[535.150843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.162250] Starting dynamic subtest: pipe-B-eDP-1
[535.185522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.195016] Starting dynamic subtest: pipe-C-eDP-1
[535.218498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.228096] Starting dynamic subtest: pipe-D-eDP-1
[535.252461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.256877] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[537.404899] [102/133] (542s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[537.504602] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[546.977370] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.475s)
[547.107154] [103/133] (532s left) gem_softpin (allocator-basic)
[547.172511] Starting subtest: allocator-basic
[547.241755] Subtest allocator-basic: SUCCESS (0.069s)
[547.356977] [104/133] (532s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[547.448539] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[554.136761] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.693s)
[554.249845] [105/133] (525s left) syncobj_basic (create-signaled)
[554.308167] Starting subtest: create-signaled
[554.310408] Subtest create-signaled: SUCCESS (0.000s)
[554.401466] [106/133] (525s left) gem_mmap (basic-small-bo)
[554.463498] Subtest basic-small-bo: SKIP (0.000s)
[554.520705] [107/133] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[554.642090] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[561.226836] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.589s)
[561.371193] [108/133] (518s left) kms_force_connector_basic (force-load-detect)
[561.449731] Starting subtest: force-load-detect
[561.454460] Subtest force-load-detect: SKIP (0.000s)
[561.577960] [109/133] (518s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[561.679684] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[561.682019] Starting dynamic subtest: pipe-A-eDP-1
[561.753613] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[561.768291] Starting dynamic subtest: pipe-B-eDP-1
[562.935981] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s)
[562.940707] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.259s)
[564.127294] [110/133] (516s left) gem_mmap_wc (coherency)
[564.191648] Subtest coherency: SKIP (0.000s)
[564.253626] [111/133] (515s left) kms_concurrent (multi-plane-atomic-lowres)
[564.349969] Starting subtest: multi-plane-atomic-lowres
[564.352172] Starting dynamic subtest: pipe-A-eDP-1
[564.830492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[564.840868] Starting dynamic subtest: pipe-B-eDP-1
[566.050266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[566.061537] Starting dynamic subtest: pipe-C-eDP-1
[567.289960] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[567.300849] Starting dynamic subtest: pipe-D-eDP-1
[568.508617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[568.510924] Subtest multi-plane-atomic-lowres: SUCCESS (4.158s)
[569.341538] [112/133] (510s left) gem_gtt_cpu_tlb
[569.471863] [113/133] (510s left) i915_module_load (reload-no-display)
[569.511251] Starting subtest: reload-no-display
[576.698825] Subtest reload-no-display: SUCCESS (7.192s)
[576.730584] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[576.731316] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[576.734482] [114/133] (503s left) i915_drm_fdinfo (idle)
[578.277582] Starting subtest: idle
[578.280008] Starting dynamic subtest: rcs0
[578.842548] Dynamic subtest rcs0: SUCCESS (0.565s)
[578.853243] Starting dynamic subtest: bcs0
[579.374948] Dynamic subtest bcs0: SUCCESS (0.530s)
[579.386206] Starting dynamic subtest: vcs0
[579.882099] Dynamic subtest vcs0: SUCCESS (0.503s)
[579.893776] Starting dynamic subtest: vcs1
[580.387894] Dynamic subtest vcs1: SUCCESS (0.503s)
[580.399544] Starting dynamic subtest: vecs0
[580.893325] Dynamic subtest vecs0: SUCCESS (0.503s)
[580.905086] Starting dynamic subtest: ccs0
[581.399593] Dynamic subtest ccs0: SUCCESS (0.503s)
[581.402563] Subtest idle: SUCCESS (3.122s)
[581.450567] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[581.451896] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[581.455700] [115/133] (498s left) dumb_buffer (create-clear)
[581.519505] Starting subtest: create-clear
[616.030976] Subtest create-clear: SUCCESS (34.513s)
[616.129652] [116/133] (464s left) kms_flip (flip-vs-fences-interruptible)
[616.227000] Starting subtest: flip-vs-fences-interruptible
[616.231428] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[616.326526] [117/133] (464s left) kms_big_fb (linear-8bpp-rotate-270)
[616.433985] Starting subtest: linear-8bpp-rotate-270
[616.475386] Subtest linear-8bpp-rotate-270: SKIP (0.041s)
[616.585779] [118/133] (463s left) gen9_exec_parse (bb-oversize)
[616.643014] Subtest bb-oversize: SKIP (0.000s)
[616.719936] [119/133] (463s left) gem_exec_schedule (smoketest)
[616.902117] Starting subtest: smoketest
[616.904361] Starting dynamic subtest: rcs0
[622.482532] Dynamic subtest rcs0: SUCCESS (5.479s)
[622.493079] Starting dynamic subtest: bcs0
[627.969712] Dynamic subtest bcs0: SUCCESS (5.491s)
[627.980957] Starting dynamic subtest: vcs0
[633.468073] Dynamic subtest vcs0: SUCCESS (5.495s)
[633.482663] Starting dynamic subtest: vcs1
[638.976040] Dynamic subtest vcs1: SUCCESS (5.506s)
[638.986966] Starting dynamic subtest: vecs0
[644.482140] Dynamic subtest vecs0: SUCCESS (5.508s)
[644.492392] Starting dynamic subtest: ccs0
[649.931847] Dynamic subtest ccs0: SUCCESS (5.497s)
[649.933887] Subtest smoketest: SUCCESS (32.985s)
[650.105361] [120/133] (430s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[650.298041] Starting subtest: cursor-rapid-movement-64x21
[650.350924] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[650.574755] [121/133] (430s left) gem_mmap (basic)
[650.643425] Subtest basic: SKIP (0.000s)
[650.705971] [122/133] (429s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[650.799080] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[651.423251] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[651.590217] [123/133] (429s left) gem_exec_balancer (hang)
[651.851894] Starting subtest: hang
[653.776427] Subtest hang: SUCCESS (1.925s)
[653.902639] [124/133] (426s left) gem_ctx_exec (basic-norecovery)
[653.958025] Starting subtest: basic-norecovery
[654.316327] Subtest basic-norecovery: SUCCESS (0.358s)
[654.446203] [125/133] (426s left) kms_hdr (static-toggle)
[654.547099] Starting subtest: static-toggle
[654.553619] Subtest static-toggle: SKIP (0.000s)
[654.617593] [126/133] (426s left) kms_properties (invalid-properties-legacy)
[654.714786] Starting subtest: invalid-properties-legacy
[654.823530] Subtest invalid-properties-legacy: SUCCESS (0.109s)
[654.897239] [127/133] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[655.013811] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[659.152627] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.142s)
[660.347841] [128/133] (420s left) gem_workarounds (suspend-resume-context)
[660.417779] Starting subtest: suspend-resume-context
[676.945584] Subtest suspend-resume-context: SUCCESS (1.576s)
[683.108012] [129/133] (403s left) gem_exec_fence (keep-in-fence)
[683.301467] Starting subtest: keep-in-fence
[683.304023] Starting dynamic subtest: rcs0
[683.362082] Dynamic subtest rcs0: SUCCESS (0.060s)
[683.374598] Starting dynamic subtest: bcs0
[683.419116] Dynamic subtest bcs0: SUCCESS (0.055s)
[683.431232] Starting dynamic subtest: vcs0
[684.790118] Dynamic subtest vcs0: SUCCESS (1.381s)
[684.802332] Starting dynamic subtest: vcs1
[686.828222] Dynamic subtest vcs1: SUCCESS (2.014s)
[686.840973] Starting dynamic subtest: vecs0
[688.876355] Dynamic subtest vecs0: SUCCESS (2.070s)
[688.888507] Starting dynamic subtest: ccs0
[689.062287] Dynamic subtest ccs0: SUCCESS (0.238s)
[689.064931] Subtest keep-in-fence: SUCCESS (5.830s)
[690.835725] [130/133] (396s left) gem_mmap_gtt (hang-user)
[690.901318] Subtest hang-user: SKIP (0.000s)
[690.962832] [131/133] (396s left) kms_atomic_transition (plane-all-transition-fencing)
[691.058505] Starting subtest: plane-all-transition-fencing
[691.060821] Starting dynamic subtest: pipe-A-eDP-1
[693.536624] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[693.856704] Starting dynamic subtest: pipe-B-eDP-1
[697.113699] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s)
[697.423233] Subtest plane-all-transition-fencing: SUCCESS (6.398s)
[698.251679] [132/133] (388s left) gem_pxp (protected-raw-src-copy-not-readible)
[698.368703] Starting subtest: protected-raw-src-copy-not-readible
[698.426220] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[698.539219] [133/133] (388s left) syncobj_wait (multi-wait-for-submit-submitted)
[698.589817] Starting subtest: multi-wait-for-submit-submitted
[698.691622] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[698.770808] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: i915_power
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: gem_ctx_sseu
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_plane_lowres
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_pm_lpsp
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: gem_ctx_exec
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: gem_pread
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_universal_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: prime_self_import
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: sriov_basic
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pread
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: gem_mmap
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_force_connector_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_concurrent
results: parsing output: 111/ for test: gem_gtt_cpu_tlb
results: parsing output: 112/ for test: i915_module_load
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gen9_exec_parse
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_ctx_exec
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_atomic_transition
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: syncobj_wait
Done.