[62.856568] Initializing watchdogs
[62.856631]   /dev/watchdog0
[62.876937] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.887708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.891226] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.893629] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[62.976974] Subtest write-snoop: SKIP (0.000s)
[63.062513] [002/133] (960s left) kms_content_protection (content-type-change)
[64.631674] Starting subtest: content-type-change
[64.638583] Subtest content-type-change: SKIP (0.005s)
[64.860063] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[66.363222] Starting subtest: multiplane-rotation
[93.771552] Subtest multiplane-rotation: SUCCESS (27.408s)
[93.995884] [004/133] (929s left) kms_chamelium_color (ctm-red-to-blue)
[95.500968] Subtest ctm-red-to-blue: SKIP (0.000s)
[95.557668] [005/133] (928s left) syncobj_wait (invalid-reset-one-illegal-handle)
[95.627171] Starting subtest: invalid-reset-one-illegal-handle
[95.628182] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[95.824446] [006/133] (927s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[97.325315] Starting subtest: disable-crc-after-crtc
[97.326218] Starting dynamic subtest: pipe-A-HDMI-A-3
[97.929187] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.602s)
[97.938147] Starting dynamic subtest: pipe-B-HDMI-A-3
[98.366059] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.435s)
[98.374880] Starting dynamic subtest: pipe-C-HDMI-A-3
[98.805750] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.438s)
[98.814371] Starting dynamic subtest: pipe-D-HDMI-A-3
[99.250620] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.444s)
[99.251555] Subtest disable-crc-after-crtc: SUCCESS (1.926s)
[99.491095] [007/133] (924s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[99.571320] Subtest tiled-to-tiled: SKIP (0.000s)
[99.655500] [008/133] (924s left) syncobj_wait (wait-all-interrupted)
[99.732481] Starting subtest: wait-all-interrupted
[99.843924] Subtest wait-all-interrupted: SUCCESS (0.105s)
[100.013347] [009/133] (923s left) syncobj_wait (wait-all-complex)
[100.083369] Starting subtest: wait-all-complex
[100.310733] Subtest wait-all-complex: SUCCESS (0.216s)
[100.434317] [010/133] (923s left) gem_pxp (reject-modify-context-protection-on)
[103.032682] Starting subtest: reject-modify-context-protection-on
[103.034576] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[103.166559] [011/133] (920s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[104.665609] Starting subtest: cursorA-vs-flipB-varying-size
[104.667406] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[104.816781] [012/133] (919s left) kms_rotation_crc (primary-rotation-90)
[106.348244] Starting subtest: primary-rotation-90
[106.350078] Subtest primary-rotation-90: SKIP (0.001s)
[106.502172] [013/133] (917s left) syncobj_wait (reset-multiple-signaled)
[106.605147] Starting subtest: reset-multiple-signaled
[106.606181] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[106.793453] [014/133] (917s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[108.293348] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[108.295131] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[108.532315] [015/133] (915s left) gem_softpin (noreloc-s3)
[108.613734] Starting subtest: noreloc-S3
[129.372322] Subtest noreloc-S3: SUCCESS (5.385s)
[135.617157] [016/133] (894s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[137.169384] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[140.046980] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.809s)
[140.260562] [017/133] (890s left) gem_ctx_param (invalid-ctx-set)
[140.327332] Starting subtest: invalid-ctx-set
[140.329350] Subtest invalid-ctx-set: SUCCESS (0.002s)
[140.531482] [018/133] (890s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[140.607112] Starting subtest: single-wait-all-for-submit-unsubmitted
[140.714888] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[140.855462] [019/133] (889s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[142.390728] Starting subtest: x-tiled-64bpp-rotate-90
[142.454278] Subtest x-tiled-64bpp-rotate-90: SKIP (0.062s)
[142.692160] [020/133] (888s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[142.765963] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[142.840419] [021/133] (887s left) kms_psr (fbc-psr-cursor-plane-move)
[144.357986] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[144.420057] [022/133] (886s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[145.946368] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[147.256325] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.298s)
[147.464849] [023/133] (883s left) kms_flip (2x-flip-vs-rmfb)
[148.974926] Starting subtest: 2x-flip-vs-rmfb
[148.988292] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[149.165880] [024/133] (881s left) kms_plane_cursor (viewport)
[150.687329] Starting subtest: viewport
[150.689112] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[153.942749] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.240s)
[154.023272] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[157.252555] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.233s)
[157.337372] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[160.526165] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.200s)
[160.661525] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[163.911297] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.254s)
[163.969755] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[167.129932] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.167s)
[167.197581] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[170.395760] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.216s)
[170.497858] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[173.777444] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.289s)
[173.850103] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[177.012128] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.183s)
[177.071075] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[180.296095] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.234s)
[180.379772] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[183.658125] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.287s)
[183.716539] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[186.841704] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.133s)
[186.915926] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[190.176885] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.283s)
[190.250931] Subtest viewport: SUCCESS (39.522s)
[190.513487] [025/133] (840s left) kms_cdclk (mode-transition)
[192.033656] Starting subtest: mode-transition
[192.034553] Starting dynamic subtest: pipe-A-HDMI-A-3
[192.087597] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.052s)
[192.097545] Starting dynamic subtest: pipe-B-HDMI-A-3
[192.099236] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[192.108951] Starting dynamic subtest: pipe-C-HDMI-A-3
[192.110724] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[192.120565] Starting dynamic subtest: pipe-D-HDMI-A-3
[192.122247] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[192.123998] Subtest mode-transition: SKIP (0.064s)
[192.303957] [026/133] (838s left) gem_exec_balancer (fairslice)
[192.383680] Starting subtest: fairslice
[198.021861] Subtest fairslice: SUCCESS (5.636s)
[198.468338] [027/133] (832s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[199.977860] Starting subtest: basic-flip-before-cursor-varying-size
[200.984152] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.005s)
[201.245261] [028/133] (830s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[202.748757] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[202.749700] Starting dynamic subtest: pipe-A-valid-mode
[202.802660] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[202.804335] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.054s)
[203.004928] [029/133] (828s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[204.523830] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[204.524763] Starting dynamic subtest: pipe-A-valid-mode
[205.352185] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.826s)
[205.353184] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.828s)
[205.604432] [030/133] (825s left) core_getstats (basic)
[205.675080] Starting subtest: basic
[205.675997] Subtest basic: SUCCESS (0.000s)
[205.871787] [031/133] (825s left) kms_rmfb (close-fd)
[207.375058] Starting subtest: close-fd
[207.375949] Starting dynamic subtest: pipe-A-HDMI-A-3
[207.539310] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.165s)
[207.563777] Starting dynamic subtest: pipe-B-HDMI-A-3
[207.784020] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.241s)
[207.799760] Starting dynamic subtest: pipe-C-HDMI-A-3
[207.996323] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.210s)
[208.012232] Starting dynamic subtest: pipe-D-HDMI-A-3
[208.195197] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.195s)
[208.196115] Subtest close-fd: SUCCESS (0.822s)
[208.435806] [032/133] (823s left) gem_exec_reloc (basic-gtt-wc)
[208.510971] Subtest basic-gtt-wc: SKIP (0.000s)
[208.596855] [033/133] (823s left) kms_properties (crtc-properties-legacy)
[210.104855] Starting subtest: crtc-properties-legacy
[210.105678] Starting dynamic subtest: pipe-A-HDMI-A-3
[210.389452] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.284s)
[210.427424] Starting dynamic subtest: pipe-B-HDMI-A-3
[210.687837] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.293s)
[210.699828] Starting dynamic subtest: pipe-C-HDMI-A-3
[210.948748] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.259s)
[210.960451] Starting dynamic subtest: pipe-D-HDMI-A-3
[211.191193] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.240s)
[211.192062] Subtest crtc-properties-legacy: SUCCESS (1.088s)
[211.444027] [034/133] (820s left) kms_invalid_mode (zero-hdisplay)
[212.952961] Starting subtest: zero-hdisplay
[212.955780] Starting dynamic subtest: pipe-A-HDMI-A-3
[212.994975] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.039s)
[213.005059] Starting dynamic subtest: pipe-B-HDMI-A-3
[213.006285] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[213.016140] Starting dynamic subtest: pipe-C-HDMI-A-3
[213.017343] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[213.026537] Starting dynamic subtest: pipe-D-HDMI-A-3
[213.027640] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[213.028838] Subtest zero-hdisplay: SUCCESS (0.049s)
[213.228411] [035/133] (818s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[214.728967] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[214.729870] Starting dynamic subtest: pipe-A
[216.338988] Dynamic subtest pipe-A: SUCCESS (1.610s)
[216.364232] Starting dynamic subtest: pipe-B
[217.980783] Dynamic subtest pipe-B: SUCCESS (1.639s)
[218.010836] Starting dynamic subtest: pipe-C
[218.221077] Dynamic subtest pipe-C: SUCCESS (0.238s)
[218.237389] Starting dynamic subtest: pipe-D
[218.445377] Dynamic subtest pipe-D: SUCCESS (0.222s)
[218.449634] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.718s)
[218.720132] [036/133] (813s left) kms_pm_rpm (legacy-planes-dpms)
[222.450277] Starting subtest: legacy-planes-dpms
[222.451275] Starting dynamic subtest: plane-63
[229.482202] Dynamic subtest plane-63: SUCCESS (7.027s)
[229.526438] Starting dynamic subtest: plane-93
[237.125512] Dynamic subtest plane-93: SUCCESS (7.642s)
[237.167109] Starting dynamic subtest: plane-123
[244.054907] Dynamic subtest plane-123: SUCCESS (6.927s)
[244.101024] Starting dynamic subtest: plane-133
[251.104240] Dynamic subtest plane-133: SUCCESS (7.046s)
[251.108686] Subtest legacy-planes-dpms: SUCCESS (28.659s)
[252.103559] [037/133] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[253.620740] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[253.622582] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.859831] [038/133] (778s left) kms_dirtyfb (default-dirtyfb-ioctl)
[255.360927] Starting subtest: default-dirtyfb-ioctl
[255.361901] Starting dynamic subtest: A-HDMI-A-3
[256.749200] Dynamic subtest A-HDMI-A-3: SUCCESS (1.387s)
[256.750086] Subtest default-dirtyfb-ioctl: SUCCESS (1.389s)
[256.987682] [039/133] (775s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[258.489957] Starting subtest: cursorB-vs-flipA-legacy
[258.493063] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[258.688888] [040/133] (773s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[258.769142] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[258.770057] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[258.946905] [041/133] (773s left) kms_prime (basic-crc-vgem)
[260.494401] Subtest basic-crc-vgem: SKIP (0.000s)
[260.698017] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[260.700033] [042/133] (771s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[260.778995] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[260.861714] [043/133] (771s left) i915_drm_fdinfo (busy)
[260.932246] Starting subtest: busy
[260.933198] Starting dynamic subtest: rcs0
[260.951963] Dynamic subtest rcs0: SKIP (0.018s)
[260.962359] Starting dynamic subtest: bcs0
[260.964380] Dynamic subtest bcs0: SKIP (0.000s)
[260.974803] Starting dynamic subtest: vcs0
[260.976807] Dynamic subtest vcs0: SKIP (0.000s)
[260.987389] Starting dynamic subtest: vcs1
[260.989544] Dynamic subtest vcs1: SKIP (0.000s)
[260.999920] Starting dynamic subtest: vecs0
[261.002323] Dynamic subtest vecs0: SKIP (0.000s)
[261.012408] Starting dynamic subtest: vecs1
[261.014617] Dynamic subtest vecs1: SKIP (0.000s)
[261.024517] Starting dynamic subtest: ccs0
[261.026565] Dynamic subtest ccs0: SKIP (0.000s)
[261.028644] Subtest busy: SKIP (0.027s)
[261.091419] [044/133] (771s left) gem_userptr_blits (nohangcheck)
[261.205892] Starting subtest: nohangcheck
[261.532771] Subtest nohangcheck: SUCCESS (0.325s)
[261.753534] [045/133] (771s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[263.271716] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[263.960815] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.689s)
[264.236660] [046/133] (768s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[265.746969] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[265.748730] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[265.996641] [047/133] (766s left) kms_scaling_modes (scaling-mode-full)
[267.507257] Starting subtest: scaling-mode-full
[267.512556] Subtest scaling-mode-full: SKIP (0.001s)
[267.711167] [048/133] (765s left) kms_psr (fbc-pr-basic)
[269.234177] Subtest fbc-pr-basic: SKIP (0.000s)
[269.286871] [049/133] (763s left) gem_ringfill (basic-all)
[269.728253] Starting subtest: basic-all
[271.411865] Subtest basic-all: SUCCESS (1.684s)
[271.581296] [050/133] (761s left) gem_exec_whisper (basic-fds-forked-all)
[271.671414] Starting subtest: basic-fds-forked-all
[294.430341] Subtest basic-fds-forked-all: SUCCESS (22.754s)
[294.710967] [051/133] (738s left) api_intel_bb (full-batch)
[294.789321] Starting subtest: full-batch
[294.814653] Subtest full-batch: SUCCESS (0.026s)
[295.041890] [052/133] (738s left) kms_cursor_crc (cursor-sliding-256x85)
[296.792043] Starting subtest: cursor-sliding-256x85
[296.797195] Starting dynamic subtest: pipe-A-HDMI-A-3
[301.154520] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.357s)
[301.188445] Starting dynamic subtest: pipe-D-HDMI-A-3
[305.304154] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.125s)
[305.305045] Subtest cursor-sliding-256x85: SUCCESS (8.510s)
[305.620750] [053/133] (727s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[307.130926] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[307.131769] Starting dynamic subtest: pipe-A-HDMI-A-3
[307.153588] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[307.164977] Starting dynamic subtest: pipe-B-HDMI-A-3
[307.187060] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[307.198207] Starting dynamic subtest: pipe-C-HDMI-A-3
[307.222767] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[307.233947] Starting dynamic subtest: pipe-D-HDMI-A-3
[307.255731] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[307.257296] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[307.428647] [054/133] (726s left) gen9_exec_parse (allowed-single)
[307.516927] Subtest allowed-single: SKIP (0.000s)
[307.593970] [055/133] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[309.121990] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[309.123739] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.365524] [056/133] (724s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[310.886195] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[310.888100] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[311.121624] [057/133] (722s left) gem_exec_fence (expired-history)
[311.642724] Starting subtest: expired-history
[318.231399] Subtest expired-history: SUCCESS (6.586s)
[320.237879] [058/133] (713s left) kms_psr (fbc-psr-sprite-plane-move)
[321.755214] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[321.813230] [059/133] (712s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[323.328747] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[323.330668] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[323.528973] [060/133] (710s left) gem_ctx_bad_destroy (double-destroy)
[323.611448] Starting subtest: double-destroy
[323.612308] Subtest double-destroy: SUCCESS (0.000s)
[323.775268] [061/133] (710s left) syncobj_timeline (invalid-signal-illegal-handle)
[323.856147] Starting subtest: invalid-signal-illegal-handle
[323.857035] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[324.062095] [062/133] (710s left) kms_chamelium_hpd (common-hpd-after-suspend)
[325.609711] Subtest common-hpd-after-suspend: SKIP (0.000s)
[325.708281] [063/133] (708s left) kms_frontbuffer_tracking (fbc-tiling-4)
[327.228765] Starting subtest: fbc-tiling-4
[329.859688] Subtest fbc-tiling-4: SUCCESS (2.631s)
[330.101161] [064/133] (704s left) gem_cs_tlb (engines)
[330.182305] Starting subtest: engines
[330.183235] Starting dynamic subtest: rcs0
[332.338254] Dynamic subtest rcs0: SUCCESS (2.154s)
[332.349420] Starting dynamic subtest: bcs0
[334.493273] Dynamic subtest bcs0: SUCCESS (2.153s)
[334.504401] Starting dynamic subtest: vcs0
[336.647700] Dynamic subtest vcs0: SUCCESS (2.152s)
[336.658992] Starting dynamic subtest: vcs1
[338.801865] Dynamic subtest vcs1: SUCCESS (2.153s)
[338.813228] Starting dynamic subtest: vecs0
[340.955424] Dynamic subtest vecs0: SUCCESS (2.152s)
[340.966759] Starting dynamic subtest: vecs1
[343.109879] Dynamic subtest vecs1: SUCCESS (2.152s)
[343.121143] Starting dynamic subtest: ccs0
[345.263069] Dynamic subtest ccs0: SUCCESS (2.152s)
[345.264651] Subtest engines: SUCCESS (15.076s)
[345.439132] [065/133] (688s left) gem_mmap_gtt (hang-busy)
[345.519060] Subtest hang-busy: SKIP (0.000s)
[345.598821] [066/133] (688s left) kms_psr (psr2-sprite-plane-onoff)
[347.109662] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[347.176704] [067/133] (687s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[348.704867] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[349.415335] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.710s)
[349.674624] [068/133] (684s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[351.194288] Starting subtest: y-tiled-64bpp-rotate-270
[351.196192] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[351.457336] [069/133] (683s left) gem_bad_reloc (negative-reloc-lut)
[351.541940] Subtest negative-reloc-lut: SKIP (0.000s)
[351.633886] [070/133] (683s left) gem_ctx_persistence (engines-mixed)
[351.715913] Starting subtest: engines-mixed
[351.716875] Starting dynamic subtest: rcs0
[351.834194] Dynamic subtest rcs0: SUCCESS (0.118s)
[351.856067] Starting dynamic subtest: bcs0
[351.907051] Dynamic subtest bcs0: SUCCESS (0.071s)
[351.922605] Starting dynamic subtest: vcs0
[351.954205] Dynamic subtest vcs0: SUCCESS (0.044s)
[351.968129] Starting dynamic subtest: vcs1
[352.021572] Dynamic subtest vcs1: SUCCESS (0.066s)
[352.062293] Starting dynamic subtest: vecs0
[352.096309] Dynamic subtest vecs0: SUCCESS (0.072s)
[352.120941] Starting dynamic subtest: vecs1
[352.171880] Dynamic subtest vecs1: SUCCESS (0.073s)
[352.185959] Starting dynamic subtest: ccs0
[352.236197] Dynamic subtest ccs0: SUCCESS (0.061s)
[352.237249] Subtest engines-mixed: SUCCESS (0.521s)
[352.446442] [071/133] (682s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[353.958843] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[353.959778] Starting dynamic subtest: pipe-A
[354.049922] Dynamic subtest pipe-A: SUCCESS (0.092s)
[354.063364] Starting dynamic subtest: pipe-B
[354.176170] Dynamic subtest pipe-B: SUCCESS (0.125s)
[354.193618] Starting dynamic subtest: pipe-C
[354.301311] Dynamic subtest pipe-C: SUCCESS (0.124s)
[354.313531] Starting dynamic subtest: pipe-D
[354.424554] Dynamic subtest pipe-D: SUCCESS (0.122s)
[354.425407] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.468s)
[354.716589] [072/133] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[356.228691] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[356.230492] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[356.469087] [073/133] (678s left) gem_exec_schedule (semaphore-noskip)
[356.564008] Starting subtest: semaphore-noskip
[357.326670] Subtest semaphore-noskip: SUCCESS (0.762s)
[357.760016] [074/133] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[359.279852] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[359.281540] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[359.505261] [075/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[361.020682] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[361.022250] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[361.259991] [076/133] (674s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[362.781770] Starting subtest: 4-tiled-16bpp-rotate-0
[364.531345] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.749s)
[364.758058] [077/133] (670s left) gem_exec_basic (basic)
[364.839483] Starting subtest: basic
[364.840353] Starting dynamic subtest: rcs0-smem
[364.842943] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[364.854393] Starting dynamic subtest: bcs0-smem
[364.855292] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[364.866499] Starting dynamic subtest: vcs0-smem
[364.867522] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[364.878402] Starting dynamic subtest: vcs1-smem
[364.879409] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[364.890142] Starting dynamic subtest: vecs0-smem
[364.891387] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[364.901940] Starting dynamic subtest: vecs1-smem
[364.902949] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[364.913330] Starting dynamic subtest: ccs0-smem
[364.914224] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[364.924986] Starting dynamic subtest: rcs0-lmem0
[364.926186] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[364.936844] Starting dynamic subtest: bcs0-lmem0
[364.937896] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[364.948468] Starting dynamic subtest: vcs0-lmem0
[364.949501] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[364.960138] Starting dynamic subtest: vcs1-lmem0
[364.961230] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[364.972281] Starting dynamic subtest: vecs0-lmem0
[364.973160] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[364.984409] Starting dynamic subtest: vecs1-lmem0
[364.985412] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[364.996174] Starting dynamic subtest: ccs0-lmem0
[364.997277] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[364.998198] Subtest basic: SUCCESS (0.023s)
[365.174264] [078/133] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[366.692821] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[366.694671] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[366.929928] [079/133] (668s left) gem_mmap (short-mmap)
[367.011150] Subtest short-mmap: SKIP (0.000s)
[367.076090] [080/133] (668s left) gem_exec_reloc (basic-gtt-wc-active)
[367.162102] Subtest basic-gtt-wc-active: SKIP (0.000s)
[367.243137] [081/133] (668s left) gem_ctx_shared (create-shared-gtt)
[367.329931] Starting subtest: create-shared-gtt
[369.479872] Subtest create-shared-gtt: SUCCESS (2.150s)
[372.106557] [082/133] (663s left) gem_exec_reloc (basic-write-wc)
[372.193954] Subtest basic-write-wc: SKIP (0.000s)
[372.274704] [083/133] (663s left) gem_eio (wait-immediate)
[372.618112] Starting subtest: wait-immediate
[373.256166] Subtest wait-immediate: SUCCESS (0.638s)
[374.853838] [084/133] (661s left) gem_ctx_persistence (legacy-engines-mixed)
[374.965573] Starting subtest: legacy-engines-mixed
[374.966502] Starting dynamic subtest: render
[375.073218] Dynamic subtest render: SUCCESS (0.107s)
[375.091588] Starting dynamic subtest: bsd1
[375.130704] Dynamic subtest bsd1: SUCCESS (0.055s)
[375.169035] Starting dynamic subtest: bsd2
[375.211319] Dynamic subtest bsd2: SUCCESS (0.077s)
[375.242950] Starting dynamic subtest: blt
[375.281302] Dynamic subtest blt: SUCCESS (0.067s)
[375.309670] Starting dynamic subtest: vebox
[375.358638] Dynamic subtest vebox: SUCCESS (0.074s)
[375.363600] Subtest legacy-engines-mixed: SUCCESS (0.395s)
[375.588183] [085/133] (660s left) perf_pmu (semaphore-busy)
[375.660146] Starting subtest: semaphore-busy
[375.661065] Starting dynamic subtest: rcs0
[377.338310] Dynamic subtest rcs0: SUCCESS (1.678s)
[377.384020] Starting dynamic subtest: bcs0
[378.983893] Dynamic subtest bcs0: SUCCESS (1.640s)
[378.998347] Starting dynamic subtest: vcs0
[380.624355] Dynamic subtest vcs0: SUCCESS (1.636s)
[380.638620] Starting dynamic subtest: vcs1
[382.262401] Dynamic subtest vcs1: SUCCESS (1.635s)
[382.277173] Starting dynamic subtest: vecs0
[383.902245] Dynamic subtest vecs0: SUCCESS (1.637s)
[383.915321] Starting dynamic subtest: vecs1
[385.540337] Dynamic subtest vecs1: SUCCESS (1.636s)
[385.555313] Starting dynamic subtest: ccs0
[387.178326] Dynamic subtest ccs0: SUCCESS (1.634s)
[387.179359] Subtest semaphore-busy: SUCCESS (11.521s)
[387.362241] [086/133] (648s left) gem_exec_schedule (pi-common)
[387.567650] Starting subtest: pi-common
[387.568558] Starting dynamic subtest: rcs0
[387.604706] Dynamic subtest rcs0: SUCCESS (0.037s)
[387.620581] Starting dynamic subtest: bcs0
[387.641544] Dynamic subtest bcs0: SUCCESS (0.036s)
[387.656136] Starting dynamic subtest: vcs0
[387.674712] Dynamic subtest vcs0: SUCCESS (0.032s)
[387.688021] Starting dynamic subtest: vcs1
[387.707182] Dynamic subtest vcs1: SUCCESS (0.031s)
[387.722022] Starting dynamic subtest: vecs0
[387.736704] Dynamic subtest vecs0: SUCCESS (0.028s)
[387.750027] Starting dynamic subtest: vecs1
[387.765930] Dynamic subtest vecs1: SUCCESS (0.028s)
[387.780639] Starting dynamic subtest: ccs0
[387.795062] Dynamic subtest ccs0: SUCCESS (0.028s)
[387.795971] Subtest pi-common: SUCCESS (0.228s)
[388.111659] [087/133] (648s left) i915_hangman (engine-error-state-capture)
[388.207946] Starting subtest: engine-error-state-capture
[388.208918] Starting dynamic subtest: rcs0
[391.005358] Dynamic subtest rcs0: SUCCESS (2.798s)
[391.022133] Starting dynamic subtest: bcs0
[394.937154] Dynamic subtest bcs0: SUCCESS (3.931s)
[394.950049] Starting dynamic subtest: vcs0
[398.951677] Dynamic subtest vcs0: SUCCESS (4.014s)
[398.964494] Starting dynamic subtest: vcs1
[402.932301] Dynamic subtest vcs1: SUCCESS (3.980s)
[402.945266] Starting dynamic subtest: vecs0
[406.962164] Dynamic subtest vecs0: SUCCESS (4.029s)
[406.976271] Starting dynamic subtest: vecs1
[410.932844] Dynamic subtest vecs1: SUCCESS (3.970s)
[410.947119] Starting dynamic subtest: ccs0
[414.971698] Dynamic subtest ccs0: SUCCESS (4.038s)
[414.972603] Subtest engine-error-state-capture: SUCCESS (26.767s)
[415.197230] [088/133] (621s left) syncobj_timeline (wait-for-submit-snapshot)
[415.275231] Starting subtest: wait-for-submit-snapshot
[415.359751] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[415.535376] [089/133] (620s left) kms_color (ctm-blue-to-red)
[417.047735] Starting subtest: ctm-blue-to-red
[417.048627] Starting dynamic subtest: pipe-A-HDMI-A-3
[417.715023] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.666s)
[417.730372] Starting dynamic subtest: pipe-B-HDMI-A-3
[418.190197] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.474s)
[418.203071] Starting dynamic subtest: pipe-C-HDMI-A-3
[418.682366] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.492s)
[418.694843] Starting dynamic subtest: pipe-D-HDMI-A-3
[419.162393] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.478s)
[419.163260] Subtest ctm-blue-to-red: SUCCESS (2.115s)
[419.425387] [090/133] (617s left) prime_vgem (basic-gtt)
[419.524378] Starting subtest: basic-gtt
[419.526238] Subtest basic-gtt: SKIP (0.000s)
[419.696972] [091/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[421.210881] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[421.212722] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[421.448851] [092/133] (615s left) api_intel_allocator (default-alignment)
[421.530046] Starting subtest: default-alignment
[421.535892] Subtest default-alignment: SUCCESS (0.006s)
[421.746814] [093/133] (615s left) i915_pm_rps (fence-order)
[421.833966] Starting subtest: fence-order
[426.229914] Subtest fence-order: SUCCESS (4.395s)
[426.419920] [094/133] (610s left) kms_vblank (query-busy)
[427.932227] Starting subtest: query-busy
[427.934829] Starting dynamic subtest: pipe-A-HDMI-A-3
[430.376180] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.442s)
[430.391865] Starting dynamic subtest: pipe-D-HDMI-A-3
[432.725902] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.345s)
[432.726751] Subtest query-busy: SUCCESS (4.793s)
[432.927560] [095/133] (603s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[434.446130] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[434.447838] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[434.676831] [096/133] (602s left) kms_addfb_basic (invalid-get-prop-any)
[434.770611] Starting subtest: invalid-get-prop-any
[434.771514] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[436.447436] [097/133] (600s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[437.957101] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[438.010982] [098/133] (599s left) kms_flip (2x-blocking-absolute-wf_vblank)
[439.525121] Starting subtest: 2x-blocking-absolute-wf_vblank
[439.538260] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[439.758240] [099/133] (597s left) kms_cursor_crc (cursor-onscreen-256x85)
[441.527079] Starting subtest: cursor-onscreen-256x85
[441.532227] Starting dynamic subtest: pipe-A-HDMI-A-3
[444.137224] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.605s)
[444.170736] Starting dynamic subtest: pipe-D-HDMI-A-3
[446.769129] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.610s)
[446.770007] Subtest cursor-onscreen-256x85: SUCCESS (5.241s)
[447.114291] [100/133] (590s left) kms_flip (2x-modeset-vs-vblank-race)
[448.619741] Starting subtest: 2x-modeset-vs-vblank-race
[448.632152] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[448.839122] [101/133] (588s left) kms_atomic_interruptible (atomic-setmode)
[450.357966] Starting subtest: atomic-setmode
[450.360071] Starting dynamic subtest: pipe-A-HDMI-A-3
[456.525436] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.165s)
[456.526294] Subtest atomic-setmode: SUCCESS (6.167s)
[456.757856] [102/133] (580s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[458.269752] Starting subtest: psr-argb161616f-draw-render
[458.271498] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[458.468090] [103/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[459.998825] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[460.000547] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[460.219800] [104/133] (577s left) kms_plane_scaling (invalid-num-scalers)
[461.732924] Starting subtest: invalid-num-scalers
[461.736706] Starting dynamic subtest: pipe-A-HDMI-A-3-invalid-num-scalers
[461.755037] Dynamic subtest pipe-A-HDMI-A-3-invalid-num-scalers: SUCCESS (0.018s)
[461.771978] Starting dynamic subtest: pipe-B-HDMI-A-3-invalid-num-scalers
[461.793931] Dynamic subtest pipe-B-HDMI-A-3-invalid-num-scalers: SUCCESS (0.033s)
[461.810878] Starting dynamic subtest: pipe-C-HDMI-A-3-invalid-num-scalers
[461.831052] Dynamic subtest pipe-C-HDMI-A-3-invalid-num-scalers: SUCCESS (0.032s)
[461.847291] Starting dynamic subtest: pipe-D-HDMI-A-3-invalid-num-scalers
[461.866571] Dynamic subtest pipe-D-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[461.867355] Subtest invalid-num-scalers: SUCCESS (0.136s)
[462.033370] [105/133] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[463.556750] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[463.558545] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[463.783544] [106/133] (574s left) sw_sync (alloc_fence_invalid_timeline)
[463.833923] Starting subtest: alloc_fence_invalid_timeline
[463.834832] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[463.969481] [107/133] (574s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[464.048246] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[464.154834] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[464.333225] [108/133] (573s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[465.846350] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[465.852776] Starting dynamic subtest: A-HDMI-A3
[473.874686] Dynamic subtest A-HDMI-A3: SUCCESS (8.021s)
[473.895849] Starting dynamic subtest: B-HDMI-A3
[481.820708] Dynamic subtest B-HDMI-A3: SUCCESS (7.943s)
[481.835582] Starting dynamic subtest: C-HDMI-A3
[489.768748] Dynamic subtest C-HDMI-A3: SUCCESS (7.945s)
[489.783671] Starting dynamic subtest: D-HDMI-A3
[497.698308] Dynamic subtest D-HDMI-A3: SUCCESS (7.927s)
[497.699230] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.847s)
[497.937503] [109/133] (540s left) kms_addfb_basic (size-max)
[499.445653] Starting subtest: size-max
[499.446568] Subtest size-max: SUCCESS (0.000s)
[499.660396] [110/133] (538s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[501.402152] Starting subtest: cursor-rapid-movement-256x256
[501.407412] Starting dynamic subtest: pipe-A-HDMI-A-3
[501.810263] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.403s)
[501.843257] Starting dynamic subtest: pipe-D-HDMI-A-3
[502.124221] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.293s)
[502.125124] Subtest cursor-rapid-movement-256x256: SUCCESS (0.723s)
[502.503130] [111/133] (536s left) gem_exec_whisper (basic-queues-all)
[502.592314] Starting subtest: basic-queues-all
[524.403307] Subtest basic-queues-all: SUCCESS (21.805s)
[524.692833] [112/133] (513s left) kms_dsc (dsc-fractional-bpp)
[526.206372] Starting subtest: dsc-fractional-bpp
[526.211269] Subtest dsc-fractional-bpp: SKIP (0.000s)
[526.410162] [113/133] (512s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[527.925803] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[527.926679] Starting dynamic subtest: pipe-A-valid-mode
[527.975567] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[527.977139] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.050s)
[528.196569] [114/133] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[529.708687] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[529.710313] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[529.927277] [115/133] (509s left) gem_softpin (evict-prime)
[530.017354] Starting subtest: evict-prime
[530.018351] Starting dynamic subtest: rcs0
[531.256205] Dynamic subtest rcs0: SUCCESS (1.238s)
[531.272856] Starting dynamic subtest: bcs0
[532.419181] Dynamic subtest bcs0: SUCCESS (1.161s)
[532.435734] Starting dynamic subtest: vcs0
[533.575212] Dynamic subtest vcs0: SUCCESS (1.155s)
[533.590062] Starting dynamic subtest: vcs1
[534.706201] Dynamic subtest vcs1: SUCCESS (1.130s)
[534.720388] Starting dynamic subtest: vecs0
[535.937437] Dynamic subtest vecs0: SUCCESS (1.230s)
[535.950095] Starting dynamic subtest: vecs1
[537.077329] Dynamic subtest vecs1: SUCCESS (1.139s)
[537.092894] Starting dynamic subtest: ccs0
[538.283603] Dynamic subtest ccs0: SUCCESS (1.205s)
[538.297728] Starting dynamic subtest: all
[539.426084] Dynamic subtest all: SUCCESS (1.141s)
[539.427246] Subtest evict-prime: SUCCESS (9.407s)
[539.614786] [116/133] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[541.131014] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[541.132741] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[541.381499] [117/133] (497s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[542.895895] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[543.111859] [118/133] (496s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[543.193185] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[543.298855] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[543.480142] [119/133] (495s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[544.995797] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[544.997567] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[545.215975] [120/133] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[546.730681] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[549.857195] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.127s)
[550.122306] [121/133] (489s left) gem_mmap_wc (bad-size)
[550.203066] Subtest bad-size: SKIP (0.000s)
[550.294182] [122/133] (489s left) kms_hdr (static-toggle-suspend)
[551.803925] Starting subtest: static-toggle-suspend
[551.806553] Subtest static-toggle-suspend: SKIP (0.000s)
[552.030019] [123/133] (487s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[553.546678] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[553.548325] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[553.767036] [124/133] (486s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[555.284711] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[555.337691] [125/133] (484s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[556.851625] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[556.853264] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[557.054876] [126/133] (483s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[558.574828] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[558.575722] Starting dynamic subtest: pipe-A-HDMI-A-3
[558.584033] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[558.597205] Starting dynamic subtest: pipe-B-HDMI-A-3
[558.605704] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[558.618307] Starting dynamic subtest: pipe-C-HDMI-A-3
[558.626742] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[558.639416] Starting dynamic subtest: pipe-D-HDMI-A-3
[558.650105] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[558.652069] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[558.846957] [127/133] (481s left) syncobj_timeline (single-wait-all-available-submitted)
[558.925181] Starting subtest: single-wait-all-available-submitted
[558.926091] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[559.112707] [128/133] (481s left) gem_exec_parallel (userptr)
[559.201223] Starting subtest: userptr
[559.202168] Starting dynamic subtest: rcs0
[560.753029] Dynamic subtest rcs0: SUCCESS (1.551s)
[560.769443] Starting dynamic subtest: bcs0
[562.215348] Dynamic subtest bcs0: SUCCESS (1.461s)
[562.233312] Starting dynamic subtest: vcs0
[563.718394] Dynamic subtest vcs0: SUCCESS (1.501s)
[563.734462] Starting dynamic subtest: vcs1
[565.252303] Dynamic subtest vcs1: SUCCESS (1.532s)
[565.270807] Starting dynamic subtest: vecs0
[566.709087] Dynamic subtest vecs0: SUCCESS (1.455s)
[566.724353] Starting dynamic subtest: vecs1
[568.162306] Dynamic subtest vecs1: SUCCESS (1.452s)
[568.180946] Starting dynamic subtest: ccs0
[569.637942] Dynamic subtest ccs0: SUCCESS (1.474s)
[569.638848] Subtest userptr: SUCCESS (10.435s)
[569.968735] [129/133] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[571.490160] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[571.492350] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[571.699607] [130/133] (468s left) i915_selftest (mock)
[572.799999] Starting subtest: mock
[572.800991] Starting dynamic subtest: sanitycheck
[573.544462] Dynamic subtest sanitycheck: SUCCESS (0.743s)
[573.579505] Starting dynamic subtest: shmem
[574.344279] Dynamic subtest shmem: SUCCESS (0.796s)
[574.377567] Starting dynamic subtest: fence
[582.464674] Dynamic subtest fence: SUCCESS (8.114s)
[582.481832] Starting dynamic subtest: scatterlist
[584.235820] Dynamic subtest scatterlist: SUCCESS (1.766s)
[584.248297] Starting dynamic subtest: syncmap
[587.105005] Dynamic subtest syncmap: SUCCESS (2.865s)
[587.118148] Starting dynamic subtest: uncore
[587.868422] Dynamic subtest uncore: SUCCESS (0.759s)
[587.903039] Starting dynamic subtest: ring
[588.702934] Dynamic subtest ring: SUCCESS (0.830s)
[588.722609] Starting dynamic subtest: engine
[589.474489] Dynamic subtest engine: SUCCESS (0.767s)
[589.509069] Starting dynamic subtest: timelines
[594.001815] Dynamic subtest timelines: SUCCESS (4.523s)
[594.021661] Starting dynamic subtest: requests
[596.730632] Dynamic subtest requests: SUCCESS (2.727s)
[596.740953] Starting dynamic subtest: objects
[597.611769] Dynamic subtest objects: SUCCESS (0.880s)
[597.624553] Starting dynamic subtest: phys
[598.516603] Dynamic subtest phys: SUCCESS (0.903s)
[598.533457] Starting dynamic subtest: dmabuf
[599.417128] Dynamic subtest dmabuf: SUCCESS (0.896s)
[599.452666] Starting dynamic subtest: vma
[607.537678] Dynamic subtest vma: SUCCESS (8.115s)
[607.548296] Starting dynamic subtest: evict
[609.321673] Dynamic subtest evict: SUCCESS (1.782s)
[609.333323] Starting dynamic subtest: gtt
[613.233016] Dynamic subtest gtt: SUCCESS (3.909s)
[613.245732] Starting dynamic subtest: hugepages
[614.318658] Dynamic subtest hugepages: SUCCESS (1.082s)
[614.328741] Starting dynamic subtest: memory_region
[617.790731] Dynamic subtest memory_region: SUCCESS (3.473s)
[617.791770] Subtest mock: SUCCESS (44.984s)
[617.838822] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[617.840037] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[617.842101] [131/133] (422s left) gem_mmap_gtt (basic-write-read)
[621.239012] Subtest basic-write-read: SKIP (0.000s)
[621.302000] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[621.304844] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[621.307666] [132/133] (419s left) perf (gen12-group-exclusive-stream-sample-oa)
[621.719648] Starting subtest: gen12-group-exclusive-stream-sample-oa
[621.742572] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[621.807031] [133/133] (418s left) perf_pmu (busy-double-start)
[621.881217] Starting subtest: busy-double-start
[621.882086] Starting dynamic subtest: rcs0
[625.518698] Dynamic subtest rcs0: SUCCESS (3.640s)
[625.533514] Starting dynamic subtest: bcs0
[629.125037] Dynamic subtest bcs0: SUCCESS (3.604s)
[629.140443] Starting dynamic subtest: vcs0
[632.730355] Dynamic subtest vcs0: FAIL (3.583s)
[632.743295] Starting dynamic subtest: vcs1
[636.297046] Dynamic subtest vcs1: FAIL (3.564s)
[636.310188] Starting dynamic subtest: vecs0
[639.860227] Dynamic subtest vecs0: FAIL (3.565s)
[639.873378] Starting dynamic subtest: vecs1
[643.425271] Dynamic subtest vecs1: FAIL (3.565s)
[643.438499] Starting dynamic subtest: ccs0
[647.008991] Dynamic subtest ccs0: SUCCESS (3.608s)
[647.013385] Subtest busy-double-start: FAIL (25.145s)
[647.216855] 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.