[63.367880] Initializing watchdogs
[63.367947]   /dev/watchdog0
[63.388451] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.399269] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.403399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.405740] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[63.493087] Subtest write-snoop: SKIP (0.000s)
[63.579941] [002/133] (960s left) kms_content_protection (content-type-change)
[65.150119] Starting subtest: content-type-change
[65.157226] Subtest content-type-change: SKIP (0.005s)
[65.393328] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[66.899459] Starting subtest: multiplane-rotation
[97.208921] Subtest multiplane-rotation: SUCCESS (30.318s)
[97.399130] [004/133] (926s left) kms_chamelium_color (ctm-red-to-blue)
[98.901251] Subtest ctm-red-to-blue: SKIP (0.000s)
[98.960228] [005/133] (925s left) syncobj_wait (invalid-reset-one-illegal-handle)
[99.031623] Starting subtest: invalid-reset-one-illegal-handle
[99.032551] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[99.227606] [006/133] (924s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[100.728419] Starting subtest: disable-crc-after-crtc
[100.729320] Starting dynamic subtest: pipe-A-HDMI-A-3
[101.345185] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.611s)
[101.354372] Starting dynamic subtest: pipe-B-HDMI-A-3
[101.787177] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.444s)
[101.796282] Starting dynamic subtest: pipe-C-HDMI-A-3
[102.233664] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.445s)
[102.243553] Starting dynamic subtest: pipe-D-HDMI-A-3
[102.698966] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.463s)
[102.699999] Subtest disable-crc-after-crtc: SUCCESS (1.971s)
[102.933635] [007/133] (921s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[103.012455] Subtest tiled-to-tiled: SKIP (0.000s)
[103.065621] [008/133] (921s left) syncobj_wait (wait-all-interrupted)
[103.141281] Starting subtest: wait-all-interrupted
[103.243499] Subtest wait-all-interrupted: SUCCESS (0.101s)
[103.422897] [009/133] (921s left) syncobj_wait (wait-all-complex)
[103.496335] Starting subtest: wait-all-complex
[103.723224] Subtest wait-all-complex: SUCCESS (0.216s)
[103.852544] [010/133] (920s left) gem_pxp (reject-modify-context-protection-on)
[106.445174] Starting subtest: reject-modify-context-protection-on
[106.447806] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[106.588431] [011/133] (917s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[108.090407] Starting subtest: cursorA-vs-flipB-varying-size
[108.092277] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[108.272899] [012/133] (916s left) kms_rotation_crc (primary-rotation-90)
[109.798436] Starting subtest: primary-rotation-90
[109.800231] Subtest primary-rotation-90: SKIP (0.001s)
[109.954425] [013/133] (914s left) syncobj_wait (reset-multiple-signaled)
[110.059218] Starting subtest: reset-multiple-signaled
[110.060202] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[110.252511] [014/133] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[111.753589] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[111.755290] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[112.003961] [015/133] (912s left) gem_softpin (noreloc-s3)
[112.088998] Starting subtest: noreloc-S3
[132.998265] Subtest noreloc-S3: SUCCESS (5.534s)
[141.175088] [016/133] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[142.695471] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[145.651184] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.937s)
[145.864311] [017/133] (887s left) gem_ctx_param (invalid-ctx-set)
[145.935057] Starting subtest: invalid-ctx-set
[145.936993] Subtest invalid-ctx-set: SUCCESS (0.001s)
[146.132132] [018/133] (886s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[146.201864] Starting subtest: single-wait-all-for-submit-unsubmitted
[146.308831] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[146.483151] [019/133] (886s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[148.010747] Starting subtest: x-tiled-64bpp-rotate-90
[148.078904] Subtest x-tiled-64bpp-rotate-90: SKIP (0.067s)
[148.324775] [020/133] (884s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[148.393565] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[148.454464] [021/133] (884s left) kms_psr (fbc-psr-cursor-plane-move)
[149.961367] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[150.009067] [022/133] (883s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[151.527072] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[152.821670] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.279s)
[153.020868] [023/133] (880s left) kms_flip (2x-flip-vs-rmfb)
[154.532752] Starting subtest: 2x-flip-vs-rmfb
[154.545678] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[154.720885] [024/133] (878s left) kms_plane_cursor (viewport)
[156.243988] Starting subtest: viewport
[156.245777] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[159.437550] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.188s)
[159.514126] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[162.674680] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.167s)
[162.756634] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[165.944206] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.200s)
[166.077787] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[169.360295] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.289s)
[169.428918] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[172.679130] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.266s)
[172.740296] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[175.981784] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.250s)
[176.066487] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[179.285381] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.227s)
[179.351106] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[182.537210] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.200s)
[182.606173] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[185.838023] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.249s)
[185.923462] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[189.155338] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.239s)
[189.213415] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[192.390181] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.183s)
[192.450998] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[195.642015] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.200s)
[195.716031] Subtest viewport: SUCCESS (39.444s)
[195.928357] [025/133] (837s left) kms_cdclk (mode-transition)
[197.430489] Starting subtest: mode-transition
[197.431413] Starting dynamic subtest: pipe-A-HDMI-A-3
[197.477486] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.045s)
[197.487135] Starting dynamic subtest: pipe-B-HDMI-A-3
[197.488947] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[197.498234] Starting dynamic subtest: pipe-C-HDMI-A-3
[197.499950] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[197.509441] Starting dynamic subtest: pipe-D-HDMI-A-3
[197.511227] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[197.512928] Subtest mode-transition: SKIP (0.057s)
[197.685097] [026/133] (835s left) gem_exec_balancer (fairslice)
[197.765972] Starting subtest: fairslice
[203.392755] Subtest fairslice: SUCCESS (5.623s)
[203.848533] [027/133] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[205.349477] Starting subtest: basic-flip-before-cursor-varying-size
[206.343600] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.993s)
[206.618472] [028/133] (827s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[208.123529] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[208.124423] Starting dynamic subtest: pipe-A-valid-mode
[208.167723] Dynamic subtest pipe-A-valid-mode: SKIP (0.042s)
[208.169494] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.044s)
[208.381522] [029/133] (825s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[209.892408] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[209.893342] Starting dynamic subtest: pipe-A-valid-mode
[210.698251] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.804s)
[210.699107] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.806s)
[210.946630] [030/133] (822s left) core_getstats (basic)
[211.018801] Starting subtest: basic
[211.019733] Subtest basic: SUCCESS (0.000s)
[211.212277] [031/133] (822s left) kms_rmfb (close-fd)
[212.718607] Starting subtest: close-fd
[212.719569] Starting dynamic subtest: pipe-A-HDMI-A-3
[212.893044] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.174s)
[212.931384] Starting dynamic subtest: pipe-B-HDMI-A-3
[213.166390] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.268s)
[213.184756] Starting dynamic subtest: pipe-C-HDMI-A-3
[213.374919] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.205s)
[213.391882] Starting dynamic subtest: pipe-D-HDMI-A-3
[213.574779] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.196s)
[213.575671] Subtest close-fd: SUCCESS (0.858s)
[213.820370] [032/133] (820s left) gem_exec_reloc (basic-gtt-wc)
[213.895053] Subtest basic-gtt-wc: SKIP (0.000s)
[213.977969] [033/133] (820s left) kms_properties (crtc-properties-legacy)
[215.483609] Starting subtest: crtc-properties-legacy
[215.484612] Starting dynamic subtest: pipe-A-HDMI-A-3
[215.791446] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.307s)
[215.813928] Starting dynamic subtest: pipe-B-HDMI-A-3
[216.091405] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.295s)
[216.101261] Starting dynamic subtest: pipe-C-HDMI-A-3
[216.357381] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.265s)
[216.369081] Starting dynamic subtest: pipe-D-HDMI-A-3
[216.620071] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.260s)
[216.621767] Subtest crtc-properties-legacy: SUCCESS (1.137s)
[216.884729] [034/133] (817s left) kms_invalid_mode (zero-hdisplay)
[218.392667] Starting subtest: zero-hdisplay
[218.393551] Starting dynamic subtest: pipe-A-HDMI-A-3
[218.433061] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.040s)
[218.444300] Starting dynamic subtest: pipe-B-HDMI-A-3
[218.445449] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[218.455151] Starting dynamic subtest: pipe-C-HDMI-A-3
[218.456300] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[218.465888] Starting dynamic subtest: pipe-D-HDMI-A-3
[218.467155] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[218.468312] Subtest zero-hdisplay: SUCCESS (0.050s)
[218.678892] [035/133] (815s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[220.188674] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[220.189596] Starting dynamic subtest: pipe-A
[221.848715] Dynamic subtest pipe-A: SUCCESS (1.659s)
[221.875193] Starting dynamic subtest: pipe-B
[223.492238] Dynamic subtest pipe-B: SUCCESS (1.640s)
[223.517039] Starting dynamic subtest: pipe-C
[223.734625] Dynamic subtest pipe-C: SUCCESS (0.240s)
[223.757333] Starting dynamic subtest: pipe-D
[223.977570] Dynamic subtest pipe-D: SUCCESS (0.241s)
[223.982053] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.789s)
[224.265203] [036/133] (810s left) kms_pm_rpm (legacy-planes-dpms)
[228.406721] Starting subtest: legacy-planes-dpms
[228.407967] Starting dynamic subtest: plane-63
[235.470766] Dynamic subtest plane-63: SUCCESS (7.071s)
[235.518960] Starting dynamic subtest: plane-93
[242.369024] Dynamic subtest plane-93: SUCCESS (6.898s)
[242.420099] Starting dynamic subtest: plane-123
[249.506589] Dynamic subtest plane-123: SUCCESS (7.136s)
[249.554621] Starting dynamic subtest: plane-133
[256.402842] Dynamic subtest plane-133: SUCCESS (6.894s)
[256.407745] Subtest legacy-planes-dpms: SUCCESS (28.019s)
[257.414344] [037/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[258.935381] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[258.936979] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.171954] [038/133] (775s left) kms_dirtyfb (default-dirtyfb-ioctl)
[260.675692] Starting subtest: default-dirtyfb-ioctl
[260.676673] Starting dynamic subtest: A-HDMI-A-3
[262.123933] Dynamic subtest A-HDMI-A-3: SUCCESS (1.448s)
[262.124764] Subtest default-dirtyfb-ioctl: SUCCESS (1.450s)
[262.351002] [039/133] (772s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[263.853652] Starting subtest: cursorB-vs-flipA-legacy
[263.856830] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[264.035030] [040/133] (770s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[264.134888] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[264.135978] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[264.333836] [041/133] (770s left) kms_prime (basic-crc-vgem)
[265.881083] Subtest basic-crc-vgem: SKIP (0.000s)
[266.085096] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[266.087370] [042/133] (768s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[266.166869] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[266.266850] [043/133] (768s left) i915_drm_fdinfo (busy)
[266.336300] Starting subtest: busy
[266.337188] Starting dynamic subtest: rcs0
[266.338923] Dynamic subtest rcs0: SKIP (0.000s)
[266.349479] Starting dynamic subtest: bcs0
[266.351702] Dynamic subtest bcs0: SKIP (0.001s)
[266.361473] Starting dynamic subtest: vcs0
[266.363328] Dynamic subtest vcs0: SKIP (0.000s)
[266.374044] Starting dynamic subtest: vcs1
[266.375996] Dynamic subtest vcs1: SKIP (0.000s)
[266.385985] Starting dynamic subtest: vecs0
[266.388034] Dynamic subtest vecs0: SKIP (0.000s)
[266.398323] Starting dynamic subtest: vecs1
[266.400724] Dynamic subtest vecs1: SKIP (0.016s)
[266.410699] Starting dynamic subtest: ccs0
[266.413059] Dynamic subtest ccs0: SKIP (0.000s)
[266.415253] Subtest busy: SKIP (0.026s)
[266.486931] [044/133] (768s left) gem_userptr_blits (nohangcheck)
[266.585020] Starting subtest: nohangcheck
[266.920171] Subtest nohangcheck: SUCCESS (0.332s)
[267.152629] [045/133] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[268.673827] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[269.436654] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.763s)
[269.719843] [046/133] (765s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[271.234805] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[271.236589] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[271.504478] [047/133] (763s left) kms_scaling_modes (scaling-mode-full)
[273.020489] Starting subtest: scaling-mode-full
[273.025693] Subtest scaling-mode-full: SKIP (0.001s)
[273.204224] [048/133] (762s left) kms_psr (fbc-pr-basic)
[274.741027] Subtest fbc-pr-basic: SKIP (0.000s)
[274.801390] [049/133] (760s left) gem_ringfill (basic-all)
[275.251567] Starting subtest: basic-all
[277.234067] Subtest basic-all: SUCCESS (1.982s)
[277.476193] [050/133] (758s left) gem_exec_whisper (basic-fds-forked-all)
[277.566423] Starting subtest: basic-fds-forked-all
[300.238575] Subtest basic-fds-forked-all: SUCCESS (22.668s)
[300.557431] [051/133] (735s left) api_intel_bb (full-batch)
[300.634136] Starting subtest: full-batch
[300.662755] Subtest full-batch: SUCCESS (0.029s)
[300.855796] [052/133] (735s left) kms_cursor_crc (cursor-sliding-256x85)
[302.619220] Starting subtest: cursor-sliding-256x85
[302.624535] Starting dynamic subtest: pipe-A-HDMI-A-3
[307.052032] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.426s)
[307.088868] Starting dynamic subtest: pipe-D-HDMI-A-3
[311.380483] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.300s)
[311.381434] Subtest cursor-sliding-256x85: SUCCESS (8.759s)
[311.722029] [053/133] (724s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[313.242637] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[313.243549] Starting dynamic subtest: pipe-A-HDMI-A-3
[313.265403] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[313.276627] Starting dynamic subtest: pipe-B-HDMI-A-3
[313.298277] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[313.308735] Starting dynamic subtest: pipe-C-HDMI-A-3
[313.333206] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[313.344024] Starting dynamic subtest: pipe-D-HDMI-A-3
[313.365466] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[313.367200] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[313.540227] [054/133] (722s left) gen9_exec_parse (allowed-single)
[313.623909] Subtest allowed-single: SKIP (0.000s)
[313.711112] [055/133] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[315.242468] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[315.244120] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.472603] [056/133] (720s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[316.994280] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[316.996000] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[317.212418] [057/133] (719s left) gem_exec_fence (expired-history)
[317.793754] Starting subtest: expired-history
[324.302477] Subtest expired-history: SUCCESS (6.507s)
[326.224964] [058/133] (710s left) kms_psr (fbc-psr-sprite-plane-move)
[327.738862] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[327.806316] [059/133] (708s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[329.336490] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[329.338308] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[329.550777] [060/133] (707s left) gem_ctx_bad_destroy (double-destroy)
[329.634299] Starting subtest: double-destroy
[329.635180] Subtest double-destroy: SUCCESS (0.000s)
[329.802948] [061/133] (706s left) syncobj_timeline (invalid-signal-illegal-handle)
[329.881940] Starting subtest: invalid-signal-illegal-handle
[329.882888] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[330.077532] [062/133] (706s left) kms_chamelium_hpd (common-hpd-after-suspend)
[331.637683] Subtest common-hpd-after-suspend: SKIP (0.000s)
[331.744709] [063/133] (705s left) kms_frontbuffer_tracking (fbc-tiling-4)
[333.268251] Starting subtest: fbc-tiling-4
[335.923131] Subtest fbc-tiling-4: SUCCESS (2.655s)
[336.190840] [064/133] (700s left) gem_cs_tlb (engines)
[336.274199] Starting subtest: engines
[336.275083] Starting dynamic subtest: rcs0
[338.429785] Dynamic subtest rcs0: SUCCESS (2.153s)
[338.441031] Starting dynamic subtest: bcs0
[340.584843] Dynamic subtest bcs0: SUCCESS (2.153s)
[340.596112] Starting dynamic subtest: vcs0
[342.738151] Dynamic subtest vcs0: SUCCESS (2.152s)
[342.749574] Starting dynamic subtest: vcs1
[344.893147] Dynamic subtest vcs1: SUCCESS (2.152s)
[344.905099] Starting dynamic subtest: vecs0
[347.045937] Dynamic subtest vecs0: SUCCESS (2.152s)
[347.056753] Starting dynamic subtest: vecs1
[349.200066] Dynamic subtest vecs1: SUCCESS (2.152s)
[349.211257] Starting dynamic subtest: ccs0
[351.355908] Dynamic subtest ccs0: SUCCESS (2.154s)
[351.356829] Subtest engines: SUCCESS (15.077s)
[351.566519] [065/133] (685s left) gem_mmap_gtt (hang-busy)
[351.649686] Subtest hang-busy: SKIP (0.000s)
[351.723324] [066/133] (685s left) kms_psr (psr2-sprite-plane-onoff)
[353.241036] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[353.307005] [067/133] (683s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[354.830309] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[355.595554] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.765s)
[355.889466] [068/133] (681s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[357.421348] Starting subtest: y-tiled-64bpp-rotate-270
[357.423133] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[357.660158] [069/133] (679s left) gem_bad_reloc (negative-reloc-lut)
[357.741873] Subtest negative-reloc-lut: SKIP (0.000s)
[357.828301] [070/133] (679s left) gem_ctx_persistence (engines-mixed)
[357.913799] Starting subtest: engines-mixed
[357.914722] Starting dynamic subtest: rcs0
[358.021855] Dynamic subtest rcs0: SUCCESS (0.107s)
[358.036740] Starting dynamic subtest: bcs0
[358.078429] Dynamic subtest bcs0: SUCCESS (0.055s)
[358.099890] Starting dynamic subtest: vcs0
[358.135184] Dynamic subtest vcs0: SUCCESS (0.055s)
[358.168595] Starting dynamic subtest: vcs1
[358.206031] Dynamic subtest vcs1: SUCCESS (0.068s)
[358.230004] Starting dynamic subtest: vecs0
[358.279662] Dynamic subtest vecs0: SUCCESS (0.071s)
[358.320792] Starting dynamic subtest: vecs1
[358.363613] Dynamic subtest vecs1: SUCCESS (0.080s)
[358.405671] Starting dynamic subtest: ccs0
[358.452917] Dynamic subtest ccs0: SUCCESS (0.085s)
[358.454074] Subtest engines-mixed: SUCCESS (0.540s)
[358.666372] [071/133] (678s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[360.177437] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[360.178384] Starting dynamic subtest: pipe-A
[360.260056] Dynamic subtest pipe-A: SUCCESS (0.083s)
[360.275839] Starting dynamic subtest: pipe-B
[360.403722] Dynamic subtest pipe-B: SUCCESS (0.142s)
[360.421168] Starting dynamic subtest: pipe-C
[360.546701] Dynamic subtest pipe-C: SUCCESS (0.142s)
[360.558765] Starting dynamic subtest: pipe-D
[360.670813] Dynamic subtest pipe-D: SUCCESS (0.123s)
[360.671742] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.495s)
[360.939019] [072/133] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[362.463626] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[362.465404] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.707953] [073/133] (675s left) gem_exec_schedule (semaphore-noskip)
[362.813286] Starting subtest: semaphore-noskip
[363.610829] Subtest semaphore-noskip: SUCCESS (0.797s)
[364.026410] [074/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[365.547539] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[365.549251] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[365.774189] [075/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[367.288722] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[367.290387] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[367.523309] [076/133] (670s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[369.050980] Starting subtest: 4-tiled-16bpp-rotate-0
[370.776354] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.725s)
[370.992214] [077/133] (667s left) gem_exec_basic (basic)
[371.083873] Starting subtest: basic
[371.084812] Starting dynamic subtest: rcs0-smem
[371.086973] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[371.098678] Starting dynamic subtest: bcs0-smem
[371.099664] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[371.111161] Starting dynamic subtest: vcs0-smem
[371.112192] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[371.123313] Starting dynamic subtest: vcs1-smem
[371.124457] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[371.135104] Starting dynamic subtest: vecs0-smem
[371.136148] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[371.146957] Starting dynamic subtest: vecs1-smem
[371.148132] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[371.158688] Starting dynamic subtest: ccs0-smem
[371.159758] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[371.170416] Starting dynamic subtest: rcs0-lmem0
[371.171706] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[371.182272] Starting dynamic subtest: bcs0-lmem0
[371.183284] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[371.193947] Starting dynamic subtest: vcs0-lmem0
[371.195047] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[371.205596] Starting dynamic subtest: vcs1-lmem0
[371.206482] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[371.217599] Starting dynamic subtest: vecs0-lmem0
[371.218637] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[371.229680] Starting dynamic subtest: vecs1-lmem0
[371.230755] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[371.242161] Starting dynamic subtest: ccs0-lmem0
[371.243125] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[371.244130] Subtest basic: SUCCESS (0.023s)
[371.360298] [078/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[372.877469] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[372.879357] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[373.105131] [079/133] (665s left) gem_mmap (short-mmap)
[373.183730] Subtest short-mmap: SKIP (0.000s)
[373.258100] [080/133] (665s left) gem_exec_reloc (basic-gtt-wc-active)
[373.341881] Subtest basic-gtt-wc-active: SKIP (0.000s)
[373.451675] [081/133] (664s left) gem_ctx_shared (create-shared-gtt)
[373.541896] Starting subtest: create-shared-gtt
[375.692291] Subtest create-shared-gtt: SUCCESS (2.150s)
[378.136783] [082/133] (660s left) gem_exec_reloc (basic-write-wc)
[378.228876] Subtest basic-write-wc: SKIP (0.000s)
[378.303091] [083/133] (660s left) gem_eio (wait-immediate)
[378.611784] Starting subtest: wait-immediate
[379.231700] Subtest wait-immediate: SUCCESS (0.620s)
[380.830712] [084/133] (657s left) gem_ctx_persistence (legacy-engines-mixed)
[380.943160] Starting subtest: legacy-engines-mixed
[380.944055] Starting dynamic subtest: render
[381.058908] Dynamic subtest render: SUCCESS (0.115s)
[381.078745] Starting dynamic subtest: bsd1
[381.108128] Dynamic subtest bsd1: SUCCESS (0.047s)
[381.137723] Starting dynamic subtest: bsd2
[381.182360] Dynamic subtest bsd2: SUCCESS (0.071s)
[381.222715] Starting dynamic subtest: blt
[381.261611] Dynamic subtest blt: SUCCESS (0.075s)
[381.283415] Starting dynamic subtest: vebox
[381.314200] Dynamic subtest vebox: SUCCESS (0.050s)
[381.315534] Subtest legacy-engines-mixed: SUCCESS (0.372s)
[381.559144] [085/133] (657s left) perf_pmu (semaphore-busy)
[381.629789] Starting subtest: semaphore-busy
[381.630682] Starting dynamic subtest: rcs0
[383.327551] Dynamic subtest rcs0: SUCCESS (1.696s)
[383.342200] Starting dynamic subtest: bcs0
[384.968119] Dynamic subtest bcs0: SUCCESS (1.636s)
[384.985342] Starting dynamic subtest: vcs0
[386.615234] Dynamic subtest vcs0: SUCCESS (1.642s)
[386.632372] Starting dynamic subtest: vcs1
[388.262149] Dynamic subtest vcs1: SUCCESS (1.642s)
[388.279141] Starting dynamic subtest: vecs0
[389.900205] Dynamic subtest vecs0: SUCCESS (1.633s)
[389.917871] Starting dynamic subtest: vecs1
[391.549548] Dynamic subtest vecs1: SUCCESS (1.644s)
[391.570553] Starting dynamic subtest: ccs0
[393.199214] Dynamic subtest ccs0: SUCCESS (1.644s)
[393.201133] Subtest semaphore-busy: SUCCESS (11.573s)
[393.424688] [086/133] (645s left) gem_exec_schedule (pi-common)
[393.636978] Starting subtest: pi-common
[393.637945] Starting dynamic subtest: rcs0
[393.677624] Dynamic subtest rcs0: SUCCESS (0.040s)
[393.694154] Starting dynamic subtest: bcs0
[393.717805] Dynamic subtest bcs0: SUCCESS (0.039s)
[393.731905] Starting dynamic subtest: vcs0
[393.749825] Dynamic subtest vcs0: SUCCESS (0.031s)
[393.763897] Starting dynamic subtest: vcs1
[393.781044] Dynamic subtest vcs1: SUCCESS (0.030s)
[393.795180] Starting dynamic subtest: vecs0
[393.812254] Dynamic subtest vecs0: SUCCESS (0.030s)
[393.826381] Starting dynamic subtest: vecs1
[393.845364] Dynamic subtest vecs1: SUCCESS (0.032s)
[393.858116] Starting dynamic subtest: ccs0
[393.876264] Dynamic subtest ccs0: SUCCESS (0.030s)
[393.877094] Subtest pi-common: SUCCESS (0.240s)
[394.170876] [087/133] (644s left) i915_hangman (engine-error-state-capture)
[394.263801] Starting subtest: engine-error-state-capture
[394.264700] Starting dynamic subtest: rcs0
[396.947065] Dynamic subtest rcs0: SUCCESS (2.683s)
[396.963720] Starting dynamic subtest: bcs0
[400.933882] Dynamic subtest bcs0: SUCCESS (3.986s)
[400.947899] Starting dynamic subtest: vcs0
[404.974755] Dynamic subtest vcs0: SUCCESS (4.040s)
[404.988708] Starting dynamic subtest: vcs1
[408.944272] Dynamic subtest vcs1: SUCCESS (3.968s)
[408.956742] Starting dynamic subtest: vecs0
[412.920879] Dynamic subtest vecs0: SUCCESS (3.976s)
[412.940769] Starting dynamic subtest: vecs1
[416.935992] Dynamic subtest vecs1: SUCCESS (4.014s)
[416.950099] Starting dynamic subtest: ccs0
[420.951112] Dynamic subtest ccs0: SUCCESS (4.014s)
[420.952139] Subtest engine-error-state-capture: SUCCESS (26.689s)
[421.152986] [088/133] (617s left) syncobj_timeline (wait-for-submit-snapshot)
[421.229971] Starting subtest: wait-for-submit-snapshot
[421.314033] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[421.510597] [089/133] (617s left) kms_color (ctm-blue-to-red)
[423.020560] Starting subtest: ctm-blue-to-red
[423.021472] Starting dynamic subtest: pipe-A-HDMI-A-3
[423.713076] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.692s)
[423.728012] Starting dynamic subtest: pipe-B-HDMI-A-3
[424.192012] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.477s)
[424.204519] Starting dynamic subtest: pipe-C-HDMI-A-3
[424.687976] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.495s)
[424.700324] Starting dynamic subtest: pipe-D-HDMI-A-3
[425.188110] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.499s)
[425.188971] Subtest ctm-blue-to-red: SUCCESS (2.167s)
[425.418827] [090/133] (613s left) prime_vgem (basic-gtt)
[425.510097] Starting subtest: basic-gtt
[425.511792] Subtest basic-gtt: SKIP (0.000s)
[425.703369] [091/133] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[427.226338] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[427.227954] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[427.440101] [092/133] (611s left) api_intel_allocator (default-alignment)
[427.527066] Starting subtest: default-alignment
[427.533993] Subtest default-alignment: SUCCESS (0.008s)
[427.774199] [093/133] (611s left) i915_pm_rps (fence-order)
[427.859531] Starting subtest: fence-order
[432.222093] Subtest fence-order: SUCCESS (4.361s)
[432.401399] [094/133] (607s left) kms_vblank (query-busy)
[433.915511] Starting subtest: query-busy
[433.916538] Starting dynamic subtest: pipe-A-HDMI-A-3
[436.360124] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.443s)
[436.375860] Starting dynamic subtest: pipe-D-HDMI-A-3
[438.712455] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.348s)
[438.713471] Subtest query-busy: SUCCESS (4.797s)
[438.944060] [095/133] (600s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[440.471757] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[440.473648] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[440.711936] [096/133] (598s left) kms_addfb_basic (invalid-get-prop-any)
[440.798005] Starting subtest: invalid-get-prop-any
[440.798907] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[442.484259] [097/133] (597s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[443.996810] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[444.059167] [098/133] (595s left) kms_flip (2x-blocking-absolute-wf_vblank)
[445.572708] Starting subtest: 2x-blocking-absolute-wf_vblank
[445.586078] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[445.752937] [099/133] (594s left) kms_cursor_crc (cursor-onscreen-256x85)
[447.537796] Starting subtest: cursor-onscreen-256x85
[447.541671] Starting dynamic subtest: pipe-A-HDMI-A-3
[450.354146] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.812s)
[450.392683] Starting dynamic subtest: pipe-D-HDMI-A-3
[453.011528] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.630s)
[453.012420] Subtest cursor-onscreen-256x85: SUCCESS (5.474s)
[453.361986] [100/133] (586s left) kms_flip (2x-modeset-vs-vblank-race)
[454.875450] Starting subtest: 2x-modeset-vs-vblank-race
[454.887565] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[455.057754] [101/133] (585s left) kms_atomic_interruptible (atomic-setmode)
[456.580642] Starting subtest: atomic-setmode
[456.582801] Starting dynamic subtest: pipe-A-HDMI-A-3
[462.777010] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.193s)
[462.777914] Subtest atomic-setmode: SUCCESS (6.196s)
[462.980136] [102/133] (577s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[464.500558] Starting subtest: psr-argb161616f-draw-render
[464.502369] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[464.756426] [103/133] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[466.279255] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[466.280836] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.517243] [104/133] (573s left) kms_plane_scaling (invalid-num-scalers)
[468.036470] Starting subtest: invalid-num-scalers
[468.041759] Starting dynamic subtest: pipe-A-HDMI-A-3-invalid-num-scalers
[468.062628] Dynamic subtest pipe-A-HDMI-A-3-invalid-num-scalers: SUCCESS (0.021s)
[468.080929] Starting dynamic subtest: pipe-B-HDMI-A-3-invalid-num-scalers
[468.105563] Dynamic subtest pipe-B-HDMI-A-3-invalid-num-scalers: SUCCESS (0.036s)
[468.122404] Starting dynamic subtest: pipe-C-HDMI-A-3-invalid-num-scalers
[468.145090] Dynamic subtest pipe-C-HDMI-A-3-invalid-num-scalers: SUCCESS (0.036s)
[468.162969] Starting dynamic subtest: pipe-D-HDMI-A-3-invalid-num-scalers
[468.187051] Dynamic subtest pipe-D-HDMI-A-3-invalid-num-scalers: SUCCESS (0.036s)
[468.187920] Subtest invalid-num-scalers: SUCCESS (0.151s)
[468.364856] [105/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[469.886498] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[469.888306] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[470.134929] [106/133] (570s left) sw_sync (alloc_fence_invalid_timeline)
[470.182793] Starting subtest: alloc_fence_invalid_timeline
[470.183684] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[470.339384] [107/133] (570s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[470.431981] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[470.541109] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[470.722107] [108/133] (570s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[472.248219] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[472.254600] Starting dynamic subtest: A-HDMI-A3
[480.265238] Dynamic subtest A-HDMI-A3: SUCCESS (8.009s)
[480.280478] Starting dynamic subtest: B-HDMI-A3
[488.215786] Dynamic subtest B-HDMI-A3: SUCCESS (7.947s)
[488.230555] Starting dynamic subtest: C-HDMI-A3
[496.166879] Dynamic subtest C-HDMI-A3: SUCCESS (7.948s)
[496.181778] Starting dynamic subtest: D-HDMI-A3
[504.120374] Dynamic subtest D-HDMI-A3: SUCCESS (7.950s)
[504.125631] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.869s)
[504.415583] [109/133] (536s left) kms_addfb_basic (size-max)
[505.929454] Starting subtest: size-max
[505.930408] Subtest size-max: SUCCESS (0.000s)
[506.185282] [110/133] (534s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[507.928692] Starting subtest: cursor-rapid-movement-256x256
[507.933658] Starting dynamic subtest: pipe-A-HDMI-A-3
[508.350319] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.416s)
[508.385706] Starting dynamic subtest: pipe-D-HDMI-A-3
[508.672737] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.299s)
[508.673665] Subtest cursor-rapid-movement-256x256: SUCCESS (0.744s)
[509.105383] [111/133] (532s left) gem_exec_whisper (basic-queues-all)
[509.195972] Starting subtest: basic-queues-all
[530.996656] Subtest basic-queues-all: SUCCESS (21.795s)
[531.250915] [112/133] (509s left) kms_dsc (dsc-fractional-bpp)
[532.761682] Starting subtest: dsc-fractional-bpp
[532.766725] Subtest dsc-fractional-bpp: SKIP (0.000s)
[532.930654] [113/133] (508s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[534.462516] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[534.463469] Starting dynamic subtest: pipe-A-valid-mode
[534.512219] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[534.513916] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.050s)
[534.734729] [114/133] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[536.248364] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[536.249993] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[536.498899] [115/133] (505s left) gem_softpin (evict-prime)
[536.588048] Starting subtest: evict-prime
[536.588974] Starting dynamic subtest: rcs0
[537.878160] Dynamic subtest rcs0: SUCCESS (1.289s)
[537.891089] Starting dynamic subtest: bcs0
[539.027901] Dynamic subtest bcs0: SUCCESS (1.149s)
[539.043541] Starting dynamic subtest: vcs0
[540.207017] Dynamic subtest vcs0: SUCCESS (1.178s)
[540.223588] Starting dynamic subtest: vcs1
[541.340824] Dynamic subtest vcs1: SUCCESS (1.132s)
[541.353747] Starting dynamic subtest: vecs0
[542.527926] Dynamic subtest vecs0: SUCCESS (1.186s)
[542.543217] Starting dynamic subtest: vecs1
[543.672801] Dynamic subtest vecs1: SUCCESS (1.144s)
[543.690565] Starting dynamic subtest: ccs0
[544.853973] Dynamic subtest ccs0: SUCCESS (1.180s)
[544.869112] Starting dynamic subtest: all
[546.016016] Dynamic subtest all: SUCCESS (1.161s)
[546.017034] Subtest evict-prime: SUCCESS (9.426s)
[546.196531] [116/133] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[547.710486] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[547.712199] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[547.986039] [117/133] (493s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[549.498828] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[549.726436] [118/133] (492s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[549.806987] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[549.916382] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[550.061968] [119/133] (491s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[551.577310] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[551.578936] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[551.813227] [120/133] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[553.329544] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[556.563188] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.233s)
[556.833995] [121/133] (485s left) gem_mmap_wc (bad-size)
[556.910674] Subtest bad-size: SKIP (0.000s)
[557.025604] [122/133] (485s left) kms_hdr (static-toggle-suspend)
[558.535858] Starting subtest: static-toggle-suspend
[558.538468] Subtest static-toggle-suspend: SKIP (0.000s)
[558.711241] [123/133] (483s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[560.251540] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[560.253315] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[560.497149] [124/133] (482s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[562.025044] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[562.076386] [125/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[563.601525] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[563.603334] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[563.831820] [126/133] (478s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[565.343604] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[565.344491] Starting dynamic subtest: pipe-A-HDMI-A-3
[565.352751] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[565.365544] Starting dynamic subtest: pipe-B-HDMI-A-3
[565.374034] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[565.386467] Starting dynamic subtest: pipe-C-HDMI-A-3
[565.394711] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[565.407325] Starting dynamic subtest: pipe-D-HDMI-A-3
[565.417957] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[565.419972] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[565.677781] [127/133] (477s left) syncobj_timeline (single-wait-all-available-submitted)
[565.756927] Starting subtest: single-wait-all-available-submitted
[565.757855] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[565.921281] [128/133] (477s left) gem_exec_parallel (userptr)
[566.007179] Starting subtest: userptr
[566.008080] Starting dynamic subtest: rcs0
[567.530710] Dynamic subtest rcs0: SUCCESS (1.523s)
[567.548365] Starting dynamic subtest: bcs0
[569.013910] Dynamic subtest bcs0: SUCCESS (1.482s)
[569.031492] Starting dynamic subtest: vcs0
[570.498008] Dynamic subtest vcs0: SUCCESS (1.482s)
[570.513194] Starting dynamic subtest: vcs1
[572.030004] Dynamic subtest vcs1: SUCCESS (1.530s)
[572.046464] Starting dynamic subtest: vecs0
[573.485636] Dynamic subtest vecs0: SUCCESS (1.454s)
[573.503628] Starting dynamic subtest: vecs1
[574.938157] Dynamic subtest vecs1: SUCCESS (1.451s)
[574.954688] Starting dynamic subtest: ccs0
[576.413857] Dynamic subtest ccs0: SUCCESS (1.474s)
[576.414697] Subtest userptr: SUCCESS (10.405s)
[576.742377] [129/133] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[578.258703] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[578.260435] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[578.462389] [130/133] (464s left) i915_selftest (mock)
[579.626565] Starting subtest: mock
[579.627663] Starting dynamic subtest: sanitycheck
[580.474359] Dynamic subtest sanitycheck: SUCCESS (0.846s)
[580.510212] Starting dynamic subtest: shmem
[581.332500] Dynamic subtest shmem: SUCCESS (0.853s)
[581.369664] Starting dynamic subtest: fence
[589.380705] Dynamic subtest fence: SUCCESS (8.041s)
[589.398769] Starting dynamic subtest: scatterlist
[591.209935] Dynamic subtest scatterlist: SUCCESS (1.824s)
[591.223873] Starting dynamic subtest: syncmap
[594.118794] Dynamic subtest syncmap: SUCCESS (2.906s)
[594.130091] Starting dynamic subtest: uncore
[594.933975] Dynamic subtest uncore: SUCCESS (0.813s)
[594.971456] Starting dynamic subtest: ring
[595.821218] Dynamic subtest ring: SUCCESS (0.883s)
[595.854399] Starting dynamic subtest: engine
[596.705412] Dynamic subtest engine: SUCCESS (0.880s)
[596.743228] Starting dynamic subtest: timelines
[601.377499] Dynamic subtest timelines: SUCCESS (4.667s)
[601.387780] Starting dynamic subtest: requests
[604.137294] Dynamic subtest requests: SUCCESS (2.758s)
[604.147020] Starting dynamic subtest: objects
[605.109682] Dynamic subtest objects: SUCCESS (0.971s)
[605.121278] Starting dynamic subtest: phys
[606.074419] Dynamic subtest phys: SUCCESS (0.963s)
[606.085010] Starting dynamic subtest: dmabuf
[607.039369] Dynamic subtest dmabuf: SUCCESS (0.963s)
[607.050440] Starting dynamic subtest: vma
[615.195662] Dynamic subtest vma: SUCCESS (8.156s)
[615.207311] Starting dynamic subtest: evict
[617.016551] Dynamic subtest evict: SUCCESS (1.821s)
[617.032403] Starting dynamic subtest: gtt
[621.004437] Dynamic subtest gtt: SUCCESS (3.989s)
[621.014464] Starting dynamic subtest: hugepages
[622.142402] Dynamic subtest hugepages: SUCCESS (1.137s)
[622.153762] Starting dynamic subtest: memory_region
[625.715486] Dynamic subtest memory_region: SUCCESS (3.574s)
[625.716562] Subtest mock: SUCCESS (46.092s)
[625.772226] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[625.773425] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[625.775517] [131/133] (417s left) gem_mmap_gtt (basic-write-read)
[629.257686] Subtest basic-write-read: SKIP (0.000s)
[629.333147] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[629.335886] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[629.339222] [132/133] (413s left) perf (gen12-group-exclusive-stream-sample-oa)
[629.802005] Starting subtest: gen12-group-exclusive-stream-sample-oa
[629.824316] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[629.883284] [133/133] (413s left) perf_pmu (busy-double-start)
[629.955914] Starting subtest: busy-double-start
[629.956832] Starting dynamic subtest: rcs0
[633.588663] Dynamic subtest rcs0: SUCCESS (3.634s)
[633.602845] Starting dynamic subtest: bcs0
[637.176623] Dynamic subtest bcs0: SUCCESS (3.588s)
[637.191751] Starting dynamic subtest: vcs0
[640.795461] Dynamic subtest vcs0: FAIL (3.582s)
[640.834632] Starting dynamic subtest: vcs1
[644.350984] Dynamic subtest vcs1: FAIL (3.566s)
[644.364166] Starting dynamic subtest: vecs0
[647.896746] Dynamic subtest vecs0: SUCCESS (3.569s)
[647.911675] Starting dynamic subtest: vecs1
[651.499713] Dynamic subtest vecs1: SUCCESS (3.599s)
[651.515323] Starting dynamic subtest: ccs0
[655.107957] Dynamic subtest ccs0: SUCCESS (3.604s)
[655.112922] Subtest busy-double-start: FAIL (25.165s)
[655.291680] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_cdclk
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: core_getstats
results: parsing output: 30/ for test: kms_rmfb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_scaling_modes
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ringfill
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_cs_tlb
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: perf_pmu
Done.