[59.495041] Initializing watchdogs
[59.495130]   /dev/watchdog0
[59.510257] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.514718] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.517171] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.520399] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[59.636069] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[59.638306] Starting dynamic subtest: pipe-A-eDP-1
[60.496674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s)
[60.504048] Starting dynamic subtest: pipe-B-eDP-1
[62.142176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.645s)
[62.151911] Starting dynamic subtest: pipe-C-eDP-1
[63.625704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[63.635064] Starting dynamic subtest: pipe-D-eDP-1
[65.153474] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[65.155768] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.522s)
[66.349459] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[66.440068] Starting subtest: fbc-pr-sprite-plane-move
[66.444337] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[66.508662] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[66.667205] Starting subtest: in-flight-contexts-immediate
[76.318063] Subtest in-flight-contexts-immediate: SUCCESS (9.660s)
[76.475810] [004/133] (943s left) kms_async_flips (async-flip-suspend-resume)
[76.567119] Starting subtest: async-flip-suspend-resume
[76.949082] Starting dynamic subtest: pipe-A-eDP-1
[94.788654] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.978s)
[95.181685] Starting dynamic subtest: pipe-B-eDP-1
[112.804188] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.903s)
[113.158087] Starting dynamic subtest: pipe-C-eDP-1
[130.807680] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s)
[131.170334] Starting dynamic subtest: pipe-D-eDP-1
[148.813369] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.905s)
[148.815675] Subtest async-flip-suspend-resume: SUCCESS (13.195s)
[149.975071] [005/133] (870s left) kms_flip (modeset-vs-vblank-race)
[150.076907] Starting subtest: modeset-vs-vblank-race
[150.079267] Starting dynamic subtest: A-eDP1
[154.780396] Dynamic subtest A-eDP1: SUCCESS (4.739s)
[154.793804] Starting dynamic subtest: B-eDP1
[159.499905] Dynamic subtest B-eDP1: SUCCESS (4.741s)
[159.511785] Starting dynamic subtest: C-eDP1
[164.078162] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[164.087646] Starting dynamic subtest: D-eDP1
[168.692499] Dynamic subtest D-eDP1: SUCCESS (4.621s)
[168.694925] Subtest modeset-vs-vblank-race: SUCCESS (18.697s)
[169.850648] [006/133] (850s left) kms_psr (pr-cursor-plane-move)
[169.955837] Starting subtest: pr-cursor-plane-move
[169.960053] Subtest pr-cursor-plane-move: SKIP (0.000s)
[170.052282] [007/133] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[170.145197] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[177.423665] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.289s)
[177.560116] [008/133] (842s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[177.670180] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[177.674666] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[177.776560] [009/133] (842s left) kms_atomic_transition (modeset-transition-nonblocking)
[177.879498] Starting subtest: modeset-transition-nonblocking
[177.881841] Starting dynamic subtest: 1x-outputs
[188.953560] Dynamic subtest 1x-outputs: SUCCESS (11.071s)
[188.956151] Subtest modeset-transition-nonblocking: SUCCESS (11.072s)
[189.815860] [010/133] (830s left) i915_power (sanity)
[189.877699] Starting subtest: sanity
[189.882309] Subtest sanity: SKIP (0.001s)
[189.969557] [011/133] (830s left) gem_exec_whisper (basic-queues-all)
[190.035786] Starting subtest: basic-queues-all
[200.794832] Subtest basic-queues-all: SUCCESS (10.758s)
[200.983142] [012/133] (819s left) drm_read (empty-nonblock)
[201.130575] Starting subtest: empty-nonblock
[201.132972] Subtest empty-nonblock: SUCCESS (0.000s)
[201.245771] [013/133] (819s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[201.333708] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[201.337795] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[201.403427] [014/133] (819s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[201.497504] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[201.501654] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[201.568476] [015/133] (819s left) kms_psr (psr-sprite-plane-move)
[201.655708] Starting subtest: psr-sprite-plane-move
[201.657998] Starting dynamic subtest: eDP-1
[203.444316] Dynamic subtest eDP-1: SUCCESS (1.788s)
[203.446323] Subtest psr-sprite-plane-move: SUCCESS (1.788s)
[204.280366] [016/133] (816s left) gem_exec_create (legacy)
[204.342912] Starting subtest: legacy
[204.345329] Starting dynamic subtest: smem
[206.435651] Dynamic subtest smem: SUCCESS (2.092s)
[206.438587] Subtest legacy: SUCCESS (2.094s)
[206.632762] [017/133] (814s left) perf (blocking)
[206.749518] Starting subtest: blocking
[206.751759] Starting dynamic subtest: 0-rcs0
[216.762403] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[216.772740] Starting dynamic subtest: 1-vcs0
[226.783038] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[226.785709] Subtest blocking: SUCCESS (20.038s)
[226.832415] [018/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[226.931949] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[226.935996] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[227.051783] [019/133] (793s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[227.140941] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[227.142854] Starting dynamic subtest: pipe-A-eDP-1
[227.883222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[227.893700] Starting dynamic subtest: pipe-B-eDP-1
[229.693159] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.810s)
[229.705056] Starting dynamic subtest: pipe-C-eDP-1
[231.533055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.839s)
[231.542449] Starting dynamic subtest: pipe-D-eDP-1
[233.361879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.827s)
[233.364088] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.216s)
[234.496412] [020/133] (786s left) kms_lease (lease-invalid-crtc)
[234.600794] Starting subtest: lease-invalid-crtc
[234.603062] Starting dynamic subtest: pipe-A-eDP-1
[234.604982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[234.615071] Starting dynamic subtest: pipe-B-eDP-1
[234.617399] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[234.626799] Starting dynamic subtest: pipe-C-eDP-1
[234.628673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[234.638510] Starting dynamic subtest: pipe-D-eDP-1
[234.640465] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[234.642443] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[234.677804] [021/133] (786s left) kms_content_protection (atomic-hdcp14)
[234.838271] Starting subtest: atomic-hdcp14
[234.842888] Subtest atomic-hdcp14: SKIP (0.000s)
[234.952966] [022/133] (785s left) gem_ctx_sseu (invalid-args)
[235.026969] Subtest invalid-args: SKIP (0.000s)
[235.110522] [023/133] (785s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[235.158599] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[235.265174] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[235.352622] [024/133] (785s left) gem_lmem_swapping (parallel-random-engines)
[235.406101] Subtest parallel-random-engines: SKIP (0.000s)
[235.454261] [025/133] (785s left) gem_softpin (evict-prime)
[235.528346] Starting subtest: evict-prime
[235.530456] Starting dynamic subtest: rcs0
[236.681344] Dynamic subtest rcs0: SUCCESS (1.155s)
[236.698455] Starting dynamic subtest: bcs0
[237.807711] Dynamic subtest bcs0: SUCCESS (1.126s)
[237.818571] Starting dynamic subtest: vcs0
[239.435729] Dynamic subtest vcs0: SUCCESS (1.625s)
[239.450090] Starting dynamic subtest: vcs1
[241.425244] Dynamic subtest vcs1: SUCCESS (1.989s)
[241.437058] Starting dynamic subtest: vecs0
[243.403795] Dynamic subtest vecs0: SUCCESS (1.977s)
[243.418922] Starting dynamic subtest: ccs0
[244.534569] Dynamic subtest ccs0: SUCCESS (1.131s)
[244.546311] Starting dynamic subtest: all
[246.404525] Dynamic subtest all: SUCCESS (1.865s)
[246.407264] Subtest evict-prime: SUCCESS (10.879s)
[246.484089] [026/133] (774s left) kms_plane_lowres (tiling-none)
[246.592559] Starting subtest: tiling-none
[246.594953] Starting dynamic subtest: pipe-A-eDP-1
[246.599659] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.887420] Starting dynamic subtest: pipe-B-eDP-1
[246.892190] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.901597] Starting dynamic subtest: pipe-C-eDP-1
[246.906350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.915655] Starting dynamic subtest: pipe-D-eDP-1
[246.920070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.924565] Subtest tiling-none: SKIP (0.293s)
[247.718043] [027/133] (773s left) kms_draw_crc (draw-method-mmap-cpu)
[247.825491] Starting subtest: draw-method-mmap-cpu
[247.827334] Starting dynamic subtest: xrgb8888-untiled
[248.089894] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[248.099589] Starting dynamic subtest: rgb565-untiled
[248.312462] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[248.322695] Starting dynamic subtest: xrgb2101010-untiled
[248.534853] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[248.544419] Starting dynamic subtest: xbgr16161616f-untiled
[248.756576] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[248.765654] Starting dynamic subtest: xrgb8888-xtiled
[248.900950] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[248.910110] Starting dynamic subtest: rgb565-xtiled
[249.034760] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[249.046648] Starting dynamic subtest: xrgb2101010-xtiled
[249.156762] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[249.166279] Starting dynamic subtest: xbgr16161616f-xtiled
[249.290037] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[249.299413] Starting dynamic subtest: xrgb8888-4tiled
[249.434573] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[249.443751] Starting dynamic subtest: rgb565-4tiled
[249.567602] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[249.580538] Starting dynamic subtest: xrgb2101010-4tiled
[249.712391] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[249.721977] Starting dynamic subtest: xbgr16161616f-4tiled
[249.856846] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[249.858676] Subtest draw-method-mmap-cpu: SUCCESS (2.034s)
[249.948568] [028/133] (771s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[250.002827] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[250.061782] [029/133] (771s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[250.167768] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[250.169736] Starting dynamic subtest: pipe-A-eDP-1
[250.279065] Dynamic subtest pipe-A-eDP-1: SKIP (0.113s)
[250.288564] Starting dynamic subtest: pipe-B-eDP-1
[251.408896] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[251.413566] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.243s)
[252.610311] [030/133] (768s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[252.718014] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[252.722067] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[252.809163] [031/133] (768s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[252.918800] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[252.923248] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[253.012945] [032/133] (768s left) kms_rotation_crc (primary-rotation-180)
[253.109803] Starting subtest: primary-rotation-180
[260.099201] Subtest primary-rotation-180: SUCCESS (6.990s)
[261.256979] [033/133] (760s left) kms_pm_rpm (universal-planes-dpms)
[262.789035] Starting subtest: universal-planes-dpms
[262.791162] Starting dynamic subtest: plane-35
[271.100813] Dynamic subtest plane-35: SUCCESS (8.313s)
[271.113446] Starting dynamic subtest: plane-65
[279.829492] Dynamic subtest plane-65: SUCCESS (8.726s)
[279.841478] Starting dynamic subtest: plane-95
[288.244123] Dynamic subtest plane-95: SUCCESS (8.412s)
[288.257362] Starting dynamic subtest: plane-125
[296.681987] Dynamic subtest plane-125: SUCCESS (8.435s)
[296.694799] Starting dynamic subtest: plane-135
[305.097281] Dynamic subtest plane-135: SUCCESS (8.415s)
[305.109623] Starting dynamic subtest: plane-145
[313.437469] Dynamic subtest plane-145: SUCCESS (8.339s)
[313.440457] Subtest universal-planes-dpms: SUCCESS (50.657s)
[313.848929] [034/133] (707s left) kms_pm_lpsp (kms-lpsp)
[314.945684] Starting subtest: kms-lpsp
[314.948284] Starting dynamic subtest: pipe-A-eDP-1
[315.093208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[315.399442] Subtest kms-lpsp: SUCCESS (0.453s)
[316.261448] [035/133] (705s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[316.647152] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[317.479098] [036/133] (703s left) api_intel_allocator (two-level-inception-interruptible)
[317.528730] Starting subtest: two-level-inception-interruptible
[322.934944] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[323.076577] [037/133] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[323.178461] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[323.182844] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[323.273670] [038/133] (698s left) gem_userptr_blits (huge-split)
[323.357344] Starting subtest: huge-split
[323.365639] Subtest huge-split: SUCCESS (0.008s)
[323.517039] [039/133] (698s left) gem_eio (in-flight-10ms)
[323.753663] Starting subtest: in-flight-10ms
[332.356151] Subtest in-flight-10ms: SUCCESS (8.604s)
[332.501970] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[332.506621] [040/133] (689s left) perf_pmu (pmu-read)
[332.547600] Starting subtest: pmu-read
[332.549896] Subtest pmu-read: SUCCESS (0.003s)
[332.658834] [041/133] (688s left) kms_properties (plane-properties-atomic)
[332.750564] Starting subtest: plane-properties-atomic
[332.752507] Starting dynamic subtest: pipe-A-eDP-1
[333.308435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[333.319227] Starting dynamic subtest: pipe-B-eDP-1
[334.569036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[334.582031] Starting dynamic subtest: pipe-C-eDP-1
[335.801779] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[335.812756] Starting dynamic subtest: pipe-D-eDP-1
[337.036979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[337.039533] Subtest plane-properties-atomic: SUCCESS (4.289s)
[337.845826] [042/133] (683s left) gem_ctx_exec (basic-invalid-context)
[337.905216] Starting subtest: basic-invalid-context
[337.910217] Subtest basic-invalid-context: SUCCESS (0.007s)
[338.049742] [043/133] (683s left) gem_exec_params (rel-constants-invalid)
[338.107361] Starting subtest: rel-constants-invalid
[338.109621] Subtest rel-constants-invalid: SUCCESS (0.000s)
[338.209411] [044/133] (683s left) syncobj_wait (reset-multiple-signaled)
[338.261790] Starting subtest: reset-multiple-signaled
[338.264063] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[338.346951] [045/133] (683s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[338.448284] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[338.452973] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[338.560026] [046/133] (683s left) gem_ctx_persistence (legacy-engines-mixed)
[338.617576] Starting subtest: legacy-engines-mixed
[338.620036] Starting dynamic subtest: render
[338.711441] Dynamic subtest render: SUCCESS (0.093s)
[338.725385] Starting dynamic subtest: bsd1
[338.775462] Dynamic subtest bsd1: SUCCESS (0.061s)
[338.787375] Starting dynamic subtest: bsd2
[338.839031] Dynamic subtest bsd2: SUCCESS (0.062s)
[338.852178] Starting dynamic subtest: blt
[338.898204] Dynamic subtest blt: SUCCESS (0.055s)
[338.910441] Starting dynamic subtest: vebox
[338.950732] Dynamic subtest vebox: SUCCESS (0.050s)
[338.952893] Subtest legacy-engines-mixed: SUCCESS (0.335s)
[339.031966] [047/133] (682s left) gem_pread (display)
[339.090673] Subtest display: SKIP (0.000s)
[339.150853] [048/133] (682s left) fbdev (unaligned-write)
[339.194893] Starting subtest: unaligned-write
[339.294607] Subtest unaligned-write: SUCCESS (0.101s)
[339.357361] [049/133] (682s left) syncobj_timeline (device-signal-unordered)
[339.411760] Starting subtest: device-signal-unordered
[339.414028] Subtest device-signal-unordered: SUCCESS (0.001s)
[339.521397] [050/133] (682s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[339.612501] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[346.553545] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.946s)
[346.707282] [051/133] (675s left) kms_flip (2x-flip-vs-expired-vblank)
[346.800766] Starting subtest: 2x-flip-vs-expired-vblank
[346.808830] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[346.889477] [052/133] (675s left) kms_psr (psr2-sprite-render)
[346.985144] Starting subtest: psr2-sprite-render
[346.987613] Starting dynamic subtest: eDP-1
[348.753683] Dynamic subtest eDP-1: SUCCESS (1.768s)
[348.756323] Subtest psr2-sprite-render: SUCCESS (1.769s)
[349.610816] [053/133] (672s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[349.709470] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[349.711993] Starting dynamic subtest: pipe-A-eDP-1
[355.580780] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.877s)
[355.593812] Starting dynamic subtest: pipe-B-eDP-1
[362.263374] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.684s)
[362.265753] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.565s)
[363.133417] [054/133] (659s left) drm_read (short-buffer-nonblock)
[363.279744] Starting subtest: short-buffer-nonblock
[363.281682] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[363.409079] [055/133] (658s left) gem_exec_schedule (pi-userfault)
[363.594920] Starting subtest: pi-userfault
[363.597151] Starting dynamic subtest: rcs0
[363.602545] Dynamic subtest rcs0: SUCCESS (0.011s)
[363.612444] Starting dynamic subtest: bcs0
[363.614737] Dynamic subtest bcs0: SUCCESS (0.009s)
[363.625213] Starting dynamic subtest: vcs0
[363.627420] Dynamic subtest vcs0: SUCCESS (0.009s)
[363.638162] Starting dynamic subtest: vcs1
[363.640716] Dynamic subtest vcs1: SUCCESS (0.007s)
[363.650988] Starting dynamic subtest: vecs0
[363.652934] Dynamic subtest vecs0: SUCCESS (0.008s)
[363.662237] Starting dynamic subtest: ccs0
[363.664174] Dynamic subtest ccs0: SUCCESS (0.008s)
[363.666098] Subtest pi-userfault: SUCCESS (0.057s)
[363.832839] [056/133] (658s left) i915_pm_rpm (sysfs-read)
[365.568344] Starting subtest: sysfs-read
[366.717510] Subtest sysfs-read: SUCCESS (1.145s)
[367.100761] [057/133] (655s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[367.193558] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[368.316778] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.124s)
[368.430752] [058/133] (653s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[368.539344] Starting subtest: y-tiled-64bpp-rotate-270
[368.542942] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[368.630563] [059/133] (653s left) kms_psr (fbc-psr-primary-blt)
[368.725037] Starting subtest: fbc-psr-primary-blt
[368.726798] Starting dynamic subtest: eDP-1
[368.730125] Dynamic subtest eDP-1: SKIP (0.000s)
[368.733379] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[368.799824] [060/133] (653s left) vgem_basic (dmabuf-export)
[368.841937] Starting subtest: dmabuf-export
[368.865818] Subtest dmabuf-export: SUCCESS (0.027s)
[368.954060] [061/133] (653s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[369.002763] Starting subtest: multi-wait-all-for-submit-available-signaled
[369.004671] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[369.094809] [062/133] (653s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[369.191063] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[369.203461] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[369.293135] [063/133] (653s left) syncobj_timeline (single-wait-all-available-submitted)
[369.351031] Starting subtest: single-wait-all-available-submitted
[369.353009] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[369.464234] [064/133] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[369.564569] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[369.568016] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[369.659408] [065/133] (653s left) kms_universal_plane (disable-primary-vs-flip)
[369.769287] Starting subtest: disable-primary-vs-flip
[369.771353] Starting dynamic subtest: pipe-A-eDP-1
[371.296286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.526s)
[371.307332] Starting dynamic subtest: pipe-B-eDP-1
[373.564123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[373.575047] Starting dynamic subtest: pipe-C-eDP-1
[375.801130] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s)
[375.812509] Starting dynamic subtest: pipe-D-eDP-1
[377.990805] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.186s)
[377.993127] Subtest disable-primary-vs-flip: SUCCESS (8.220s)
[378.876100] [066/133] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[378.986282] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[378.990351] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[379.086968] [067/133] (643s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[379.181028] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[379.192717] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[379.274705] [068/133] (643s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[379.363826] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[379.367823] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[379.436757] [069/133] (643s left) vgem_basic (bad-handle)
[379.479740] Starting subtest: bad-handle
[379.481740] Subtest bad-handle: SUCCESS (0.000s)
[379.535531] [070/133] (643s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[379.630959] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[379.633292] Starting dynamic subtest: pipe-A-eDP-1
[379.655923] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.668038] Starting dynamic subtest: pipe-B-eDP-1
[379.689561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.699309] Starting dynamic subtest: pipe-C-eDP-1
[379.720653] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.730177] Starting dynamic subtest: pipe-D-eDP-1
[379.752910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.757022] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[381.936445] [071/133] (640s left) api_intel_bb (intel-bb-blit-x)
[381.995115] Starting subtest: intel-bb-blit-x
[385.824412] Subtest intel-bb-blit-x: SUCCESS (3.828s)
[385.961791] [072/133] (637s left) kms_cursor_crc (cursor-sliding-32x10)
[386.128400] Starting subtest: cursor-sliding-32x10
[386.177713] Subtest cursor-sliding-32x10: SKIP (0.042s)
[386.453132] [073/133] (636s left) prime_self_import (export-vs-gem_close-race)
[386.499720] Starting subtest: export-vs-gem_close-race
[391.598232] Subtest export-vs-gem_close-race: SUCCESS (5.098s)
[391.705208] [074/133] (631s left) perf (non-sampling-read-error)
[391.823260] Starting subtest: non-sampling-read-error
[391.833300] Subtest non-sampling-read-error: SUCCESS (0.008s)
[391.877500] [075/133] (631s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[391.993825] Starting subtest: bad-rotation-90-y-tiled-ccs
[391.996209] Starting dynamic subtest: pipe-A-eDP-1
[392.018948] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.033326] Starting dynamic subtest: pipe-B-eDP-1
[392.055349] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.064889] Starting dynamic subtest: pipe-C-eDP-1
[392.086681] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.096190] Starting dynamic subtest: pipe-D-eDP-1
[392.118633] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[392.123029] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.010s)
[394.291626] [076/133] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[394.389809] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[401.265874] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.877s)
[401.403529] [077/133] (621s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[401.464154] Starting subtest: invalid-bsd2-flag-on-blt
[401.466468] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[401.579067] [078/133] (621s left) kms_cursor_crc (cursor-onscreen-128x42)
[401.805999] Starting subtest: cursor-onscreen-128x42
[401.855307] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[402.076797] [079/133] (621s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[402.198861] Starting subtest: modeset-atomic-cursor-hotspot
[402.203312] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[402.345856] [080/133] (620s left) gem_render_copy (linear)
[402.412281] Starting subtest: linear
[402.413883] Starting dynamic subtest: smem
[402.452990] Dynamic subtest smem: SUCCESS (0.043s)
[402.455074] Subtest linear: SUCCESS (0.044s)
[402.672887] [081/133] (620s left) prime_self_import (basic-with_one_bo_two_files)
[402.717755] Starting subtest: basic-with_one_bo_two_files
[402.731515] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[402.826654] [082/133] (620s left) kms_chamelium_edid (hdmi-edid-read)
[403.207267] Subtest hdmi-edid-read: SKIP (0.000s)
[404.000297] [083/133] (619s left) gem_exec_params (readonly)
[404.051997] Starting subtest: readonly
[404.054301] Subtest readonly: SUCCESS (0.002s)
[404.172718] [084/133] (619s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[404.268769] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[404.270959] Starting dynamic subtest: pipe-A-default-mode
[405.393210] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[405.397453] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.124s)
[405.560965] [085/133] (618s left) gem_mmap_gtt (cpuset-big-copy)
[405.620418] Subtest cpuset-big-copy: SKIP (0.000s)
[405.686565] [086/133] (617s left) sriov_basic (enable-vfs-autoprobe-on)
[405.738352] Starting subtest: enable-vfs-autoprobe-on
[405.740441] Starting dynamic subtest: numvfs-1
[405.819891] Dynamic subtest numvfs-1: FAIL (0.035s)
[405.831659] Starting dynamic subtest: numvfs-2
[405.905064] Dynamic subtest numvfs-2: FAIL (0.004s)
[405.916681] Starting dynamic subtest: numvfs-3
[405.989732] Dynamic subtest numvfs-3: FAIL (0.004s)
[406.003338] Starting dynamic subtest: numvfs-4
[406.072313] Dynamic subtest numvfs-4: FAIL (0.004s)
[406.082585] Starting dynamic subtest: numvfs-5
[406.151545] Dynamic subtest numvfs-5: FAIL (0.004s)
[406.161805] Starting dynamic subtest: numvfs-6
[406.230430] Dynamic subtest numvfs-6: FAIL (0.004s)
[406.240904] Starting dynamic subtest: numvfs-7
[406.308114] Dynamic subtest numvfs-7: FAIL (0.004s)
[406.317668] Starting dynamic subtest: numvfs-random
[406.373906] Dynamic subtest numvfs-random: FAIL (0.003s)
[406.383381] Starting dynamic subtest: numvfs-all
[406.439392] Dynamic subtest numvfs-all: FAIL (0.004s)
[406.441126] Subtest enable-vfs-autoprobe-on: FAIL (0.072s)
[406.477907] [087/133] (617s left) kms_plane_scaling (planes-downscale-factor-0-75)
[406.568950] Starting subtest: planes-downscale-factor-0-75
[406.570773] Starting dynamic subtest: pipe-A
[406.589543] Dynamic subtest pipe-A: SKIP (0.019s)
[406.601148] Starting dynamic subtest: pipe-B
[406.631118] Dynamic subtest pipe-B: SKIP (0.037s)
[406.641107] Starting dynamic subtest: pipe-C
[406.665286] Dynamic subtest pipe-C: SKIP (0.033s)
[406.674975] Starting dynamic subtest: pipe-D
[406.701769] Dynamic subtest pipe-D: SKIP (0.036s)
[406.704745] Subtest planes-downscale-factor-0-75: SKIP (0.130s)
[406.795000] [088/133] (616s left) kms_plane (plane-panning-top-left)
[406.897056] Starting subtest: plane-panning-top-left
[406.898699] Starting dynamic subtest: pipe-A
[408.649658] Dynamic subtest pipe-A: SUCCESS (1.752s)
[408.660571] Starting dynamic subtest: pipe-B
[411.097544] Dynamic subtest pipe-B: SUCCESS (2.444s)
[411.100056] Subtest plane-panning-top-left: SUCCESS (4.199s)
[411.894159] [089/133] (611s left) kms_plane_cursor (overlay)
[411.988618] Starting subtest: overlay
[411.993081] Starting dynamic subtest: pipe-A-eDP-1-size-64
[414.450620] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.463s)
[414.511398] Starting dynamic subtest: pipe-A-eDP-1-size-128
[416.962670] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s)
[417.024081] Starting dynamic subtest: pipe-A-eDP-1-size-256
[419.530665] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[419.881627] Starting dynamic subtest: pipe-B-eDP-1-size-64
[423.191920] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.322s)
[423.252744] Starting dynamic subtest: pipe-B-eDP-1-size-128
[425.793939] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[425.855314] Starting dynamic subtest: pipe-B-eDP-1-size-256
[428.373049] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[428.723338] Starting dynamic subtest: pipe-C-eDP-1-size-64
[431.576342] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.865s)
[431.613811] Starting dynamic subtest: pipe-C-eDP-1-size-128
[433.709312] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[433.747253] Starting dynamic subtest: pipe-C-eDP-1-size-256
[435.865030] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[436.197137] Starting dynamic subtest: pipe-D-eDP-1-size-64
[438.979998] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.795s)
[439.019363] Starting dynamic subtest: pipe-D-eDP-1-size-128
[441.180570] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[441.219969] Starting dynamic subtest: pipe-D-eDP-1-size-256
[443.402961] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[443.729153] Subtest overlay: SUCCESS (31.739s)
[444.533031] [090/133] (579s left) perf_pmu (busy)
[444.581666] Starting subtest: busy
[444.584188] Starting dynamic subtest: rcs0
[445.163791] Dynamic subtest rcs0: SUCCESS (0.582s)
[445.177859] Starting dynamic subtest: bcs0
[445.740557] Dynamic subtest bcs0: SUCCESS (0.575s)
[445.753716] Starting dynamic subtest: vcs0
[447.436984] Dynamic subtest vcs0: SUCCESS (1.693s)
[447.450403] Starting dynamic subtest: vcs1
[449.421085] Dynamic subtest vcs1: SUCCESS (1.982s)
[449.434428] Starting dynamic subtest: vecs0
[451.468911] Dynamic subtest vecs0: SUCCESS (2.045s)
[451.482042] Starting dynamic subtest: ccs0
[452.042512] Dynamic subtest ccs0: SUCCESS (0.573s)
[452.044903] Subtest busy: SUCCESS (7.463s)
[452.156121] [091/133] (571s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[452.257676] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[452.269874] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[452.362113] [092/133] (571s left) kms_frontbuffer_tracking (fbc-stridechange)
[452.471153] Starting subtest: fbc-stridechange
[455.707597] Subtest fbc-stridechange: SUCCESS (3.239s)
[456.833657] [093/133] (567s left) gem_pread (bench)
[456.905767] Subtest bench: SKIP (0.000s)
[456.973086] [094/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[457.075337] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[463.896823] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.826s)
[464.014924] [095/133] (559s left) syncobj_basic (bad-fd-to-handle)
[464.074644] Starting subtest: bad-fd-to-handle
[464.076599] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[464.196239] [096/133] (559s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[464.249189] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[464.251192] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[464.345155] [097/133] (559s left) perf (mi-rpc)
[464.438328] Starting subtest: mi-rpc
[464.443045] Subtest mi-rpc: SKIP (0.000s)
[464.486907] [098/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[464.593725] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[464.598212] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[464.699059] [099/133] (559s left) kms_vblank (ts-continuation-modeset-rpm)
[464.793803] Starting subtest: ts-continuation-modeset-rpm
[464.796017] Starting dynamic subtest: pipe-A-eDP-1
[467.288426] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[467.304864] Starting dynamic subtest: pipe-D-eDP-1
[469.512752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.221s)
[469.515180] Subtest ts-continuation-modeset-rpm: SUCCESS (4.720s)
[470.324498] [100/133] (553s left) perf (non-system-wide-paranoid)
[470.430736] Starting subtest: non-system-wide-paranoid
[470.457949] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[470.501111] [101/133] (553s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[470.593651] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[470.595876] Starting dynamic subtest: pipe-A-eDP-1
[470.620081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[470.631490] Starting dynamic subtest: pipe-B-eDP-1
[470.653900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[470.663635] Starting dynamic subtest: pipe-C-eDP-1
[470.686134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[470.698328] Starting dynamic subtest: pipe-D-eDP-1
[470.721674] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[470.725876] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[472.865298] [102/133] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[472.960174] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[482.321139] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.364s)
[482.462832] [103/133] (541s left) gem_softpin (allocator-basic)
[482.517616] Starting subtest: allocator-basic
[482.586116] Subtest allocator-basic: SUCCESS (0.068s)
[482.726074] [104/133] (541s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[482.821176] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[489.567003] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.749s)
[489.682554] [105/133] (534s left) syncobj_basic (create-signaled)
[489.750166] Starting subtest: create-signaled
[489.752566] Subtest create-signaled: SUCCESS (0.000s)
[489.873865] [106/133] (534s left) gem_mmap (basic-small-bo)
[489.938649] Subtest basic-small-bo: SKIP (0.000s)
[490.000901] [107/133] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[490.104412] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[496.613917] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.513s)
[496.743670] [108/133] (527s left) kms_force_connector_basic (force-load-detect)
[496.825368] Starting subtest: force-load-detect
[496.829721] Subtest force-load-detect: SKIP (0.000s)
[496.950442] [109/133] (527s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[497.039445] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[497.041719] Starting dynamic subtest: pipe-A-eDP-1
[497.115582] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[497.126960] Starting dynamic subtest: pipe-B-eDP-1
[498.255060] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[498.259561] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.217s)
[499.444017] [110/133] (525s left) gem_mmap_wc (coherency)
[499.506346] Subtest coherency: SKIP (0.000s)
[499.568457] [111/133] (525s left) kms_concurrent (multi-plane-atomic-lowres)
[499.674903] Starting subtest: multi-plane-atomic-lowres
[499.676818] Starting dynamic subtest: pipe-A-eDP-1
[500.155333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[500.169227] Starting dynamic subtest: pipe-B-eDP-1
[501.397305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.241s)
[501.410244] Starting dynamic subtest: pipe-C-eDP-1
[502.597021] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[502.608145] Starting dynamic subtest: pipe-D-eDP-1
[503.842423] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[503.844713] Subtest multi-plane-atomic-lowres: SUCCESS (4.167s)
[504.679119] [112/133] (520s left) gem_gtt_cpu_tlb
[504.786594] [113/133] (520s left) i915_module_load (reload-no-display)
[504.826686] Starting subtest: reload-no-display
[510.723759] Subtest reload-no-display: SUCCESS (5.898s)
[510.756835] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[510.757898] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[510.761386] [114/133] (514s left) i915_drm_fdinfo (idle)
[512.304457] Starting subtest: idle
[512.306837] Starting dynamic subtest: rcs0
[512.873857] Dynamic subtest rcs0: SUCCESS (0.568s)
[512.889077] Starting dynamic subtest: bcs0
[513.404679] Dynamic subtest bcs0: SUCCESS (0.528s)
[513.416937] Starting dynamic subtest: vcs0
[513.911434] Dynamic subtest vcs0: SUCCESS (0.503s)
[513.921649] Starting dynamic subtest: vcs1
[514.421370] Dynamic subtest vcs1: SUCCESS (0.503s)
[514.430300] Starting dynamic subtest: vecs0
[514.927693] Dynamic subtest vecs0: SUCCESS (0.503s)
[514.939067] Starting dynamic subtest: ccs0
[515.429994] Dynamic subtest ccs0: SUCCESS (0.503s)
[515.432533] Subtest idle: SUCCESS (3.126s)
[515.477763] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.479406] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[515.483419] [115/133] (509s left) dumb_buffer (create-clear)
[515.539082] Starting subtest: create-clear
[549.417515] Subtest create-clear: SUCCESS (33.879s)
[549.538812] [116/133] (475s left) kms_flip (flip-vs-fences-interruptible)
[549.637871] Starting subtest: flip-vs-fences-interruptible
[549.642195] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[549.751167] [117/133] (475s left) kms_big_fb (linear-8bpp-rotate-270)
[549.842573] Starting subtest: linear-8bpp-rotate-270
[549.878498] Subtest linear-8bpp-rotate-270: SKIP (0.035s)
[550.003509] [118/133] (475s left) gen9_exec_parse (bb-oversize)
[550.068350] Subtest bb-oversize: SKIP (0.000s)
[550.125786] [119/133] (474s left) gem_exec_schedule (smoketest)
[550.303218] Starting subtest: smoketest
[550.305412] Starting dynamic subtest: rcs0
[555.859028] Dynamic subtest rcs0: SUCCESS (5.510s)
[555.874335] Starting dynamic subtest: bcs0
[561.349633] Dynamic subtest bcs0: SUCCESS (5.489s)
[561.365111] Starting dynamic subtest: vcs0
[566.845441] Dynamic subtest vcs0: SUCCESS (5.493s)
[566.856726] Starting dynamic subtest: vcs1
[572.333190] Dynamic subtest vcs1: SUCCESS (5.489s)
[572.344972] Starting dynamic subtest: vecs0
[577.823208] Dynamic subtest vecs0: SUCCESS (5.488s)
[577.835053] Starting dynamic subtest: ccs0
[583.321124] Dynamic subtest ccs0: SUCCESS (5.497s)
[583.323409] Subtest smoketest: SUCCESS (32.976s)
[583.467255] [120/133] (441s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[583.666403] Starting subtest: cursor-rapid-movement-64x21
[583.719425] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[583.936839] [121/133] (441s left) gem_mmap (basic)
[584.000249] Subtest basic: SKIP (0.000s)
[584.055742] [122/133] (441s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[584.152364] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[584.776305] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[584.952859] [123/133] (440s left) gem_exec_balancer (hang)
[585.213164] Starting subtest: hang
[586.935466] Subtest hang: SUCCESS (1.725s)
[587.047599] [124/133] (438s left) gem_ctx_exec (basic-norecovery)
[587.110076] Starting subtest: basic-norecovery
[587.463343] Subtest basic-norecovery: SUCCESS (0.352s)
[587.621766] [125/133] (437s left) kms_hdr (static-toggle)
[587.723401] Starting subtest: static-toggle
[587.729881] Subtest static-toggle: SKIP (0.000s)
[587.802281] [126/133] (437s left) kms_properties (invalid-properties-legacy)
[587.904520] Starting subtest: invalid-properties-legacy
[588.012700] Subtest invalid-properties-legacy: SUCCESS (0.109s)
[588.086232] [127/133] (437s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[588.178904] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[592.235588] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.059s)
[593.447197] [128/133] (432s left) gem_workarounds (suspend-resume-context)
[593.522847] Starting subtest: suspend-resume-context
[609.795316] Subtest suspend-resume-context: SUCCESS (1.168s)
[609.942021] [129/133] (415s left) gem_exec_fence (keep-in-fence)
[610.124943] Starting subtest: keep-in-fence
[610.126980] Starting dynamic subtest: rcs0
[610.177646] Dynamic subtest rcs0: SUCCESS (0.055s)
[610.191703] Starting dynamic subtest: bcs0
[610.231363] Dynamic subtest bcs0: SUCCESS (0.052s)
[610.243335] Starting dynamic subtest: vcs0
[611.537556] Dynamic subtest vcs0: SUCCESS (1.315s)
[611.550607] Starting dynamic subtest: vcs1
[613.520871] Dynamic subtest vcs1: SUCCESS (1.998s)
[613.533909] Starting dynamic subtest: vecs0
[615.505494] Dynamic subtest vecs0: SUCCESS (1.995s)
[615.521011] Starting dynamic subtest: ccs0
[615.741173] Dynamic subtest ccs0: SUCCESS (0.235s)
[615.743666] Subtest keep-in-fence: SUCCESS (5.664s)
[617.658964] [130/133] (407s left) gem_mmap_gtt (hang-user)
[617.712337] Subtest hang-user: SKIP (0.000s)
[617.782561] [131/133] (407s left) kms_atomic_transition (plane-all-transition-fencing)
[617.882181] Starting subtest: plane-all-transition-fencing
[617.884495] Starting dynamic subtest: pipe-A-eDP-1
[620.371349] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[620.692861] Starting dynamic subtest: pipe-B-eDP-1
[623.922947] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s)
[624.234804] Subtest plane-all-transition-fencing: SUCCESS (6.373s)
[625.048321] [132/133] (400s left) gem_pxp (protected-raw-src-copy-not-readible)
[625.174980] Starting subtest: protected-raw-src-copy-not-readible
[625.231384] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[625.349075] [133/133] (400s left) syncobj_wait (multi-wait-for-submit-submitted)
[625.409109] Starting subtest: multi-wait-for-submit-submitted
[625.517234] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[625.591722] 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.