[69.088813] Initializing watchdogs
[69.088858]   /dev/watchdog0
[69.104396] [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]
[69.108825] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.110970] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.114549] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[69.230671] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[69.232875] Starting dynamic subtest: pipe-A-eDP-1
[70.067961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[70.077152] Starting dynamic subtest: pipe-B-eDP-1
[71.630361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s)
[71.638624] Starting dynamic subtest: pipe-C-eDP-1
[73.127388] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[73.139161] Starting dynamic subtest: pipe-D-eDP-1
[74.667359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[74.669248] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.434s)
[75.810744] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[75.921877] Starting subtest: fbc-pr-sprite-plane-move
[75.925839] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[75.991125] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[76.127657] Starting subtest: in-flight-contexts-immediate
[84.317511] Subtest in-flight-contexts-immediate: SUCCESS (8.191s)
[84.446668] [004/133] (945s left) kms_async_flips (async-flip-suspend-resume)
[84.545955] Starting subtest: async-flip-suspend-resume
[84.921601] Starting dynamic subtest: pipe-A-eDP-1
[103.090834] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.809s)
[103.462458] Starting dynamic subtest: pipe-B-eDP-1
[121.109341] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.941s)
[121.500330] Starting dynamic subtest: pipe-C-eDP-1
[139.100887] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s)
[139.467866] Starting dynamic subtest: pipe-D-eDP-1
[157.085700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[157.088382] Subtest async-flip-suspend-resume: SUCCESS (14.032s)
[158.284273] [005/133] (871s left) kms_flip (modeset-vs-vblank-race)
[158.381192] Starting subtest: modeset-vs-vblank-race
[158.383688] Starting dynamic subtest: A-eDP1
[163.108375] Dynamic subtest A-eDP1: SUCCESS (4.737s)
[163.120759] Starting dynamic subtest: B-eDP1
[167.825829] Dynamic subtest B-eDP1: SUCCESS (4.721s)
[167.837641] Starting dynamic subtest: C-eDP1
[172.513128] Dynamic subtest C-eDP1: SUCCESS (4.690s)
[172.527080] Starting dynamic subtest: D-eDP1
[177.074191] Dynamic subtest D-eDP1: SUCCESS (4.564s)
[177.076655] Subtest modeset-vs-vblank-race: SUCCESS (18.722s)
[178.231048] [006/133] (851s left) kms_psr (pr-cursor-plane-move)
[178.334818] Starting subtest: pr-cursor-plane-move
[178.340631] Subtest pr-cursor-plane-move: SKIP (0.000s)
[178.402618] [007/133] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[178.514748] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[185.868103] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.381s)
[185.993262] [008/133] (843s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[186.114803] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[186.120413] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[186.211924] [009/133] (843s left) kms_atomic_transition (modeset-transition-nonblocking)
[186.297615] Starting subtest: modeset-transition-nonblocking
[186.299818] Starting dynamic subtest: 1x-outputs
[197.086815] Dynamic subtest 1x-outputs: SUCCESS (10.804s)
[197.089669] Subtest modeset-transition-nonblocking: SUCCESS (10.806s)
[197.951326] [010/133] (832s left) i915_power (sanity)
[198.020840] Starting subtest: sanity
[202.063716] Subtest sanity: SUCCESS (4.039s)
[203.915926] [011/133] (826s left) gem_exec_whisper (basic-queues-all)
[203.994369] Starting subtest: basic-queues-all
[215.132814] Subtest basic-queues-all: SUCCESS (11.136s)
[215.342730] [012/133] (814s left) drm_read (empty-nonblock)
[215.501531] Starting subtest: empty-nonblock
[215.504509] Subtest empty-nonblock: SUCCESS (0.000s)
[215.599923] [013/133] (814s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[215.694811] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[215.700586] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[215.777093] [014/133] (814s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[215.873051] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[215.877741] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[215.954793] [015/133] (814s left) kms_psr (psr-sprite-plane-move)
[216.043536] Starting subtest: psr-sprite-plane-move
[216.046165] Starting dynamic subtest: eDP-1
[217.785653] Dynamic subtest eDP-1: SUCCESS (1.741s)
[217.788607] Subtest psr-sprite-plane-move: SUCCESS (1.742s)
[218.595542] [016/133] (811s left) gem_exec_create (legacy)
[218.660350] Starting subtest: legacy
[218.663098] Starting dynamic subtest: smem
[220.751183] Dynamic subtest smem: SUCCESS (2.090s)
[220.754207] Subtest legacy: SUCCESS (2.091s)
[220.931478] [017/133] (809s left) perf (blocking)
[221.064825] Starting subtest: blocking
[221.067418] Starting dynamic subtest: 0-rcs0
[231.081125] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[231.091499] Starting dynamic subtest: 1-vcs0
[241.103499] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[241.106519] Subtest blocking: SUCCESS (20.041s)
[241.154130] [018/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[241.262614] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[241.267697] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[241.356707] [019/133] (788s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[241.453572] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[241.455726] Starting dynamic subtest: pipe-A-eDP-1
[242.181057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[242.191270] Starting dynamic subtest: pipe-B-eDP-1
[243.922408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.740s)
[243.938416] Starting dynamic subtest: pipe-C-eDP-1
[245.651261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.727s)
[245.662611] Starting dynamic subtest: pipe-D-eDP-1
[247.424435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.772s)
[247.427242] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.964s)
[248.533824] [020/133] (781s left) kms_lease (lease-invalid-crtc)
[248.616612] Starting subtest: lease-invalid-crtc
[248.619337] Starting dynamic subtest: pipe-A-eDP-1
[248.621826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[248.631656] Starting dynamic subtest: pipe-B-eDP-1
[248.634670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[248.644983] Starting dynamic subtest: pipe-C-eDP-1
[248.647496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[248.656720] Starting dynamic subtest: pipe-D-eDP-1
[248.659081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[248.661516] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[248.698495] [021/133] (781s left) kms_content_protection (atomic-hdcp14)
[248.841446] Starting subtest: atomic-hdcp14
[248.846817] Subtest atomic-hdcp14: SKIP (0.000s)
[248.955266] [022/133] (781s left) gem_ctx_sseu (invalid-args)
[249.012667] Subtest invalid-args: SKIP (0.000s)
[249.069315] [023/133] (781s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[249.131645] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[249.231809] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[249.307338] [024/133] (781s left) gem_lmem_swapping (parallel-random-engines)
[249.349491] Subtest parallel-random-engines: SKIP (0.000s)
[249.392839] [025/133] (781s left) gem_softpin (evict-prime)
[249.448754] Starting subtest: evict-prime
[249.451150] Starting dynamic subtest: rcs0
[250.593230] Dynamic subtest rcs0: SUCCESS (1.148s)
[250.610664] Starting dynamic subtest: bcs0
[251.719700] Dynamic subtest bcs0: SUCCESS (1.124s)
[251.735833] Starting dynamic subtest: vcs0
[252.852066] Dynamic subtest vcs0: SUCCESS (1.131s)
[252.862828] Starting dynamic subtest: vcs1
[254.837399] Dynamic subtest vcs1: SUCCESS (1.983s)
[254.849836] Starting dynamic subtest: vecs0
[256.820690] Dynamic subtest vecs0: SUCCESS (1.981s)
[256.833807] Starting dynamic subtest: ccs0
[257.976445] Dynamic subtest ccs0: SUCCESS (1.155s)
[257.988873] Starting dynamic subtest: all
[259.808294] Dynamic subtest all: SUCCESS (1.829s)
[259.811307] Subtest evict-prime: SUCCESS (10.366s)
[259.937570] [026/133] (770s left) kms_plane_lowres (tiling-none)
[260.035838] Starting subtest: tiling-none
[260.038104] Starting dynamic subtest: pipe-A-eDP-1
[260.042635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.342632] Starting dynamic subtest: pipe-B-eDP-1
[260.347472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.356662] Starting dynamic subtest: pipe-C-eDP-1
[260.361455] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.370970] Starting dynamic subtest: pipe-D-eDP-1
[260.375802] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.380631] Subtest tiling-none: SKIP (0.307s)
[261.168586] [027/133] (769s left) kms_draw_crc (draw-method-mmap-cpu)
[261.255557] Starting subtest: draw-method-mmap-cpu
[261.257820] Starting dynamic subtest: xrgb8888-untiled
[261.475564] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[261.485643] Starting dynamic subtest: rgb565-untiled
[261.697688] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[261.709279] Starting dynamic subtest: xrgb2101010-untiled
[261.908272] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[261.917602] Starting dynamic subtest: xbgr16161616f-untiled
[262.119282] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[262.128591] Starting dynamic subtest: xrgb8888-xtiled
[262.241251] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[262.251593] Starting dynamic subtest: rgb565-xtiled
[262.363187] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[262.373215] Starting dynamic subtest: xrgb2101010-xtiled
[262.475005] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[262.485218] Starting dynamic subtest: xbgr16161616f-xtiled
[262.597365] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[262.607321] Starting dynamic subtest: xrgb8888-4tiled
[262.742411] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[262.752244] Starting dynamic subtest: rgb565-4tiled
[262.874400] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[262.884162] Starting dynamic subtest: xrgb2101010-4tiled
[262.996411] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[263.006405] Starting dynamic subtest: xbgr16161616f-4tiled
[263.130233] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[263.132684] Subtest draw-method-mmap-cpu: SUCCESS (1.878s)
[263.224225] [028/133] (767s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[263.283278] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[263.347551] [029/133] (767s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[263.448837] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[263.450961] Starting dynamic subtest: pipe-A-eDP-1
[263.544447] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[263.553864] Starting dynamic subtest: pipe-B-eDP-1
[264.659098] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[264.663685] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.214s)
[265.849800] [030/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[265.955272] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[265.960279] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[266.050894] [031/133] (764s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[266.146535] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[266.151573] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[266.227327] [032/133] (764s left) kms_rotation_crc (primary-rotation-180)
[266.316316] Starting subtest: primary-rotation-180
[273.613562] Subtest primary-rotation-180: SUCCESS (7.299s)
[274.834808] [033/133] (756s left) kms_pm_rpm (universal-planes-dpms)
[276.976376] Starting subtest: universal-planes-dpms
[276.979662] Starting dynamic subtest: plane-35
[285.271316] Dynamic subtest plane-35: SUCCESS (8.295s)
[285.283731] Starting dynamic subtest: plane-65
[293.608232] Dynamic subtest plane-65: SUCCESS (8.332s)
[293.620414] Starting dynamic subtest: plane-95
[304.525905] Dynamic subtest plane-95: SUCCESS (10.913s)
[304.540995] Starting dynamic subtest: plane-125
[312.860697] Dynamic subtest plane-125: SUCCESS (8.329s)
[312.874437] Starting dynamic subtest: plane-135
[321.207366] Dynamic subtest plane-135: SUCCESS (8.344s)
[321.219717] Starting dynamic subtest: plane-145
[329.504486] Dynamic subtest plane-145: SUCCESS (8.295s)
[329.507394] Subtest universal-planes-dpms: SUCCESS (52.528s)
[329.898296] [034/133] (701s left) kms_pm_lpsp (kms-lpsp)
[331.013793] Starting subtest: kms-lpsp
[331.016198] Starting dynamic subtest: pipe-A-eDP-1
[331.152834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[331.462603] Subtest kms-lpsp: SUCCESS (0.450s)
[332.338294] [035/133] (698s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[332.715564] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[333.532443] [036/133] (697s left) api_intel_allocator (two-level-inception-interruptible)
[333.607285] Starting subtest: two-level-inception-interruptible
[339.015950] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[339.128368] [037/133] (691s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[339.231791] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[339.236655] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[339.357186] [038/133] (691s left) gem_userptr_blits (huge-split)
[339.442834] Starting subtest: huge-split
[339.452097] Subtest huge-split: SUCCESS (0.010s)
[339.617156] [039/133] (691s left) gem_eio (in-flight-10ms)
[339.851605] Starting subtest: in-flight-10ms
[348.813502] Subtest in-flight-10ms: SUCCESS (8.961s)
[348.981206] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[348.985569] [040/133] (682s left) perf_pmu (pmu-read)
[349.027302] Starting subtest: pmu-read
[349.029616] Subtest pmu-read: SUCCESS (0.002s)
[349.143004] [041/133] (682s left) kms_properties (plane-properties-atomic)
[349.235175] Starting subtest: plane-properties-atomic
[349.237618] Starting dynamic subtest: pipe-A-eDP-1
[349.799321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[349.810729] Starting dynamic subtest: pipe-B-eDP-1
[351.065364] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[351.076238] Starting dynamic subtest: pipe-C-eDP-1
[352.368042] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s)
[352.378428] Starting dynamic subtest: pipe-D-eDP-1
[353.600801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[353.603646] Subtest plane-properties-atomic: SUCCESS (4.368s)
[354.404148] [042/133] (676s left) gem_ctx_exec (basic-invalid-context)
[354.457538] Starting subtest: basic-invalid-context
[354.462725] Subtest basic-invalid-context: SUCCESS (0.006s)
[354.591486] [043/133] (676s left) gem_exec_params (rel-constants-invalid)
[354.646681] Starting subtest: rel-constants-invalid
[354.649600] Subtest rel-constants-invalid: SUCCESS (0.000s)
[354.750223] [044/133] (676s left) syncobj_wait (reset-multiple-signaled)
[354.806620] Starting subtest: reset-multiple-signaled
[354.809586] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[354.912359] [045/133] (676s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[355.011483] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[355.017585] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[355.126157] [046/133] (676s left) gem_ctx_persistence (legacy-engines-mixed)
[355.197806] Starting subtest: legacy-engines-mixed
[355.200589] Starting dynamic subtest: render
[355.291426] Dynamic subtest render: SUCCESS (0.093s)
[355.302978] Starting dynamic subtest: bsd1
[355.335079] Dynamic subtest bsd1: SUCCESS (0.042s)
[355.344860] Starting dynamic subtest: bsd2
[355.385659] Dynamic subtest bsd2: SUCCESS (0.048s)
[355.396810] Starting dynamic subtest: blt
[355.433588] Dynamic subtest blt: SUCCESS (0.046s)
[355.449998] Starting dynamic subtest: vebox
[355.482271] Dynamic subtest vebox: SUCCESS (0.046s)
[355.484369] Subtest legacy-engines-mixed: SUCCESS (0.286s)
[355.559423] [047/133] (675s left) gem_pread (display)
[355.610928] Subtest display: SKIP (0.000s)
[355.674078] [048/133] (675s left) fbdev (unaligned-write)
[355.714527] Starting subtest: unaligned-write
[355.813374] Subtest unaligned-write: SUCCESS (0.098s)
[355.882830] [049/133] (675s left) syncobj_timeline (device-signal-unordered)
[355.930468] Starting subtest: device-signal-unordered
[355.932619] Subtest device-signal-unordered: SUCCESS (0.001s)
[356.022847] [050/133] (675s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[356.111810] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[362.962889] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.853s)
[363.104616] [051/133] (668s left) kms_flip (2x-flip-vs-expired-vblank)
[363.193706] Starting subtest: 2x-flip-vs-expired-vblank
[363.198844] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[363.281397] [052/133] (668s left) kms_psr (psr2-sprite-render)
[363.371446] Starting subtest: psr2-sprite-render
[363.373951] Starting dynamic subtest: eDP-1
[365.130482] Dynamic subtest eDP-1: SUCCESS (1.760s)
[365.133503] Subtest psr2-sprite-render: SUCCESS (1.761s)
[365.992436] [053/133] (665s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[366.093295] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[366.095606] Starting dynamic subtest: pipe-A-eDP-1
[371.973486] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s)
[371.983826] Starting dynamic subtest: pipe-B-eDP-1
[378.672649] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.698s)
[378.675454] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.585s)
[379.551705] [054/133] (652s left) drm_read (short-buffer-nonblock)
[379.697644] Starting subtest: short-buffer-nonblock
[379.700546] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[379.824636] [055/133] (652s left) gem_exec_schedule (pi-userfault)
[380.002855] Starting subtest: pi-userfault
[380.005543] Starting dynamic subtest: rcs0
[380.011990] Dynamic subtest rcs0: SUCCESS (0.012s)
[380.023246] Starting dynamic subtest: bcs0
[380.025736] Dynamic subtest bcs0: SUCCESS (0.010s)
[380.035856] Starting dynamic subtest: vcs0
[380.038418] Dynamic subtest vcs0: SUCCESS (0.010s)
[380.047877] Starting dynamic subtest: vcs1
[380.050271] Dynamic subtest vcs1: SUCCESS (0.011s)
[380.062841] Starting dynamic subtest: vecs0
[380.065537] Dynamic subtest vecs0: SUCCESS (0.009s)
[380.076465] Starting dynamic subtest: ccs0
[380.078500] Dynamic subtest ccs0: SUCCESS (0.007s)
[380.080497] Subtest pi-userfault: SUCCESS (0.066s)
[380.263932] [056/133] (651s left) i915_pm_rpm (sysfs-read)
[381.997323] Starting subtest: sysfs-read
[383.145555] Subtest sysfs-read: SUCCESS (1.149s)
[383.542031] [057/133] (648s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[383.642082] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[384.654541] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.012s)
[384.775309] [058/133] (647s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[384.878822] Starting subtest: y-tiled-64bpp-rotate-270
[384.884638] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[384.999550] [059/133] (647s left) kms_psr (fbc-psr-primary-blt)
[385.096369] Starting subtest: fbc-psr-primary-blt
[385.098519] Starting dynamic subtest: eDP-1
[385.102469] Dynamic subtest eDP-1: SKIP (0.000s)
[385.106412] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[385.169177] [060/133] (646s left) vgem_basic (dmabuf-export)
[385.211456] Starting subtest: dmabuf-export
[385.246980] Subtest dmabuf-export: SUCCESS (0.037s)
[385.328673] [061/133] (646s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[385.379690] Starting subtest: multi-wait-all-for-submit-available-signaled
[385.382199] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[385.476115] [062/133] (646s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[385.564814] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[385.575582] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[385.653494] [063/133] (646s left) syncobj_timeline (single-wait-all-available-submitted)
[385.709069] Starting subtest: single-wait-all-available-submitted
[385.711613] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[385.803084] [064/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[385.898375] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[385.902532] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[385.987566] [065/133] (646s left) kms_universal_plane (disable-primary-vs-flip)
[386.086528] Starting subtest: disable-primary-vs-flip
[386.088508] Starting dynamic subtest: pipe-A-eDP-1
[387.604023] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[387.615665] Starting dynamic subtest: pipe-B-eDP-1
[389.866804] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.259s)
[389.877858] Starting dynamic subtest: pipe-C-eDP-1
[392.093944] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.228s)
[392.106136] Starting dynamic subtest: pipe-D-eDP-1
[394.265500] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[394.268449] Subtest disable-primary-vs-flip: SUCCESS (8.182s)
[395.064314] [066/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[395.168678] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[395.173662] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[395.285213] [067/133] (637s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[395.384710] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[395.396845] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[395.475428] [068/133] (636s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[395.573579] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[395.579562] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[395.652693] [069/133] (636s left) vgem_basic (bad-handle)
[395.700659] Starting subtest: bad-handle
[395.703485] Subtest bad-handle: SUCCESS (0.000s)
[395.758082] [070/133] (636s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[395.860798] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[395.863589] Starting dynamic subtest: pipe-A-eDP-1
[395.890574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.901363] Starting dynamic subtest: pipe-B-eDP-1
[395.926761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.936813] Starting dynamic subtest: pipe-C-eDP-1
[395.962952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.972854] Starting dynamic subtest: pipe-D-eDP-1
[395.998812] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.003226] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[398.125750] [071/133] (634s left) api_intel_bb (intel-bb-blit-x)
[398.185988] Starting subtest: intel-bb-blit-x
[401.557129] Subtest intel-bb-blit-x: SUCCESS (3.373s)
[401.666626] [072/133] (630s left) kms_cursor_crc (cursor-sliding-32x10)
[401.843337] Starting subtest: cursor-sliding-32x10
[401.886522] Subtest cursor-sliding-32x10: SKIP (0.038s)
[402.183334] [073/133] (630s left) prime_self_import (export-vs-gem_close-race)
[402.223656] Starting subtest: export-vs-gem_close-race
[407.317152] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[407.394016] [074/133] (625s left) perf (non-sampling-read-error)
[407.507076] Starting subtest: non-sampling-read-error
[407.517510] Subtest non-sampling-read-error: SUCCESS (0.009s)
[407.564209] [075/133] (625s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[407.685640] Starting subtest: bad-rotation-90-y-tiled-ccs
[407.688449] Starting dynamic subtest: pipe-A-eDP-1
[407.715058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[407.728850] Starting dynamic subtest: pipe-B-eDP-1
[407.753472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[407.763883] Starting dynamic subtest: pipe-C-eDP-1
[407.788730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[407.799240] Starting dynamic subtest: pipe-D-eDP-1
[407.825365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[407.830532] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[409.976825] [076/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[410.085646] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[416.928824] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.846s)
[417.069001] [077/133] (615s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[417.127141] Starting subtest: invalid-bsd2-flag-on-blt
[417.129634] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[417.218670] [078/133] (615s left) kms_cursor_crc (cursor-onscreen-128x42)
[417.432680] Starting subtest: cursor-onscreen-128x42
[417.478289] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[417.671193] [079/133] (615s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[417.786493] Starting subtest: modeset-atomic-cursor-hotspot
[417.791678] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[417.931800] [080/133] (615s left) gem_render_copy (linear)
[418.001309] Starting subtest: linear
[418.003535] Starting dynamic subtest: smem
[418.040332] Dynamic subtest smem: SUCCESS (0.042s)
[418.042440] Subtest linear: SUCCESS (0.043s)
[418.256720] [081/133] (614s left) prime_self_import (basic-with_one_bo_two_files)
[418.295182] Starting subtest: basic-with_one_bo_two_files
[418.303802] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[418.399216] [082/133] (614s left) kms_chamelium_edid (hdmi-edid-read)
[418.793721] Subtest hdmi-edid-read: SKIP (0.000s)
[419.595064] [083/133] (613s left) gem_exec_params (readonly)
[419.650350] Starting subtest: readonly
[419.655694] Subtest readonly: SUCCESS (0.003s)
[419.766249] [084/133] (613s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[419.861094] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[419.863679] Starting dynamic subtest: pipe-A-default-mode
[420.975743] Dynamic subtest pipe-A-default-mode: SKIP (1.111s)
[420.981690] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.112s)
[421.118725] [085/133] (612s left) gem_mmap_gtt (cpuset-big-copy)
[421.182851] Subtest cpuset-big-copy: SKIP (0.000s)
[421.250981] [086/133] (611s left) sriov_basic (enable-vfs-autoprobe-on)
[421.309793] Starting subtest: enable-vfs-autoprobe-on
[421.312592] Starting dynamic subtest: numvfs-1
[421.401799] Dynamic subtest numvfs-1: FAIL (0.037s)
[421.411795] Starting dynamic subtest: numvfs-2
[421.499054] Dynamic subtest numvfs-2: FAIL (0.003s)
[421.510489] Starting dynamic subtest: numvfs-3
[421.596468] Dynamic subtest numvfs-3: FAIL (0.003s)
[421.607099] Starting dynamic subtest: numvfs-4
[421.694192] Dynamic subtest numvfs-4: FAIL (0.003s)
[421.705649] Starting dynamic subtest: numvfs-5
[421.794271] Dynamic subtest numvfs-5: FAIL (0.003s)
[421.804654] Starting dynamic subtest: numvfs-6
[421.888614] Dynamic subtest numvfs-6: FAIL (0.003s)
[421.899593] Starting dynamic subtest: numvfs-7
[421.972696] Dynamic subtest numvfs-7: FAIL (0.003s)
[421.983752] Starting dynamic subtest: numvfs-random
[422.056536] Dynamic subtest numvfs-random: FAIL (0.003s)
[422.067734] Starting dynamic subtest: numvfs-all
[422.141812] Dynamic subtest numvfs-all: FAIL (0.587s)
[422.144075] Subtest enable-vfs-autoprobe-on: FAIL (0.655s)
[422.183793] [087/133] (611s left) kms_plane_scaling (planes-downscale-factor-0-75)
[422.277317] Starting subtest: planes-downscale-factor-0-75
[422.279596] Starting dynamic subtest: pipe-A
[422.295991] Dynamic subtest pipe-A: SKIP (0.017s)
[422.305940] Starting dynamic subtest: pipe-B
[422.326402] Dynamic subtest pipe-B: SKIP (0.030s)
[422.336168] Starting dynamic subtest: pipe-C
[422.357634] Dynamic subtest pipe-C: SKIP (0.029s)
[422.367632] Starting dynamic subtest: pipe-D
[422.387056] Dynamic subtest pipe-D: SKIP (0.029s)
[422.391102] Subtest planes-downscale-factor-0-75: SKIP (0.107s)
[422.479203] [088/133] (610s left) kms_plane (plane-panning-top-left)
[422.568103] Starting subtest: plane-panning-top-left
[422.570427] Starting dynamic subtest: pipe-A
[424.210947] Dynamic subtest pipe-A: SUCCESS (1.641s)
[424.221510] Starting dynamic subtest: pipe-B
[426.465966] Dynamic subtest pipe-B: SUCCESS (2.255s)
[426.468637] Subtest plane-panning-top-left: SUCCESS (3.898s)
[427.286962] [089/133] (606s left) kms_plane_cursor (overlay)
[427.392199] Starting subtest: overlay
[427.396565] Starting dynamic subtest: pipe-A-eDP-1-size-64
[429.871959] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.479s)
[429.933529] Starting dynamic subtest: pipe-A-eDP-1-size-128
[432.473617] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[432.536380] Starting dynamic subtest: pipe-A-eDP-1-size-256
[434.996628] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.472s)
[435.350829] Starting dynamic subtest: pipe-B-eDP-1-size-64
[438.506639] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.171s)
[438.567707] Starting dynamic subtest: pipe-B-eDP-1-size-128
[441.173808] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.615s)
[441.234628] Starting dynamic subtest: pipe-B-eDP-1-size-256
[443.631630] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.405s)
[443.983829] Starting dynamic subtest: pipe-C-eDP-1-size-64
[446.787556] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.815s)
[446.824169] Starting dynamic subtest: pipe-C-eDP-1-size-128
[449.020376] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[449.058197] Starting dynamic subtest: pipe-C-eDP-1-size-256
[451.163952] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[451.495076] Starting dynamic subtest: pipe-D-eDP-1-size-64
[454.290401] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.806s)
[454.333228] Starting dynamic subtest: pipe-D-eDP-1-size-128
[456.380170] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.059s)
[456.418790] Starting dynamic subtest: pipe-D-eDP-1-size-256
[458.449121] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[458.768844] Subtest overlay: SUCCESS (31.373s)
[459.622345] [090/133] (573s left) perf_pmu (busy)
[459.670885] Starting subtest: busy
[459.673745] Starting dynamic subtest: rcs0
[460.268949] Dynamic subtest rcs0: SUCCESS (0.600s)
[460.282653] Starting dynamic subtest: bcs0
[460.836572] Dynamic subtest bcs0: SUCCESS (0.565s)
[460.849902] Starting dynamic subtest: vcs0
[462.837642] Dynamic subtest vcs0: SUCCESS (1.997s)
[462.851549] Starting dynamic subtest: vcs1
[464.821340] Dynamic subtest vcs1: SUCCESS (1.980s)
[464.835087] Starting dynamic subtest: vecs0
[466.870124] Dynamic subtest vecs0: SUCCESS (2.045s)
[466.883671] Starting dynamic subtest: ccs0
[467.435146] Dynamic subtest ccs0: SUCCESS (0.564s)
[467.437950] Subtest busy: SUCCESS (7.768s)
[467.539555] [091/133] (565s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[467.637573] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[467.648618] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[467.731071] [092/133] (565s left) kms_frontbuffer_tracking (fbc-stridechange)
[467.837796] Starting subtest: fbc-stridechange
[471.122354] Subtest fbc-stridechange: SUCCESS (3.291s)
[472.243074] [093/133] (561s left) gem_pread (bench)
[472.309155] Subtest bench: SKIP (0.000s)
[472.366511] [094/133] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[472.456749] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[479.291659] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.840s)
[479.406434] [095/133] (554s left) syncobj_basic (bad-fd-to-handle)
[479.461158] Starting subtest: bad-fd-to-handle
[479.463604] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[479.551258] [096/133] (554s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[479.610694] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[479.613264] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[479.710514] [097/133] (553s left) perf (mi-rpc)
[479.804745] Starting subtest: mi-rpc
[479.810591] Subtest mi-rpc: SKIP (0.000s)
[479.853117] [098/133] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[479.944135] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[479.949244] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[480.054490] [099/133] (553s left) kms_vblank (ts-continuation-modeset-rpm)
[480.159833] Starting subtest: ts-continuation-modeset-rpm
[480.162298] Starting dynamic subtest: pipe-A-eDP-1
[482.661326] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[482.677098] Starting dynamic subtest: pipe-D-eDP-1
[484.921121] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[484.923679] Subtest ts-continuation-modeset-rpm: SUCCESS (4.763s)
[485.727642] [100/133] (548s left) perf (non-system-wide-paranoid)
[485.834661] Starting subtest: non-system-wide-paranoid
[485.862412] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[485.909719] [101/133] (547s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[486.009015] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[486.011422] Starting dynamic subtest: pipe-A-eDP-1
[486.036560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.047554] Starting dynamic subtest: pipe-B-eDP-1
[486.072795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.082910] Starting dynamic subtest: pipe-C-eDP-1
[486.110527] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.120192] Starting dynamic subtest: pipe-D-eDP-1
[486.148425] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.153631] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[488.201639] [102/133] (545s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[488.299225] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[497.713475] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.416s)
[497.844349] [103/133] (536s left) gem_softpin (allocator-basic)
[497.900848] Starting subtest: allocator-basic
[497.966857] Subtest allocator-basic: SUCCESS (0.066s)
[498.092931] [104/133] (535s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[498.188613] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[504.876144] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.690s)
[504.989002] [105/133] (529s left) syncobj_basic (create-signaled)
[505.039095] Starting subtest: create-signaled
[505.041839] Subtest create-signaled: SUCCESS (0.000s)
[505.133244] [106/133] (528s left) gem_mmap (basic-small-bo)
[505.196649] Subtest basic-small-bo: SKIP (0.000s)
[505.268201] [107/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[505.364099] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[511.941122] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.582s)
[512.056368] [108/133] (522s left) kms_force_connector_basic (force-load-detect)
[512.135493] Starting subtest: force-load-detect
[512.140565] Subtest force-load-detect: SKIP (0.000s)
[512.249337] [109/133] (521s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[512.355078] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[512.357296] Starting dynamic subtest: pipe-A-eDP-1
[512.429316] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[512.439643] Starting dynamic subtest: pipe-B-eDP-1
[513.583660] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[513.589511] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.231s)
[514.775085] [110/133] (519s left) gem_mmap_wc (coherency)
[514.830843] Subtest coherency: SKIP (0.000s)
[514.899979] [111/133] (519s left) kms_concurrent (multi-plane-atomic-lowres)
[514.995250] Starting subtest: multi-plane-atomic-lowres
[514.997727] Starting dynamic subtest: pipe-A-eDP-1
[515.488387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[515.498755] Starting dynamic subtest: pipe-B-eDP-1
[516.739522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s)
[516.754633] Starting dynamic subtest: pipe-C-eDP-1
[517.948658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[517.959761] Starting dynamic subtest: pipe-D-eDP-1
[519.159951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[519.162709] Subtest multi-plane-atomic-lowres: SUCCESS (4.164s)
[520.003259] [112/133] (514s left) gem_gtt_cpu_tlb
[520.123932] [113/133] (514s left) i915_module_load (reload-no-display)
[520.166436] Starting subtest: reload-no-display
[525.362177] Subtest reload-no-display: SUCCESS (5.202s)
[525.393020] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[525.393726] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[525.397339] [114/133] (509s left) i915_drm_fdinfo (idle)
[527.746268] Starting subtest: idle
[527.749003] Starting dynamic subtest: rcs0
[528.311575] Dynamic subtest rcs0: SUCCESS (0.564s)
[528.325100] Starting dynamic subtest: bcs0
[528.849644] Dynamic subtest bcs0: SUCCESS (0.536s)
[528.861820] Starting dynamic subtest: vcs0
[529.356053] Dynamic subtest vcs0: SUCCESS (0.503s)
[529.367851] Starting dynamic subtest: vcs1
[529.861629] Dynamic subtest vcs1: SUCCESS (0.503s)
[529.874409] Starting dynamic subtest: vecs0
[530.367385] Dynamic subtest vecs0: SUCCESS (0.503s)
[530.379232] Starting dynamic subtest: ccs0
[530.873635] Dynamic subtest ccs0: SUCCESS (0.504s)
[530.876813] Subtest idle: SUCCESS (3.128s)
[530.925070] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[530.926258] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[530.930208] [115/133] (503s left) dumb_buffer (create-clear)
[531.003126] Starting subtest: create-clear
[565.290069] Subtest create-clear: SUCCESS (34.289s)
[565.388220] [116/133] (469s left) kms_flip (flip-vs-fences-interruptible)
[565.478989] Starting subtest: flip-vs-fences-interruptible
[565.483685] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[565.591849] [117/133] (468s left) kms_big_fb (linear-8bpp-rotate-270)
[565.689120] Starting subtest: linear-8bpp-rotate-270
[565.724122] Subtest linear-8bpp-rotate-270: SKIP (0.035s)
[565.824224] [118/133] (468s left) gen9_exec_parse (bb-oversize)
[565.887655] Subtest bb-oversize: SKIP (0.000s)
[565.954648] [119/133] (468s left) gem_exec_schedule (smoketest)
[566.130664] Starting subtest: smoketest
[566.133245] Starting dynamic subtest: rcs0
[571.696413] Dynamic subtest rcs0: SUCCESS (5.517s)
[571.710620] Starting dynamic subtest: bcs0
[577.239162] Dynamic subtest bcs0: SUCCESS (5.533s)
[577.249836] Starting dynamic subtest: vcs0
[582.771644] Dynamic subtest vcs0: SUCCESS (5.527s)
[582.785707] Starting dynamic subtest: vcs1
[588.283452] Dynamic subtest vcs1: SUCCESS (5.518s)
[588.300048] Starting dynamic subtest: vecs0
[593.818906] Dynamic subtest vecs0: SUCCESS (5.531s)
[593.832878] Starting dynamic subtest: ccs0
[599.321530] Dynamic subtest ccs0: SUCCESS (5.504s)
[599.324370] Subtest smoketest: SUCCESS (33.139s)
[599.504382] [120/133] (435s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[599.713029] Starting subtest: cursor-rapid-movement-64x21
[599.762142] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[599.999253] [121/133] (434s left) gem_mmap (basic)
[600.047091] Subtest basic: SKIP (0.000s)
[600.107752] [122/133] (434s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[600.199254] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[600.834149] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[600.996569] [123/133] (433s left) gem_exec_balancer (hang)
[601.251470] Starting subtest: hang
[602.945733] Subtest hang: SUCCESS (1.698s)
[603.059937] [124/133] (431s left) gem_ctx_exec (basic-norecovery)
[603.114045] Starting subtest: basic-norecovery
[603.450102] Subtest basic-norecovery: SUCCESS (0.334s)
[603.574686] [125/133] (431s left) kms_hdr (static-toggle)
[603.677788] Starting subtest: static-toggle
[603.685791] Subtest static-toggle: SKIP (0.001s)
[603.751442] [126/133] (431s left) kms_properties (invalid-properties-legacy)
[603.848139] Starting subtest: invalid-properties-legacy
[603.944456] Subtest invalid-properties-legacy: SUCCESS (0.099s)
[604.020342] [127/133] (430s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[604.118500] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[608.394311] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.279s)
[609.556851] [128/133] (425s left) gem_workarounds (suspend-resume-context)
[609.624761] Starting subtest: suspend-resume-context
[626.083062] Subtest suspend-resume-context: SUCCESS (1.190s)
[627.227868] [129/133] (408s left) gem_exec_fence (keep-in-fence)
[627.429737] Starting subtest: keep-in-fence
[627.432133] Starting dynamic subtest: rcs0
[627.491591] Dynamic subtest rcs0: SUCCESS (0.065s)
[627.505142] Starting dynamic subtest: bcs0
[627.546758] Dynamic subtest bcs0: SUCCESS (0.053s)
[627.557994] Starting dynamic subtest: vcs0
[629.147246] Dynamic subtest vcs0: SUCCESS (1.597s)
[629.159144] Starting dynamic subtest: vcs1
[631.129981] Dynamic subtest vcs1: SUCCESS (1.980s)
[631.142892] Starting dynamic subtest: vecs0
[633.050342] Dynamic subtest vecs0: SUCCESS (1.921s)
[633.069126] Starting dynamic subtest: ccs0
[633.305288] Dynamic subtest ccs0: SUCCESS (0.255s)
[633.308153] Subtest keep-in-fence: SUCCESS (5.886s)
[635.192749] [130/133] (400s left) gem_mmap_gtt (hang-user)
[635.259581] Subtest hang-user: SKIP (0.000s)
[635.324875] [131/133] (400s left) kms_atomic_transition (plane-all-transition-fencing)
[635.415852] Starting subtest: plane-all-transition-fencing
[635.418086] Starting dynamic subtest: pipe-A-eDP-1
[637.898163] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[638.221075] Starting dynamic subtest: pipe-B-eDP-1
[641.423114] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[641.721141] Subtest plane-all-transition-fencing: SUCCESS (6.327s)
[642.541421] [132/133] (393s left) gem_pxp (protected-raw-src-copy-not-readible)
[642.663594] Starting subtest: protected-raw-src-copy-not-readible
[642.720675] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[642.839363] [133/133] (393s left) syncobj_wait (multi-wait-for-submit-submitted)
[642.895494] Starting subtest: multi-wait-for-submit-submitted
[642.995200] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[643.070017] 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.