[65.377918] Initializing watchdogs
[65.378000]   /dev/watchdog0
[65.408885] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.423102] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.428148] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.431888] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[67.030461] Starting subtest: dp-mst-lic-type-0-hdcp14
[67.033318] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[67.282709] [002/133] (958s left) core_getversion (all-cards)
[67.330720] Starting subtest: all-cards
[67.346766] Subtest all-cards: SUCCESS (0.020s)
[67.410478] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[68.903840] Starting subtest: legacy-dpms
[68.905244] Starting dynamic subtest: pipe-A-HDMI-A-4
[75.096462] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.160s)
[75.097965] Subtest legacy-dpms: SUCCESS (6.162s)
[75.278318] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[76.766525] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[76.775970] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[76.908859] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[78.419707] Starting subtest: plane-primary-toggle-with-vblank-wait
[78.421121] Starting dynamic subtest: pipe-A-HDMI-A-4
[78.645932] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.224s)
[78.788716] Starting dynamic subtest: pipe-B-HDMI-A-4
[79.017653] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.240s)
[79.074923] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.654s)
[79.306068] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[80.801149] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[80.804120] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[81.046961] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[82.551779] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[82.624736] [008/133] (943s left) perf (invalid-oa-exponent)
[82.795347] Starting subtest: invalid-oa-exponent
[82.821540] Subtest invalid-oa-exponent: SUCCESS (0.026s)
[82.895767] [009/133] (943s left) gem_eio (create-ext)
[83.034172] Starting subtest: create-ext
[83.218799] Subtest create-ext: SUCCESS (0.185s)
[84.829499] [010/133] (941s left) kms_color (invalid-degamma-lut-sizes)
[86.319203] Starting subtest: invalid-degamma-lut-sizes
[86.320785] Starting dynamic subtest: pipe-A
[86.364713] Dynamic subtest pipe-A: SUCCESS (0.046s)
[86.373951] Starting dynamic subtest: pipe-B
[86.375564] Dynamic subtest pipe-B: SUCCESS (0.001s)
[86.384617] Starting dynamic subtest: pipe-C
[86.386143] Dynamic subtest pipe-C: SUCCESS (0.001s)
[86.395123] Starting dynamic subtest: pipe-D
[86.396722] Dynamic subtest pipe-D: SUCCESS (0.001s)
[86.398265] Subtest invalid-degamma-lut-sizes: SUCCESS (0.049s)
[86.562142] [011/133] (940s left) gem_softpin (allocator-basic)
[86.610950] Starting subtest: allocator-basic
[86.874484] Subtest allocator-basic: SUCCESS (0.260s)
[87.037163] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[88.526970] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[88.595177] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[90.105698] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[91.248769] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.138s)
[91.491873] [014/133] (935s left) kms_psr (pr-primary-render)
[92.977384] Subtest pr-primary-render: SKIP (0.000s)
[93.049439] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[94.541784] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[94.544831] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.757159] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[96.247324] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[96.319278] [017/133] (930s left) gem_ccs (ctrl-surf-copy)
[96.372448] Starting subtest: ctrl-surf-copy
[96.375844] Subtest ctrl-surf-copy: SKIP (0.000s)
[96.528900] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[96.690007] Starting subtest: invalid-oa-metric-set-id
[96.710465] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[96.770954] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[98.264563] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[98.267721] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.519452] [020/133] (929s left) gem_pxp (create-regular-buffer)
[101.090564] Starting subtest: create-regular-buffer
[101.094393] Subtest create-regular-buffer: SKIP (0.000s)
[101.213997] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[101.350744] Starting subtest: in-flight-contexts-10ms
[114.874563] Subtest in-flight-contexts-10ms: SUCCESS (13.520s)
[116.478501] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[118.011854] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[118.014657] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[118.243312] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[118.302156] Starting subtest: u-fairslice-all
[120.377822] Subtest u-fairslice-all: SUCCESS (2.075s)
[120.859386] [024/133] (907s left) core_getstats (basic)
[120.907177] Starting subtest: basic
[120.908856] Subtest basic: SUCCESS (0.000s)
[121.067642] [025/133] (906s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[122.554427] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[122.556114] Starting dynamic subtest: pipe-A-HDMI-A-4
[122.572961] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[122.583024] Starting dynamic subtest: pipe-B-HDMI-A-4
[122.596674] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[122.605839] Starting dynamic subtest: pipe-C-HDMI-A-4
[122.618864] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[122.627848] Starting dynamic subtest: pipe-D-HDMI-A-4
[122.641286] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[122.643901] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[122.817380] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[124.299277] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[124.300830] Starting dynamic subtest: pipe-A-HDMI-A-4
[124.316595] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[124.326385] Starting dynamic subtest: pipe-B-HDMI-A-4
[124.342246] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[124.351680] Starting dynamic subtest: pipe-C-HDMI-A-4
[124.367888] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[124.377394] Starting dynamic subtest: pipe-D-HDMI-A-4
[124.394284] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[124.397756] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[124.566457] [027/133] (903s left) sw_sync (alloc_fence)
[124.611693] Starting subtest: alloc_fence
[124.613510] Subtest alloc_fence: SUCCESS (0.000s)
[124.747819] [028/133] (903s left) i915_pm_rps (basic-api)
[124.798518] Starting subtest: basic-api
[124.802547] Subtest basic-api: SKIP (0.000s)
[124.980614] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[126.464570] Starting subtest: cursorB-vs-flipA-toggle
[126.467786] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[126.664427] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[128.333854] Starting subtest: cursor-rapid-movement-128x42
[128.340753] Starting dynamic subtest: pipe-A-HDMI-A-4
[128.770305] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.430s)
[128.801264] Starting dynamic subtest: pipe-D-HDMI-A-4
[129.112162] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.317s)
[129.113764] Subtest cursor-rapid-movement-128x42: SUCCESS (0.776s)
[129.594035] [031/133] (898s left) kms_dp_link_training (non-uhbr-sst)
[131.076296] Starting subtest: non-uhbr-sst
[131.081435] Subtest non-uhbr-sst: SKIP (0.000s)
[131.280509] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[132.773661] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[132.776889] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.022028] [033/133] (895s left) gem_exec_parallel (engines)
[133.078385] Starting subtest: engines
[133.080104] Starting dynamic subtest: basic
[134.696851] Dynamic subtest basic: SUCCESS (1.618s)
[134.706842] Starting dynamic subtest: contexts
[139.303769] Dynamic subtest contexts: SUCCESS (4.603s)
[139.313528] Starting dynamic subtest: fds
[143.560295] Dynamic subtest fds: SUCCESS (4.255s)
[143.570999] Starting dynamic subtest: userptr
[145.095901] Dynamic subtest userptr: SUCCESS (1.538s)
[145.097478] Subtest engines: SUCCESS (12.017s)
[145.458901] [034/133] (883s left) gem_eio (in-flight-immediate)
[145.664396] Starting subtest: in-flight-immediate
[150.236026] Subtest in-flight-immediate: SUCCESS (4.575s)
[151.888398] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[151.894078] [035/133] (877s left) prime_mmap (test_forked)
[151.938528] Starting subtest: test_forked
[151.939872] Starting dynamic subtest: test_forked-smem
[152.007656] Dynamic subtest test_forked-smem: SUCCESS (0.070s)
[152.017653] Starting dynamic subtest: test_forked-lmem0
[152.079995] Dynamic subtest test_forked-lmem0: SUCCESS (0.072s)
[152.081482] Subtest test_forked: SUCCESS (0.143s)
[152.295639] [036/133] (876s left) kms_dsc (dsc-with-formats)
[153.778050] Starting subtest: dsc-with-formats
[153.805203] Subtest dsc-with-formats: SKIP (0.002s)
[153.984406] [037/133] (875s left) prime_busy (hang)
[154.033025] Starting subtest: hang
[154.034688] Starting dynamic subtest: rcs0
[180.407118] Dynamic subtest rcs0: SUCCESS (26.374s)
[180.417114] Starting dynamic subtest: bcs0
[187.556119] Dynamic subtest bcs0: SUCCESS (7.149s)
[187.566235] Starting dynamic subtest: vcs0
[194.596300] Dynamic subtest vcs0: SUCCESS (7.041s)
[194.606255] Starting dynamic subtest: vcs1
[201.571051] Dynamic subtest vcs1: SUCCESS (6.974s)
[201.581933] Starting dynamic subtest: vecs0
[208.547278] Dynamic subtest vecs0: SUCCESS (6.974s)
[208.549040] Subtest hang: SUCCESS (54.515s)
[208.775991] [038/133] (820s left) kms_vblank (wait-idle)
[210.260959] Starting subtest: wait-idle
[210.262438] Starting dynamic subtest: pipe-A-HDMI-A-4
[212.597685] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.337s)
[212.610708] Starting dynamic subtest: pipe-D-HDMI-A-4
[214.768961] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.167s)
[214.770621] Subtest wait-idle: SUCCESS (4.510s)
[214.973791] [039/133] (814s left) kms_pm_rpm (package-g7)
[219.090589] Starting subtest: package-g7
[219.095518] Subtest package-g7: SKIP (0.000s)
[220.104259] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[221.589847] Starting subtest: flip-vs-cursor-varying-size
[236.031588] Subtest flip-vs-cursor-varying-size: SUCCESS (14.442s)
[236.237635] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[237.729675] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[237.732618] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[237.960941] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[238.006802] Starting subtest: single-wait-all-for-submit-signaled
[238.008408] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[238.189736] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[238.356048] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[238.382700] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[238.446931] [044/133] (791s left) gem_wait (busy)
[238.509109] Starting subtest: busy
[238.511211] Starting dynamic subtest: all-engines
[239.084036] Dynamic subtest all-engines: SUCCESS (0.575s)
[239.095056] Starting dynamic subtest: rcs0
[239.622288] Dynamic subtest rcs0: SUCCESS (0.538s)
[239.632494] Starting dynamic subtest: bcs0
[240.161324] Dynamic subtest bcs0: SUCCESS (0.538s)
[240.171575] Starting dynamic subtest: vcs0
[240.701349] Dynamic subtest vcs0: SUCCESS (0.539s)
[240.711756] Starting dynamic subtest: vcs1
[241.240325] Dynamic subtest vcs1: SUCCESS (0.538s)
[241.250655] Starting dynamic subtest: vecs0
[241.778310] Dynamic subtest vecs0: SUCCESS (0.537s)
[241.779733] Subtest busy: SUCCESS (3.270s)
[242.052217] [045/133] (787s left) gen9_exec_parse (bb-secure)
[242.104785] Subtest bb-secure: SKIP (0.000s)
[242.178180] [046/133] (787s left) kms_cursor_edge_walk (128x128-right-edge)
[243.661096] Starting subtest: 128x128-right-edge
[243.662509] Starting dynamic subtest: pipe-A-HDMI-A-4
[246.990628] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.328s)
[247.003518] Starting dynamic subtest: pipe-D-HDMI-A-4
[250.207849] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.214s)
[250.209304] Subtest 128x128-right-edge: SUCCESS (6.547s)
[250.430780] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[251.921194] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[251.923982] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.171196] [048/133] (778s left) prime_mmap (test_forked_cpu_write)
[252.233936] Starting subtest: test_forked_cpu_write
[252.235461] Starting dynamic subtest: test_forked_cpu_write-smem
[252.244926] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[252.255349] Starting dynamic subtest: test_forked_cpu_write-lmem0
[252.256814] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[252.258276] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[252.472855] [049/133] (777s left) kms_addfb_basic (small-bo)
[253.958373] Starting subtest: small-bo
[253.959894] Subtest small-bo: SUCCESS (0.000s)
[254.224561] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[255.759442] Subtest dp-audio: SKIP (0.000s)
[255.868246] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[257.396747] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[257.506201] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[258.996439] Starting subtest: psr-shrfb-scaledprimary
[258.999423] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[259.237349] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[260.722542] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[260.725519] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[260.913606] [054/133] (770s left) perf (i915-ref-count)
[261.073720] Starting subtest: i915-ref-count
[261.111204] Subtest i915-ref-count: SUCCESS (0.036s)
[261.189258] [055/133] (769s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.674373] Starting subtest: invalid-modeset-force-big-joiner
[262.676919] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[262.856567] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[264.342130] Starting subtest: cursor-alpha-opaque
[264.343773] Starting dynamic subtest: pipe-A-HDMI-A-4
[265.033160] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.691s)
[265.043508] Starting dynamic subtest: pipe-D-HDMI-A-4
[265.436532] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.402s)
[265.438104] Subtest cursor-alpha-opaque: SUCCESS (1.097s)
[266.147638] [057/133] (765s left) kms_legacy_colorkey (basic)
[267.651486] Starting subtest: basic
[267.652894] Starting dynamic subtest: pipe-A
[267.745550] Dynamic subtest pipe-A: SUCCESS (0.096s)
[267.763502] Starting dynamic subtest: pipe-B
[267.765421] Dynamic subtest pipe-B: SUCCESS (0.001s)
[267.791820] Starting dynamic subtest: pipe-C
[267.793878] Dynamic subtest pipe-C: SUCCESS (0.001s)
[267.825861] Starting dynamic subtest: pipe-D
[267.827878] Dynamic subtest pipe-D: SUCCESS (0.001s)
[267.829989] Subtest basic: SUCCESS (0.103s)
[267.979611] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[269.482030] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[269.484759] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.728225] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[269.773674] Starting subtest: bad-pitch-32
[269.775091] Subtest bad-pitch-32: SUCCESS (0.000s)
[271.429083] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[271.502628] Starting subtest: x-tiled-to-vebox-y-tiled
[271.503979] Starting dynamic subtest: smem
[271.581211] Dynamic subtest smem: SUCCESS (0.081s)
[271.591647] Starting dynamic subtest: lmem0
[272.338888] Dynamic subtest lmem0: SUCCESS (0.754s)
[272.340617] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.836s)
[272.613220] [061/133] (759s left) gem_exec_reloc (basic-range)
[272.665160] Subtest basic-range: SKIP (0.000s)
[272.777583] [062/133] (758s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[274.278969] Starting subtest: yf-tiled-64bpp-rotate-0
[274.282236] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[274.513565] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[274.561156] Starting subtest: wait-all-for-submit-snapshot
[274.642257] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[274.823410] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[276.307417] Starting subtest: invalid-async-flip
[276.543961] Starting dynamic subtest: pipe-A-HDMI-A-4
[276.960051] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s)
[277.140398] Starting dynamic subtest: pipe-B-HDMI-A-4
[277.226710] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.095s)
[277.400803] Starting dynamic subtest: pipe-C-HDMI-A-4
[277.500028] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.108s)
[277.653701] Starting dynamic subtest: pipe-D-HDMI-A-4
[277.750954] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.106s)
[277.752896] Subtest invalid-async-flip: SUCCESS (1.446s)
[278.168938] [065/133] (753s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[279.657041] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[279.665451] Starting dynamic subtest: A-HDMI-A4
[280.433865] Dynamic subtest A-HDMI-A4: SUCCESS (0.768s)
[280.444445] Starting dynamic subtest: B-HDMI-A4
[281.106972] Dynamic subtest B-HDMI-A4: SUCCESS (0.672s)
[281.117385] Starting dynamic subtest: C-HDMI-A4
[281.781995] Dynamic subtest C-HDMI-A4: SUCCESS (0.673s)
[281.792802] Starting dynamic subtest: D-HDMI-A4
[282.455843] Dynamic subtest D-HDMI-A4: SUCCESS (0.674s)
[282.457328] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.799s)
[282.677962] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[284.172528] Starting subtest: fbc-suspend
[330.235680] Subtest fbc-suspend: SUCCESS (22.740s)
[334.552891] [067/133] (701s left) syncobj_timeline (invalid-transfer-bad-pad)
[334.602670] Starting subtest: invalid-transfer-bad-pad
[334.604160] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[334.719408] [068/133] (701s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[336.222030] Starting subtest: 4-tiled-64bpp-rotate-90
[336.225609] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[336.499883] [069/133] (700s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[336.551104] Starting subtest: saturated-hostile-nopreempt
[336.552778] Starting dynamic subtest: rcs0
[337.391159] Dynamic subtest rcs0: SUCCESS (0.839s)
[337.406553] Starting dynamic subtest: bcs0
[338.179657] Dynamic subtest bcs0: SUCCESS (0.786s)
[338.199966] Starting dynamic subtest: vcs0
[338.997520] Dynamic subtest vcs0: SUCCESS (0.811s)
[339.012971] Starting dynamic subtest: vcs1
[339.804507] Dynamic subtest vcs1: SUCCESS (0.804s)
[339.819333] Starting dynamic subtest: vecs0
[340.585098] Dynamic subtest vecs0: SUCCESS (0.778s)
[340.588552] Subtest saturated-hostile-nopreempt: SUCCESS (4.036s)
[340.807325] [070/133] (695s left) gem_exec_big (single)
[340.860215] Starting subtest: single
[348.165162] Subtest single: SUCCESS (7.304s)
[349.060948] [071/133] (687s left) gem_exec_fence (submit67)
[349.282924] Starting subtest: submit67
[349.285836] Subtest submit67: SKIP (0.000s)
[349.866010] [072/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[351.358706] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[351.361650] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[351.551404] [073/133] (685s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[353.043744] Starting subtest: fbc-rgb101010-draw-mmap-wc
[353.049019] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[353.292892] [074/133] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[354.793572] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[354.796841] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[355.035316] [075/133] (682s left) i915_drm_fdinfo (busy-idle)
[355.083058] Starting subtest: busy-idle
[355.084520] Starting dynamic subtest: rcs0
[355.087304] Dynamic subtest rcs0: SKIP (0.000s)
[355.100048] Starting dynamic subtest: bcs0
[355.102894] Dynamic subtest bcs0: SKIP (0.000s)
[355.115404] Starting dynamic subtest: vcs0
[355.118531] Dynamic subtest vcs0: SKIP (0.000s)
[355.131024] Starting dynamic subtest: vcs1
[355.134404] Dynamic subtest vcs1: SKIP (0.000s)
[355.146893] Starting dynamic subtest: vecs0
[355.150193] Dynamic subtest vecs0: SKIP (0.000s)
[355.153575] Subtest busy-idle: SKIP (0.008s)
[355.235189] [076/133] (681s left) kms_psr (psr2-primary-page-flip)
[356.722258] Subtest psr2-primary-page-flip: SKIP (0.000s)
[356.798860] [077/133] (680s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[358.286856] Starting subtest: cursorA-vs-flipB-atomic
[358.290246] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[358.492229] [078/133] (678s left) kms_prop_blob (blob-prop-lifetime)
[358.538717] Starting subtest: blob-prop-lifetime
[358.540157] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[358.730406] [079/133] (678s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[360.215392] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[360.216698] Starting dynamic subtest: pipe-A
[362.752780] Dynamic subtest pipe-A: SUCCESS (2.536s)
[362.772684] Starting dynamic subtest: pipe-B
[365.176103] Dynamic subtest pipe-B: SUCCESS (2.421s)
[365.198538] Starting dynamic subtest: pipe-C
[365.465323] Dynamic subtest pipe-C: SUCCESS (0.287s)
[365.482014] Starting dynamic subtest: pipe-D
[365.756413] Dynamic subtest pipe-D: SUCCESS (0.289s)
[365.758153] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.542s)
[366.018440] [080/133] (671s left) kms_pipe_crc_basic (hang-read-crc)
[367.508882] Starting subtest: hang-read-crc
[367.513331] Starting dynamic subtest: pipe-A-HDMI-A-4
[368.931149] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.421s)
[368.946354] Starting dynamic subtest: pipe-B-HDMI-A-4
[370.192028] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.257s)
[370.208540] Starting dynamic subtest: pipe-C-HDMI-A-4
[371.469369] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.275s)
[371.484789] Starting dynamic subtest: pipe-D-HDMI-A-4
[372.692371] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.218s)
[372.693918] Subtest hang-read-crc: SUCCESS (5.182s)
[372.934179] [081/133] (664s left) kms_selftest (drm_format)
[373.010193] Starting subtest: drm_format
[373.085165] Starting dynamic subtest: drm_test_format_block_width_invalid
[373.110251] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.087s)
[373.154706] Starting dynamic subtest: drm_test_format_block_width_one_plane
[373.185890] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.071s)
[373.208356] Starting dynamic subtest: drm_test_format_block_width_two_plane
[373.281613] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.090s)
[373.329444] Starting dynamic subtest: drm_test_format_block_width_three_plane
[373.368675] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.082s)
[373.392124] Starting dynamic subtest: drm_test_format_block_width_tiled
[373.450222] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.078s)
[373.498899] Starting dynamic subtest: drm_test_format_block_height_invalid
[373.541754] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.085s)
[373.568353] Starting dynamic subtest: drm_test_format_block_height_one_plane
[373.628042] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.081s)
[373.674498] Starting dynamic subtest: drm_test_format_block_height_two_plane
[373.708756] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.076s)
[373.723637] Starting dynamic subtest: drm_test_format_block_height_three_plane
[373.798071] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.085s)
[373.847700] Starting dynamic subtest: drm_test_format_block_height_tiled
[373.887104] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.082s)
[373.912371] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[373.977714] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.086s)
[374.024152] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[374.062315] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.079s)
[374.087722] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[374.153833] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.087s)
[374.200006] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[374.243209] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.083s)
[374.266312] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[374.321954] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.075s)
[374.369419] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[374.414374] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.085s)
[374.430200] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[374.511459] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.092s)
[374.562265] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[374.598333] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.082s)
[374.600143] Subtest drm_format: SUCCESS (1.587s)
[374.789488] [082/133] (662s left) gem_close_race (multigpu-basic-process)
[374.864533] Starting subtest: multigpu-basic-process
[374.868249] Subtest multigpu-basic-process: SKIP (0.000s)
[375.165340] [083/133] (662s left) gem_set_tiling_vs_gtt
[375.303425] [084/133] (662s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[376.805853] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[376.807411] Starting dynamic subtest: pipe-A
[376.957702] Dynamic subtest pipe-A: SUCCESS (0.151s)
[376.973683] Starting dynamic subtest: pipe-B
[377.116801] Dynamic subtest pipe-B: SUCCESS (0.158s)
[377.131746] Starting dynamic subtest: pipe-C
[377.258027] Dynamic subtest pipe-C: SUCCESS (0.140s)
[377.277715] Starting dynamic subtest: pipe-D
[377.399097] Dynamic subtest pipe-D: SUCCESS (0.139s)
[377.400528] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.594s)
[377.596116] [085/133] (660s left) kms_addfb_basic (basic-y-tiled-legacy)
[377.641226] Starting subtest: basic-y-tiled-legacy
[377.644498] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[379.311062] [086/133] (658s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[380.819158] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[382.140215] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.321s)
[382.362876] [087/133] (655s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[382.416750] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[382.418310] Starting dynamic subtest: smem
[382.518210] Dynamic subtest smem: SUCCESS (0.101s)
[382.531410] Starting dynamic subtest: lmem0
[383.629169] Dynamic subtest lmem0: SUCCESS (1.109s)
[383.632847] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.213s)
[383.953709] [088/133] (654s left) gem_caching (writes)
[384.006892] Starting subtest: writes
[389.156792] Subtest writes: SUCCESS (5.152s)
[389.386366] [089/133] (649s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[389.435573] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[389.541222] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[389.733760] [090/133] (648s left) kms_flip (wf_vblank-ts-check)
[391.249820] Starting subtest: wf_vblank-ts-check
[391.256193] Starting dynamic subtest: A-HDMI-A4
[399.268880] Dynamic subtest A-HDMI-A4: SUCCESS (8.012s)
[399.287215] Starting dynamic subtest: B-HDMI-A4
[407.230040] Dynamic subtest B-HDMI-A4: SUCCESS (7.959s)
[407.246276] Starting dynamic subtest: C-HDMI-A4
[415.191910] Dynamic subtest C-HDMI-A4: SUCCESS (7.959s)
[415.207955] Starting dynamic subtest: D-HDMI-A4
[423.154096] Dynamic subtest D-HDMI-A4: SUCCESS (7.960s)
[423.155735] Subtest wf_vblank-ts-check: SUCCESS (31.905s)
[423.443859] [091/133] (615s left) gem_lmem_evict (dontneed-evict-race)
[427.826777] Starting subtest: dontneed-evict-race
[429.922244] Subtest dontneed-evict-race: SUCCESS (2.092s)
[431.733766] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[431.734889] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[431.738188] [092/133] (606s left) gem_mmap_gtt (medium-copy-odd)
[434.986569] Subtest medium-copy-odd: SKIP (0.000s)
[435.083775] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[435.087926] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[435.092095] [093/133] (603s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[436.592357] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[436.601037] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[436.800505] [094/133] (602s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[438.283705] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[438.287819] Starting dynamic subtest: pipe-A-HDMI-A-4
[438.330135] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[438.342561] Starting dynamic subtest: pipe-B-HDMI-A-4
[438.384929] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[438.396476] Starting dynamic subtest: pipe-C-HDMI-A-4
[438.443900] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[438.455447] Starting dynamic subtest: pipe-D-HDMI-A-4
[438.516448] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[438.519985] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[438.607426] [095/133] (600s left) gem_exec_suspend (basic-s0)
[438.672437] Starting subtest: basic-S0
[438.673920] Starting dynamic subtest: smem
[458.802012] Dynamic subtest smem: SUCCESS (5.387s)
[458.814010] Starting dynamic subtest: lmem0
[478.787777] Dynamic subtest lmem0: SUCCESS (5.209s)
[478.789643] Subtest basic-S0: SUCCESS (10.599s)
[483.114516] [096/133] (559s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[484.656172] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[484.659901] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[484.865456] [097/133] (558s left) gem_mmap_offset (bad-extensions)
[484.915532] Starting subtest: bad-extensions
[484.917587] Subtest bad-extensions: SUCCESS (0.000s)
[485.110163] [098/133] (558s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[486.654614] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[486.658048] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[486.832309] [099/133] (556s left) gem_mmap_gtt (cpuset-big-copy-odd)
[486.886315] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[486.959790] [100/133] (556s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[488.502169] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[488.505704] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[488.757057] [101/133] (554s left) kms_psr (fbc-psr2-sprite-render)
[490.275033] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[490.358661] [102/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[491.874688] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[491.877766] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[492.119300] [103/133] (551s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[493.633374] Starting subtest: crc-primary-basic-y-tiled-ccs
[493.634990] Starting dynamic subtest: pipe-A-HDMI-A-4
[493.649440] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[493.661975] Starting dynamic subtest: pipe-B-HDMI-A-4
[493.678244] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[493.690007] Starting dynamic subtest: pipe-C-HDMI-A-4
[493.704556] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[493.716456] Starting dynamic subtest: pipe-D-HDMI-A-4
[493.731970] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[493.735031] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.013s)
[493.928338] [104/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[495.437411] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[495.440306] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[495.672423] [105/133] (548s left) api_intel_bb (add-remove-objects)
[495.718716] Starting subtest: add-remove-objects
[495.744226] Subtest add-remove-objects: SUCCESS (0.026s)
[495.926623] [106/133] (548s left) sysfs_heartbeat_interval (nopreempt)
[495.977864] Starting subtest: nopreempt
[495.979508] Starting dynamic subtest: vecs0
[500.054206] Dynamic subtest vecs0: SUCCESS (4.044s)
[500.072850] Starting dynamic subtest: vcs0
[504.126654] Dynamic subtest vcs0: SUCCESS (4.050s)
[504.149572] Starting dynamic subtest: bcs0
[508.172735] Dynamic subtest bcs0: SUCCESS (4.033s)
[508.190742] Starting dynamic subtest: rcs0
[512.242033] Dynamic subtest rcs0: SUCCESS (4.059s)
[512.255397] Starting dynamic subtest: vcs1
[516.268710] Dynamic subtest vcs1: SUCCESS (4.021s)
[516.270178] Subtest nopreempt: SUCCESS (20.218s)
[516.482592] [107/133] (527s left) kms_getfb (getfb2-into-addfb2)
[517.971603] Starting subtest: getfb2-into-addfb2
[517.973076] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[518.227225] [108/133] (526s left) gem_close (basic)
[518.279325] Starting subtest: basic
[518.280874] Subtest basic: SUCCESS (0.000s)
[518.481564] [109/133] (526s left) gem_exec_schedule (preemptive-hang)
[518.655930] Starting subtest: preemptive-hang
[518.657492] Starting dynamic subtest: rcs0
[527.909989] Dynamic subtest rcs0: SUCCESS (9.252s)
[527.922951] Starting dynamic subtest: bcs0
[536.930918] Dynamic subtest bcs0: SUCCESS (9.014s)
[536.944052] Starting dynamic subtest: vcs0
[545.910137] Dynamic subtest vcs0: SUCCESS (8.962s)
[545.922908] Starting dynamic subtest: vcs1
[554.922704] Dynamic subtest vcs1: SUCCESS (9.019s)
[554.935573] Starting dynamic subtest: vecs0
[563.939130] Dynamic subtest vecs0: SUCCESS (9.011s)
[563.940611] Subtest preemptive-hang: SUCCESS (45.265s)
[564.285021] [110/133] (480s left) i915_drm_fdinfo (virtual-busy-idle)
[564.368179] Starting subtest: virtual-busy-idle
[564.371775] Subtest virtual-busy-idle: SKIP (0.000s)
[564.520258] [111/133] (480s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[566.013134] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[566.016026] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[566.230906] [112/133] (478s left) gem_linear_blits (interruptible)
[566.477762] Starting subtest: interruptible
[575.085853] Subtest interruptible: SUCCESS (8.601s)
[575.272579] [113/133] (469s left) gem_ctx_persistence (engines-mixed)
[575.374446] Starting subtest: engines-mixed
[575.376041] Starting dynamic subtest: rcs0
[575.451498] Dynamic subtest rcs0: SUCCESS (0.078s)
[575.465320] Starting dynamic subtest: bcs0
[575.496489] Dynamic subtest bcs0: SUCCESS (0.043s)
[575.517504] Starting dynamic subtest: vcs0
[575.553761] Dynamic subtest vcs0: SUCCESS (0.055s)
[575.570651] Starting dynamic subtest: vcs1
[575.599831] Dynamic subtest vcs1: SUCCESS (0.043s)
[575.618389] Starting dynamic subtest: vecs0
[575.667099] Dynamic subtest vecs0: SUCCESS (0.065s)
[575.671341] Subtest engines-mixed: SUCCESS (0.298s)
[575.922536] [114/133] (469s left) perf_pmu (init-wait)
[575.973652] Starting subtest: init-wait
[575.975376] Starting dynamic subtest: rcs0
[575.977039] Dynamic subtest rcs0: SUCCESS (0.002s)
[575.990666] Starting dynamic subtest: bcs0
[576.002192] Dynamic subtest bcs0: SUCCESS (0.001s)
[576.014739] Starting dynamic subtest: vcs0
[576.016346] Dynamic subtest vcs0: SUCCESS (0.001s)
[576.028834] Starting dynamic subtest: vcs1
[576.030470] Dynamic subtest vcs1: SUCCESS (0.001s)
[576.043447] Starting dynamic subtest: vecs0
[576.045074] Dynamic subtest vecs0: SUCCESS (0.001s)
[576.046552] Subtest init-wait: SUCCESS (0.011s)
[576.168779] [115/133] (468s left) gem_exec_reloc (basic-gtt-cpu-active)
[576.225701] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[576.382983] [116/133] (468s left) kms_pm_lpsp (screens-disabled)
[578.886851] Starting subtest: screens-disabled
[578.889807] Subtest screens-disabled: SKIP (0.000s)
[579.108710] [117/133] (466s left) kms_flip (flip-vs-expired-vblank-interruptible)
[580.601553] Starting subtest: flip-vs-expired-vblank-interruptible
[580.608098] Starting dynamic subtest: A-HDMI-A4
[588.369047] Dynamic subtest A-HDMI-A4: SUCCESS (7.766s)
[588.389723] Starting dynamic subtest: B-HDMI-A4
[596.044547] Dynamic subtest B-HDMI-A4: SUCCESS (7.676s)
[596.060480] Starting dynamic subtest: C-HDMI-A4
[603.703836] Dynamic subtest C-HDMI-A4: SUCCESS (7.659s)
[603.719905] Starting dynamic subtest: D-HDMI-A4
[611.364505] Dynamic subtest D-HDMI-A4: SUCCESS (7.660s)
[611.365902] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.775s)
[611.642226] [118/133] (433s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[613.144479] Starting subtest: psr-1p-primscrn-cur-indfb-move
[613.147562] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[613.395519] [119/133] (432s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[614.882845] Starting subtest: plane-all-modeset-transition-internal-panels
[614.885402] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[615.085019] [120/133] (430s left) gem_userptr_blits (stress-mm)
[615.147508] Starting subtest: stress-mm
[620.521296] Subtest stress-mm: SUCCESS (5.369s)
[620.760724] [121/133] (425s left) syncobj_eventfd (invalid-bad-flags)
[620.814873] Starting subtest: invalid-bad-flags
[620.816278] Subtest invalid-bad-flags: SUCCESS (0.000s)
[620.996054] [122/133] (424s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[621.042109] Starting subtest: framebuffer-vs-set-tiling
[621.045043] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[622.745842] [123/133] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[624.240272] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[624.246354] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[624.492595] [124/133] (421s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[624.548474] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[624.549967] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[624.726092] [125/133] (421s left) kms_flip (2x-modeset-vs-vblank-race)
[626.213076] Starting subtest: 2x-modeset-vs-vblank-race
[626.231209] Subtest 2x-modeset-vs-vblank-race: SKIP (0.017s)
[626.449172] [126/133] (419s left) i915_query (query-regions-garbage-items)
[626.497953] Starting subtest: query-regions-garbage-items
[626.499986] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[626.696332] [127/133] (419s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[626.749541] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[626.839352] [128/133] (419s left) gem_exec_balancer (full-late)
[626.894669] Starting subtest: full-late
[629.233347] Subtest full-late: SUCCESS (2.338s)
[629.817361] [129/133] (416s left) gem_exec_reloc (basic-write-wc)
[629.868203] Subtest basic-write-wc: SKIP (0.000s)
[630.000029] [130/133] (416s left) kms_force_connector_basic (force-load-detect)
[630.134416] Starting subtest: force-load-detect
[630.137557] Subtest force-load-detect: SKIP (0.000s)
[631.136648] [131/133] (415s left) kms_chamelium_hpd (hdmi-hpd-fast)
[632.667410] Subtest hdmi-hpd-fast: SKIP (0.000s)
[632.779524] [132/133] (414s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[634.266682] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[634.268117] Starting dynamic subtest: pipe-A-valid-mode
[635.062794] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.796s)
[635.064400] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.799s)
[635.310259] [133/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[636.801940] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[636.805442] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[637.049007] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.