[72.764110] Initializing watchdogs
[72.764175]   /dev/watchdog0
[72.784227] [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]
[72.792469] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.796033] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.799847] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[72.944175] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[72.946425] Starting dynamic subtest: pipe-A-eDP-1
[73.808812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s)
[73.816964] Starting dynamic subtest: pipe-B-eDP-1
[75.368101] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.556s)
[75.376754] Starting dynamic subtest: pipe-C-eDP-1
[76.930727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.560s)
[76.938530] Starting dynamic subtest: pipe-D-eDP-1
[78.422686] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[78.425046] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.469s)
[79.600031] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[79.701933] Starting subtest: fbc-pr-sprite-plane-move
[79.705935] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[79.767936] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[79.919978] Starting subtest: in-flight-contexts-immediate
[89.303948] Subtest in-flight-contexts-immediate: SUCCESS (9.382s)
[89.483164] [004/133] (943s left) kms_async_flips (async-flip-suspend-resume)
[89.577395] Starting subtest: async-flip-suspend-resume
[89.959385] Starting dynamic subtest: pipe-A-eDP-1
[107.634171] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.959s)
[108.017659] Starting dynamic subtest: pipe-B-eDP-1
[125.639792] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.876s)
[126.015831] Starting dynamic subtest: pipe-C-eDP-1
[143.653118] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.917s)
[144.027877] Starting dynamic subtest: pipe-D-eDP-1
[161.626367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.848s)
[161.629300] Subtest async-flip-suspend-resume: SUCCESS (13.098s)
[162.838459] [005/133] (870s left) kms_flip (modeset-vs-vblank-race)
[162.968277] Starting subtest: modeset-vs-vblank-race
[162.970792] Starting dynamic subtest: A-eDP1
[167.675589] Dynamic subtest A-eDP1: SUCCESS (4.691s)
[167.687054] Starting dynamic subtest: B-eDP1
[172.427037] Dynamic subtest B-eDP1: SUCCESS (4.740s)
[172.439903] Starting dynamic subtest: C-eDP1
[177.058451] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[177.070000] Starting dynamic subtest: D-eDP1
[181.692933] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[181.695343] Subtest modeset-vs-vblank-race: SUCCESS (18.692s)
[182.869853] [006/133] (850s left) kms_psr (pr-cursor-plane-move)
[182.964444] Starting subtest: pr-cursor-plane-move
[182.970415] Subtest pr-cursor-plane-move: SKIP (0.000s)
[183.034232] [007/133] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[183.134439] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[190.430357] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.295s)
[190.552845] [008/133] (843s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[190.664719] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[190.669361] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[190.761613] [009/133] (842s left) kms_atomic_transition (modeset-transition-nonblocking)
[190.850169] Starting subtest: modeset-transition-nonblocking
[190.852326] Starting dynamic subtest: 1x-outputs
[201.957430] Dynamic subtest 1x-outputs: SUCCESS (11.115s)
[201.960186] Subtest modeset-transition-nonblocking: SUCCESS (11.116s)
[202.809033] [010/133] (830s left) i915_power (sanity)
[202.869136] Starting subtest: sanity
[206.914924] Subtest sanity: SUCCESS (4.040s)
[208.226517] [011/133] (825s left) gem_exec_whisper (basic-queues-all)
[208.288278] Starting subtest: basic-queues-all
[220.004790] Subtest basic-queues-all: SUCCESS (11.714s)
[220.188451] [012/133] (813s left) drm_read (empty-nonblock)
[220.324566] Starting subtest: empty-nonblock
[220.326899] Subtest empty-nonblock: SUCCESS (0.000s)
[220.438913] [013/133] (813s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[220.525604] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[220.530039] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[220.596915] [014/133] (813s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[220.704511] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[220.708933] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[220.789515] [015/133] (813s left) kms_psr (psr-sprite-plane-move)
[220.877858] Starting subtest: psr-sprite-plane-move
[220.880200] Starting dynamic subtest: eDP-1
[222.644760] Dynamic subtest eDP-1: SUCCESS (1.766s)
[222.646690] Subtest psr-sprite-plane-move: SUCCESS (1.767s)
[223.469138] [016/133] (810s left) gem_exec_create (legacy)
[223.543212] Starting subtest: legacy
[223.545278] Starting dynamic subtest: smem
[225.633237] Dynamic subtest smem: SUCCESS (2.089s)
[225.636320] Subtest legacy: SUCCESS (2.091s)
[225.816029] [017/133] (808s left) perf (blocking)
[225.942868] Starting subtest: blocking
[225.945114] Starting dynamic subtest: 0-rcs0
[235.972303] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[235.983152] Starting dynamic subtest: 1-vecs0
[245.997078] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[245.999905] Subtest blocking: SUCCESS (20.048s)
[246.047639] [018/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[246.148663] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[246.152666] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[246.269769] [019/133] (787s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[246.355502] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[246.357702] Starting dynamic subtest: pipe-A-eDP-1
[247.081149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[247.090595] Starting dynamic subtest: pipe-B-eDP-1
[248.919713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.836s)
[248.929209] Starting dynamic subtest: pipe-C-eDP-1
[250.727586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.806s)
[250.738604] Starting dynamic subtest: pipe-D-eDP-1
[252.565170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[252.567122] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.201s)
[253.700045] [020/133] (780s left) kms_lease (lease-invalid-crtc)
[253.800589] Starting subtest: lease-invalid-crtc
[253.802925] Starting dynamic subtest: pipe-A-eDP-1
[253.805200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[253.818751] Starting dynamic subtest: pipe-B-eDP-1
[253.820731] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[253.832255] Starting dynamic subtest: pipe-C-eDP-1
[253.834455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[253.844282] Starting dynamic subtest: pipe-D-eDP-1
[253.846452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[253.848587] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[253.885411] [021/133] (780s left) kms_content_protection (atomic-hdcp14)
[254.018660] Starting subtest: atomic-hdcp14
[254.023166] Subtest atomic-hdcp14: SKIP (0.000s)
[254.155302] [022/133] (779s left) gem_ctx_sseu (invalid-args)
[254.217674] Subtest invalid-args: SKIP (0.000s)
[254.293988] [023/133] (779s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[254.355557] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[254.462853] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[254.537200] [024/133] (779s left) gem_lmem_swapping (parallel-random-engines)
[254.586013] Subtest parallel-random-engines: SKIP (0.000s)
[254.636565] [025/133] (779s left) gem_softpin (evict-prime)
[254.687351] Starting subtest: evict-prime
[254.689358] Starting dynamic subtest: rcs0
[255.850599] Dynamic subtest rcs0: SUCCESS (1.166s)
[255.862495] Starting dynamic subtest: bcs0
[256.968753] Dynamic subtest bcs0: SUCCESS (1.116s)
[256.979592] Starting dynamic subtest: vcs0
[258.143173] Dynamic subtest vcs0: SUCCESS (1.173s)
[258.156187] Starting dynamic subtest: vcs1
[260.127214] Dynamic subtest vcs1: SUCCESS (1.982s)
[260.139392] Starting dynamic subtest: vecs0
[262.169003] Dynamic subtest vecs0: SUCCESS (2.040s)
[262.181593] Starting dynamic subtest: ccs0
[263.295054] Dynamic subtest ccs0: SUCCESS (1.126s)
[263.307100] Starting dynamic subtest: all
[265.179320] Dynamic subtest all: SUCCESS (1.883s)
[265.181778] Subtest evict-prime: SUCCESS (10.496s)
[265.257959] [026/133] (769s left) kms_plane_lowres (tiling-none)
[265.361484] Starting subtest: tiling-none
[265.363864] Starting dynamic subtest: pipe-A-eDP-1
[265.368333] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.661549] Starting dynamic subtest: pipe-B-eDP-1
[265.666347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.676041] Starting dynamic subtest: pipe-C-eDP-1
[265.680779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.690330] Starting dynamic subtest: pipe-D-eDP-1
[265.694437] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.698488] Subtest tiling-none: SKIP (0.298s)
[266.513374] [027/133] (767s left) kms_draw_crc (draw-method-mmap-cpu)
[266.612703] Starting subtest: draw-method-mmap-cpu
[266.615053] Starting dynamic subtest: xrgb8888-untiled
[266.844529] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[266.854561] Starting dynamic subtest: rgb565-untiled
[267.088534] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[267.098411] Starting dynamic subtest: xrgb2101010-untiled
[267.299538] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[267.309243] Starting dynamic subtest: xbgr16161616f-untiled
[267.510543] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[267.519841] Starting dynamic subtest: xrgb8888-xtiled
[267.632492] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[267.642283] Starting dynamic subtest: rgb565-xtiled
[267.754697] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[267.766750] Starting dynamic subtest: xrgb2101010-xtiled
[267.876649] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[267.885371] Starting dynamic subtest: xbgr16161616f-xtiled
[268.010175] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[268.019273] Starting dynamic subtest: xrgb8888-4tiled
[268.187961] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.177s)
[268.198395] Starting dynamic subtest: rgb565-4tiled
[268.332406] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[268.343290] Starting dynamic subtest: xrgb2101010-4tiled
[268.454562] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[268.466984] Starting dynamic subtest: xbgr16161616f-4tiled
[268.588297] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[268.590181] Subtest draw-method-mmap-cpu: SUCCESS (1.978s)
[268.688059] [028/133] (765s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[268.752483] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[268.809285] [029/133] (765s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[268.906679] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[268.908670] Starting dynamic subtest: pipe-A-eDP-1
[269.002917] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[269.012253] Starting dynamic subtest: pipe-B-eDP-1
[270.183331] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s)
[270.187834] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.280s)
[271.360962] [030/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[271.466879] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[271.471206] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[271.566401] [031/133] (762s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[271.676976] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[271.681481] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[271.780355] [032/133] (762s left) kms_rotation_crc (primary-rotation-180)
[271.869035] Starting subtest: primary-rotation-180
[279.020846] Subtest primary-rotation-180: SUCCESS (7.155s)
[280.213190] [033/133] (754s left) kms_pm_rpm (universal-planes-dpms)
[282.351349] Starting subtest: universal-planes-dpms
[282.353872] Starting dynamic subtest: plane-35
[291.088302] Dynamic subtest plane-35: SUCCESS (8.740s)
[291.099704] Starting dynamic subtest: plane-65
[299.496487] Dynamic subtest plane-65: SUCCESS (8.404s)
[299.510096] Starting dynamic subtest: plane-95
[308.196196] Dynamic subtest plane-95: SUCCESS (8.696s)
[308.217273] Starting dynamic subtest: plane-125
[316.522710] Dynamic subtest plane-125: SUCCESS (8.324s)
[316.535311] Starting dynamic subtest: plane-135
[324.836294] Dynamic subtest plane-135: SUCCESS (8.309s)
[324.848488] Starting dynamic subtest: plane-145
[333.112299] Dynamic subtest plane-145: SUCCESS (8.272s)
[333.114906] Subtest universal-planes-dpms: SUCCESS (50.759s)
[333.500769] [034/133] (701s left) kms_pm_lpsp (kms-lpsp)
[334.599789] Starting subtest: kms-lpsp
[334.602095] Starting dynamic subtest: pipe-A-eDP-1
[334.745408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[335.045660] Subtest kms-lpsp: SUCCESS (0.447s)
[335.919171] [035/133] (698s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[336.315125] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[337.125227] [036/133] (697s left) api_intel_allocator (two-level-inception-interruptible)
[337.187856] Starting subtest: two-level-inception-interruptible
[342.596043] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[342.672073] [037/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[342.778496] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[342.783060] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[342.886221] [038/133] (691s left) gem_userptr_blits (huge-split)
[342.970699] Starting subtest: huge-split
[342.976393] Subtest huge-split: SUCCESS (0.008s)
[343.120110] [039/133] (691s left) gem_eio (in-flight-10ms)
[343.361240] Starting subtest: in-flight-10ms
[352.116576] Subtest in-flight-10ms: SUCCESS (8.752s)
[352.235686] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[352.239169] [040/133] (682s left) perf_pmu (pmu-read)
[352.284641] Starting subtest: pmu-read
[352.286977] Subtest pmu-read: SUCCESS (0.002s)
[352.388193] [041/133] (682s left) kms_properties (plane-properties-atomic)
[352.478136] Starting subtest: plane-properties-atomic
[352.480009] Starting dynamic subtest: pipe-A-eDP-1
[353.024178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[353.035081] Starting dynamic subtest: pipe-B-eDP-1
[354.316018] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[354.327406] Starting dynamic subtest: pipe-C-eDP-1
[355.551335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[355.562352] Starting dynamic subtest: pipe-D-eDP-1
[356.786089] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[356.788586] Subtest plane-properties-atomic: SUCCESS (4.309s)
[357.588612] [042/133] (677s left) gem_ctx_exec (basic-invalid-context)
[357.647862] Starting subtest: basic-invalid-context
[357.652602] Subtest basic-invalid-context: SUCCESS (0.004s)
[357.779443] [043/133] (677s left) gem_exec_params (rel-constants-invalid)
[357.830420] Starting subtest: rel-constants-invalid
[357.832787] Subtest rel-constants-invalid: SUCCESS (0.000s)
[357.923491] [044/133] (677s left) syncobj_wait (reset-multiple-signaled)
[357.974624] Starting subtest: reset-multiple-signaled
[357.976898] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[358.066164] [045/133] (677s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[358.164884] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[358.169391] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[358.265867] [046/133] (676s left) gem_ctx_persistence (legacy-engines-mixed)
[358.341384] Starting subtest: legacy-engines-mixed
[358.343598] Starting dynamic subtest: render
[358.416826] Dynamic subtest render: SUCCESS (0.076s)
[358.430288] Starting dynamic subtest: bsd1
[358.476167] Dynamic subtest bsd1: SUCCESS (0.057s)
[358.489383] Starting dynamic subtest: bsd2
[358.528428] Dynamic subtest bsd2: SUCCESS (0.050s)
[358.540023] Starting dynamic subtest: blt
[358.570025] Dynamic subtest blt: SUCCESS (0.039s)
[358.580605] Starting dynamic subtest: vebox
[358.610941] Dynamic subtest vebox: SUCCESS (0.039s)
[358.612955] Subtest legacy-engines-mixed: SUCCESS (0.273s)
[358.689140] [047/133] (676s left) gem_pread (display)
[358.744180] Subtest display: SKIP (0.000s)
[358.818032] [048/133] (676s left) fbdev (unaligned-write)
[358.853777] Starting subtest: unaligned-write
[359.024867] Subtest unaligned-write: SUCCESS (0.169s)
[359.099263] [049/133] (676s left) syncobj_timeline (device-signal-unordered)
[359.149297] Starting subtest: device-signal-unordered
[359.151503] Subtest device-signal-unordered: SUCCESS (0.001s)
[359.252426] [050/133] (676s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[359.350964] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[366.317125] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.967s)
[366.453929] [051/133] (668s left) kms_flip (2x-flip-vs-expired-vblank)
[366.550790] Starting subtest: 2x-flip-vs-expired-vblank
[366.559527] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[366.642132] [052/133] (668s left) kms_psr (psr2-sprite-render)
[366.743561] Starting subtest: psr2-sprite-render
[366.746517] Starting dynamic subtest: eDP-1
[368.491224] Dynamic subtest eDP-1: SUCCESS (1.748s)
[368.493449] Subtest psr2-sprite-render: SUCCESS (1.749s)
[369.358076] [053/133] (666s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[369.451502] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[369.453893] Starting dynamic subtest: pipe-A-eDP-1
[375.347929] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.901s)
[375.358042] Starting dynamic subtest: pipe-B-eDP-1
[382.006845] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[382.009222] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.557s)
[382.895876] [054/133] (652s left) drm_read (short-buffer-nonblock)
[383.044733] Starting subtest: short-buffer-nonblock
[383.047045] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[383.178536] [055/133] (652s left) gem_exec_schedule (pi-userfault)
[383.358372] Starting subtest: pi-userfault
[383.360479] Starting dynamic subtest: rcs0
[383.367985] Dynamic subtest rcs0: SUCCESS (0.014s)
[383.379798] Starting dynamic subtest: bcs0
[383.384359] Dynamic subtest bcs0: SUCCESS (0.014s)
[383.393867] Starting dynamic subtest: vcs0
[383.398887] Dynamic subtest vcs0: SUCCESS (0.012s)
[383.412583] Starting dynamic subtest: vcs1
[383.414654] Dynamic subtest vcs1: SUCCESS (0.009s)
[383.424150] Starting dynamic subtest: vecs0
[383.426320] Dynamic subtest vecs0: SUCCESS (0.008s)
[383.435376] Starting dynamic subtest: ccs0
[383.437282] Dynamic subtest ccs0: SUCCESS (0.009s)
[383.439170] Subtest pi-userfault: SUCCESS (0.072s)
[383.622637] [056/133] (651s left) i915_pm_rpm (sysfs-read)
[385.355326] Starting subtest: sysfs-read
[386.523189] Subtest sysfs-read: SUCCESS (1.165s)
[386.912397] [057/133] (648s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[387.007437] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[387.985849] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[388.130656] [058/133] (647s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[388.259142] Starting subtest: y-tiled-64bpp-rotate-270
[388.263930] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[388.371997] [059/133] (647s left) kms_psr (fbc-psr-primary-blt)
[388.480384] Starting subtest: fbc-psr-primary-blt
[388.482384] Starting dynamic subtest: eDP-1
[388.486078] Dynamic subtest eDP-1: SKIP (0.000s)
[388.489456] Subtest fbc-psr-primary-blt: SKIP (0.002s)
[388.560457] [060/133] (647s left) vgem_basic (dmabuf-export)
[388.610130] Starting subtest: dmabuf-export
[388.625247] Subtest dmabuf-export: SUCCESS (0.019s)
[388.737014] [061/133] (647s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[388.797342] Starting subtest: multi-wait-all-for-submit-available-signaled
[388.799312] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[388.894629] [062/133] (646s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[388.994773] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[389.006563] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[389.083256] [063/133] (646s left) syncobj_timeline (single-wait-all-available-submitted)
[389.135205] Starting subtest: single-wait-all-available-submitted
[389.137143] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[389.217329] [064/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[389.307915] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[389.311550] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[389.405654] [065/133] (646s left) kms_universal_plane (disable-primary-vs-flip)
[389.482233] Starting subtest: disable-primary-vs-flip
[389.484136] Starting dynamic subtest: pipe-A-eDP-1
[391.002506] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[391.013091] Starting dynamic subtest: pipe-B-eDP-1
[393.255369] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.253s)
[393.266138] Starting dynamic subtest: pipe-C-eDP-1
[395.488719] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.233s)
[395.499443] Starting dynamic subtest: pipe-D-eDP-1
[397.657606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[397.659906] Subtest disable-primary-vs-flip: SUCCESS (8.178s)
[398.463731] [066/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[398.563733] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[398.567940] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[398.649984] [067/133] (637s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[398.739176] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[398.752573] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.013s)
[398.835536] [068/133] (637s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[398.916821] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[398.921257] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[398.992584] [069/133] (637s left) vgem_basic (bad-handle)
[399.041562] Starting subtest: bad-handle
[399.043656] Subtest bad-handle: SUCCESS (0.000s)
[399.098733] [070/133] (637s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[399.188944] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[399.191122] Starting dynamic subtest: pipe-A-eDP-1
[399.213139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.225893] Starting dynamic subtest: pipe-B-eDP-1
[399.245899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.255072] Starting dynamic subtest: pipe-C-eDP-1
[399.276042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.285559] Starting dynamic subtest: pipe-D-eDP-1
[399.306525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.310347] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[401.430856] [071/133] (634s left) api_intel_bb (intel-bb-blit-x)
[401.493081] Starting subtest: intel-bb-blit-x
[405.053920] Subtest intel-bb-blit-x: SUCCESS (3.562s)
[405.168785] [072/133] (631s left) kms_cursor_crc (cursor-sliding-32x10)
[405.334356] Starting subtest: cursor-sliding-32x10
[405.377620] Subtest cursor-sliding-32x10: SKIP (0.039s)
[405.669752] [073/133] (630s left) prime_self_import (export-vs-gem_close-race)
[405.709111] Starting subtest: export-vs-gem_close-race
[410.774749] Subtest export-vs-gem_close-race: SUCCESS (5.066s)
[410.894289] [074/133] (625s left) perf (non-sampling-read-error)
[411.028268] Starting subtest: non-sampling-read-error
[411.039024] Subtest non-sampling-read-error: SUCCESS (0.009s)
[411.080925] [075/133] (625s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[411.195956] Starting subtest: bad-rotation-90-y-tiled-ccs
[411.198215] Starting dynamic subtest: pipe-A-eDP-1
[411.220490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.237692] Starting dynamic subtest: pipe-B-eDP-1
[411.258719] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.269417] Starting dynamic subtest: pipe-C-eDP-1
[411.289882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.299327] Starting dynamic subtest: pipe-D-eDP-1
[411.320144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.324298] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[413.490751] [076/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[413.575967] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[420.456630] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.884s)
[420.578203] [077/133] (615s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[420.636794] Starting subtest: invalid-bsd2-flag-on-blt
[420.639428] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[420.733089] [078/133] (615s left) kms_cursor_crc (cursor-onscreen-128x42)
[420.966292] Starting subtest: cursor-onscreen-128x42
[421.011849] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[421.218029] [079/133] (615s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[421.324853] Starting subtest: modeset-atomic-cursor-hotspot
[421.329236] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[421.470648] [080/133] (615s left) gem_render_copy (linear)
[421.517299] Starting subtest: linear
[421.519031] Starting dynamic subtest: smem
[421.556659] Dynamic subtest smem: SUCCESS (0.039s)
[421.558828] Subtest linear: SUCCESS (0.040s)
[421.739672] [081/133] (614s left) prime_self_import (basic-with_one_bo_two_files)
[421.777271] Starting subtest: basic-with_one_bo_two_files
[421.798656] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[421.926074] [082/133] (614s left) kms_chamelium_edid (hdmi-edid-read)
[422.318328] Subtest hdmi-edid-read: SKIP (0.000s)
[423.105293] [083/133] (613s left) gem_exec_params (readonly)
[423.165005] Starting subtest: readonly
[423.170117] Subtest readonly: SUCCESS (0.003s)
[423.281890] [084/133] (613s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[423.374386] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[423.376627] Starting dynamic subtest: pipe-A-default-mode
[424.493546] Dynamic subtest pipe-A-default-mode: SKIP (1.115s)
[424.497943] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.117s)
[424.649262] [085/133] (612s left) gem_mmap_gtt (cpuset-big-copy)
[424.704368] Subtest cpuset-big-copy: SKIP (0.000s)
[424.768235] [086/133] (612s left) sriov_basic (enable-vfs-autoprobe-on)
[424.821303] Starting subtest: enable-vfs-autoprobe-on
[424.823387] Starting dynamic subtest: numvfs-1
[424.902508] Dynamic subtest numvfs-1: FAIL (0.034s)
[424.914034] Starting dynamic subtest: numvfs-2
[424.986897] Dynamic subtest numvfs-2: FAIL (0.003s)
[424.999280] Starting dynamic subtest: numvfs-3
[425.071912] Dynamic subtest numvfs-3: FAIL (0.003s)
[425.082564] Starting dynamic subtest: numvfs-4
[425.154877] Dynamic subtest numvfs-4: FAIL (0.003s)
[425.165897] Starting dynamic subtest: numvfs-5
[425.237752] Dynamic subtest numvfs-5: FAIL (0.003s)
[425.249042] Starting dynamic subtest: numvfs-6
[425.322688] Dynamic subtest numvfs-6: FAIL (0.004s)
[425.333539] Starting dynamic subtest: numvfs-7
[425.405269] Dynamic subtest numvfs-7: FAIL (0.003s)
[425.416223] Starting dynamic subtest: numvfs-random
[425.476214] Dynamic subtest numvfs-random: FAIL (0.004s)
[425.485473] Starting dynamic subtest: numvfs-all
[425.545387] Dynamic subtest numvfs-all: FAIL (0.003s)
[425.547077] Subtest enable-vfs-autoprobe-on: FAIL (0.583s)
[425.585353] [087/133] (611s left) kms_plane_scaling (planes-downscale-factor-0-75)
[425.678715] Starting subtest: planes-downscale-factor-0-75
[425.680616] Starting dynamic subtest: pipe-A
[425.698870] Dynamic subtest pipe-A: SKIP (0.017s)
[425.708306] Starting dynamic subtest: pipe-B
[425.729645] Dynamic subtest pipe-B: SKIP (0.030s)
[425.742024] Starting dynamic subtest: pipe-C
[425.759638] Dynamic subtest pipe-C: SKIP (0.030s)
[425.769308] Starting dynamic subtest: pipe-D
[425.791773] Dynamic subtest pipe-D: SKIP (0.030s)
[425.795314] Subtest planes-downscale-factor-0-75: SKIP (0.110s)
[425.906432] [088/133] (610s left) kms_plane (plane-panning-top-left)
[425.993222] Starting subtest: plane-panning-top-left
[425.994940] Starting dynamic subtest: pipe-A
[427.726317] Dynamic subtest pipe-A: SUCCESS (1.733s)
[427.740143] Starting dynamic subtest: pipe-B
[430.115252] Dynamic subtest pipe-B: SUCCESS (2.385s)
[430.117675] Subtest plane-panning-top-left: SUCCESS (4.123s)
[430.990645] [089/133] (605s left) kms_plane_cursor (overlay)
[431.102549] Starting subtest: overlay
[431.107309] Starting dynamic subtest: pipe-A-eDP-1-size-64
[433.616191] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.512s)
[433.675691] Starting dynamic subtest: pipe-A-eDP-1-size-128
[436.228868] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[436.292408] Starting dynamic subtest: pipe-A-eDP-1-size-256
[438.685446] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.405s)
[439.035589] Starting dynamic subtest: pipe-B-eDP-1-size-64
[442.098647] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.074s)
[442.160106] Starting dynamic subtest: pipe-B-eDP-1-size-128
[444.578239] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.429s)
[444.637749] Starting dynamic subtest: pipe-B-eDP-1-size-256
[447.011488] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.383s)
[447.364709] Starting dynamic subtest: pipe-C-eDP-1-size-64
[450.047175] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.697s)
[450.087539] Starting dynamic subtest: pipe-C-eDP-1-size-128
[452.168475] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[452.206549] Starting dynamic subtest: pipe-C-eDP-1-size-256
[454.245028] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.047s)
[454.593586] Starting dynamic subtest: pipe-D-eDP-1-size-64
[457.333103] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.751s)
[457.372139] Starting dynamic subtest: pipe-D-eDP-1-size-128
[459.433688] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.070s)
[459.470860] Starting dynamic subtest: pipe-D-eDP-1-size-256
[461.543480] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[461.866209] Subtest overlay: SUCCESS (30.762s)
[462.716453] [090/133] (574s left) perf_pmu (busy)
[462.759958] Starting subtest: busy
[462.761900] Starting dynamic subtest: rcs0
[463.355782] Dynamic subtest rcs0: SUCCESS (0.597s)
[463.368846] Starting dynamic subtest: bcs0
[463.921255] Dynamic subtest bcs0: SUCCESS (0.563s)
[463.933854] Starting dynamic subtest: vcs0
[465.178797] Dynamic subtest vcs0: SUCCESS (1.254s)
[465.190547] Starting dynamic subtest: vcs1
[467.227386] Dynamic subtest vcs1: SUCCESS (2.045s)
[467.248560] Starting dynamic subtest: vecs0
[469.211096] Dynamic subtest vecs0: SUCCESS (1.980s)
[469.223834] Starting dynamic subtest: ccs0
[469.780132] Dynamic subtest ccs0: SUCCESS (0.567s)
[469.782715] Subtest busy: SUCCESS (7.022s)
[469.891228] [091/133] (567s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[469.994002] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[470.003707] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[470.080186] [092/133] (566s left) kms_frontbuffer_tracking (fbc-stridechange)
[470.169540] Starting subtest: fbc-stridechange
[473.390788] Subtest fbc-stridechange: SUCCESS (3.224s)
[474.519172] [093/133] (562s left) gem_pread (bench)
[474.579109] Subtest bench: SKIP (0.000s)
[474.638594] [094/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[474.726942] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[481.506074] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.781s)
[481.635185] [095/133] (555s left) syncobj_basic (bad-fd-to-handle)
[481.698510] Starting subtest: bad-fd-to-handle
[481.700865] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[481.813236] [096/133] (555s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[481.871908] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[481.874103] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[481.972367] [097/133] (555s left) perf (mi-rpc)
[482.079856] Starting subtest: mi-rpc
[482.084490] Subtest mi-rpc: SKIP (0.000s)
[482.126438] [098/133] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[482.233900] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[482.238196] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[482.337422] [099/133] (555s left) kms_vblank (ts-continuation-modeset-rpm)
[482.430723] Starting subtest: ts-continuation-modeset-rpm
[482.432659] Starting dynamic subtest: pipe-A-eDP-1
[484.906133] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.476s)
[484.921872] Starting dynamic subtest: pipe-D-eDP-1
[487.157292] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[487.159883] Subtest ts-continuation-modeset-rpm: SUCCESS (4.729s)
[487.961724] [100/133] (549s left) perf (non-system-wide-paranoid)
[488.051738] Starting subtest: non-system-wide-paranoid
[488.079875] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[488.123800] [101/133] (549s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[488.214616] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[488.216867] Starting dynamic subtest: pipe-A-eDP-1
[488.240489] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.251778] Starting dynamic subtest: pipe-B-eDP-1
[488.274528] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.284560] Starting dynamic subtest: pipe-C-eDP-1
[488.307498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.317057] Starting dynamic subtest: pipe-D-eDP-1
[488.341206] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.345274] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[490.529586] [102/133] (546s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[490.625125] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[499.927332] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.304s)
[500.053336] [103/133] (537s left) gem_softpin (allocator-basic)
[500.111165] Starting subtest: allocator-basic
[500.175006] Subtest allocator-basic: SUCCESS (0.064s)
[500.298748] [104/133] (537s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[500.401132] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[507.117483] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.718s)
[507.219002] [105/133] (530s left) syncobj_basic (create-signaled)
[507.287502] Starting subtest: create-signaled
[507.289935] Subtest create-signaled: SUCCESS (0.000s)
[507.402454] [106/133] (530s left) gem_mmap (basic-small-bo)
[507.463333] Subtest basic-small-bo: SKIP (0.000s)
[507.529515] [107/133] (530s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[507.626203] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[514.141105] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.517s)
[514.253188] [108/133] (523s left) kms_force_connector_basic (force-load-detect)
[514.329708] Starting subtest: force-load-detect
[514.334021] Subtest force-load-detect: SKIP (0.000s)
[514.460658] [109/133] (523s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[514.571389] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[514.573532] Starting dynamic subtest: pipe-A-eDP-1
[514.656631] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[514.667887] Starting dynamic subtest: pipe-B-eDP-1
[515.813248] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s)
[515.817313] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.247s)
[516.999480] [110/133] (520s left) gem_mmap_wc (coherency)
[517.071421] Subtest coherency: SKIP (0.000s)
[517.127104] [111/133] (520s left) kms_concurrent (multi-plane-atomic-lowres)
[517.223421] Starting subtest: multi-plane-atomic-lowres
[517.225569] Starting dynamic subtest: pipe-A-eDP-1
[517.736027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[517.746484] Starting dynamic subtest: pipe-B-eDP-1
[518.923417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.186s)
[518.934302] Starting dynamic subtest: pipe-C-eDP-1
[520.152835] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[520.162482] Starting dynamic subtest: pipe-D-eDP-1
[521.412193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[521.414476] Subtest multi-plane-atomic-lowres: SUCCESS (4.187s)
[522.226307] [112/133] (515s left) gem_gtt_cpu_tlb
[522.351326] [113/133] (515s left) i915_module_load (reload-no-display)
[522.390951] Starting subtest: reload-no-display
[526.678983] Subtest reload-no-display: SUCCESS (4.292s)
[526.707078] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[526.707799] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[526.711468] [114/133] (511s left) i915_drm_fdinfo (idle)
[528.224642] Starting subtest: idle
[528.226882] Starting dynamic subtest: rcs0
[528.798697] Dynamic subtest rcs0: SUCCESS (0.573s)
[528.810216] Starting dynamic subtest: bcs0
[529.335357] Dynamic subtest bcs0: SUCCESS (0.533s)
[529.346004] Starting dynamic subtest: vcs0
[529.841353] Dynamic subtest vcs0: SUCCESS (0.503s)
[529.851697] Starting dynamic subtest: vcs1
[530.347564] Dynamic subtest vcs1: SUCCESS (0.503s)
[530.359470] Starting dynamic subtest: vecs0
[530.853916] Dynamic subtest vecs0: SUCCESS (0.503s)
[530.865596] Starting dynamic subtest: ccs0
[531.359257] Dynamic subtest ccs0: SUCCESS (0.503s)
[531.362056] Subtest idle: SUCCESS (3.134s)
[531.411654] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[531.412825] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[531.416648] [115/133] (506s left) dumb_buffer (create-clear)
[531.483335] Starting subtest: create-clear
[565.716043] Subtest create-clear: SUCCESS (34.225s)
[565.834935] [116/133] (472s left) kms_flip (flip-vs-fences-interruptible)
[565.932046] Starting subtest: flip-vs-fences-interruptible
[565.936554] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[566.040295] [117/133] (472s left) kms_big_fb (linear-8bpp-rotate-270)
[566.132125] Starting subtest: linear-8bpp-rotate-270
[566.169704] Subtest linear-8bpp-rotate-270: SKIP (0.035s)
[566.275255] [118/133] (471s left) gen9_exec_parse (bb-oversize)
[566.343624] Subtest bb-oversize: SKIP (0.000s)
[566.430848] [119/133] (471s left) gem_exec_schedule (smoketest)
[566.609134] Starting subtest: smoketest
[566.611357] Starting dynamic subtest: rcs0
[572.148028] Dynamic subtest rcs0: SUCCESS (5.488s)
[572.170679] Starting dynamic subtest: bcs0
[577.658461] Dynamic subtest bcs0: SUCCESS (5.508s)
[577.677502] Starting dynamic subtest: vcs0
[583.156117] Dynamic subtest vcs0: SUCCESS (5.494s)
[583.169495] Starting dynamic subtest: vcs1
[588.666844] Dynamic subtest vcs1: SUCCESS (5.511s)
[588.684126] Starting dynamic subtest: vecs0
[594.175306] Dynamic subtest vecs0: SUCCESS (5.503s)
[594.185778] Starting dynamic subtest: ccs0
[599.687305] Dynamic subtest ccs0: SUCCESS (5.515s)
[599.689538] Subtest smoketest: SUCCESS (33.027s)
[599.826348] [120/133] (438s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[600.028916] Starting subtest: cursor-rapid-movement-64x21
[600.079451] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[600.326650] [121/133] (438s left) gem_mmap (basic)
[600.378118] Subtest basic: SKIP (0.000s)
[600.437211] [122/133] (437s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[600.531664] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[601.144921] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[601.328302] [123/133] (437s left) gem_exec_balancer (hang)
[601.592865] Starting subtest: hang
[603.262399] Subtest hang: SUCCESS (1.673s)
[603.374229] [124/133] (435s left) gem_ctx_exec (basic-norecovery)
[603.437179] Starting subtest: basic-norecovery
[603.766951] Subtest basic-norecovery: SUCCESS (0.330s)
[603.896391] [125/133] (434s left) kms_hdr (static-toggle)
[603.987644] Starting subtest: static-toggle
[603.993788] Subtest static-toggle: SKIP (0.000s)
[604.076091] [126/133] (434s left) kms_properties (invalid-properties-legacy)
[604.160322] Starting subtest: invalid-properties-legacy
[604.261543] Subtest invalid-properties-legacy: SUCCESS (0.102s)
[604.338404] [127/133] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[604.423221] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[608.481840] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.061s)
[609.639689] [128/133] (428s left) gem_workarounds (suspend-resume-context)
[609.700984] Starting subtest: suspend-resume-context
[625.612218] Subtest suspend-resume-context: SUCCESS (1.154s)
[625.759169] [129/133] (412s left) gem_exec_fence (keep-in-fence)
[625.942681] Starting subtest: keep-in-fence
[625.944714] Starting dynamic subtest: rcs0
[625.993235] Dynamic subtest rcs0: SUCCESS (0.053s)
[626.005244] Starting dynamic subtest: bcs0
[626.046978] Dynamic subtest bcs0: SUCCESS (0.052s)
[626.058942] Starting dynamic subtest: vcs0
[627.971277] Dynamic subtest vcs0: SUCCESS (1.912s)
[627.984052] Starting dynamic subtest: vcs1
[629.950756] Dynamic subtest vcs1: SUCCESS (1.969s)
[629.963414] Starting dynamic subtest: vecs0
[631.998540] Dynamic subtest vecs0: SUCCESS (2.039s)
[632.011283] Starting dynamic subtest: ccs0
[632.234287] Dynamic subtest ccs0: SUCCESS (0.234s)
[632.237173] Subtest keep-in-fence: SUCCESS (6.274s)
[634.070727] [130/133] (404s left) gem_mmap_gtt (hang-user)
[634.116099] Subtest hang-user: SKIP (0.000s)
[634.182839] [131/133] (404s left) kms_atomic_transition (plane-all-transition-fencing)
[634.283979] Starting subtest: plane-all-transition-fencing
[634.286286] Starting dynamic subtest: pipe-A-eDP-1
[636.781865] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[637.090870] Starting dynamic subtest: pipe-B-eDP-1
[640.361691] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.277s)
[640.661998] Subtest plane-all-transition-fencing: SUCCESS (6.370s)
[641.487884] [132/133] (397s left) gem_pxp (protected-raw-src-copy-not-readible)
[641.621062] Starting subtest: protected-raw-src-copy-not-readible
[641.676330] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.058s)
[641.791586] [133/133] (397s left) syncobj_wait (multi-wait-for-submit-submitted)
[641.863761] Starting subtest: multi-wait-for-submit-submitted
[641.969537] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[642.046771] 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.