[63.905432] Initializing watchdogs
[63.905508]   /dev/watchdog0
[63.928981] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.940069] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.943754] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.946671] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[64.032966] Subtest write-snoop: SKIP (0.000s)
[64.112656] [002/133] (960s left) kms_content_protection (content-type-change)
[65.690431] Starting subtest: content-type-change
[65.698168] Subtest content-type-change: SKIP (0.006s)
[65.917770] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[67.427524] Starting subtest: multiplane-rotation
[96.935490] Subtest multiplane-rotation: SUCCESS (29.489s)
[97.141696] [004/133] (927s left) kms_chamelium_color (ctm-red-to-blue)
[98.647596] Subtest ctm-red-to-blue: SKIP (0.000s)
[98.797947] [005/133] (925s left) syncobj_wait (invalid-reset-one-illegal-handle)
[98.885233] Starting subtest: invalid-reset-one-illegal-handle
[98.886209] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[99.077463] [006/133] (925s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[100.574434] Starting subtest: disable-crc-after-crtc
[100.576443] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.185145] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.609s)
[101.194055] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.627152] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.440s)
[101.636669] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.055987] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.427s)
[102.065522] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.483917] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.426s)
[102.484845] Subtest disable-crc-after-crtc: SUCCESS (1.909s)
[102.728601] [007/133] (922s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[102.805254] Subtest tiled-to-tiled: SKIP (0.000s)
[102.885662] [008/133] (922s left) syncobj_wait (wait-all-interrupted)
[102.957124] Starting subtest: wait-all-interrupted
[103.059710] Subtest wait-all-interrupted: SUCCESS (0.102s)
[103.236181] [009/133] (921s left) syncobj_wait (wait-all-complex)
[103.314366] Starting subtest: wait-all-complex
[103.537923] Subtest wait-all-complex: SUCCESS (0.216s)
[103.707831] [010/133] (921s left) gem_pxp (reject-modify-context-protection-on)
[106.303524] Starting subtest: reject-modify-context-protection-on
[106.305336] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[106.437237] [011/133] (918s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[107.945979] Starting subtest: cursorA-vs-flipB-varying-size
[107.949042] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[108.131269] [012/133] (917s left) kms_rotation_crc (primary-rotation-90)
[109.647500] Starting subtest: primary-rotation-90
[109.650236] Subtest primary-rotation-90: SKIP (0.001s)
[109.846056] [013/133] (915s left) syncobj_wait (reset-multiple-signaled)
[109.925205] Starting subtest: reset-multiple-signaled
[109.926138] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[110.120609] [014/133] (915s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[111.622084] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[111.623988] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[111.881389] [015/133] (913s left) gem_softpin (noreloc-s3)
[111.961166] Starting subtest: noreloc-S3
[132.879408] Subtest noreloc-S3: SUCCESS (5.467s)
[141.128942] [016/133] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[142.638366] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[145.500572] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.862s)
[145.704579] [017/133] (888s left) gem_ctx_param (invalid-ctx-set)
[145.774095] Starting subtest: invalid-ctx-set
[145.776104] Subtest invalid-ctx-set: SUCCESS (0.001s)
[145.980370] [018/133] (887s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[146.048842] Starting subtest: single-wait-all-for-submit-unsubmitted
[146.152328] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[146.326079] [019/133] (887s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[147.841131] Starting subtest: x-tiled-64bpp-rotate-90
[147.900871] Subtest x-tiled-64bpp-rotate-90: SKIP (0.059s)
[148.146605] [020/133] (885s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[148.216714] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[148.310337] [021/133] (885s left) kms_psr (fbc-psr-cursor-plane-move)
[149.816615] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[149.878685] [022/133] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[151.404951] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[152.684941] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.279s)
[152.914186] [023/133] (881s left) kms_flip (2x-flip-vs-rmfb)
[154.420826] Starting subtest: 2x-flip-vs-rmfb
[154.436577] Subtest 2x-flip-vs-rmfb: SKIP (0.015s)
[154.630700] [024/133] (879s left) kms_plane_cursor (viewport)
[156.138144] Starting subtest: viewport
[156.139937] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[159.401241] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (3.261s)
[159.506116] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[162.735866] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (3.266s)
[162.820449] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[166.085292] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (3.283s)
[166.223976] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[169.474885] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (3.260s)
[169.533008] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[172.741952] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (3.217s)
[172.800054] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[176.042156] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (3.250s)
[176.126213] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[179.394987] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (3.278s)
[179.473897] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[182.696162] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (3.249s)
[182.755183] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[185.913997] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (3.167s)
[185.997733] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[189.259675] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (3.271s)
[189.317955] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[192.575845] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (3.266s)
[192.658754] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[195.877290] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (3.249s)
[195.951665] Subtest viewport: SUCCESS (39.809s)
[196.197268] [025/133] (838s left) kms_cdclk (mode-transition)
[197.704871] Starting subtest: mode-transition
[197.705768] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.749441] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.043s)
[197.759304] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.760986] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[197.770636] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.772403] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[197.781989] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.783622] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[197.785368] Subtest mode-transition: SKIP (0.055s)
[197.961979] [026/133] (836s left) gem_exec_balancer (fairslice)
[198.043364] Starting subtest: fairslice
[203.668800] Subtest fairslice: SUCCESS (5.624s)
[204.116110] [027/133] (830s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[205.619959] Starting subtest: basic-flip-before-cursor-varying-size
[206.612817] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.992s)
[206.889092] [028/133] (827s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[208.393849] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[208.394750] Starting dynamic subtest: pipe-A-valid-mode
[208.445736] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[208.447551] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.052s)
[208.661058] [029/133] (826s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[210.163954] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[210.164852] Starting dynamic subtest: pipe-A-valid-mode
[211.031031] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.866s)
[211.031953] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.868s)
[211.286358] [030/133] (823s left) core_getstats (basic)
[211.352943] Starting subtest: basic
[211.353852] Subtest basic: SUCCESS (0.000s)
[211.495864] [031/133] (823s left) kms_rmfb (close-fd)
[213.008940] Starting subtest: close-fd
[213.009860] Starting dynamic subtest: pipe-A-HDMI-A-1
[213.233045] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.223s)
[213.257435] Starting dynamic subtest: pipe-B-HDMI-A-1
[213.448944] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.210s)
[213.460640] Starting dynamic subtest: pipe-C-HDMI-A-1
[213.643864] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.193s)
[213.655135] Starting dynamic subtest: pipe-D-HDMI-A-1
[213.835956] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.190s)
[213.836869] Subtest close-fd: SUCCESS (0.828s)
[214.053439] [032/133] (820s left) gem_exec_reloc (basic-gtt-wc)
[214.135027] Subtest basic-gtt-wc: SKIP (0.000s)
[214.204431] [033/133] (820s left) kms_properties (crtc-properties-legacy)
[215.709403] Starting subtest: crtc-properties-legacy
[215.711797] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.008909] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.297s)
[216.027206] Starting dynamic subtest: pipe-B-HDMI-A-1
[216.286600] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.274s)
[216.299032] Starting dynamic subtest: pipe-C-HDMI-A-1
[216.553813] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.265s)
[216.566064] Starting dynamic subtest: pipe-D-HDMI-A-1
[216.819462] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.263s)
[216.820383] Subtest crtc-properties-legacy: SUCCESS (1.110s)
[217.077951] [034/133] (817s left) kms_invalid_mode (zero-hdisplay)
[218.583749] Starting subtest: zero-hdisplay
[218.585981] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.631427] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.046s)
[218.643208] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.644353] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[218.654180] Starting dynamic subtest: pipe-C-HDMI-A-1
[218.655323] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[218.665607] Starting dynamic subtest: pipe-D-HDMI-A-1
[218.666733] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[218.667971] Subtest zero-hdisplay: SUCCESS (0.055s)
[218.887565] [035/133] (816s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[220.393538] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[220.394500] Starting dynamic subtest: pipe-A
[222.026429] Dynamic subtest pipe-A: SUCCESS (1.632s)
[222.045575] Starting dynamic subtest: pipe-B
[223.667567] Dynamic subtest pipe-B: SUCCESS (1.639s)
[223.697032] Starting dynamic subtest: pipe-C
[223.909837] Dynamic subtest pipe-C: SUCCESS (0.240s)
[223.935784] Starting dynamic subtest: pipe-D
[224.152315] Dynamic subtest pipe-D: SUCCESS (0.240s)
[224.153411] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.759s)
[224.410486] [036/133] (810s left) kms_pm_rpm (legacy-planes-dpms)
[228.542227] Starting subtest: legacy-planes-dpms
[228.545315] Starting dynamic subtest: plane-63
[235.441885] Dynamic subtest plane-63: SUCCESS (6.897s)
[235.490554] Starting dynamic subtest: plane-93
[242.337373] Dynamic subtest plane-93: SUCCESS (6.893s)
[242.375961] Starting dynamic subtest: plane-123
[249.216294] Dynamic subtest plane-123: SUCCESS (6.880s)
[249.264910] Starting dynamic subtest: plane-133
[257.031769] Dynamic subtest plane-133: SUCCESS (7.814s)
[257.037532] Subtest legacy-planes-dpms: SUCCESS (28.502s)
[258.074641] [037/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[259.585497] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[259.587132] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.811269] [038/133] (775s left) kms_dirtyfb (default-dirtyfb-ioctl)
[261.317898] Starting subtest: default-dirtyfb-ioctl
[261.318825] Starting dynamic subtest: A-HDMI-A-1
[262.735877] Dynamic subtest A-HDMI-A-1: SUCCESS (1.418s)
[262.736761] Subtest default-dirtyfb-ioctl: SUCCESS (1.420s)
[262.993208] [039/133] (772s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[264.499856] Starting subtest: cursorB-vs-flipA-legacy
[264.502847] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[264.684037] [040/133] (770s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[264.762050] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[264.762981] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[264.955484] [041/133] (770s left) kms_prime (basic-crc-vgem)
[266.509492] Subtest basic-crc-vgem: SKIP (0.000s)
[266.690444] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[266.692882] [042/133] (769s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[266.771765] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[266.838104] [043/133] (769s left) i915_drm_fdinfo (busy)
[266.910030] Starting subtest: busy
[266.910947] Starting dynamic subtest: rcs0
[266.912746] Dynamic subtest rcs0: SKIP (0.000s)
[266.923262] Starting dynamic subtest: bcs0
[266.925493] Dynamic subtest bcs0: SKIP (0.000s)
[266.935772] Starting dynamic subtest: vcs0
[266.937756] Dynamic subtest vcs0: SKIP (0.000s)
[266.948437] Starting dynamic subtest: vcs1
[266.950825] Dynamic subtest vcs1: SKIP (0.000s)
[266.961147] Starting dynamic subtest: vecs0
[266.963436] Dynamic subtest vecs0: SKIP (0.013s)
[266.973720] Starting dynamic subtest: vecs1
[266.975940] Dynamic subtest vecs1: SKIP (0.000s)
[266.985920] Starting dynamic subtest: ccs0
[266.987846] Dynamic subtest ccs0: SKIP (0.000s)
[266.989609] Subtest busy: SKIP (0.023s)
[267.057530] [044/133] (768s left) gem_userptr_blits (nohangcheck)
[267.153089] Starting subtest: nohangcheck
[267.466171] Subtest nohangcheck: SUCCESS (0.312s)
[267.692962] [045/133] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[269.215153] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[269.909649] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.694s)
[270.203457] [046/133] (765s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[271.717103] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[271.718841] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[271.981859] [047/133] (764s left) kms_scaling_modes (scaling-mode-full)
[273.498184] Starting subtest: scaling-mode-full
[273.503550] Subtest scaling-mode-full: SKIP (0.001s)
[273.692649] [048/133] (762s left) kms_psr (fbc-pr-basic)
[275.209306] Subtest fbc-pr-basic: SKIP (0.000s)
[275.275940] [049/133] (761s left) gem_ringfill (basic-all)
[275.715936] Starting subtest: basic-all
[277.473623] Subtest basic-all: SUCCESS (1.758s)
[277.719364] [050/133] (758s left) gem_exec_whisper (basic-fds-forked-all)
[277.811203] Starting subtest: basic-fds-forked-all
[300.483145] Subtest basic-fds-forked-all: SUCCESS (22.673s)
[300.769942] [051/133] (735s left) api_intel_bb (full-batch)
[300.854078] Starting subtest: full-batch
[300.882119] Subtest full-batch: SUCCESS (0.029s)
[301.105149] [052/133] (735s left) kms_cursor_crc (cursor-sliding-256x85)
[302.862221] Starting subtest: cursor-sliding-256x85
[302.867135] Starting dynamic subtest: pipe-A-HDMI-A-1
[307.101626] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.235s)
[307.141616] Starting dynamic subtest: pipe-D-HDMI-A-1
[311.396125] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.264s)
[311.396992] Subtest cursor-sliding-256x85: SUCCESS (8.534s)
[311.719686] [053/133] (725s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[313.229150] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[313.231308] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.252456] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[313.263273] Starting dynamic subtest: pipe-B-HDMI-A-1
[313.284756] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[313.295234] Starting dynamic subtest: pipe-C-HDMI-A-1
[313.320332] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[313.331521] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.354165] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[313.355982] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.014s)
[313.564190] [054/133] (723s left) gen9_exec_parse (allowed-single)
[313.652755] Subtest allowed-single: SKIP (0.000s)
[313.736764] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[315.260858] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[315.262786] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.487800] [056/133] (721s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[317.026744] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[317.028629] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[317.246975] [057/133] (719s left) gem_exec_fence (expired-history)
[317.817293] Starting subtest: expired-history
[324.345436] Subtest expired-history: SUCCESS (6.528s)
[326.417112] [058/133] (710s left) kms_psr (fbc-psr-sprite-plane-move)
[327.928246] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[327.983685] [059/133] (709s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[329.525662] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[329.527553] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[329.749009] [060/133] (707s left) gem_ctx_bad_destroy (double-destroy)
[329.823535] Starting subtest: double-destroy
[329.824454] Subtest double-destroy: SUCCESS (0.000s)
[329.994325] [061/133] (707s left) syncobj_timeline (invalid-signal-illegal-handle)
[330.072940] Starting subtest: invalid-signal-illegal-handle
[330.073854] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[330.266009] [062/133] (707s left) kms_chamelium_hpd (common-hpd-after-suspend)
[331.828362] Subtest common-hpd-after-suspend: SKIP (0.000s)
[331.935818] [063/133] (705s left) kms_frontbuffer_tracking (fbc-tiling-4)
[333.464578] Starting subtest: fbc-tiling-4
[336.111934] Subtest fbc-tiling-4: SUCCESS (2.648s)
[336.383480] [064/133] (701s left) gem_cs_tlb (engines)
[336.464556] Starting subtest: engines
[336.465497] Starting dynamic subtest: rcs0
[338.619318] Dynamic subtest rcs0: SUCCESS (2.153s)
[338.630946] Starting dynamic subtest: bcs0
[340.775193] Dynamic subtest bcs0: SUCCESS (2.155s)
[340.786450] Starting dynamic subtest: vcs0
[342.929596] Dynamic subtest vcs0: SUCCESS (2.153s)
[342.940808] Starting dynamic subtest: vcs1
[345.083582] Dynamic subtest vcs1: SUCCESS (2.153s)
[345.094762] Starting dynamic subtest: vecs0
[347.236939] Dynamic subtest vecs0: SUCCESS (2.152s)
[347.248225] Starting dynamic subtest: vecs1
[349.390027] Dynamic subtest vecs1: SUCCESS (2.152s)
[349.401472] Starting dynamic subtest: ccs0
[351.543202] Dynamic subtest ccs0: SUCCESS (2.152s)
[351.544108] Subtest engines: SUCCESS (15.079s)
[351.724892] [065/133] (686s left) gem_mmap_gtt (hang-busy)
[351.803753] Subtest hang-busy: SKIP (0.000s)
[351.880278] [066/133] (685s left) kms_psr (psr2-sprite-plane-onoff)
[353.389165] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[353.461387] [067/133] (684s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[354.992012] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[355.711086] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.719s)
[355.994260] [068/133] (681s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[357.518031] Starting subtest: y-tiled-64bpp-rotate-270
[357.519819] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[357.756465] [069/133] (680s left) gem_bad_reloc (negative-reloc-lut)
[357.839899] Subtest negative-reloc-lut: SKIP (0.000s)
[357.928224] [070/133] (680s left) gem_ctx_persistence (engines-mixed)
[358.018863] Starting subtest: engines-mixed
[358.019773] Starting dynamic subtest: rcs0
[358.131796] Dynamic subtest rcs0: SUCCESS (0.112s)
[358.145063] Starting dynamic subtest: bcs0
[358.182119] Dynamic subtest bcs0: SUCCESS (0.049s)
[358.206920] Starting dynamic subtest: vcs0
[358.238336] Dynamic subtest vcs0: SUCCESS (0.054s)
[358.266740] Starting dynamic subtest: vcs1
[358.306226] Dynamic subtest vcs1: SUCCESS (0.065s)
[358.336218] Starting dynamic subtest: vecs0
[358.383254] Dynamic subtest vecs0: SUCCESS (0.074s)
[358.410509] Starting dynamic subtest: vecs1
[358.450430] Dynamic subtest vecs1: SUCCESS (0.065s)
[358.491169] Starting dynamic subtest: ccs0
[358.533045] Dynamic subtest ccs0: SUCCESS (0.080s)
[358.534152] Subtest engines-mixed: SUCCESS (0.515s)
[358.701050] [071/133] (679s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[360.212875] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[360.213767] Starting dynamic subtest: pipe-A
[360.294564] Dynamic subtest pipe-A: SUCCESS (0.082s)
[360.310647] Starting dynamic subtest: pipe-B
[360.439050] Dynamic subtest pipe-B: SUCCESS (0.143s)
[360.457539] Starting dynamic subtest: pipe-C
[360.580700] Dynamic subtest pipe-C: SUCCESS (0.140s)
[360.592175] Starting dynamic subtest: pipe-D
[360.705061] Dynamic subtest pipe-D: SUCCESS (0.123s)
[360.706000] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.494s)
[360.954784] [072/133] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[362.472567] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[362.474479] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.715304] [073/133] (675s left) gem_exec_schedule (semaphore-noskip)
[362.809943] Starting subtest: semaphore-noskip
[363.567798] Subtest semaphore-noskip: SUCCESS (0.759s)
[364.030474] [074/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[365.558751] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[365.560568] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[365.772833] [075/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[367.290804] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[367.292638] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[367.503658] [076/133] (671s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[369.028741] Starting subtest: 4-tiled-16bpp-rotate-0
[370.799515] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.770s)
[371.030309] [077/133] (667s left) gem_exec_basic (basic)
[371.111558] Starting subtest: basic
[371.112492] Starting dynamic subtest: rcs0-smem
[371.115016] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[371.127794] Starting dynamic subtest: bcs0-smem
[371.128851] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[371.140139] Starting dynamic subtest: vcs0-smem
[371.141048] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[371.151744] Starting dynamic subtest: vcs1-smem
[371.152761] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[371.163477] Starting dynamic subtest: vecs0-smem
[371.164655] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[371.175241] Starting dynamic subtest: vecs1-smem
[371.176297] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[371.187006] Starting dynamic subtest: ccs0-smem
[371.188168] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[371.198838] Starting dynamic subtest: rcs0-lmem0
[371.199925] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[371.210636] Starting dynamic subtest: bcs0-lmem0
[371.211715] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[371.222273] Starting dynamic subtest: vcs0-lmem0
[371.223294] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[371.233852] Starting dynamic subtest: vcs1-lmem0
[371.234739] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[371.245688] Starting dynamic subtest: vecs0-lmem0
[371.246708] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[371.257928] Starting dynamic subtest: vecs1-lmem0
[371.259058] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[371.270110] Starting dynamic subtest: ccs0-lmem0
[371.271175] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[371.272193] Subtest basic: SUCCESS (0.022s)
[371.375809] [078/133] (667s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[372.894568] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[372.896425] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[373.140407] [079/133] (665s left) gem_mmap (short-mmap)
[373.224736] Subtest short-mmap: SKIP (0.000s)
[373.293688] [080/133] (665s left) gem_exec_reloc (basic-gtt-wc-active)
[373.374923] Subtest basic-gtt-wc-active: SKIP (0.000s)
[373.467493] [081/133] (665s left) gem_ctx_shared (create-shared-gtt)
[373.557974] Starting subtest: create-shared-gtt
[375.709353] Subtest create-shared-gtt: SUCCESS (2.150s)
[378.172568] [082/133] (661s left) gem_exec_reloc (basic-write-wc)
[378.254830] Subtest basic-write-wc: SKIP (0.000s)
[378.359368] [083/133] (660s left) gem_eio (wait-immediate)
[378.700350] Starting subtest: wait-immediate
[379.272085] Subtest wait-immediate: SUCCESS (0.574s)
[380.901343] [084/133] (658s left) gem_ctx_persistence (legacy-engines-mixed)
[380.992224] Starting subtest: legacy-engines-mixed
[380.993119] Starting dynamic subtest: render
[381.107021] Dynamic subtest render: SUCCESS (0.114s)
[381.127206] Starting dynamic subtest: bsd1
[381.156985] Dynamic subtest bsd1: SUCCESS (0.048s)
[381.187789] Starting dynamic subtest: bsd2
[381.232227] Dynamic subtest bsd2: SUCCESS (0.072s)
[381.269706] Starting dynamic subtest: blt
[381.317024] Dynamic subtest blt: SUCCESS (0.082s)
[381.346112] Starting dynamic subtest: vebox
[381.398705] Dynamic subtest vebox: SUCCESS (0.079s)
[381.404280] Subtest legacy-engines-mixed: SUCCESS (0.408s)
[381.619050] [085/133] (657s left) perf_pmu (semaphore-busy)
[381.688048] Starting subtest: semaphore-busy
[381.688924] Starting dynamic subtest: rcs0
[383.367062] Dynamic subtest rcs0: SUCCESS (1.676s)
[383.383980] Starting dynamic subtest: bcs0
[385.010168] Dynamic subtest bcs0: SUCCESS (1.638s)
[385.027537] Starting dynamic subtest: vcs0
[386.656651] Dynamic subtest vcs0: SUCCESS (1.641s)
[386.677704] Starting dynamic subtest: vcs1
[388.302236] Dynamic subtest vcs1: SUCCESS (1.640s)
[388.323236] Starting dynamic subtest: vecs0
[389.950311] Dynamic subtest vecs0: SUCCESS (1.643s)
[389.971383] Starting dynamic subtest: vecs1
[391.600278] Dynamic subtest vecs1: SUCCESS (1.644s)
[391.620963] Starting dynamic subtest: ccs0
[393.246123] Dynamic subtest ccs0: SUCCESS (1.640s)
[393.248001] Subtest semaphore-busy: SUCCESS (11.556s)
[393.488096] [086/133] (646s left) gem_exec_schedule (pi-common)
[393.693857] Starting subtest: pi-common
[393.694798] Starting dynamic subtest: rcs0
[393.734958] Dynamic subtest rcs0: SUCCESS (0.041s)
[393.750410] Starting dynamic subtest: bcs0
[393.768810] Dynamic subtest bcs0: SUCCESS (0.033s)
[393.782944] Starting dynamic subtest: vcs0
[393.802951] Dynamic subtest vcs0: SUCCESS (0.033s)
[393.817186] Starting dynamic subtest: vcs1
[393.836661] Dynamic subtest vcs1: SUCCESS (0.033s)
[393.850884] Starting dynamic subtest: vecs0
[393.869178] Dynamic subtest vecs0: SUCCESS (0.031s)
[393.882053] Starting dynamic subtest: vecs1
[393.900266] Dynamic subtest vecs1: SUCCESS (0.030s)
[393.914668] Starting dynamic subtest: ccs0
[393.929761] Dynamic subtest ccs0: SUCCESS (0.028s)
[393.930845] Subtest pi-common: SUCCESS (0.237s)
[394.277245] [087/133] (645s left) i915_hangman (engine-error-state-capture)
[394.372406] Starting subtest: engine-error-state-capture
[394.373239] Starting dynamic subtest: rcs0
[396.992995] Dynamic subtest rcs0: SUCCESS (2.620s)
[397.006842] Starting dynamic subtest: bcs0
[401.027639] Dynamic subtest bcs0: SUCCESS (4.033s)
[401.040096] Starting dynamic subtest: vcs0
[405.025463] Dynamic subtest vcs0: SUCCESS (3.996s)
[405.042892] Starting dynamic subtest: vcs1
[409.016944] Dynamic subtest vcs1: SUCCESS (3.989s)
[409.029393] Starting dynamic subtest: vecs0
[412.987981] Dynamic subtest vecs0: SUCCESS (3.969s)
[413.001749] Starting dynamic subtest: vecs1
[417.013957] Dynamic subtest vecs1: SUCCESS (4.024s)
[417.027793] Starting dynamic subtest: ccs0
[420.999968] Dynamic subtest ccs0: SUCCESS (3.984s)
[421.000870] Subtest engine-error-state-capture: SUCCESS (26.624s)
[421.213849] [088/133] (618s left) syncobj_timeline (wait-for-submit-snapshot)
[421.294018] Starting subtest: wait-for-submit-snapshot
[421.377521] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[421.563009] [089/133] (618s left) kms_color (ctm-blue-to-red)
[423.073864] Starting subtest: ctm-blue-to-red
[423.074768] Starting dynamic subtest: pipe-A-HDMI-A-1
[423.768530] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.694s)
[423.782516] Starting dynamic subtest: pipe-B-HDMI-A-1
[424.261166] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.491s)
[424.273741] Starting dynamic subtest: pipe-C-HDMI-A-1
[424.758711] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.496s)
[424.771081] Starting dynamic subtest: pipe-D-HDMI-A-1
[425.278943] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.520s)
[425.279895] Subtest ctm-blue-to-red: SUCCESS (2.206s)
[425.514456] [090/133] (614s left) prime_vgem (basic-gtt)
[425.614751] Starting subtest: basic-gtt
[425.616660] Subtest basic-gtt: SKIP (0.000s)
[425.810322] [091/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[427.327734] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[427.329640] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[427.567007] [092/133] (612s left) api_intel_allocator (default-alignment)
[427.645089] Starting subtest: default-alignment
[427.651848] Subtest default-alignment: SUCCESS (0.008s)
[427.877169] [093/133] (612s left) i915_pm_rps (fence-order)
[427.966754] Starting subtest: fence-order
[432.351322] Subtest fence-order: SUCCESS (4.383s)
[432.558141] [094/133] (607s left) kms_vblank (query-busy)
[434.074337] Starting subtest: query-busy
[434.076742] Starting dynamic subtest: pipe-A-HDMI-A-1
[436.535150] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.458s)
[436.552090] Starting dynamic subtest: pipe-D-HDMI-A-1
[438.907389] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.365s)
[438.908204] Subtest query-busy: SUCCESS (4.830s)
[439.130209] [095/133] (601s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[440.654876] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[440.656744] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[440.874363] [096/133] (599s left) kms_addfb_basic (invalid-get-prop-any)
[440.953103] Starting subtest: invalid-get-prop-any
[440.953992] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[442.620450] [097/133] (597s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[444.135423] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[444.201474] [098/133] (596s left) kms_flip (2x-blocking-absolute-wf_vblank)
[445.714130] Starting subtest: 2x-blocking-absolute-wf_vblank
[445.728859] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.015s)
[445.936212] [099/133] (594s left) kms_cursor_crc (cursor-onscreen-256x85)
[447.710072] Starting subtest: cursor-onscreen-256x85
[447.714999] Starting dynamic subtest: pipe-A-HDMI-A-1
[450.395457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.679s)
[450.430387] Starting dynamic subtest: pipe-D-HDMI-A-1
[453.034368] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.616s)
[453.035241] Subtest cursor-onscreen-256x85: SUCCESS (5.324s)
[453.386561] [100/133] (587s left) kms_flip (2x-modeset-vs-vblank-race)
[454.901420] Starting subtest: 2x-modeset-vs-vblank-race
[454.915964] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s)
[455.121070] [101/133] (585s left) kms_atomic_interruptible (atomic-setmode)
[456.639053] Starting subtest: atomic-setmode
[456.639997] Starting dynamic subtest: pipe-A-HDMI-A-1
[462.822886] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.183s)
[462.823779] Subtest atomic-setmode: SUCCESS (6.185s)
[463.041697] [102/133] (578s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[464.561710] Starting subtest: psr-argb161616f-draw-render
[464.563466] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[464.792807] [103/133] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[466.314628] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[466.316378] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.558341] [104/133] (574s left) kms_plane_scaling (invalid-num-scalers)
[468.072861] Starting subtest: invalid-num-scalers
[468.077915] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[468.098770] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.021s)
[468.115430] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[468.139856] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.035s)
[468.156977] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[468.181162] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.036s)
[468.197893] Starting dynamic subtest: pipe-D-HDMI-A-1-invalid-num-scalers
[468.222289] Dynamic subtest pipe-D-HDMI-A-1-invalid-num-scalers: SUCCESS (0.036s)
[468.224312] Subtest invalid-num-scalers: SUCCESS (0.150s)
[468.403770] [105/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[469.921754] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[469.923602] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[470.171732] [106/133] (571s left) sw_sync (alloc_fence_invalid_timeline)
[470.219986] Starting subtest: alloc_fence_invalid_timeline
[470.220874] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[470.368336] [107/133] (571s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[470.446026] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[470.551988] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[470.728941] [108/133] (570s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[472.243546] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[472.247940] Starting dynamic subtest: A-HDMI-A1
[480.264332] Dynamic subtest A-HDMI-A1: SUCCESS (8.015s)
[480.280181] Starting dynamic subtest: B-HDMI-A1
[488.213957] Dynamic subtest B-HDMI-A1: SUCCESS (7.947s)
[488.228876] Starting dynamic subtest: C-HDMI-A1
[496.164053] Dynamic subtest C-HDMI-A1: SUCCESS (7.948s)
[496.179190] Starting dynamic subtest: D-HDMI-A1
[504.115102] Dynamic subtest D-HDMI-A1: SUCCESS (7.948s)
[504.120919] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.875s)
[504.406183] [109/133] (537s left) kms_addfb_basic (size-max)
[505.918542] Starting subtest: size-max
[505.919673] Subtest size-max: SUCCESS (0.000s)
[506.156442] [110/133] (535s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[507.890187] Starting subtest: cursor-rapid-movement-256x256
[507.895579] Starting dynamic subtest: pipe-A-HDMI-A-1
[508.295910] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.400s)
[508.332718] Starting dynamic subtest: pipe-D-HDMI-A-1
[508.617950] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.298s)
[508.618845] Subtest cursor-rapid-movement-256x256: SUCCESS (0.728s)
[509.012196] [111/133] (533s left) gem_exec_whisper (basic-queues-all)
[509.099389] Starting subtest: basic-queues-all
[530.917256] Subtest basic-queues-all: SUCCESS (21.814s)
[531.192136] [112/133] (510s left) kms_dsc (dsc-fractional-bpp)
[532.707892] Starting subtest: dsc-fractional-bpp
[532.713633] Subtest dsc-fractional-bpp: SKIP (0.000s)
[532.898502] [113/133] (509s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[534.416862] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[534.417769] Starting dynamic subtest: pipe-A-valid-mode
[534.457279] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s)
[534.458959] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.040s)
[534.671159] [114/133] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[536.189748] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[536.191631] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[536.409186] [115/133] (506s left) gem_softpin (evict-prime)
[536.501185] Starting subtest: evict-prime
[536.502106] Starting dynamic subtest: rcs0
[537.778114] Dynamic subtest rcs0: SUCCESS (1.276s)
[537.795550] Starting dynamic subtest: bcs0
[538.918876] Dynamic subtest bcs0: SUCCESS (1.140s)
[538.931422] Starting dynamic subtest: vcs0
[540.076030] Dynamic subtest vcs0: SUCCESS (1.156s)
[540.090668] Starting dynamic subtest: vcs1
[541.286999] Dynamic subtest vcs1: SUCCESS (1.210s)
[541.300364] Starting dynamic subtest: vecs0
[542.440993] Dynamic subtest vecs0: SUCCESS (1.153s)
[542.453993] Starting dynamic subtest: vecs1
[543.630015] Dynamic subtest vecs1: SUCCESS (1.188s)
[543.646807] Starting dynamic subtest: ccs0
[544.840100] Dynamic subtest ccs0: SUCCESS (1.209s)
[544.860365] Starting dynamic subtest: all
[545.971030] Dynamic subtest all: SUCCESS (1.130s)
[545.972046] Subtest evict-prime: SUCCESS (9.470s)
[546.166172] [116/133] (496s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[547.687836] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[547.689655] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[547.915412] [117/133] (494s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[549.427486] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[549.668922] [118/133] (493s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[549.754971] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[549.864516] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[550.031675] [119/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[551.548543] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[551.550420] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[551.787032] [120/133] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[553.305763] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[556.554111] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.249s)
[556.818006] [121/133] (486s left) gem_mmap_wc (bad-size)
[556.900757] Subtest bad-size: SKIP (0.000s)
[556.968914] [122/133] (486s left) kms_hdr (static-toggle-suspend)
[558.492863] Starting subtest: static-toggle-suspend
[558.495543] Subtest static-toggle-suspend: SKIP (0.000s)
[558.688039] [123/133] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[560.208514] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[560.210328] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[560.442283] [124/133] (482s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[561.970403] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[562.034980] [125/133] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[563.553580] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[563.555579] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[563.795289] [126/133] (479s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[565.323850] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[565.324760] Starting dynamic subtest: pipe-A-HDMI-A-1
[565.332963] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[565.345476] Starting dynamic subtest: pipe-B-HDMI-A-1
[565.353778] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[565.365793] Starting dynamic subtest: pipe-C-HDMI-A-1
[565.374468] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[565.386780] Starting dynamic subtest: pipe-D-HDMI-A-1
[565.395376] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[565.396979] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[565.646623] [127/133] (478s left) syncobj_timeline (single-wait-all-available-submitted)
[565.725941] Starting subtest: single-wait-all-available-submitted
[565.726960] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[565.933583] [128/133] (477s left) gem_exec_parallel (userptr)
[566.022362] Starting subtest: userptr
[566.023238] Starting dynamic subtest: rcs0
[567.563765] Dynamic subtest rcs0: SUCCESS (1.541s)
[567.579970] Starting dynamic subtest: bcs0
[569.042866] Dynamic subtest bcs0: SUCCESS (1.478s)
[569.056626] Starting dynamic subtest: vcs0
[570.565264] Dynamic subtest vcs0: SUCCESS (1.521s)
[570.582362] Starting dynamic subtest: vcs1
[572.072815] Dynamic subtest vcs1: SUCCESS (1.506s)
[572.088251] Starting dynamic subtest: vecs0
[573.534765] Dynamic subtest vecs0: SUCCESS (1.461s)
[573.553023] Starting dynamic subtest: vecs1
[575.006103] Dynamic subtest vecs1: SUCCESS (1.470s)
[575.021413] Starting dynamic subtest: ccs0
[576.463239] Dynamic subtest ccs0: SUCCESS (1.456s)
[576.464275] Subtest userptr: SUCCESS (10.441s)
[576.802774] [129/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[578.318973] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[578.320867] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[578.563531] [130/133] (465s left) i915_selftest (mock)
[579.637225] Starting subtest: mock
[579.638194] Starting dynamic subtest: sanitycheck
[580.467427] Dynamic subtest sanitycheck: SUCCESS (0.830s)
[580.504678] Starting dynamic subtest: shmem
[581.349531] Dynamic subtest shmem: SUCCESS (0.877s)
[581.386188] Starting dynamic subtest: fence
[589.484758] Dynamic subtest fence: SUCCESS (8.130s)
[589.502139] Starting dynamic subtest: scatterlist
[591.329421] Dynamic subtest scatterlist: SUCCESS (1.840s)
[591.346146] Starting dynamic subtest: syncmap
[594.227883] Dynamic subtest syncmap: SUCCESS (2.894s)
[594.244303] Starting dynamic subtest: uncore
[595.045356] Dynamic subtest uncore: SUCCESS (0.813s)
[595.080360] Starting dynamic subtest: ring
[595.937904] Dynamic subtest ring: SUCCESS (0.888s)
[595.972616] Starting dynamic subtest: engine
[596.848274] Dynamic subtest engine: SUCCESS (0.906s)
[596.884040] Starting dynamic subtest: timelines
[601.484477] Dynamic subtest timelines: SUCCESS (4.632s)
[601.499111] Starting dynamic subtest: requests
[604.622631] Dynamic subtest requests: SUCCESS (3.137s)
[604.632694] Starting dynamic subtest: objects
[605.583531] Dynamic subtest objects: SUCCESS (0.959s)
[605.596015] Starting dynamic subtest: phys
[606.553490] Dynamic subtest phys: SUCCESS (0.968s)
[606.564366] Starting dynamic subtest: dmabuf
[607.519576] Dynamic subtest dmabuf: SUCCESS (0.965s)
[607.535604] Starting dynamic subtest: vma
[615.675711] Dynamic subtest vma: SUCCESS (8.154s)
[615.687973] Starting dynamic subtest: evict
[617.534707] Dynamic subtest evict: SUCCESS (1.858s)
[617.545594] Starting dynamic subtest: gtt
[621.486751] Dynamic subtest gtt: SUCCESS (3.950s)
[621.498676] Starting dynamic subtest: hugepages
[622.648654] Dynamic subtest hugepages: SUCCESS (1.160s)
[622.659104] Starting dynamic subtest: memory_region
[626.227579] Dynamic subtest memory_region: SUCCESS (3.578s)
[626.228620] Subtest mock: SUCCESS (46.591s)
[626.266730] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[626.267683] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[626.269664] [131/133] (417s left) gem_mmap_gtt (basic-write-read)
[629.894629] Subtest basic-write-read: SKIP (0.000s)
[629.968017] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[629.970819] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[629.973968] [132/133] (414s left) perf (gen12-group-exclusive-stream-sample-oa)
[630.413430] Starting subtest: gen12-group-exclusive-stream-sample-oa
[630.436891] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[630.503107] [133/133] (413s left) perf_pmu (busy-double-start)
[630.575007] Starting subtest: busy-double-start
[630.575882] Starting dynamic subtest: rcs0
[634.235700] Dynamic subtest rcs0: SUCCESS (3.659s)
[634.250046] Starting dynamic subtest: bcs0
[637.836699] Dynamic subtest bcs0: SUCCESS (3.597s)
[637.851269] Starting dynamic subtest: vcs0
[641.441791] Dynamic subtest vcs0: FAIL (3.580s)
[641.454161] Starting dynamic subtest: vcs1
[645.012078] Dynamic subtest vcs1: FAIL (3.566s)
[645.028519] Starting dynamic subtest: vecs0
[648.577605] Dynamic subtest vecs0: FAIL (3.566s)
[648.590215] Starting dynamic subtest: vecs1
[652.144202] Dynamic subtest vecs1: FAIL (3.565s)
[652.157261] Starting dynamic subtest: ccs0
[655.708725] Dynamic subtest ccs0: SUCCESS (3.586s)
[655.713228] Subtest busy-double-start: FAIL (25.136s)
[655.952615] 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.