[62.836421] Initializing watchdogs
[62.836486]   /dev/watchdog0
[62.857388] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.868480] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.872219] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.874666] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[62.966179] Subtest write-snoop: SKIP (0.000s)
[63.033682] [002/133] (960s left) kms_content_protection (content-type-change)
[64.609827] Starting subtest: content-type-change
[64.615935] Subtest content-type-change: SKIP (0.005s)
[64.841311] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[66.341132] Starting subtest: multiplane-rotation
[94.333275] Subtest multiplane-rotation: SUCCESS (27.991s)
[94.479279] [004/133] (929s left) kms_chamelium_color (ctm-red-to-blue)
[95.982239] Subtest ctm-red-to-blue: SKIP (0.000s)
[96.041879] [005/133] (927s left) syncobj_wait (invalid-reset-one-illegal-handle)
[96.111130] Starting subtest: invalid-reset-one-illegal-handle
[96.112143] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[96.302578] [006/133] (927s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[97.802148] Starting subtest: disable-crc-after-crtc
[97.804293] Starting dynamic subtest: pipe-A-HDMI-A-3
[98.428175] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.625s)
[98.438079] Starting dynamic subtest: pipe-B-HDMI-A-3
[98.867327] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.437s)
[98.875584] Starting dynamic subtest: pipe-C-HDMI-A-3
[99.306914] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.438s)
[99.316241] Starting dynamic subtest: pipe-D-HDMI-A-3
[99.736892] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.429s)
[99.737959] Subtest disable-crc-after-crtc: SUCCESS (1.935s)
[99.989679] [007/133] (923s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[100.066383] Subtest tiled-to-tiled: SKIP (0.000s)
[100.144712] [008/133] (923s left) syncobj_wait (wait-all-interrupted)
[100.214507] Starting subtest: wait-all-interrupted
[100.316564] Subtest wait-all-interrupted: SUCCESS (0.102s)
[100.436032] [009/133] (923s left) syncobj_wait (wait-all-complex)
[100.506362] Starting subtest: wait-all-complex
[100.730021] Subtest wait-all-complex: SUCCESS (0.216s)
[100.897601] [010/133] (923s left) gem_pxp (reject-modify-context-protection-on)
[103.502460] Starting subtest: reject-modify-context-protection-on
[103.504293] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[103.631684] [011/133] (920s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[105.133555] Starting subtest: cursorA-vs-flipB-varying-size
[105.135407] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[105.279904] [012/133] (918s left) kms_rotation_crc (primary-rotation-90)
[106.812624] Starting subtest: primary-rotation-90
[106.814401] Subtest primary-rotation-90: SKIP (0.001s)
[106.969582] [013/133] (917s left) syncobj_wait (reset-multiple-signaled)
[107.075286] Starting subtest: reset-multiple-signaled
[107.076171] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[107.280775] [014/133] (916s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[108.781196] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[108.782920] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[109.039886] [015/133] (915s left) gem_softpin (noreloc-s3)
[109.120542] Starting subtest: noreloc-S3
[129.424086] Subtest noreloc-S3: SUCCESS (5.400s)
[134.602229] [016/133] (894s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[136.157966] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[139.103368] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.874s)
[139.354549] [017/133] (890s left) gem_ctx_param (invalid-ctx-set)
[139.432188] Starting subtest: invalid-ctx-set
[139.434139] Subtest invalid-ctx-set: SUCCESS (0.001s)
[139.634422] [018/133] (889s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[139.716123] Starting subtest: single-wait-all-for-submit-unsubmitted
[139.821153] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[139.997850] [019/133] (889s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[141.533964] Starting subtest: x-tiled-64bpp-rotate-90
[141.595333] Subtest x-tiled-64bpp-rotate-90: SKIP (0.060s)
[141.884325] [020/133] (887s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[141.953648] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[142.029131] [021/133] (887s left) kms_psr (fbc-psr-cursor-plane-move)
[143.547090] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[143.611608] [022/133] (886s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[145.139245] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[146.448005] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.296s)
[146.660358] [023/133] (883s left) kms_flip (2x-flip-vs-rmfb)
[148.181662] Starting subtest: 2x-flip-vs-rmfb
[148.194856] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[148.365866] [024/133] (881s left) kms_plane_cursor (viewport)
[149.897825] Starting subtest: viewport
[149.899580] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[153.150147] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.236s)
[153.228836] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[156.460075] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.233s)
[156.544074] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[159.750289] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.216s)
[159.856443] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[163.106737] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.257s)
[163.178064] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[166.359814] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.200s)
[166.418569] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[169.513388] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.100s)
[169.596870] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[172.843755] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.254s)
[172.902264] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[176.095184] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.200s)
[176.156921] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[179.380781] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.233s)
[179.463840] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[182.643627] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.187s)
[182.702071] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[185.878178] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.184s)
[185.946983] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[189.092509] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.166s)
[189.164240] Subtest viewport: SUCCESS (39.217s)
[189.428721] [025/133] (840s left) kms_cdclk (mode-transition)
[190.932697] Starting subtest: mode-transition
[190.933581] Starting dynamic subtest: pipe-A-HDMI-A-3
[190.979504] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.045s)
[190.989120] Starting dynamic subtest: pipe-B-HDMI-A-3
[190.990935] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[191.000467] Starting dynamic subtest: pipe-C-HDMI-A-3
[191.002206] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[191.011586] Starting dynamic subtest: pipe-D-HDMI-A-3
[191.013341] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[191.015087] Subtest mode-transition: SKIP (0.056s)
[191.192355] [026/133] (839s left) gem_exec_balancer (fairslice)
[191.272025] Starting subtest: fairslice
[196.898780] Subtest fairslice: SUCCESS (5.628s)
[197.347447] [027/133] (832s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[198.847615] Starting subtest: basic-flip-before-cursor-varying-size
[199.849045] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.002s)
[200.098730] [028/133] (830s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[201.599627] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[201.600538] Starting dynamic subtest: pipe-A-valid-mode
[201.646908] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s)
[201.648734] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.048s)
[201.859780] [029/133] (828s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[203.362647] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[203.363599] Starting dynamic subtest: pipe-A-valid-mode
[204.201993] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.839s)
[204.202892] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.841s)
[204.450099] [030/133] (826s left) core_getstats (basic)
[204.520216] Starting subtest: basic
[204.521080] Subtest basic: SUCCESS (0.000s)
[204.713548] [031/133] (825s left) kms_rmfb (close-fd)
[206.215702] Starting subtest: close-fd
[206.216577] Starting dynamic subtest: pipe-A-HDMI-A-3
[206.413324] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.197s)
[206.447699] Starting dynamic subtest: pipe-B-HDMI-A-3
[206.643434] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.224s)
[206.659254] Starting dynamic subtest: pipe-C-HDMI-A-3
[206.843937] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.197s)
[206.854867] Starting dynamic subtest: pipe-D-HDMI-A-3
[207.037936] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.192s)
[207.038831] Subtest close-fd: SUCCESS (0.823s)
[207.287524] [032/133] (823s left) gem_exec_reloc (basic-gtt-wc)
[207.363122] Subtest basic-gtt-wc: SKIP (0.000s)
[207.438447] [033/133] (823s left) kms_properties (crtc-properties-legacy)
[208.951073] Starting subtest: crtc-properties-legacy
[208.951992] Starting dynamic subtest: pipe-A-HDMI-A-3
[209.280920] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.329s)
[209.301420] Starting dynamic subtest: pipe-B-HDMI-A-3
[209.557884] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.273s)
[209.569218] Starting dynamic subtest: pipe-C-HDMI-A-3
[209.835107] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.276s)
[209.846192] Starting dynamic subtest: pipe-D-HDMI-A-3
[210.096292] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.258s)
[210.097193] Subtest crtc-properties-legacy: SUCCESS (1.146s)
[210.352550] [034/133] (820s left) kms_invalid_mode (zero-hdisplay)
[211.859654] Starting subtest: zero-hdisplay
[211.860647] Starting dynamic subtest: pipe-A-HDMI-A-3
[211.908557] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.048s)
[211.918461] Starting dynamic subtest: pipe-B-HDMI-A-3
[211.919579] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[211.929187] Starting dynamic subtest: pipe-C-HDMI-A-3
[211.930392] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[211.940393] Starting dynamic subtest: pipe-D-HDMI-A-3
[211.941238] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[211.942133] Subtest zero-hdisplay: SUCCESS (0.057s)
[212.146433] [035/133] (818s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[213.648691] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[213.649542] Starting dynamic subtest: pipe-A
[215.301445] Dynamic subtest pipe-A: SUCCESS (1.653s)
[215.334591] Starting dynamic subtest: pipe-B
[216.958542] Dynamic subtest pipe-B: SUCCESS (1.654s)
[216.975219] Starting dynamic subtest: pipe-C
[217.183104] Dynamic subtest pipe-C: SUCCESS (0.223s)
[217.210818] Starting dynamic subtest: pipe-D
[217.424656] Dynamic subtest pipe-D: SUCCESS (0.239s)
[217.425784] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.778s)
[217.694570] [036/133] (813s left) kms_pm_rpm (legacy-planes-dpms)
[221.928334] Starting subtest: legacy-planes-dpms
[221.929405] Starting dynamic subtest: plane-63
[228.960463] Dynamic subtest plane-63: SUCCESS (7.029s)
[229.001850] Starting dynamic subtest: plane-93
[235.842175] Dynamic subtest plane-93: SUCCESS (6.876s)
[235.890393] Starting dynamic subtest: plane-123
[242.811177] Dynamic subtest plane-123: SUCCESS (6.962s)
[242.859329] Starting dynamic subtest: plane-133
[249.860114] Dynamic subtest plane-133: SUCCESS (7.042s)
[249.865882] Subtest legacy-planes-dpms: SUCCESS (27.926s)
[250.896188] [037/133] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[252.405533] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[252.407143] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.657070] [038/133] (778s left) kms_dirtyfb (default-dirtyfb-ioctl)
[254.158820] Starting subtest: default-dirtyfb-ioctl
[254.159826] Starting dynamic subtest: A-HDMI-A-3
[255.584993] Dynamic subtest A-HDMI-A-3: SUCCESS (1.426s)
[255.585852] Subtest default-dirtyfb-ioctl: SUCCESS (1.428s)
[255.833510] [039/133] (775s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[257.332794] Starting subtest: cursorB-vs-flipA-legacy
[257.335979] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[257.506483] [040/133] (773s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[257.601013] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[257.602154] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[257.801920] [041/133] (773s left) kms_prime (basic-crc-vgem)
[259.344910] Subtest basic-crc-vgem: SKIP (0.000s)
[259.578729] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[259.581124] [042/133] (772s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[259.661912] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[259.743016] [043/133] (771s left) i915_drm_fdinfo (busy)
[259.815011] Starting subtest: busy
[259.816245] Starting dynamic subtest: rcs0
[259.834844] Dynamic subtest rcs0: SKIP (0.020s)
[259.845054] Starting dynamic subtest: bcs0
[259.846896] Dynamic subtest bcs0: SKIP (0.000s)
[259.857132] Starting dynamic subtest: vcs0
[259.859137] Dynamic subtest vcs0: SKIP (0.000s)
[259.870576] Starting dynamic subtest: vcs1
[259.873021] Dynamic subtest vcs1: SKIP (0.000s)
[259.883172] Starting dynamic subtest: vecs0
[259.885410] Dynamic subtest vecs0: SKIP (0.000s)
[259.895202] Starting dynamic subtest: vecs1
[259.897520] Dynamic subtest vecs1: SKIP (0.000s)
[259.907260] Starting dynamic subtest: ccs0
[259.909478] Dynamic subtest ccs0: SKIP (0.000s)
[259.911724] Subtest busy: SKIP (0.029s)
[259.975634] [044/133] (771s left) gem_userptr_blits (nohangcheck)
[260.078820] Starting subtest: nohangcheck
[260.394220] Subtest nohangcheck: SUCCESS (0.315s)
[260.595875] [045/133] (771s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[262.121144] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[262.811127] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.690s)
[263.097743] [046/133] (768s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[264.605815] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[264.607701] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[264.858240] [047/133] (767s left) kms_scaling_modes (scaling-mode-full)
[266.366752] Starting subtest: scaling-mode-full
[266.372168] Subtest scaling-mode-full: SKIP (0.001s)
[266.540803] [048/133] (765s left) kms_psr (fbc-pr-basic)
[268.079076] Subtest fbc-pr-basic: SKIP (0.000s)
[268.135252] [049/133] (763s left) gem_ringfill (basic-all)
[268.581845] Starting subtest: basic-all
[270.119083] Subtest basic-all: SUCCESS (1.537s)
[270.327442] [050/133] (761s left) gem_exec_whisper (basic-fds-forked-all)
[270.416225] Starting subtest: basic-fds-forked-all
[293.197953] Subtest basic-fds-forked-all: SUCCESS (22.780s)
[293.487682] [051/133] (738s left) api_intel_bb (full-batch)
[293.576164] Starting subtest: full-batch
[293.602841] Subtest full-batch: SUCCESS (0.028s)
[293.812885] [052/133] (738s left) kms_cursor_crc (cursor-sliding-256x85)
[295.561305] Starting subtest: cursor-sliding-256x85
[295.566655] Starting dynamic subtest: pipe-A-HDMI-A-3
[299.717512] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.148s)
[299.761853] Starting dynamic subtest: pipe-D-HDMI-A-3
[303.830040] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.078s)
[303.830941] Subtest cursor-sliding-256x85: SUCCESS (8.267s)
[304.164573] [053/133] (728s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[305.678771] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[305.679672] Starting dynamic subtest: pipe-A-HDMI-A-3
[305.701193] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[305.712119] Starting dynamic subtest: pipe-B-HDMI-A-3
[305.733573] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[305.744425] Starting dynamic subtest: pipe-C-HDMI-A-3
[305.769418] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[305.780123] Starting dynamic subtest: pipe-D-HDMI-A-3
[305.802417] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[305.804062] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[305.985504] [054/133] (726s left) gen9_exec_parse (allowed-single)
[306.072126] Subtest allowed-single: SKIP (0.000s)
[306.149452] [055/133] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[307.661889] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[307.663616] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.900544] [056/133] (724s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[309.419241] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[309.421210] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[309.644218] [057/133] (723s left) gem_exec_fence (expired-history)
[310.197790] Starting subtest: expired-history
[316.757084] Subtest expired-history: SUCCESS (6.558s)
[318.527551] [058/133] (714s left) kms_psr (fbc-psr-sprite-plane-move)
[320.037925] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[320.097194] [059/133] (712s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[321.612000] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[321.613754] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[321.818694] [060/133] (711s left) gem_ctx_bad_destroy (double-destroy)
[321.898433] Starting subtest: double-destroy
[321.899289] Subtest double-destroy: SUCCESS (0.000s)
[322.058632] [061/133] (711s left) syncobj_timeline (invalid-signal-illegal-handle)
[322.136156] Starting subtest: invalid-signal-illegal-handle
[322.137102] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[322.316061] [062/133] (710s left) kms_chamelium_hpd (common-hpd-after-suspend)
[323.877090] Subtest common-hpd-after-suspend: SKIP (0.000s)
[323.974184] [063/133] (709s left) kms_frontbuffer_tracking (fbc-tiling-4)
[325.493652] Starting subtest: fbc-tiling-4
[328.241209] Subtest fbc-tiling-4: SUCCESS (2.747s)
[328.459090] [064/133] (704s left) gem_cs_tlb (engines)
[328.543186] Starting subtest: engines
[328.544134] Starting dynamic subtest: rcs0
[330.699202] Dynamic subtest rcs0: SUCCESS (2.154s)
[330.710160] Starting dynamic subtest: bcs0
[332.853094] Dynamic subtest bcs0: SUCCESS (2.152s)
[332.864067] Starting dynamic subtest: vcs0
[335.007970] Dynamic subtest vcs0: SUCCESS (2.153s)
[335.019144] Starting dynamic subtest: vcs1
[337.162888] Dynamic subtest vcs1: SUCCESS (2.153s)
[337.173897] Starting dynamic subtest: vecs0
[339.317113] Dynamic subtest vecs0: SUCCESS (2.153s)
[339.328145] Starting dynamic subtest: vecs1
[341.470667] Dynamic subtest vecs1: SUCCESS (2.152s)
[341.481622] Starting dynamic subtest: ccs0
[343.624526] Dynamic subtest ccs0: SUCCESS (2.152s)
[343.625472] Subtest engines: SUCCESS (15.077s)
[343.815234] [065/133] (689s left) gem_mmap_gtt (hang-busy)
[343.893827] Subtest hang-busy: SKIP (0.000s)
[343.975982] [066/133] (689s left) kms_psr (psr2-sprite-plane-onoff)
[345.484899] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[345.548813] [067/133] (688s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[347.074013] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[347.845497] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.771s)
[348.111210] [068/133] (685s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[349.636988] Starting subtest: y-tiled-64bpp-rotate-270
[349.638849] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[349.854291] [069/133] (683s left) gem_bad_reloc (negative-reloc-lut)
[349.941062] Subtest negative-reloc-lut: SKIP (0.000s)
[350.028299] [070/133] (683s left) gem_ctx_persistence (engines-mixed)
[350.111959] Starting subtest: engines-mixed
[350.113226] Starting dynamic subtest: rcs0
[350.229194] Dynamic subtest rcs0: SUCCESS (0.117s)
[350.250283] Starting dynamic subtest: bcs0
[350.297740] Dynamic subtest bcs0: SUCCESS (0.066s)
[350.312162] Starting dynamic subtest: vcs0
[350.364062] Dynamic subtest vcs0: SUCCESS (0.063s)
[350.377921] Starting dynamic subtest: vcs1
[350.429296] Dynamic subtest vcs1: SUCCESS (0.063s)
[350.462159] Starting dynamic subtest: vecs0
[350.502792] Dynamic subtest vecs0: SUCCESS (0.071s)
[350.543538] Starting dynamic subtest: vecs1
[350.585055] Dynamic subtest vecs1: SUCCESS (0.078s)
[350.609508] Starting dynamic subtest: ccs0
[350.641112] Dynamic subtest ccs0: SUCCESS (0.054s)
[350.642137] Subtest engines-mixed: SUCCESS (0.530s)
[350.849043] [071/133] (683s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[352.361801] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[352.362759] Starting dynamic subtest: pipe-A
[352.446205] Dynamic subtest pipe-A: SUCCESS (0.085s)
[352.460510] Starting dynamic subtest: pipe-B
[352.571593] Dynamic subtest pipe-B: SUCCESS (0.124s)
[352.585690] Starting dynamic subtest: pipe-C
[352.696680] Dynamic subtest pipe-C: SUCCESS (0.124s)
[352.708121] Starting dynamic subtest: pipe-D
[352.820622] Dynamic subtest pipe-D: SUCCESS (0.123s)
[352.821550] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.461s)
[353.107256] [072/133] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[354.621772] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[354.623490] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[354.862431] [073/133] (679s left) gem_exec_schedule (semaphore-noskip)
[354.956947] Starting subtest: semaphore-noskip
[355.716654] Subtest semaphore-noskip: SUCCESS (0.760s)
[356.126438] [074/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[357.645442] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[357.647145] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[357.881038] [075/133] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[359.392672] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[359.394471] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[359.623502] [076/133] (674s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[361.149462] Starting subtest: 4-tiled-16bpp-rotate-0
[362.881488] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.731s)
[363.095513] [077/133] (671s left) gem_exec_basic (basic)
[363.178364] Starting subtest: basic
[363.179212] Starting dynamic subtest: rcs0-smem
[363.182714] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[363.195364] Starting dynamic subtest: bcs0-smem
[363.196152] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[363.207217] Starting dynamic subtest: vcs0-smem
[363.208222] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[363.218804] Starting dynamic subtest: vcs1-smem
[363.219829] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[363.230055] Starting dynamic subtest: vecs0-smem
[363.231160] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[363.241404] Starting dynamic subtest: vecs1-smem
[363.242540] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[363.252700] Starting dynamic subtest: ccs0-smem
[363.253776] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[363.264079] Starting dynamic subtest: rcs0-lmem0
[363.265186] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[363.275527] Starting dynamic subtest: bcs0-lmem0
[363.276484] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[363.286781] Starting dynamic subtest: vcs0-lmem0
[363.287780] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[363.298091] Starting dynamic subtest: vcs1-lmem0
[363.299176] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[363.309427] Starting dynamic subtest: vecs0-lmem0
[363.310252] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[363.320924] Starting dynamic subtest: vecs1-lmem0
[363.321788] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[363.332240] Starting dynamic subtest: ccs0-lmem0
[363.333379] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[363.334350] Subtest basic: SUCCESS (0.024s)
[363.473077] [078/133] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[364.989635] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[364.991423] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[365.243558] [079/133] (669s left) gem_mmap (short-mmap)
[365.325954] Subtest short-mmap: SKIP (0.000s)
[365.406139] [080/133] (669s left) gem_exec_reloc (basic-gtt-wc-active)
[365.492177] Subtest basic-gtt-wc-active: SKIP (0.000s)
[365.560310] [081/133] (669s left) gem_ctx_shared (create-shared-gtt)
[365.649223] Starting subtest: create-shared-gtt
[367.800042] Subtest create-shared-gtt: SUCCESS (2.150s)
[369.604199] [082/133] (665s left) gem_exec_reloc (basic-write-wc)
[369.686817] Subtest basic-write-wc: SKIP (0.000s)
[369.790972] [083/133] (665s left) gem_eio (wait-immediate)
[370.074192] Starting subtest: wait-immediate
[370.726569] Subtest wait-immediate: SUCCESS (0.652s)
[372.318462] [084/133] (662s left) gem_ctx_persistence (legacy-engines-mixed)
[372.431156] Starting subtest: legacy-engines-mixed
[372.432105] Starting dynamic subtest: render
[372.539183] Dynamic subtest render: SUCCESS (0.107s)
[372.555982] Starting dynamic subtest: bsd1
[372.608737] Dynamic subtest bsd1: SUCCESS (0.067s)
[372.653308] Starting dynamic subtest: bsd2
[372.696233] Dynamic subtest bsd2: SUCCESS (0.083s)
[372.725686] Starting dynamic subtest: blt
[372.775739] Dynamic subtest blt: SUCCESS (0.076s)
[372.819730] Starting dynamic subtest: vebox
[372.864258] Dynamic subtest vebox: SUCCESS (0.084s)
[372.865406] Subtest legacy-engines-mixed: SUCCESS (0.434s)
[373.116577] [085/133] (662s left) perf_pmu (semaphore-busy)
[373.186052] Starting subtest: semaphore-busy
[373.187017] Starting dynamic subtest: rcs0
[374.862548] Dynamic subtest rcs0: SUCCESS (1.673s)
[374.879349] Starting dynamic subtest: bcs0
[376.504850] Dynamic subtest bcs0: SUCCESS (1.637s)
[376.523930] Starting dynamic subtest: vcs0
[378.155213] Dynamic subtest vcs0: SUCCESS (1.645s)
[378.176405] Starting dynamic subtest: vcs1
[379.802374] Dynamic subtest vcs1: SUCCESS (1.643s)
[379.823318] Starting dynamic subtest: vecs0
[381.449450] Dynamic subtest vecs0: SUCCESS (1.642s)
[381.470896] Starting dynamic subtest: vecs1
[383.099215] Dynamic subtest vecs1: SUCCESS (1.645s)
[383.120292] Starting dynamic subtest: ccs0
[384.746415] Dynamic subtest ccs0: SUCCESS (1.642s)
[384.748345] Subtest semaphore-busy: SUCCESS (11.562s)
[384.969103] [086/133] (650s left) gem_exec_schedule (pi-common)
[385.173228] Starting subtest: pi-common
[385.174115] Starting dynamic subtest: rcs0
[385.210696] Dynamic subtest rcs0: SUCCESS (0.037s)
[385.223115] Starting dynamic subtest: bcs0
[385.247646] Dynamic subtest bcs0: SUCCESS (0.036s)
[385.261548] Starting dynamic subtest: vcs0
[385.281090] Dynamic subtest vcs0: SUCCESS (0.032s)
[385.295061] Starting dynamic subtest: vcs1
[385.313298] Dynamic subtest vcs1: SUCCESS (0.031s)
[385.327383] Starting dynamic subtest: vecs0
[385.345920] Dynamic subtest vecs0: SUCCESS (0.032s)
[385.359812] Starting dynamic subtest: vecs1
[385.377097] Dynamic subtest vecs1: SUCCESS (0.030s)
[385.391403] Starting dynamic subtest: ccs0
[385.406935] Dynamic subtest ccs0: SUCCESS (0.029s)
[385.408018] Subtest pi-common: SUCCESS (0.234s)
[385.716848] [087/133] (649s left) i915_hangman (engine-error-state-capture)
[385.809991] Starting subtest: engine-error-state-capture
[385.810906] Starting dynamic subtest: rcs0
[390.476868] Dynamic subtest rcs0: SUCCESS (4.667s)
[390.490411] Starting dynamic subtest: bcs0
[394.477216] Dynamic subtest bcs0: SUCCESS (4.000s)
[394.493385] Starting dynamic subtest: vcs0
[398.524466] Dynamic subtest vcs0: SUCCESS (4.046s)
[398.541407] Starting dynamic subtest: vcs1
[402.458941] Dynamic subtest vcs1: SUCCESS (3.933s)
[402.472551] Starting dynamic subtest: vecs0
[406.490023] Dynamic subtest vecs0: SUCCESS (4.030s)
[406.503666] Starting dynamic subtest: vecs1
[410.446010] Dynamic subtest vecs1: SUCCESS (3.955s)
[410.459740] Starting dynamic subtest: ccs0
[414.496719] Dynamic subtest ccs0: SUCCESS (4.050s)
[414.497644] Subtest engine-error-state-capture: SUCCESS (28.691s)
[414.672409] [088/133] (620s left) syncobj_timeline (wait-for-submit-snapshot)
[414.749071] Starting subtest: wait-for-submit-snapshot
[414.833366] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[415.035233] [089/133] (620s left) kms_color (ctm-blue-to-red)
[416.550135] Starting subtest: ctm-blue-to-red
[416.551061] Starting dynamic subtest: pipe-A-HDMI-A-3
[417.233166] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.689s)
[417.247039] Starting dynamic subtest: pipe-B-HDMI-A-3
[417.736747] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.502s)
[417.749200] Starting dynamic subtest: pipe-C-HDMI-A-3
[418.212049] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.474s)
[418.224268] Starting dynamic subtest: pipe-D-HDMI-A-3
[418.726243] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.513s)
[418.727161] Subtest ctm-blue-to-red: SUCCESS (2.183s)
[418.977501] [090/133] (616s left) prime_vgem (basic-gtt)
[419.073398] Starting subtest: basic-gtt
[419.075568] Subtest basic-gtt: SKIP (0.000s)
[419.238138] [091/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[420.756650] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[420.758315] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[421.016099] [092/133] (614s left) api_intel_allocator (default-alignment)
[421.093126] Starting subtest: default-alignment
[421.100855] Subtest default-alignment: SUCCESS (0.008s)
[421.312201] [093/133] (614s left) i915_pm_rps (fence-order)
[421.398396] Starting subtest: fence-order
[425.798222] Subtest fence-order: SUCCESS (4.398s)
[425.962368] [094/133] (609s left) kms_vblank (query-busy)
[427.470697] Starting subtest: query-busy
[427.471631] Starting dynamic subtest: pipe-A-HDMI-A-3
[429.936360] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.465s)
[429.952241] Starting dynamic subtest: pipe-D-HDMI-A-3
[432.283451] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.343s)
[432.284564] Subtest query-busy: SUCCESS (4.814s)
[432.511154] [095/133] (603s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[434.035010] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[434.037002] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[434.262070] [096/133] (601s left) kms_addfb_basic (invalid-get-prop-any)
[434.339219] Starting subtest: invalid-get-prop-any
[434.340081] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[436.017725] [097/133] (600s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[437.533101] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[437.595331] [098/133] (598s left) kms_flip (2x-blocking-absolute-wf_vblank)
[439.107886] Starting subtest: 2x-blocking-absolute-wf_vblank
[439.121636] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[439.295935] [099/133] (597s left) kms_cursor_crc (cursor-onscreen-256x85)
[441.075134] Starting subtest: cursor-onscreen-256x85
[441.080304] Starting dynamic subtest: pipe-A-HDMI-A-3
[443.787776] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.708s)
[443.820871] Starting dynamic subtest: pipe-D-HDMI-A-3
[446.455079] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.645s)
[446.455993] Subtest cursor-onscreen-256x85: SUCCESS (5.379s)
[446.781989] [100/133] (589s left) kms_flip (2x-modeset-vs-vblank-race)
[448.289003] Starting subtest: 2x-modeset-vs-vblank-race
[448.302483] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[448.510402] [101/133] (588s left) kms_atomic_interruptible (atomic-setmode)
[450.020570] Starting subtest: atomic-setmode
[450.022823] Starting dynamic subtest: pipe-A-HDMI-A-3
[456.196072] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.173s)
[456.196937] Subtest atomic-setmode: SUCCESS (6.175s)
[456.427586] [102/133] (580s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[457.945742] Starting subtest: psr-argb161616f-draw-render
[457.947450] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[458.168422] [103/133] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[459.684549] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[459.686129] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[459.917182] [104/133] (577s left) kms_plane_scaling (invalid-num-scalers)
[461.426718] Starting subtest: invalid-num-scalers
[461.430594] Starting dynamic subtest: pipe-A-HDMI-A-3-invalid-num-scalers
[461.450377] Dynamic subtest pipe-A-HDMI-A-3-invalid-num-scalers: SUCCESS (0.019s)
[461.467050] Starting dynamic subtest: pipe-B-HDMI-A-3-invalid-num-scalers
[461.485896] Dynamic subtest pipe-B-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[461.503888] Starting dynamic subtest: pipe-C-HDMI-A-3-invalid-num-scalers
[461.522873] Dynamic subtest pipe-C-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[461.539348] Starting dynamic subtest: pipe-D-HDMI-A-3-invalid-num-scalers
[461.559644] Dynamic subtest pipe-D-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[461.560473] Subtest invalid-num-scalers: SUCCESS (0.134s)
[461.729415] [105/133] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[463.252883] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[463.254640] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[463.488579] [106/133] (573s left) sw_sync (alloc_fence_invalid_timeline)
[463.536945] Starting subtest: alloc_fence_invalid_timeline
[463.537870] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[463.692920] [107/133] (573s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[463.771065] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[463.876307] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[464.051701] [108/133] (573s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[465.569039] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[465.573938] Starting dynamic subtest: A-HDMI-A3
[473.583375] Dynamic subtest A-HDMI-A3: SUCCESS (8.009s)
[473.598881] Starting dynamic subtest: B-HDMI-A3
[481.529031] Dynamic subtest B-HDMI-A3: SUCCESS (7.943s)
[481.543844] Starting dynamic subtest: C-HDMI-A3
[489.476886] Dynamic subtest C-HDMI-A3: SUCCESS (7.945s)
[489.493462] Starting dynamic subtest: D-HDMI-A3
[497.420878] Dynamic subtest D-HDMI-A3: SUCCESS (7.938s)
[497.421815] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.850s)
[497.705599] [109/133] (539s left) kms_addfb_basic (size-max)
[499.213864] Starting subtest: size-max
[499.214788] Subtest size-max: SUCCESS (0.000s)
[499.442647] [110/133] (538s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[501.173629] Starting subtest: cursor-rapid-movement-256x256
[501.178005] Starting dynamic subtest: pipe-A-HDMI-A-3
[501.600129] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.422s)
[501.633195] Starting dynamic subtest: pipe-D-HDMI-A-3
[501.918784] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.296s)
[501.919666] Subtest cursor-rapid-movement-256x256: SUCCESS (0.745s)
[502.316039] [111/133] (535s left) gem_exec_whisper (basic-queues-all)
[502.404024] Starting subtest: basic-queues-all
[524.218997] Subtest basic-queues-all: SUCCESS (21.810s)
[524.505611] [112/133] (513s left) kms_dsc (dsc-fractional-bpp)
[526.016882] Starting subtest: dsc-fractional-bpp
[526.021880] Subtest dsc-fractional-bpp: SKIP (0.000s)
[526.189329] [113/133] (511s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[527.714739] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[527.715579] Starting dynamic subtest: pipe-A-valid-mode
[527.768377] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[527.770044] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.054s)
[527.982436] [114/133] (509s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[529.500924] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[529.502742] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[529.741039] [115/133] (508s left) gem_softpin (evict-prime)
[529.825314] Starting subtest: evict-prime
[529.826211] Starting dynamic subtest: rcs0
[531.110455] Dynamic subtest rcs0: SUCCESS (1.284s)
[531.123051] Starting dynamic subtest: bcs0
[532.282164] Dynamic subtest bcs0: SUCCESS (1.171s)
[532.298685] Starting dynamic subtest: vcs0
[533.450197] Dynamic subtest vcs0: SUCCESS (1.167s)
[533.466608] Starting dynamic subtest: vcs1
[534.605150] Dynamic subtest vcs1: SUCCESS (1.154s)
[534.620865] Starting dynamic subtest: vecs0
[535.780226] Dynamic subtest vecs0: SUCCESS (1.174s)
[535.796461] Starting dynamic subtest: vecs1
[536.956028] Dynamic subtest vecs1: SUCCESS (1.174s)
[536.972631] Starting dynamic subtest: ccs0
[538.175932] Dynamic subtest ccs0: SUCCESS (1.219s)
[538.190602] Starting dynamic subtest: all
[539.361082] Dynamic subtest all: SUCCESS (1.184s)
[539.362281] Subtest evict-prime: SUCCESS (9.535s)
[539.542748] [116/133] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[541.056490] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[541.058056] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[541.303557] [117/133] (496s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[542.813555] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[543.036878] [118/133] (495s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[543.118149] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[543.220299] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[543.353476] [119/133] (495s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[544.861704] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[544.863544] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[545.089831] [120/133] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[546.618838] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[549.880711] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.269s)
[550.114718] [121/133] (488s left) gem_mmap_wc (bad-size)
[550.191806] Subtest bad-size: SKIP (0.000s)
[550.266270] [122/133] (488s left) kms_hdr (static-toggle-suspend)
[551.775875] Starting subtest: static-toggle-suspend
[551.778499] Subtest static-toggle-suspend: SKIP (0.000s)
[551.936261] [123/133] (486s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[553.472658] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[553.474579] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[553.714615] [124/133] (485s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[555.236319] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[555.293591] [125/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[556.805742] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[556.807566] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[557.028989] [126/133] (482s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[558.540634] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[558.541542] Starting dynamic subtest: pipe-A-HDMI-A-3
[558.550066] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[558.563004] Starting dynamic subtest: pipe-B-HDMI-A-3
[558.571576] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[558.583798] Starting dynamic subtest: pipe-C-HDMI-A-3
[558.591982] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[558.604154] Starting dynamic subtest: pipe-D-HDMI-A-3
[558.615208] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[558.617193] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[558.832939] [127/133] (480s left) syncobj_timeline (single-wait-all-available-submitted)
[558.918031] Starting subtest: single-wait-all-available-submitted
[558.919017] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[559.093772] [128/133] (480s left) gem_exec_parallel (userptr)
[559.186396] Starting subtest: userptr
[559.187238] Starting dynamic subtest: rcs0
[560.749168] Dynamic subtest rcs0: SUCCESS (1.562s)
[560.765721] Starting dynamic subtest: bcs0
[562.203256] Dynamic subtest bcs0: SUCCESS (1.453s)
[562.217121] Starting dynamic subtest: vcs0
[563.697357] Dynamic subtest vcs0: SUCCESS (1.493s)
[563.712698] Starting dynamic subtest: vcs1
[565.180207] Dynamic subtest vcs1: SUCCESS (1.481s)
[565.195771] Starting dynamic subtest: vecs0
[566.643166] Dynamic subtest vecs0: SUCCESS (1.461s)
[566.658624] Starting dynamic subtest: vecs1
[568.090154] Dynamic subtest vecs1: SUCCESS (1.445s)
[568.106684] Starting dynamic subtest: ccs0
[569.548898] Dynamic subtest ccs0: SUCCESS (1.457s)
[569.549841] Subtest userptr: SUCCESS (10.361s)
[569.881670] [129/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[571.394483] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[571.396097] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[571.643431] [130/133] (467s left) i915_selftest (mock)
[572.781348] Starting subtest: mock
[572.782325] Starting dynamic subtest: sanitycheck
[573.539703] Dynamic subtest sanitycheck: SUCCESS (0.758s)
[573.557045] Starting dynamic subtest: shmem
[574.292706] Dynamic subtest shmem: SUCCESS (0.748s)
[574.328919] Starting dynamic subtest: fence
[581.946044] Dynamic subtest fence: SUCCESS (7.648s)
[581.960205] Starting dynamic subtest: scatterlist
[583.712760] Dynamic subtest scatterlist: SUCCESS (1.764s)
[583.725882] Starting dynamic subtest: syncmap
[586.592837] Dynamic subtest syncmap: SUCCESS (2.877s)
[586.609483] Starting dynamic subtest: uncore
[587.353252] Dynamic subtest uncore: SUCCESS (0.756s)
[587.390506] Starting dynamic subtest: ring
[588.143528] Dynamic subtest ring: SUCCESS (0.785s)
[588.180741] Starting dynamic subtest: engine
[588.912759] Dynamic subtest engine: SUCCESS (0.764s)
[588.951050] Starting dynamic subtest: timelines
[593.480935] Dynamic subtest timelines: SUCCESS (4.563s)
[593.495035] Starting dynamic subtest: requests
[597.116562] Dynamic subtest requests: SUCCESS (3.633s)
[597.126566] Starting dynamic subtest: objects
[598.008275] Dynamic subtest objects: SUCCESS (0.890s)
[598.045685] Starting dynamic subtest: phys
[598.917978] Dynamic subtest phys: SUCCESS (0.906s)
[598.939411] Starting dynamic subtest: dmabuf
[599.852907] Dynamic subtest dmabuf: SUCCESS (0.933s)
[599.868554] Starting dynamic subtest: vma
[607.943455] Dynamic subtest vma: SUCCESS (8.088s)
[607.955861] Starting dynamic subtest: evict
[609.696767] Dynamic subtest evict: SUCCESS (1.751s)
[609.712259] Starting dynamic subtest: gtt
[613.612561] Dynamic subtest gtt: SUCCESS (3.914s)
[613.622442] Starting dynamic subtest: hugepages
[614.665564] Dynamic subtest hugepages: SUCCESS (1.052s)
[614.676236] Starting dynamic subtest: memory_region
[618.178857] Dynamic subtest memory_region: SUCCESS (3.511s)
[618.179867] Subtest mock: SUCCESS (45.391s)
[618.217202] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[618.218136] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[618.220209] [131/133] (421s left) gem_mmap_gtt (basic-write-read)
[621.572636] Subtest basic-write-read: SKIP (0.000s)
[621.634138] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[621.636547] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[621.640010] [132/133] (417s left) perf (gen12-group-exclusive-stream-sample-oa)
[622.054045] Starting subtest: gen12-group-exclusive-stream-sample-oa
[622.076366] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[622.140006] [133/133] (417s left) perf_pmu (busy-double-start)
[622.213940] Starting subtest: busy-double-start
[622.214814] Starting dynamic subtest: rcs0
[625.855759] Dynamic subtest rcs0: SUCCESS (3.641s)
[625.870590] Starting dynamic subtest: bcs0
[629.464134] Dynamic subtest bcs0: SUCCESS (3.603s)
[629.478822] Starting dynamic subtest: vcs0
[633.074364] Dynamic subtest vcs0: FAIL (3.579s)
[633.089180] Starting dynamic subtest: vcs1
[636.638143] Dynamic subtest vcs1: FAIL (3.566s)
[636.653828] Starting dynamic subtest: vecs0
[640.203861] Dynamic subtest vecs0: FAIL (3.566s)
[640.216527] Starting dynamic subtest: vecs1
[643.768076] Dynamic subtest vecs1: FAIL (3.564s)
[643.781199] Starting dynamic subtest: ccs0
[647.339970] Dynamic subtest ccs0: SUCCESS (3.594s)
[647.344296] Subtest busy-double-start: FAIL (25.130s)
[647.554360] 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.