[54.449580] Initializing watchdogs
[54.449625]   /dev/watchdog0
[54.464541] [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]
[54.468911] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.471252] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.474357] [001/131] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[54.592066] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[54.594257] Starting dynamic subtest: pipe-A-eDP-1
[54.603102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[54.609848] Starting dynamic subtest: pipe-B-eDP-1
[54.618448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[54.626231] Starting dynamic subtest: pipe-C-eDP-1
[54.634746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[54.640832] Starting dynamic subtest: pipe-D-eDP-1
[54.649359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[54.653626] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[56.798744] [002/131] (958s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[56.917157] Starting subtest: cursorB-vs-flipA-varying-size
[56.921870] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[57.057737] [003/131] (957s left) gem_exec_balancer (invalid-balancer)
[57.123049] Starting subtest: invalid-balancer
[58.016584] Subtest invalid-balancer: SUCCESS (0.903s)
[58.322861] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[58.416668] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[58.420815] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[58.530009] [005/131] (956s left) kms_feature_discovery (dp-mst)
[58.624525] Starting subtest: dp-mst
[58.628522] Subtest dp-mst: SKIP (0.000s)
[58.694216] [006/131] (956s left) kms_atomic_transition (plane-all-transition)
[58.789090] Starting subtest: plane-all-transition
[58.791437] Starting dynamic subtest: pipe-A-eDP-1
[61.270879] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[61.584304] Starting dynamic subtest: pipe-B-eDP-1
[64.769266] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s)
[65.066146] Subtest plane-all-transition: SUCCESS (6.319s)
[65.877578] [007/131] (949s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[65.928992] Starting subtest: etime-multi-wait-all-for-submit-submitted
[66.031805] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[66.101676] [008/131] (949s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[66.200718] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[66.212096] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[66.328314] [009/131] (948s left) prime_mmap (test_forked)
[66.388263] Starting subtest: test_forked
[66.390153] Starting dynamic subtest: test_forked-smem
[66.427727] Dynamic subtest test_forked-smem: SUCCESS (0.042s)
[66.430094] Subtest test_forked: SUCCESS (0.042s)
[66.544504] [010/131] (948s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[66.641964] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[66.644349] Starting dynamic subtest: pipe-A-default-mode
[66.941730] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[66.946309] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.298s)
[67.801447] [011/131] (947s left) gem_exec_balancer (bonded-sync)
[67.860800] Starting subtest: bonded-sync
[67.865433] Subtest bonded-sync: SKIP (0.000s)
[68.165809] [012/131] (947s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[68.251139] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[68.253509] Starting dynamic subtest: pipe-A-eDP-1
[68.276732] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.285725] Starting dynamic subtest: pipe-B-eDP-1
[68.307169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.313742] Starting dynamic subtest: pipe-C-eDP-1
[68.335664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.342256] Starting dynamic subtest: pipe-D-eDP-1
[68.364913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.369130] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[70.447218] [013/131] (944s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[70.547261] Starting subtest: fbc-psr-cursor-mmap-gtt
[70.549614] Starting dynamic subtest: eDP-1
[70.553788] Dynamic subtest eDP-1: SKIP (0.000s)
[70.557997] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[70.616808] [014/131] (944s left) syncobj_wait (multi-wait-for-submit-signaled)
[70.680224] Starting subtest: multi-wait-for-submit-signaled
[70.682567] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[70.788651] [015/131] (944s left) perf_pmu (module-unload)
[70.889782] Starting subtest: module-unload
[77.048086] Subtest module-unload: FAIL (6.060s)
[77.087463] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[77.090283] [016/131] (938s left) kms_vblank (wait-forked)
[78.569995] Starting subtest: wait-forked
[78.571961] Starting dynamic subtest: pipe-A-eDP-1
[80.405881] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s)
[80.420111] Starting dynamic subtest: pipe-D-eDP-1
[82.905839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.499s)
[82.908328] Subtest wait-forked: SUCCESS (4.339s)
[83.771103] [FACT kms_vblank (wait-forked)] new: kernel.kmod_is_loaded.i915: true
[83.774800] [017/131] (931s left) gem_exec_schedule (preempt-queue-contexts-chain)
[83.855796] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[84.140306] [018/131] (931s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[84.254454] Starting subtest: yf-tiled-64bpp-rotate-180
[84.258587] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[84.371046] [019/131] (931s left) kms_color (invalid-gamma-lut-sizes)
[84.480054] Starting subtest: invalid-gamma-lut-sizes
[84.482242] Starting dynamic subtest: pipe-A
[84.781251] Dynamic subtest pipe-A: SUCCESS (0.300s)
[84.791264] Starting dynamic subtest: pipe-B
[84.793733] Dynamic subtest pipe-B: SUCCESS (0.001s)
[84.800631] Starting dynamic subtest: pipe-C
[84.802980] Dynamic subtest pipe-C: SUCCESS (0.001s)
[84.810328] Starting dynamic subtest: pipe-D
[84.812189] Dynamic subtest pipe-D: SUCCESS (0.001s)
[84.814061] Subtest invalid-gamma-lut-sizes: SUCCESS (0.303s)
[85.592836] [020/131] (930s left) i915_drm_fdinfo (busy)
[85.629845] Starting subtest: busy
[85.631814] Starting dynamic subtest: rcs0
[85.646861] Dynamic subtest rcs0: SKIP (0.017s)
[85.655967] Starting dynamic subtest: bcs0
[85.662689] Dynamic subtest bcs0: SKIP (0.015s)
[85.671842] Starting dynamic subtest: vcs0
[85.676306] Dynamic subtest vcs0: SKIP (0.000s)
[85.682953] Starting dynamic subtest: vcs1
[85.687225] Dynamic subtest vcs1: SKIP (0.000s)
[85.694075] Starting dynamic subtest: vecs0
[85.698297] Dynamic subtest vecs0: SKIP (0.000s)
[85.706159] Starting dynamic subtest: ccs0
[85.710251] Dynamic subtest ccs0: SKIP (0.000s)
[85.714310] Subtest busy: SKIP (0.034s)
[85.749091] [021/131] (929s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[85.814931] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[85.818980] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[86.005270] [022/131] (929s left) kms_lease (setcrtc-implicit-plane)
[86.099035] Starting subtest: setcrtc-implicit-plane
[86.101464] Starting dynamic subtest: pipe-A-eDP-1
[86.580180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[86.588647] Starting dynamic subtest: pipe-B-eDP-1
[87.720367] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[87.729568] Starting dynamic subtest: pipe-C-eDP-1
[88.821818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[88.830495] Starting dynamic subtest: pipe-D-eDP-1
[89.943471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[89.945407] Subtest setcrtc-implicit-plane: SUCCESS (3.842s)
[90.790728] [023/131] (925s left) i915_hangman (engine-engine-error)
[90.865769] Starting subtest: engine-engine-error
[90.868044] Starting dynamic subtest: rcs0
[92.855591] Dynamic subtest rcs0: SUCCESS (1.989s)
[92.866386] Starting dynamic subtest: bcs0
[94.901066] Dynamic subtest bcs0: SUCCESS (2.044s)
[94.913086] Starting dynamic subtest: vcs0
[96.882308] Dynamic subtest vcs0: SUCCESS (1.980s)
[96.890921] Starting dynamic subtest: vcs1
[98.866656] Dynamic subtest vcs1: SUCCESS (1.983s)
[98.878529] Starting dynamic subtest: vecs0
[100.849743] Dynamic subtest vecs0: SUCCESS (1.982s)
[100.858141] Starting dynamic subtest: ccs0
[102.897564] Dynamic subtest ccs0: SUCCESS (2.046s)
[102.899736] Subtest engine-engine-error: SUCCESS (12.031s)
[102.978172] [024/131] (912s left) gem_mmap_gtt (medium-copy)
[103.044746] Subtest medium-copy: SKIP (0.000s)
[103.111691] [025/131] (912s left) kms_pipe_crc_basic (suspend-read-crc)
[103.216307] Starting subtest: suspend-read-crc
[103.218480] Starting dynamic subtest: pipe-A-eDP-1
[121.624668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.626s)
[121.635342] Starting dynamic subtest: pipe-B-eDP-1
[139.329395] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.793s)
[139.338533] Starting dynamic subtest: pipe-C-eDP-1
[157.238432] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.658s)
[157.247771] Starting dynamic subtest: pipe-D-eDP-1
[175.246115] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.697s)
[175.248426] Subtest suspend-read-crc: SUCCESS (10.777s)
[176.053209] [026/131] (839s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[176.146143] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[176.148420] Starting dynamic subtest: pipe-A
[176.168451] Dynamic subtest pipe-A: SKIP (0.017s)
[176.178127] Starting dynamic subtest: pipe-B
[176.199783] Dynamic subtest pipe-B: SKIP (0.032s)
[176.207564] Starting dynamic subtest: pipe-C
[176.229567] Dynamic subtest pipe-C: SKIP (0.031s)
[176.237179] Starting dynamic subtest: pipe-D
[176.261529] Dynamic subtest pipe-D: SKIP (0.031s)
[176.265772] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.112s)
[176.349820] [027/131] (839s left) kms_atomic_interruptible (legacy-cursor)
[176.448959] Starting subtest: legacy-cursor
[176.451142] Starting dynamic subtest: pipe-A-eDP-1
[183.823669] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.514s)
[183.825936] Subtest legacy-cursor: SUCCESS (7.515s)
[184.646016] [028/131] (831s left) kms_draw_crc (draw-method-blt)
[184.741126] Starting subtest: draw-method-blt
[184.743282] Starting dynamic subtest: xrgb8888-untiled
[184.960848] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s)
[184.969180] Starting dynamic subtest: rgb565-untiled
[185.168769] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[185.180468] Starting dynamic subtest: xrgb2101010-untiled
[185.367280] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[185.375352] Starting dynamic subtest: xbgr16161616f-untiled
[185.565255] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[185.573296] Starting dynamic subtest: xrgb8888-xtiled
[185.675422] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[185.683969] Starting dynamic subtest: rgb565-xtiled
[185.774101] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s)
[185.781961] Starting dynamic subtest: xrgb2101010-xtiled
[185.862085] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.088s)
[185.870242] Starting dynamic subtest: xbgr16161616f-xtiled
[185.972425] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[185.980417] Starting dynamic subtest: xrgb8888-4tiled
[186.093208] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[186.100820] Starting dynamic subtest: rgb565-4tiled
[186.203333] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[186.211520] Starting dynamic subtest: xrgb2101010-4tiled
[186.302935] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.100s)
[186.310878] Starting dynamic subtest: xbgr16161616f-4tiled
[186.402119] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[186.404126] Subtest draw-method-blt: SUCCESS (1.679s)
[186.536051] [029/131] (829s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[186.600227] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[186.681046] [030/131] (829s left) gem_pread (exhaustion)
[186.729466] Subtest exhaustion: SKIP (0.000s)
[186.782027] [031/131] (829s left) kms_vblank (ts-continuation-idle-hang)
[186.881878] Starting subtest: ts-continuation-idle-hang
[186.883754] Starting dynamic subtest: pipe-A-eDP-1
[213.052785] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.214s)
[213.070015] Starting dynamic subtest: pipe-D-eDP-1
[238.071365] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.007s)
[238.073629] Subtest ts-continuation-idle-hang: SUCCESS (51.225s)
[238.934913] [032/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[239.056691] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[239.060877] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[239.161927] [033/131] (777s left) gem_userptr_blits (map-fixed-invalidate)
[239.244912] Starting subtest: map-fixed-invalidate
[239.249438] Subtest map-fixed-invalidate: SKIP (0.000s)
[239.389510] [034/131] (776s left) gem_exec_reloc (basic-cpu-wc)
[239.460010] Subtest basic-cpu-wc: SKIP (0.000s)
[239.525317] [035/131] (776s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[239.622255] Starting subtest: fbc-psr-sprite-mmap-gtt
[239.624355] Starting dynamic subtest: eDP-1
[239.628579] Dynamic subtest eDP-1: SKIP (0.000s)
[239.632949] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[239.692176] [036/131] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[239.801077] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[240.469052] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[240.643103] [037/131] (775s left) gem_set_tiling_vs_gtt
[240.768813] [038/131] (775s left) kms_async_flips (test-time-stamp-atomic)
[240.869231] Starting subtest: test-time-stamp-atomic
[241.250041] Starting dynamic subtest: pipe-A-eDP-1
[242.036237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[242.411600] Starting dynamic subtest: pipe-B-eDP-1
[243.156529] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[243.517882] Starting dynamic subtest: pipe-C-eDP-1
[244.277932] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[244.641285] Starting dynamic subtest: pipe-D-eDP-1
[245.398582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[245.400985] Subtest test-time-stamp-atomic: SUCCESS (4.531s)
[246.543780] [039/131] (769s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[246.643972] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[246.648178] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[246.763981] [040/131] (769s left) kms_flip (basic-flip-vs-modeset)
[246.862328] Starting subtest: basic-flip-vs-modeset
[246.864645] Starting dynamic subtest: A-eDP1
[249.432829] Dynamic subtest A-eDP1: SUCCESS (2.568s)
[249.441948] Starting dynamic subtest: B-eDP1
[251.585780] Dynamic subtest B-eDP1: SUCCESS (2.153s)
[251.595410] Starting dynamic subtest: C-eDP1
[253.644131] Dynamic subtest C-eDP1: SUCCESS (2.055s)
[253.653156] Starting dynamic subtest: D-eDP1
[255.794179] Dynamic subtest D-eDP1: SUCCESS (2.152s)
[255.796367] Subtest basic-flip-vs-modeset: SUCCESS (8.937s)
[256.583591] [041/131] (759s left) gem_mmap_gtt (basic)
[256.643881] Subtest basic: SKIP (0.000s)
[256.711252] [042/131] (759s left) kms_properties (crtc-properties-atomic)
[256.806300] Starting subtest: crtc-properties-atomic
[256.808715] Starting dynamic subtest: pipe-A-eDP-1
[257.248243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[257.256974] Starting dynamic subtest: pipe-B-eDP-1
[258.436883] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[258.449833] Starting dynamic subtest: pipe-C-eDP-1
[259.544540] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[259.553837] Starting dynamic subtest: pipe-D-eDP-1
[260.674720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[260.677073] Subtest crtc-properties-atomic: SUCCESS (3.869s)
[261.472333] [043/131] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[261.582078] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[261.586420] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[261.687745] [044/131] (754s left) syncobj_wait (multi-wait-submitted)
[261.748883] Starting subtest: multi-wait-submitted
[261.857150] Subtest multi-wait-submitted: SUCCESS (0.107s)
[261.936170] [045/131] (754s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[262.043472] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[262.045732] Starting dynamic subtest: pipe-A-eDP-1
[262.069018] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.079737] Starting dynamic subtest: pipe-B-eDP-1
[262.101316] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.109691] Starting dynamic subtest: pipe-C-eDP-1
[262.130916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.139038] Starting dynamic subtest: pipe-D-eDP-1
[262.160797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.164857] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[264.228304] [046/131] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[264.337559] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[264.341600] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[264.439575] [047/131] (752s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[264.547805] Starting subtest: y-tiled-16bpp-rotate-180
[264.552151] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[264.654084] [048/131] (752s left) kms_big_fb (linear-32bpp-rotate-180)
[264.755035] Starting subtest: linear-32bpp-rotate-180
[266.135798] Subtest linear-32bpp-rotate-180: SUCCESS (1.380s)
[266.285748] [049/131] (750s left) kms_chamelium_color (ctm-0-75)
[266.373876] Subtest ctm-0-75: SKIP (0.000s)
[266.417104] [050/131] (750s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[266.513161] Starting subtest: plane-use-after-nonblocking-unbind
[266.515231] Starting dynamic subtest: pipe-A-eDP-1
[266.585449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[266.890715] Starting dynamic subtest: pipe-B-eDP-1
[267.730313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.848s)
[268.028398] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.515s)
[268.885882] [051/131] (747s left) sw_sync (sync_busy)
[268.923131] Starting subtest: sync_busy
[268.925470] Subtest sync_busy: SUCCESS (0.002s)
[268.975128] [052/131] (747s left) gem_mmap_gtt (big-copy-odd)
[269.040786] Subtest big-copy-odd: SKIP (0.000s)
[269.106366] [053/131] (747s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[269.172661] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[269.177347] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[269.355718] [054/131] (747s left) kms_concurrent (multi-plane-atomic-lowres)
[269.458253] Starting subtest: multi-plane-atomic-lowres
[269.460150] Starting dynamic subtest: pipe-A-eDP-1
[269.960313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[269.962634] Subtest multi-plane-atomic-lowres: SUCCESS (0.503s)
[270.813771] [055/131] (746s left) syncobj_timeline (invalid-transfer-illegal-handle)
[270.860130] Starting subtest: invalid-transfer-illegal-handle
[270.862475] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[270.946271] [056/131] (746s left) kms_psr (psr2-sprite-blt)
[271.045367] Starting subtest: psr2-sprite-blt
[271.047676] Starting dynamic subtest: eDP-1
[272.706692] Dynamic subtest eDP-1: SUCCESS (1.661s)
[272.708914] Subtest psr2-sprite-blt: SUCCESS (1.662s)
[273.565201] [057/131] (743s left) kms_sequence (get-forked)
[273.661328] Starting subtest: get-forked
[273.663596] Starting dynamic subtest: pipe-A-eDP-1
[275.530156] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s)
[275.540122] Starting dynamic subtest: pipe-B-eDP-1
[278.105253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[278.115334] Starting dynamic subtest: pipe-C-eDP-1
[280.610940] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.504s)
[280.621810] Starting dynamic subtest: pipe-D-eDP-1
[283.131249] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.515s)
[283.133449] Subtest get-forked: SUCCESS (9.464s)
[283.960486] [058/131] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[284.064402] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[284.068493] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[284.182930] [059/131] (732s left) kms_psr (psr2-cursor-render)
[284.287409] Starting subtest: psr2-cursor-render
[284.289655] Starting dynamic subtest: eDP-1
[285.946854] Dynamic subtest eDP-1: SUCCESS (1.659s)
[285.949086] Subtest psr2-cursor-render: SUCCESS (1.659s)
[286.727383] [060/131] (730s left) kms_properties (connector-properties-legacy)
[286.818426] Starting subtest: connector-properties-legacy
[286.820771] Starting dynamic subtest: pipe-A-eDP-1
[294.460956] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.639s)
[294.469946] Starting dynamic subtest: pipe-None-DP-1
[294.474578] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[294.482859] Starting dynamic subtest: pipe-None-HDMI-A-1
[294.487582] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[294.495819] Starting dynamic subtest: pipe-None-DP-2
[294.499806] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[294.507599] Starting dynamic subtest: pipe-None-HDMI-A-2
[294.511637] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[294.519487] Starting dynamic subtest: pipe-None-DP-3
[294.523497] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[294.531317] Starting dynamic subtest: pipe-None-DP-4
[294.535391] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[294.537254] Subtest connector-properties-legacy: SUCCESS (7.652s)
[295.317490] [061/131] (721s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[295.415492] Starting subtest: plane-scaler-unity-scaling-with-rotation
[295.417931] Starting dynamic subtest: pipe-A
[295.646638] Dynamic subtest pipe-A: SUCCESS (0.231s)
[295.656167] Starting dynamic subtest: pipe-B
[296.893276] Dynamic subtest pipe-B: SUCCESS (1.246s)
[296.901819] Starting dynamic subtest: pipe-C
[298.223952] Dynamic subtest pipe-C: SUCCESS (1.330s)
[298.233905] Starting dynamic subtest: pipe-D
[299.547455] Dynamic subtest pipe-D: SUCCESS (1.323s)
[299.549712] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.132s)
[300.712457] [062/131] (716s left) kms_chamelium_hpd (hdmi-hpd)
[301.117321] Subtest hdmi-hpd: SKIP (0.000s)
[301.925513] [063/131] (715s left) kms_prop_blob (invalid-set-prop)
[301.979346] Starting subtest: invalid-set-prop
[301.981763] Subtest invalid-set-prop: SUCCESS (0.000s)
[302.081584] [064/131] (715s left) kms_cursor_crc (cursor-suspend)
[302.214852] Starting subtest: cursor-suspend
[302.217181] Starting dynamic subtest: pipe-A-eDP-1
[335.167331] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.090s)
[335.178858] Starting dynamic subtest: pipe-D-eDP-1
[368.107276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.585s)
[368.109531] Subtest cursor-suspend: SUCCESS (6.677s)
[368.889984] [065/131] (648s left) gem_ccs (ctrl-surf-copy-new-ctx)
[368.949080] Starting subtest: ctrl-surf-copy-new-ctx
[368.953782] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[369.064738] [066/131] (648s left) kms_cursor_crc (cursor-onscreen-512x170)
[369.335619] Starting subtest: cursor-onscreen-512x170
[369.339816] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[369.477998] [067/131] (647s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[374.354849] Starting subtest: psr2-plane-move-sf-dmg-area
[374.357347] Starting dynamic subtest: pipe-A-eDP-1
[379.575465] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.270s)
[379.583982] Starting dynamic subtest: pipe-B-eDP-1
[384.841042] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.295s)
[384.843371] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.570s)
[385.700543] [068/131] (631s left) gem_exec_create (basic)
[385.773745] Starting subtest: basic
[385.776073] Starting dynamic subtest: smem
[389.630885] Dynamic subtest smem: SUCCESS (3.866s)
[389.633264] Subtest basic: SUCCESS (3.868s)
[389.814394] [069/131] (627s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[389.917648] Starting subtest: fbcpsr-rgb565-draw-pwrite
[396.926282] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.022s)
[397.037615] [070/131] (620s left) gem_mmap_wc (write-wc-read-gtt)
[397.104115] Subtest write-wc-read-gtt: SKIP (0.000s)
[397.155295] [071/131] (620s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[402.159160] Starting subtest: fbc-psr2-cursor-plane-update-sf
[402.161662] Starting dynamic subtest: pipe-A-eDP-1
[402.938564] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s)
[402.948406] Starting dynamic subtest: pipe-B-eDP-1
[404.061320] Dynamic subtest pipe-B-eDP-1: SKIP (1.116s)
[404.065785] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.894s)
[405.232047] [072/131] (612s left) kms_rotation_crc (sprite-rotation-180)
[405.319025] Starting subtest: sprite-rotation-180
[410.214793] Subtest sprite-rotation-180: SUCCESS (4.891s)
[411.375845] [073/131] (606s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[412.899157] Starting subtest: gem-execbuf-stress-pc8
[412.952955] Subtest gem-execbuf-stress-pc8: SKIP (0.052s)
[413.608254] [074/131] (604s left) gem_exec_schedule (noreorder)
[413.786990] Starting subtest: noreorder
[413.789427] Starting dynamic subtest: rcs0
[413.875942] Dynamic subtest rcs0: SUCCESS (0.089s)
[413.887686] Starting dynamic subtest: vcs0
[415.659520] Dynamic subtest vcs0: SUCCESS (1.780s)
[415.671317] Starting dynamic subtest: vcs1
[417.692697] Dynamic subtest vcs1: SUCCESS (2.031s)
[417.704851] Starting dynamic subtest: vecs0
[419.677342] Dynamic subtest vecs0: SUCCESS (1.983s)
[419.688611] Starting dynamic subtest: ccs0
[419.769652] Dynamic subtest ccs0: SUCCESS (0.091s)
[419.772569] Subtest noreorder: SUCCESS (5.983s)
[419.953442] [075/131] (597s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[420.008759] Starting subtest: multi-wait-for-submit-available-signaled
[420.011192] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[420.125282] [076/131] (597s left) gem_ctx_persistence (saturated-hostile)
[420.191963] Starting subtest: saturated-hostile
[420.194479] Starting dynamic subtest: rcs0
[421.059205] Dynamic subtest rcs0: SUCCESS (0.866s)
[421.069694] Starting dynamic subtest: bcs0
[421.869890] Dynamic subtest bcs0: SUCCESS (0.809s)
[421.881431] Starting dynamic subtest: vcs0
[422.694135] Dynamic subtest vcs0: SUCCESS (0.822s)
[422.705900] Starting dynamic subtest: vcs1
[423.493993] Dynamic subtest vcs1: SUCCESS (0.795s)
[423.502715] Starting dynamic subtest: vecs0
[424.313774] Dynamic subtest vecs0: SUCCESS (0.822s)
[424.325139] Starting dynamic subtest: ccs0
[425.164858] Dynamic subtest ccs0: SUCCESS (0.850s)
[425.167284] Subtest saturated-hostile: SUCCESS (4.973s)
[425.242284] [077/131] (592s left) gem_exec_params (invalid-batch-start-offset)
[425.311401] Starting subtest: invalid-batch-start-offset
[425.317035] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[425.450898] [078/131] (592s left) kms_psr2_su (frontbuffer-xrgb8888)
[425.511951] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[425.574665] [079/131] (592s left) kms_invalid_mode (bad-vsync-end)
[425.674429] Starting subtest: bad-vsync-end
[425.676803] Starting dynamic subtest: pipe-A-eDP-1
[425.955447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[425.965370] Starting dynamic subtest: pipe-B-eDP-1
[425.967385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[425.977764] Starting dynamic subtest: pipe-C-eDP-1
[425.980126] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[425.988507] Starting dynamic subtest: pipe-D-eDP-1
[425.990673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[425.992868] Subtest bad-vsync-end: SUCCESS (0.288s)
[426.822452] [080/131] (591s left) gem_exec_fence (nb-await)
[427.007983] Starting subtest: nb-await
[427.010357] Starting dynamic subtest: rcs0
[427.079950] Dynamic subtest rcs0: SUCCESS (0.071s)
[427.095042] Starting dynamic subtest: bcs0
[427.139439] Dynamic subtest bcs0: SUCCESS (0.058s)
[427.150426] Starting dynamic subtest: vcs0
[427.198218] Dynamic subtest vcs0: SUCCESS (0.057s)
[427.209591] Starting dynamic subtest: vcs1
[427.256752] Dynamic subtest vcs1: SUCCESS (0.057s)
[427.266374] Starting dynamic subtest: vecs0
[427.315981] Dynamic subtest vecs0: SUCCESS (0.057s)
[427.327077] Starting dynamic subtest: ccs0
[427.373919] Dynamic subtest ccs0: SUCCESS (0.056s)
[427.376389] Subtest nb-await: SUCCESS (0.367s)
[428.751201] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[428.754771] [081/131] (589s left) kms_addfb_basic (bad-pitch-32)
[428.811329] Starting subtest: bad-pitch-32
[428.813195] Subtest bad-pitch-32: SUCCESS (0.000s)
[428.940819] [082/131] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[429.049356] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[429.053319] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[429.162710] [083/131] (588s left) gem_close (basic)
[429.217500] Starting subtest: basic
[429.219852] Subtest basic: SUCCESS (0.000s)
[429.320061] [084/131] (588s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[429.435642] Starting subtest: 2x-cursor-vs-flip-atomic
[429.440042] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[429.580487] [085/131] (588s left) intel_hwmon (hwmon-read)
[429.637865] Subtest hwmon-read: SKIP (0.000s)
[429.704896] [086/131] (588s left) kms_frontbuffer_tracking (psr-1p-rte)
[429.797652] Starting subtest: psr-1p-rte
[435.187523] Subtest psr-1p-rte: SUCCESS (5.392s)
[435.344326] [087/131] (582s left) drm_read (invalid-buffer)
[435.499613] Starting subtest: invalid-buffer
[435.502069] Subtest invalid-buffer: SUCCESS (0.000s)
[435.651636] [088/131] (582s left) kms_cursor_edge_walk (64x64-top-bottom)
[435.740528] Starting subtest: 64x64-top-bottom
[435.742819] Starting dynamic subtest: pipe-A-eDP-1
[439.179813] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[439.193838] Starting dynamic subtest: pipe-D-eDP-1
[442.298768] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[442.300983] Subtest 64x64-top-bottom: SUCCESS (6.557s)
[443.094215] [089/131] (575s left) gem_mmap_wc (read-write-distinct)
[443.157461] Subtest read-write-distinct: SKIP (0.000s)
[443.214739] [090/131] (575s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[443.273010] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[443.378584] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[443.458160] [091/131] (574s left) kms_getfb (getfb2-accept-nv12)
[443.560552] Starting subtest: getfb2-accept-nv12
[443.562925] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[443.686656] [092/131] (574s left) kms_getfb (getfb-handle-not-fb)
[443.783336] Starting subtest: getfb-handle-not-fb
[443.785539] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[443.889029] [093/131] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[443.992943] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[443.997420] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[444.123168] [094/131] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[444.227365] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[447.923198] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.702s)
[449.074451] [095/131] (569s left) prime_vgem (coherency-blt)
[449.164733] Starting subtest: coherency-blt
[450.258074] Subtest coherency-blt: SUCCESS (1.093s)
[450.388501] [096/131] (568s left) gem_ctx_persistence (engines-hostile-preempt)
[450.437980] Starting subtest: engines-hostile-preempt
[450.440307] Starting dynamic subtest: rcs0
[450.570129] Dynamic subtest rcs0: SUCCESS (0.131s)
[450.582050] Starting dynamic subtest: bcs0
[450.604064] Dynamic subtest bcs0: SUCCESS (0.032s)
[450.613106] Starting dynamic subtest: vcs0
[452.663427] Dynamic subtest vcs0: SUCCESS (2.057s)
[452.675995] Starting dynamic subtest: vcs1
[454.673685] Dynamic subtest vcs1: SUCCESS (2.009s)
[454.686748] Starting dynamic subtest: vecs0
[456.620546] Dynamic subtest vecs0: SUCCESS (1.946s)
[456.631444] Starting dynamic subtest: ccs0
[456.693656] Dynamic subtest ccs0: SUCCESS (0.073s)
[456.696063] Subtest engines-hostile-preempt: SUCCESS (6.257s)
[456.820497] [097/131] (561s left) syncobj_timeline (wait-zero-handles)
[456.868914] Starting subtest: wait-zero-handles
[456.871152] Subtest wait-zero-handles: SUCCESS (0.000s)
[456.969512] [098/131] (561s left) syncobj_timeline (wait-all-delayed-signal)
[457.022574] Starting subtest: wait-all-delayed-signal
[457.125258] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[457.204206] [099/131] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[457.312926] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[464.208158] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.899s)
[464.331186] [100/131] (554s left) gem_exec_schedule (u-semaphore-resolve)
[464.398225] Starting subtest: u-semaphore-resolve
[464.428569] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[464.785287] [101/131] (554s left) kms_properties (get_properties-sanity-non-atomic)
[464.886534] Starting subtest: get_properties-sanity-non-atomic
[464.888839] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[464.962005] [102/131] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[465.067675] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[465.071888] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[465.177739] [103/131] (553s left) kms_pm_rpm (cursor-dpms)
[466.804952] Starting subtest: cursor-dpms
[466.810278] Subtest cursor-dpms: SKIP (0.000s)
[467.490789] [104/131] (551s left) device_reset (unbind-reset-rebind)
[467.538664] Starting subtest: unbind-reset-rebind
[472.240206] Subtest unbind-reset-rebind: SUCCESS (4.694s)
[472.283105] [105/131] (546s left) kms_frontbuffer_tracking (psr-suspend)
[472.380320] Starting subtest: psr-suspend
[511.125477] Subtest psr-suspend: SUCCESS (7.802s)
[511.245407] [106/131] (507s left) api_intel_allocator (fork-simple-stress-signal)
[511.311867] Starting subtest: fork-simple-stress-signal
[516.585091] Subtest fork-simple-stress-signal: SUCCESS (5.401s)
[516.713103] [107/131] (502s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[516.826014] Starting subtest: 4-tiled-64bpp-rotate-90
[516.845571] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[516.942324] [108/131] (502s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[517.069840] Starting subtest: cursor-vs-flip-atomic
[546.417625] Subtest cursor-vs-flip-atomic: SUCCESS (29.437s)
[547.213180] [109/131] (471s left) gem_exec_params (no-bsd)
[547.274981] Starting subtest: no-bsd
[547.280531] Subtest no-bsd: SUCCESS (0.003s)
[548.683902] [110/131] (470s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[548.785254] Starting subtest: fbc-rgb565-draw-mmap-wc
[552.837288] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.059s)
[553.988353] [111/131] (465s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[554.085802] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[554.088131] Starting dynamic subtest: pipe-A-eDP-1
[554.573838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[554.584599] Starting dynamic subtest: pipe-B-eDP-1
[555.968907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[555.980694] Starting dynamic subtest: pipe-C-eDP-1
[557.366499] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[557.376342] Starting dynamic subtest: pipe-D-eDP-1
[558.696157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[558.698379] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.584s)
[559.888657] [112/131] (459s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[559.978813] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[559.980958] Starting dynamic subtest: pipe-A-eDP-1
[560.005248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.017453] Starting dynamic subtest: pipe-B-eDP-1
[560.039290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.048964] Starting dynamic subtest: pipe-C-eDP-1
[560.070272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.079204] Starting dynamic subtest: pipe-D-eDP-1
[560.100881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.104923] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[562.219387] [113/131] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[562.323746] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[568.957340] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.640s)
[569.091599] [114/131] (450s left) prime_mmap_coherency (read)
[569.147359] Starting subtest: read
[574.521739] Subtest read: SUCCESS (5.376s)
[574.658534] [115/131] (444s left) gem_ctx_param (invalid-get-engines)
[574.725847] Starting subtest: invalid-get-engines
[574.728099] Subtest invalid-get-engines: SUCCESS (0.001s)
[574.840950] [116/131] (444s left) perf (gen12-mi-rpc)
[574.960877] Starting subtest: gen12-mi-rpc
[574.963095] Starting dynamic subtest: rcs0
[574.980548] Dynamic subtest rcs0: SUCCESS (0.017s)
[574.982863] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[575.030367] [117/131] (444s left) kms_busy (extended-modeset-hang-newfb)
[575.132673] Starting subtest: extended-modeset-hang-newfb
[575.134955] Starting dynamic subtest: pipe-A
[609.535024] Dynamic subtest pipe-A: SUCCESS (34.398s)
[609.545902] Starting dynamic subtest: pipe-D
[632.558119] Dynamic subtest pipe-D: SUCCESS (23.019s)
[632.560546] Subtest extended-modeset-hang-newfb: SUCCESS (57.422s)
[633.349282] [118/131] (386s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[633.411323] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[633.475982] [119/131] (386s left) drm_mm (drm_mm)
[633.512251] Starting subtest: drm_mm
[633.547533] Starting dynamic subtest: drm_test_mm_init
[633.684595] Dynamic subtest drm_test_mm_init: SUCCESS (0.136s)
[633.695889] Starting dynamic subtest: drm_test_mm_debug
[633.824193] Dynamic subtest drm_test_mm_debug: SUCCESS (0.135s)
[633.835615] Starting dynamic subtest: drm_test_mm_align32
[633.951514] Dynamic subtest drm_test_mm_align32: SUCCESS (0.128s)
[633.962886] Starting dynamic subtest: drm_test_mm_align64
[634.120949] Dynamic subtest drm_test_mm_align64: SUCCESS (0.169s)
[634.132743] Starting dynamic subtest: drm_test_mm_lowest
[634.255318] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.134s)
[634.264587] Starting dynamic subtest: drm_test_mm_highest
[634.363466] Dynamic subtest drm_test_mm_highest: SUCCESS (0.108s)
[634.365400] Subtest drm_mm: SUCCESS (0.854s)
[634.555619] [120/131] (385s left) api_intel_bb (intel-bb-blit-y)
[634.604694] Starting subtest: intel-bb-blit-y
[638.359000] Subtest intel-bb-blit-y: SUCCESS (3.755s)
[638.486738] [121/131] (381s left) perf (create-destroy-userspace-config)
[638.575092] Starting subtest: create-destroy-userspace-config
[638.592985] Subtest create-destroy-userspace-config: SUCCESS (0.015s)
[638.643915] [122/131] (381s left) gem_spin_batch (resubmit)
[638.708392] Starting subtest: resubmit
[638.710727] Starting dynamic subtest: rcs0
[638.720185] Dynamic subtest rcs0: SUCCESS (0.011s)
[638.732249] Starting dynamic subtest: bcs0
[638.734492] Dynamic subtest bcs0: SUCCESS (0.003s)
[638.751407] Starting dynamic subtest: vcs0
[638.753799] Dynamic subtest vcs0: SUCCESS (0.004s)
[638.765771] Starting dynamic subtest: vcs1
[638.767949] Dynamic subtest vcs1: SUCCESS (0.003s)
[638.777795] Starting dynamic subtest: vecs0
[638.780042] Dynamic subtest vecs0: SUCCESS (0.005s)
[638.790353] Starting dynamic subtest: ccs0
[638.792682] Dynamic subtest ccs0: SUCCESS (0.006s)
[638.794848] Subtest resubmit: SUCCESS (0.035s)
[638.994827] [123/131] (380s left) perf (rc6-disable)
[639.079570] Starting subtest: rc6-disable
[639.265447] Subtest rc6-disable: SUCCESS (0.185s)
[639.318482] [124/131] (380s left) kms_plane_alpha_blend (constant-alpha-min)
[639.420745] Starting subtest: constant-alpha-min
[639.705789] Starting dynamic subtest: pipe-A-eDP-1
[640.407949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[640.418907] Starting dynamic subtest: pipe-D-eDP-1
[641.894678] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.485s)
[641.896943] Subtest constant-alpha-min: SUCCESS (2.472s)
[642.693511] [125/131] (377s left) kms_big_fb (linear-addfb)
[642.801660] Starting subtest: linear-addfb
[642.803956] Subtest linear-addfb: SUCCESS (0.000s)
[642.912435] [126/131] (376s left) gem_create (create-invalid-size)
[642.969040] Starting subtest: create-invalid-size
[642.971299] Subtest create-invalid-size: SUCCESS (0.000s)
[643.150123] [127/131] (376s left) gem_vm_create (isolation)
[643.206213] Starting subtest: isolation
[643.214973] Subtest isolation: SUCCESS (0.009s)
[643.347916] [128/131] (376s left) gem_huc_copy (huc-copy)
[643.411636] Starting subtest: huc-copy
[643.417928] Subtest huc-copy: SUCCESS (0.003s)
[643.572618] [129/131] (376s left) gem_lmem_swapping (heavy-verify-random)
[643.610749] Subtest heavy-verify-random: SKIP (0.000s)
[643.657181] [130/131] (376s left) i915_pm_rpm (system-suspend-execbuf)
[645.790367] Starting subtest: system-suspend-execbuf
[706.743819] Subtest system-suspend-execbuf: SUCCESS (45.337s)
[707.101000] [131/131] (312s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[707.196990] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[707.200960] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[707.299220] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: i915_hangman
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_pipe_crc_basic
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_atomic_interruptible
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_pread
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_set_tiling_vs_gtt
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_concurrent
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_properties
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_prop_blob
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_exec_create
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_psr2_su
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_close
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: intel_hwmon
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_getfb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_vgem
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_mmap_coherency
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_busy
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: drm_mm
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: gem_vm_create
results: parsing output: 127/ for test: gem_huc_copy
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.