[64.931170] Initializing watchdogs
[64.931236]   /dev/watchdog0
[64.952133] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.963486] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.967231] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.969955] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[65.059414] Subtest write-snoop: SKIP (0.000s)
[65.140918] [002/133] (960s left) kms_content_protection (content-type-change)
[66.718939] Starting subtest: content-type-change
[66.726843] Subtest content-type-change: SKIP (0.005s)
[67.072644] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[68.699282] Starting subtest: multiplane-rotation
[95.791055] Subtest multiplane-rotation: SUCCESS (27.089s)
[95.996907] [004/133] (929s left) kms_chamelium_color (ctm-red-to-blue)
[97.504971] Subtest ctm-red-to-blue: SKIP (0.000s)
[97.560954] [005/133] (928s left) syncobj_wait (invalid-reset-one-illegal-handle)
[97.630118] Starting subtest: invalid-reset-one-illegal-handle
[97.631059] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[97.826863] [006/133] (928s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[99.327136] Starting subtest: disable-crc-after-crtc
[99.329291] Starting dynamic subtest: pipe-A-HDMI-A-3
[99.949374] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.621s)
[99.960055] Starting dynamic subtest: pipe-B-HDMI-A-3
[100.385303] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.434s)
[100.395100] Starting dynamic subtest: pipe-C-HDMI-A-3
[100.810551] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.423s)
[100.821915] Starting dynamic subtest: pipe-D-HDMI-A-3
[101.254309] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.442s)
[101.255258] Subtest disable-crc-after-crtc: SUCCESS (1.927s)
[101.503362] [007/133] (924s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[101.579149] Subtest tiled-to-tiled: SKIP (0.000s)
[101.639084] [008/133] (924s left) syncobj_wait (wait-all-interrupted)
[101.707177] Starting subtest: wait-all-interrupted
[101.809943] Subtest wait-all-interrupted: SUCCESS (0.102s)
[101.972532] [009/133] (924s left) syncobj_wait (wait-all-complex)
[102.043179] Starting subtest: wait-all-complex
[102.265388] Subtest wait-all-complex: SUCCESS (0.216s)
[102.425742] [010/133] (923s left) gem_pxp (reject-modify-context-protection-on)
[105.022071] Starting subtest: reject-modify-context-protection-on
[105.024488] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[105.156978] [011/133] (921s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[106.662424] Starting subtest: cursorA-vs-flipB-varying-size
[106.665489] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[106.810588] [012/133] (919s left) kms_rotation_crc (primary-rotation-90)
[108.342564] Starting subtest: primary-rotation-90
[108.344407] Subtest primary-rotation-90: SKIP (0.001s)
[108.464610] [013/133] (917s left) syncobj_wait (reset-multiple-signaled)
[108.549111] Starting subtest: reset-multiple-signaled
[108.549947] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[108.754650] [014/133] (917s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[110.253238] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[110.255093] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[110.497093] [015/133] (916s left) gem_softpin (noreloc-s3)
[110.584179] Starting subtest: noreloc-S3
[130.859795] Subtest noreloc-S3: SUCCESS (5.415s)
[135.060421] [016/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[136.568317] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[139.427504] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.859s)
[139.667768] [017/133] (891s left) gem_ctx_param (invalid-ctx-set)
[139.736797] Starting subtest: invalid-ctx-set
[139.738789] Subtest invalid-ctx-set: SUCCESS (0.001s)
[139.935014] [018/133] (890s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[140.004706] Starting subtest: single-wait-all-for-submit-unsubmitted
[140.109249] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[140.284079] [019/133] (890s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[141.808359] Starting subtest: x-tiled-64bpp-rotate-90
[141.860792] Subtest x-tiled-64bpp-rotate-90: SKIP (0.052s)
[142.094978] [020/133] (888s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[142.167448] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[142.247977] [021/133] (888s left) kms_psr (fbc-psr-cursor-plane-move)
[143.753119] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[143.800841] [022/133] (887s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[145.313300] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[146.611154] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.297s)
[146.823805] [023/133] (884s left) kms_flip (2x-flip-vs-rmfb)
[148.323712] Starting subtest: 2x-flip-vs-rmfb
[148.336467] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[148.531133] [024/133] (882s left) kms_plane_cursor (viewport)
[150.051864] Starting subtest: viewport
[150.053524] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[153.277792] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.225s)
[153.358103] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[156.644628] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.300s)
[156.721761] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[159.993865] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.283s)
[160.095566] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[163.293620] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.207s)
[163.352775] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[166.593897] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.250s)
[166.653566] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[169.810590] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.167s)
[169.895891] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[173.145700] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.259s)
[173.204776] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[176.395731] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.200s)
[176.454281] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[179.646360] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.200s)
[179.728243] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[183.071744] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.352s)
[183.154539] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[186.321666] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.199s)
[186.400241] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[189.555559] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.183s)
[189.646363] Subtest viewport: SUCCESS (39.593s)
[189.892637] [025/133] (841s left) kms_cdclk (mode-transition)
[191.396247] Starting subtest: mode-transition
[191.397196] Starting dynamic subtest: pipe-A-HDMI-A-3
[191.441197] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.043s)
[191.451083] Starting dynamic subtest: pipe-B-HDMI-A-3
[191.452784] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[191.462552] Starting dynamic subtest: pipe-C-HDMI-A-3
[191.464320] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[191.474115] Starting dynamic subtest: pipe-D-HDMI-A-3
[191.475734] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[191.477438] Subtest mode-transition: SKIP (0.055s)
[191.657480] [026/133] (839s left) gem_exec_balancer (fairslice)
[191.737281] Starting subtest: fairslice
[197.368972] Subtest fairslice: SUCCESS (5.631s)
[197.812344] [027/133] (833s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[199.316277] Starting subtest: basic-flip-before-cursor-varying-size
[200.316771] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.001s)
[200.528083] [028/133] (830s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[202.035496] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[202.036477] Starting dynamic subtest: pipe-A-valid-mode
[202.078740] Dynamic subtest pipe-A-valid-mode: SKIP (0.042s)
[202.087515] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.044s)
[202.281165] [029/133] (829s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[203.784284] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[203.785231] Starting dynamic subtest: pipe-A-valid-mode
[204.573921] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.788s)
[204.574842] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.790s)
[204.836006] [030/133] (826s left) core_getstats (basic)
[204.908570] Starting subtest: basic
[204.909492] Subtest basic: SUCCESS (0.000s)
[205.059760] [031/133] (826s left) kms_rmfb (close-fd)
[206.568120] Starting subtest: close-fd
[206.568900] Starting dynamic subtest: pipe-A-HDMI-A-3
[206.760925] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.192s)
[206.795595] Starting dynamic subtest: pipe-B-HDMI-A-3
[206.988696] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.223s)
[206.999909] Starting dynamic subtest: pipe-C-HDMI-A-3
[207.187964] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.197s)
[207.204102] Starting dynamic subtest: pipe-D-HDMI-A-3
[207.399883] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.209s)
[207.400943] Subtest close-fd: SUCCESS (0.833s)
[207.655243] [032/133] (824s left) gem_exec_reloc (basic-gtt-wc)
[207.732369] Subtest basic-gtt-wc: SKIP (0.000s)
[207.817758] [033/133] (824s left) kms_properties (crtc-properties-legacy)
[209.315550] Starting subtest: crtc-properties-legacy
[209.316512] Starting dynamic subtest: pipe-A-HDMI-A-3
[209.617062] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.300s)
[209.641577] Starting dynamic subtest: pipe-B-HDMI-A-3
[209.897354] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.276s)
[209.909188] Starting dynamic subtest: pipe-C-HDMI-A-3
[210.160179] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.260s)
[210.172410] Starting dynamic subtest: pipe-D-HDMI-A-3
[210.421964] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.259s)
[210.422853] Subtest crtc-properties-legacy: SUCCESS (1.107s)
[210.666728] [034/133] (821s left) kms_invalid_mode (zero-hdisplay)
[212.173611] Starting subtest: zero-hdisplay
[212.174534] Starting dynamic subtest: pipe-A-HDMI-A-3
[212.224292] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.049s)
[212.234843] Starting dynamic subtest: pipe-B-HDMI-A-3
[212.235905] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[212.245681] Starting dynamic subtest: pipe-C-HDMI-A-3
[212.246599] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[212.256661] Starting dynamic subtest: pipe-D-HDMI-A-3
[212.257536] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[212.258464] Subtest zero-hdisplay: SUCCESS (0.058s)
[212.443293] [035/133] (819s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[213.941483] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[213.942455] Starting dynamic subtest: pipe-A
[215.553884] Dynamic subtest pipe-A: SUCCESS (1.613s)
[215.579877] Starting dynamic subtest: pipe-B
[217.195590] Dynamic subtest pipe-B: SUCCESS (1.639s)
[217.219379] Starting dynamic subtest: pipe-C
[217.438012] Dynamic subtest pipe-C: SUCCESS (0.240s)
[217.469595] Starting dynamic subtest: pipe-D
[217.678854] Dynamic subtest pipe-D: SUCCESS (0.238s)
[217.680132] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.739s)
[217.958260] [036/133] (814s left) kms_pm_rpm (legacy-planes-dpms)
[221.881580] Starting subtest: legacy-planes-dpms
[221.885120] Starting dynamic subtest: plane-63
[228.982648] Dynamic subtest plane-63: SUCCESS (7.099s)
[229.020026] Starting dynamic subtest: plane-93
[236.265115] Dynamic subtest plane-93: SUCCESS (7.279s)
[236.307006] Starting dynamic subtest: plane-123
[243.507073] Dynamic subtest plane-123: SUCCESS (7.238s)
[243.544205] Starting dynamic subtest: plane-133
[250.497454] Dynamic subtest plane-133: SUCCESS (6.987s)
[250.502422] Subtest legacy-planes-dpms: SUCCESS (28.617s)
[251.561980] [037/133] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[253.102276] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[253.104183] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.314749] [038/133] (778s left) kms_dirtyfb (default-dirtyfb-ioctl)
[254.836353] Starting subtest: default-dirtyfb-ioctl
[254.837263] Starting dynamic subtest: A-HDMI-A-3
[256.269762] Dynamic subtest A-HDMI-A-3: SUCCESS (1.432s)
[256.270590] Subtest default-dirtyfb-ioctl: SUCCESS (1.434s)
[256.495930] [039/133] (775s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[258.003432] Starting subtest: cursorB-vs-flipA-legacy
[258.005363] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[258.165443] [040/133] (774s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[258.275791] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[258.276704] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[258.487752] [041/133] (774s left) kms_prime (basic-crc-vgem)
[260.036477] Subtest basic-crc-vgem: SKIP (0.000s)
[260.235717] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[260.237969] [042/133] (772s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[260.313546] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[260.400132] [043/133] (772s left) i915_drm_fdinfo (busy)
[260.471696] Starting subtest: busy
[260.472577] Starting dynamic subtest: rcs0
[260.492480] Dynamic subtest rcs0: SKIP (0.019s)
[260.502794] Starting dynamic subtest: bcs0
[260.504797] Dynamic subtest bcs0: SKIP (0.000s)
[260.514984] Starting dynamic subtest: vcs0
[260.517173] Dynamic subtest vcs0: SKIP (0.000s)
[260.527312] Starting dynamic subtest: vcs1
[260.529447] Dynamic subtest vcs1: SKIP (0.000s)
[260.539762] Starting dynamic subtest: vecs0
[260.542016] Dynamic subtest vecs0: SKIP (0.000s)
[260.551909] Starting dynamic subtest: vecs1
[260.554142] Dynamic subtest vecs1: SKIP (0.000s)
[260.564156] Starting dynamic subtest: ccs0
[260.566421] Dynamic subtest ccs0: SKIP (0.000s)
[260.568764] Subtest busy: SKIP (0.028s)
[260.628355] [044/133] (772s left) gem_userptr_blits (nohangcheck)
[260.732697] Starting subtest: nohangcheck
[261.053244] Subtest nohangcheck: SUCCESS (0.319s)
[261.270304] [045/133] (771s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[262.792230] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[263.530039] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.739s)
[263.764925] [046/133] (769s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[265.275454] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[265.277235] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[265.531028] [047/133] (767s left) kms_scaling_modes (scaling-mode-full)
[267.042502] Starting subtest: scaling-mode-full
[267.047803] Subtest scaling-mode-full: SKIP (0.001s)
[267.268728] [048/133] (765s left) kms_psr (fbc-pr-basic)
[268.785551] Subtest fbc-pr-basic: SKIP (0.000s)
[268.840769] [049/133] (764s left) gem_ringfill (basic-all)
[269.292796] Starting subtest: basic-all
[271.092798] Subtest basic-all: SUCCESS (1.802s)
[271.323180] [050/133] (761s left) gem_exec_whisper (basic-fds-forked-all)
[271.412088] Starting subtest: basic-fds-forked-all
[294.145802] Subtest basic-fds-forked-all: SUCCESS (22.731s)
[294.432385] [051/133] (738s left) api_intel_bb (full-batch)
[294.509852] Starting subtest: full-batch
[294.538713] Subtest full-batch: SUCCESS (0.030s)
[294.715142] [052/133] (738s left) kms_cursor_crc (cursor-sliding-256x85)
[296.465615] Starting subtest: cursor-sliding-256x85
[296.469396] Starting dynamic subtest: pipe-A-HDMI-A-3
[300.621271] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.151s)
[300.652435] Starting dynamic subtest: pipe-D-HDMI-A-3
[304.820658] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.178s)
[304.821509] Subtest cursor-sliding-256x85: SUCCESS (8.356s)
[305.169188] [053/133] (728s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[306.682497] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[306.683449] Starting dynamic subtest: pipe-A-HDMI-A-3
[306.704840] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[306.715897] Starting dynamic subtest: pipe-B-HDMI-A-3
[306.737373] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[306.748483] Starting dynamic subtest: pipe-C-HDMI-A-3
[306.773162] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[306.784738] Starting dynamic subtest: pipe-D-HDMI-A-3
[306.806496] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[306.808168] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[306.973285] [054/133] (726s left) gen9_exec_parse (allowed-single)
[307.058371] Subtest allowed-single: SKIP (0.000s)
[307.145605] [055/133] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[308.660496] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[308.662187] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[308.901080] [056/133] (724s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[310.421170] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[310.422852] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[310.636581] [057/133] (723s left) gem_exec_fence (expired-history)
[311.163421] Starting subtest: expired-history
[317.709750] Subtest expired-history: SUCCESS (6.542s)
[319.389241] [058/133] (714s left) kms_psr (fbc-psr-sprite-plane-move)
[320.909138] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[320.960171] [059/133] (713s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[322.482429] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[322.484227] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[322.700399] [060/133] (711s left) gem_ctx_bad_destroy (double-destroy)
[322.779080] Starting subtest: double-destroy
[322.779926] Subtest double-destroy: SUCCESS (0.000s)
[322.955216] [061/133] (711s left) syncobj_timeline (invalid-signal-illegal-handle)
[323.044785] Starting subtest: invalid-signal-illegal-handle
[323.045706] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[323.210920] [062/133] (711s left) kms_chamelium_hpd (common-hpd-after-suspend)
[324.755643] Subtest common-hpd-after-suspend: SKIP (0.000s)
[324.850952] [063/133] (709s left) kms_frontbuffer_tracking (fbc-tiling-4)
[326.365284] Starting subtest: fbc-tiling-4
[328.937483] Subtest fbc-tiling-4: SUCCESS (2.573s)
[329.150055] [064/133] (705s left) gem_cs_tlb (engines)
[329.234604] Starting subtest: engines
[329.235498] Starting dynamic subtest: rcs0
[331.388102] Dynamic subtest rcs0: SUCCESS (2.153s)
[331.399571] Starting dynamic subtest: bcs0
[333.543079] Dynamic subtest bcs0: SUCCESS (2.154s)
[333.554789] Starting dynamic subtest: vcs0
[335.695769] Dynamic subtest vcs0: SUCCESS (2.152s)
[335.707133] Starting dynamic subtest: vcs1
[337.849781] Dynamic subtest vcs1: SUCCESS (2.153s)
[337.860921] Starting dynamic subtest: vecs0
[340.003005] Dynamic subtest vecs0: SUCCESS (2.152s)
[340.014531] Starting dynamic subtest: vecs1
[342.158300] Dynamic subtest vecs1: SUCCESS (2.154s)
[342.169573] Starting dynamic subtest: ccs0
[344.311825] Dynamic subtest ccs0: SUCCESS (2.152s)
[344.312706] Subtest engines: SUCCESS (15.078s)
[344.493294] [065/133] (689s left) gem_mmap_gtt (hang-busy)
[344.570504] Subtest hang-busy: SKIP (0.000s)
[344.650625] [066/133] (689s left) kms_psr (psr2-sprite-plane-onoff)
[346.155651] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[346.215569] [067/133] (688s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[347.737464] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[348.470637] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.733s)
[348.729613] [068/133] (685s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[350.257103] Starting subtest: y-tiled-64bpp-rotate-270
[350.258816] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[350.463135] [069/133] (684s left) gem_bad_reloc (negative-reloc-lut)
[350.555852] Subtest negative-reloc-lut: SKIP (0.000s)
[350.669517] [070/133] (684s left) gem_ctx_persistence (engines-mixed)
[350.751650] Starting subtest: engines-mixed
[350.752516] Starting dynamic subtest: rcs0
[350.878765] Dynamic subtest rcs0: SUCCESS (0.127s)
[350.894685] Starting dynamic subtest: bcs0
[350.944875] Dynamic subtest bcs0: SUCCESS (0.064s)
[350.959470] Starting dynamic subtest: vcs0
[351.002820] Dynamic subtest vcs0: SUCCESS (0.056s)
[351.030278] Starting dynamic subtest: vcs1
[351.065339] Dynamic subtest vcs1: SUCCESS (0.060s)
[351.101692] Starting dynamic subtest: vecs0
[351.136640] Dynamic subtest vecs0: SUCCESS (0.068s)
[351.159479] Starting dynamic subtest: vecs1
[351.200286] Dynamic subtest vecs1: SUCCESS (0.061s)
[351.236845] Starting dynamic subtest: ccs0
[351.281845] Dynamic subtest ccs0: SUCCESS (0.078s)
[351.285773] Subtest engines-mixed: SUCCESS (0.531s)
[351.498820] [071/133] (683s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[353.007462] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[353.008346] Starting dynamic subtest: pipe-A
[353.087412] Dynamic subtest pipe-A: SUCCESS (0.080s)
[353.102322] Starting dynamic subtest: pipe-B
[353.213889] Dynamic subtest pipe-B: SUCCESS (0.125s)
[353.229841] Starting dynamic subtest: pipe-C
[353.340014] Dynamic subtest pipe-C: SUCCESS (0.125s)
[353.351411] Starting dynamic subtest: pipe-D
[353.464149] Dynamic subtest pipe-D: SUCCESS (0.123s)
[353.465072] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.458s)
[353.744739] [072/133] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[355.260459] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[355.262197] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[355.507481] [073/133] (679s left) gem_exec_schedule (semaphore-noskip)
[355.613046] Starting subtest: semaphore-noskip
[356.439937] Subtest semaphore-noskip: SUCCESS (0.826s)
[356.858142] [074/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[358.378352] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[358.380151] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[358.617882] [075/133] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[360.138480] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[360.140227] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[360.381484] [076/133] (674s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[361.901382] Starting subtest: 4-tiled-16bpp-rotate-0
[363.703763] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.802s)
[363.901289] [077/133] (671s left) gem_exec_basic (basic)
[363.993567] Starting subtest: basic
[363.994512] Starting dynamic subtest: rcs0-smem
[363.998865] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[364.011593] Starting dynamic subtest: bcs0-smem
[364.012497] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[364.023501] Starting dynamic subtest: vcs0-smem
[364.024476] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[364.035115] Starting dynamic subtest: vcs1-smem
[364.036135] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[364.046465] Starting dynamic subtest: vecs0-smem
[364.047461] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[364.057794] Starting dynamic subtest: vecs1-smem
[364.058789] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[364.069059] Starting dynamic subtest: ccs0-smem
[364.070008] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[364.080497] Starting dynamic subtest: rcs0-lmem0
[364.081674] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[364.091953] Starting dynamic subtest: bcs0-lmem0
[364.092951] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[364.103380] Starting dynamic subtest: vcs0-lmem0
[364.104419] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[364.114811] Starting dynamic subtest: vcs1-lmem0
[364.115753] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[364.126225] Starting dynamic subtest: vecs0-lmem0
[364.127167] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[364.137945] Starting dynamic subtest: vecs1-lmem0
[364.138824] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[364.149661] Starting dynamic subtest: ccs0-lmem0
[364.150707] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[364.151865] Subtest basic: SUCCESS (0.024s)
[364.270605] [078/133] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[365.785340] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[365.787050] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[366.014249] [079/133] (669s left) gem_mmap (short-mmap)
[366.093481] Subtest short-mmap: SKIP (0.000s)
[366.165402] [080/133] (669s left) gem_exec_reloc (basic-gtt-wc-active)
[366.247784] Subtest basic-gtt-wc-active: SKIP (0.000s)
[366.317289] [081/133] (669s left) gem_ctx_shared (create-shared-gtt)
[366.408754] Starting subtest: create-shared-gtt
[368.558923] Subtest create-shared-gtt: SUCCESS (2.150s)
[370.589305] [082/133] (665s left) gem_exec_reloc (basic-write-wc)
[370.680723] Subtest basic-write-wc: SKIP (0.000s)
[370.769060] [083/133] (665s left) gem_eio (wait-immediate)
[371.092842] Starting subtest: wait-immediate
[371.718243] Subtest wait-immediate: SUCCESS (0.625s)
[373.349705] [084/133] (662s left) gem_ctx_persistence (legacy-engines-mixed)
[373.443842] Starting subtest: legacy-engines-mixed
[373.444756] Starting dynamic subtest: render
[373.545844] Dynamic subtest render: SUCCESS (0.101s)
[373.561331] Starting dynamic subtest: bsd1
[373.598701] Dynamic subtest bsd1: SUCCESS (0.051s)
[373.621726] Starting dynamic subtest: bsd2
[373.648962] Dynamic subtest bsd2: SUCCESS (0.048s)
[373.679031] Starting dynamic subtest: blt
[373.730282] Dynamic subtest blt: SUCCESS (0.078s)
[373.768468] Starting dynamic subtest: vebox
[373.815116] Dynamic subtest vebox: SUCCESS (0.081s)
[373.819514] Subtest legacy-engines-mixed: SUCCESS (0.373s)
[374.036202] [085/133] (662s left) perf_pmu (semaphore-busy)
[374.107794] Starting subtest: semaphore-busy
[374.108756] Starting dynamic subtest: rcs0
[375.791777] Dynamic subtest rcs0: SUCCESS (1.681s)
[375.806650] Starting dynamic subtest: bcs0
[377.427840] Dynamic subtest bcs0: SUCCESS (1.632s)
[377.442521] Starting dynamic subtest: vcs0
[379.063694] Dynamic subtest vcs0: SUCCESS (1.631s)
[379.078906] Starting dynamic subtest: vcs1
[380.702660] Dynamic subtest vcs1: SUCCESS (1.634s)
[380.716992] Starting dynamic subtest: vecs0
[382.338883] Dynamic subtest vecs0: SUCCESS (1.632s)
[382.352944] Starting dynamic subtest: vecs1
[383.973924] Dynamic subtest vecs1: SUCCESS (1.631s)
[383.988905] Starting dynamic subtest: ccs0
[385.611879] Dynamic subtest ccs0: SUCCESS (1.633s)
[385.613591] Subtest semaphore-busy: SUCCESS (11.504s)
[385.834265] [086/133] (650s left) gem_exec_schedule (pi-common)
[386.045808] Starting subtest: pi-common
[386.046749] Starting dynamic subtest: rcs0
[386.090258] Dynamic subtest rcs0: SUCCESS (0.044s)
[386.106678] Starting dynamic subtest: bcs0
[386.129942] Dynamic subtest bcs0: SUCCESS (0.038s)
[386.142733] Starting dynamic subtest: vcs0
[386.164476] Dynamic subtest vcs0: SUCCESS (0.033s)
[386.178769] Starting dynamic subtest: vcs1
[386.197010] Dynamic subtest vcs1: SUCCESS (0.031s)
[386.211497] Starting dynamic subtest: vecs0
[386.228140] Dynamic subtest vecs0: SUCCESS (0.030s)
[386.241089] Starting dynamic subtest: vecs1
[386.258879] Dynamic subtest vecs1: SUCCESS (0.030s)
[386.273480] Starting dynamic subtest: ccs0
[386.291442] Dynamic subtest ccs0: SUCCESS (0.031s)
[386.292270] Subtest pi-common: SUCCESS (0.246s)
[386.619632] [087/133] (649s left) i915_hangman (engine-error-state-capture)
[386.713484] Starting subtest: engine-error-state-capture
[386.714422] Starting dynamic subtest: rcs0
[389.410896] Dynamic subtest rcs0: SUCCESS (2.697s)
[389.424882] Starting dynamic subtest: bcs0
[393.432641] Dynamic subtest bcs0: SUCCESS (4.021s)
[393.446621] Starting dynamic subtest: vcs0
[397.432741] Dynamic subtest vcs0: SUCCESS (3.999s)
[397.448813] Starting dynamic subtest: vcs1
[401.443685] Dynamic subtest vcs1: SUCCESS (4.010s)
[401.457763] Starting dynamic subtest: vecs0
[405.432903] Dynamic subtest vecs0: SUCCESS (3.988s)
[405.448333] Starting dynamic subtest: vecs1
[409.370653] Dynamic subtest vecs1: SUCCESS (3.937s)
[409.384517] Starting dynamic subtest: ccs0
[413.456031] Dynamic subtest ccs0: SUCCESS (4.084s)
[413.457102] Subtest engine-error-state-capture: SUCCESS (26.744s)
[413.641694] [088/133] (622s left) syncobj_timeline (wait-for-submit-snapshot)
[413.725890] Starting subtest: wait-for-submit-snapshot
[413.810182] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[413.985407] [089/133] (622s left) kms_color (ctm-blue-to-red)
[415.505736] Starting subtest: ctm-blue-to-red
[415.506628] Starting dynamic subtest: pipe-A-HDMI-A-3
[416.177750] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.672s)
[416.191864] Starting dynamic subtest: pipe-B-HDMI-A-3
[416.632698] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.454s)
[416.645489] Starting dynamic subtest: pipe-C-HDMI-A-3
[417.109532] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.475s)
[417.122114] Starting dynamic subtest: pipe-D-HDMI-A-3
[417.571488] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.461s)
[417.572416] Subtest ctm-blue-to-red: SUCCESS (2.066s)
[417.822935] [090/133] (618s left) prime_vgem (basic-gtt)
[417.923862] Starting subtest: basic-gtt
[417.925599] Subtest basic-gtt: SKIP (0.000s)
[418.117908] [091/133] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[419.634397] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[419.636187] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[419.859838] [092/133] (616s left) api_intel_allocator (default-alignment)
[419.936601] Starting subtest: default-alignment
[419.942442] Subtest default-alignment: SUCCESS (0.006s)
[420.164482] [093/133] (616s left) i915_pm_rps (fence-order)
[420.259520] Starting subtest: fence-order
[424.704775] Subtest fence-order: SUCCESS (4.445s)
[424.902710] [094/133] (611s left) kms_vblank (query-busy)
[426.420346] Starting subtest: query-busy
[426.421286] Starting dynamic subtest: pipe-A-HDMI-A-3
[428.891852] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.471s)
[428.907735] Starting dynamic subtest: pipe-D-HDMI-A-3
[431.239271] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.343s)
[431.240151] Subtest query-busy: SUCCESS (4.821s)
[431.434074] [095/133] (605s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[432.964793] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[432.966649] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[433.196258] [096/133] (603s left) kms_addfb_basic (invalid-get-prop-any)
[433.276908] Starting subtest: invalid-get-prop-any
[433.277773] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[434.974955] [097/133] (602s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[436.492849] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[436.552742] [098/133] (600s left) kms_flip (2x-blocking-absolute-wf_vblank)
[438.063165] Starting subtest: 2x-blocking-absolute-wf_vblank
[438.075675] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[438.272815] [099/133] (598s left) kms_cursor_crc (cursor-onscreen-256x85)
[440.036666] Starting subtest: cursor-onscreen-256x85
[440.041825] Starting dynamic subtest: pipe-A-HDMI-A-3
[442.746581] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.704s)
[442.783497] Starting dynamic subtest: pipe-D-HDMI-A-3
[445.381219] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.609s)
[445.382162] Subtest cursor-onscreen-256x85: SUCCESS (5.344s)
[445.722653] [100/133] (591s left) kms_flip (2x-modeset-vs-vblank-race)
[447.240430] Starting subtest: 2x-modeset-vs-vblank-race
[447.252560] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[447.414233] [101/133] (589s left) kms_atomic_interruptible (atomic-setmode)
[448.939457] Starting subtest: atomic-setmode
[448.941729] Starting dynamic subtest: pipe-A-HDMI-A-3
[455.117626] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.176s)
[455.118582] Subtest atomic-setmode: SUCCESS (6.178s)
[455.309883] [102/133] (582s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[456.823074] Starting subtest: psr-argb161616f-draw-render
[456.824715] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[457.046412] [103/133] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[458.560506] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[458.562418] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[458.777510] [104/133] (578s left) kms_plane_scaling (invalid-num-scalers)
[460.297535] Starting subtest: invalid-num-scalers
[460.301164] Starting dynamic subtest: pipe-A-HDMI-A-3-invalid-num-scalers
[460.319409] Dynamic subtest pipe-A-HDMI-A-3-invalid-num-scalers: SUCCESS (0.018s)
[460.336299] Starting dynamic subtest: pipe-B-HDMI-A-3-invalid-num-scalers
[460.356206] Dynamic subtest pipe-B-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[460.373141] Starting dynamic subtest: pipe-C-HDMI-A-3-invalid-num-scalers
[460.391733] Dynamic subtest pipe-C-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[460.408361] Starting dynamic subtest: pipe-D-HDMI-A-3-invalid-num-scalers
[460.429137] Dynamic subtest pipe-D-HDMI-A-3-invalid-num-scalers: SUCCESS (0.031s)
[460.429911] Subtest invalid-num-scalers: SUCCESS (0.132s)
[460.593861] [105/133] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[462.109171] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[462.110791] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[462.327117] [106/133] (575s left) sw_sync (alloc_fence_invalid_timeline)
[462.377432] Starting subtest: alloc_fence_invalid_timeline
[462.378407] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[462.513114] [107/133] (575s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[462.590775] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[462.693400] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[462.834442] [108/133] (575s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[464.345738] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[464.351893] Starting dynamic subtest: A-HDMI-A3
[472.369845] Dynamic subtest A-HDMI-A3: SUCCESS (8.017s)
[472.386140] Starting dynamic subtest: B-HDMI-A3
[480.315990] Dynamic subtest B-HDMI-A3: SUCCESS (7.941s)
[480.332773] Starting dynamic subtest: C-HDMI-A3
[488.261903] Dynamic subtest C-HDMI-A3: SUCCESS (7.942s)
[488.276596] Starting dynamic subtest: D-HDMI-A3
[496.206952] Dynamic subtest D-HDMI-A3: SUCCESS (7.944s)
[496.207787] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.862s)
[496.431409] [109/133] (541s left) kms_addfb_basic (size-max)
[497.942648] Starting subtest: size-max
[497.943566] Subtest size-max: SUCCESS (0.000s)
[498.184516] [110/133] (540s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[499.937034] Starting subtest: cursor-rapid-movement-256x256
[499.942634] Starting dynamic subtest: pipe-A-HDMI-A-3
[500.334956] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.393s)
[500.366893] Starting dynamic subtest: pipe-D-HDMI-A-3
[500.650230] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.295s)
[500.651215] Subtest cursor-rapid-movement-256x256: SUCCESS (0.714s)
[501.024734] [111/133] (537s left) gem_exec_whisper (basic-queues-all)
[501.123500] Starting subtest: basic-queues-all
[522.951431] Subtest basic-queues-all: SUCCESS (21.827s)
[523.235977] [112/133] (515s left) kms_dsc (dsc-fractional-bpp)
[524.751560] Starting subtest: dsc-fractional-bpp
[524.756710] Subtest dsc-fractional-bpp: SKIP (0.000s)
[524.928021] [113/133] (513s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[526.454470] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[526.455417] Starting dynamic subtest: pipe-A-valid-mode
[526.503295] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[526.505092] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.049s)
[526.719000] [114/133] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[528.232282] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[528.234100] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[528.472620] [115/133] (510s left) gem_softpin (evict-prime)
[528.560614] Starting subtest: evict-prime
[528.561524] Starting dynamic subtest: rcs0
[529.808717] Dynamic subtest rcs0: SUCCESS (1.248s)
[529.827350] Starting dynamic subtest: bcs0
[530.996792] Dynamic subtest bcs0: SUCCESS (1.187s)
[531.011439] Starting dynamic subtest: vcs0
[532.157753] Dynamic subtest vcs0: SUCCESS (1.160s)
[532.174146] Starting dynamic subtest: vcs1
[533.356699] Dynamic subtest vcs1: SUCCESS (1.198s)
[533.373473] Starting dynamic subtest: vecs0
[534.536764] Dynamic subtest vecs0: SUCCESS (1.179s)
[534.551248] Starting dynamic subtest: vecs1
[535.673628] Dynamic subtest vecs1: SUCCESS (1.136s)
[535.688298] Starting dynamic subtest: ccs0
[536.850660] Dynamic subtest ccs0: SUCCESS (1.176s)
[536.866535] Starting dynamic subtest: all
[538.042774] Dynamic subtest all: SUCCESS (1.191s)
[538.043752] Subtest evict-prime: SUCCESS (9.483s)
[538.225047] [116/133] (500s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[539.742239] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[539.743860] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[539.932392] [117/133] (498s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[541.469550] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[541.681704] [118/133] (497s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[541.765722] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[541.869258] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[542.038586] [119/133] (497s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[543.554217] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[543.555833] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[543.795350] [120/133] (495s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[545.319305] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[548.565449] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.246s)
[548.826708] [121/133] (490s left) gem_mmap_wc (bad-size)
[548.904448] Subtest bad-size: SKIP (0.000s)
[548.980304] [122/133] (490s left) kms_hdr (static-toggle-suspend)
[550.491412] Starting subtest: static-toggle-suspend
[550.494091] Subtest static-toggle-suspend: SKIP (0.000s)
[550.661752] [123/133] (488s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[552.191315] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[552.193133] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[552.423233] [124/133] (487s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[553.938266] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[553.994326] [125/133] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[555.507395] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[555.509153] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[555.743063] [126/133] (484s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[557.253475] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[557.254390] Starting dynamic subtest: pipe-A-HDMI-A-3
[557.263070] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[557.276120] Starting dynamic subtest: pipe-B-HDMI-A-3
[557.284593] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[557.296786] Starting dynamic subtest: pipe-C-HDMI-A-3
[557.305445] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[557.317685] Starting dynamic subtest: pipe-D-HDMI-A-3
[557.327657] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[557.329852] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[557.553199] [127/133] (482s left) syncobj_timeline (single-wait-all-available-submitted)
[557.632790] Starting subtest: single-wait-all-available-submitted
[557.633963] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[557.836052] [128/133] (482s left) gem_exec_parallel (userptr)
[557.925703] Starting subtest: userptr
[557.926590] Starting dynamic subtest: rcs0
[559.456811] Dynamic subtest rcs0: SUCCESS (1.532s)
[559.472890] Starting dynamic subtest: bcs0
[560.931582] Dynamic subtest bcs0: SUCCESS (1.473s)
[560.946753] Starting dynamic subtest: vcs0
[562.422938] Dynamic subtest vcs0: SUCCESS (1.490s)
[562.439496] Starting dynamic subtest: vcs1
[563.929733] Dynamic subtest vcs1: SUCCESS (1.506s)
[563.946821] Starting dynamic subtest: vecs0
[565.380493] Dynamic subtest vecs0: SUCCESS (1.449s)
[565.397325] Starting dynamic subtest: vecs1
[566.847779] Dynamic subtest vecs1: SUCCESS (1.466s)
[566.863200] Starting dynamic subtest: ccs0
[568.298571] Dynamic subtest ccs0: SUCCESS (1.449s)
[568.299552] Subtest userptr: SUCCESS (10.375s)
[568.636082] [129/133] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[570.157447] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[570.159173] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[570.401036] [130/133] (469s left) i915_selftest (mock)
[571.419898] Starting subtest: mock
[571.420852] Starting dynamic subtest: sanitycheck
[572.173524] Dynamic subtest sanitycheck: SUCCESS (0.753s)
[572.185812] Starting dynamic subtest: shmem
[572.921621] Dynamic subtest shmem: SUCCESS (0.744s)
[572.955405] Starting dynamic subtest: fence
[580.877069] Dynamic subtest fence: SUCCESS (7.951s)
[580.893912] Starting dynamic subtest: scatterlist
[582.612218] Dynamic subtest scatterlist: SUCCESS (1.732s)
[582.628753] Starting dynamic subtest: syncmap
[585.430342] Dynamic subtest syncmap: SUCCESS (2.814s)
[585.446406] Starting dynamic subtest: uncore
[586.189713] Dynamic subtest uncore: SUCCESS (0.756s)
[586.222190] Starting dynamic subtest: ring
[586.942641] Dynamic subtest ring: SUCCESS (0.749s)
[586.976257] Starting dynamic subtest: engine
[587.722792] Dynamic subtest engine: SUCCESS (0.776s)
[587.756523] Starting dynamic subtest: timelines
[592.315463] Dynamic subtest timelines: SUCCESS (4.589s)
[592.328975] Starting dynamic subtest: requests
[595.163130] Dynamic subtest requests: SUCCESS (2.846s)
[595.173797] Starting dynamic subtest: objects
[596.031533] Dynamic subtest objects: SUCCESS (0.867s)
[596.054428] Starting dynamic subtest: phys
[596.949446] Dynamic subtest phys: SUCCESS (0.916s)
[596.969683] Starting dynamic subtest: dmabuf
[597.829249] Dynamic subtest dmabuf: SUCCESS (0.878s)
[597.843044] Starting dynamic subtest: vma
[605.928614] Dynamic subtest vma: SUCCESS (8.098s)
[605.940858] Starting dynamic subtest: evict
[607.665376] Dynamic subtest evict: SUCCESS (1.735s)
[607.677501] Starting dynamic subtest: gtt
[611.586326] Dynamic subtest gtt: SUCCESS (3.919s)
[611.597337] Starting dynamic subtest: hugepages
[612.682429] Dynamic subtest hugepages: SUCCESS (1.095s)
[612.695701] Starting dynamic subtest: memory_region
[616.183317] Dynamic subtest memory_region: SUCCESS (3.499s)
[616.184346] Subtest mock: SUCCESS (44.764s)
[616.221944] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[616.222880] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[616.224723] [131/133] (423s left) gem_mmap_gtt (basic-write-read)
[619.642796] Subtest basic-write-read: SKIP (0.000s)
[619.713240] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[619.716370] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[619.719221] [132/133] (420s left) perf (gen12-group-exclusive-stream-sample-oa)
[620.124053] Starting subtest: gen12-group-exclusive-stream-sample-oa
[620.147780] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[620.215539] [133/133] (420s left) perf_pmu (busy-double-start)
[620.287088] Starting subtest: busy-double-start
[620.287966] Starting dynamic subtest: rcs0
[623.933508] Dynamic subtest rcs0: SUCCESS (3.645s)
[623.948500] Starting dynamic subtest: bcs0
[627.528603] Dynamic subtest bcs0: SUCCESS (3.591s)
[627.543699] Starting dynamic subtest: vcs0
[631.132345] Dynamic subtest vcs0: FAIL (3.579s)
[631.145527] Starting dynamic subtest: vcs1
[634.702236] Dynamic subtest vcs1: FAIL (3.566s)
[634.715299] Starting dynamic subtest: vecs0
[638.268081] Dynamic subtest vecs0: FAIL (3.565s)
[638.281047] Starting dynamic subtest: vecs1
[641.833739] Dynamic subtest vecs1: FAIL (3.565s)
[641.846924] Starting dynamic subtest: ccs0
[645.408608] Dynamic subtest ccs0: SUCCESS (3.595s)
[645.413304] Subtest busy-double-start: FAIL (25.122s)
[645.568085] 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.