[56.420742] Initializing watchdogs
[56.420807]   /dev/watchdog0
[56.440788] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[56.451719] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[56.455674] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.457977] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.540383] Subtest write-snoop: SKIP (0.000s)
[56.601948] [002/133] (960s left) kms_content_protection (content-type-change)
[58.173581] Starting subtest: content-type-change
[58.180562] Subtest content-type-change: SKIP (0.005s)
[58.419444] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[59.920744] Starting subtest: multiplane-rotation
[89.050551] Subtest multiplane-rotation: SUCCESS (29.130s)
[89.274176] [004/133] (927s left) kms_chamelium_color (ctm-red-to-blue)
[90.778370] Subtest ctm-red-to-blue: SKIP (0.000s)
[90.838543] [005/133] (926s left) syncobj_wait (invalid-reset-one-illegal-handle)
[90.911614] Starting subtest: invalid-reset-one-illegal-handle
[90.912567] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[91.106174] [006/133] (926s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[92.612526] Starting subtest: disable-crc-after-crtc
[92.614462] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.216204] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.602s)
[93.226183] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.660034] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.442s)
[93.669734] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.095244] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.434s)
[94.105372] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.527119] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.429s)
[94.528054] Subtest disable-crc-after-crtc: SUCCESS (1.914s)
[94.767889] [007/133] (922s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[94.847462] Subtest tiled-to-tiled: SKIP (0.000s)
[94.917656] [008/133] (922s left) syncobj_wait (wait-all-interrupted)
[94.987200] Starting subtest: wait-all-interrupted
[95.088929] Subtest wait-all-interrupted: SUCCESS (0.101s)
[95.267200] [009/133] (922s left) syncobj_wait (wait-all-complex)
[95.338154] Starting subtest: wait-all-complex
[95.564980] Subtest wait-all-complex: SUCCESS (0.216s)
[95.701828] [010/133] (921s left) gem_pxp (reject-modify-context-protection-on)
[98.295127] Starting subtest: reject-modify-context-protection-on
[98.297844] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[98.437677] [011/133] (919s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[99.949175] Starting subtest: cursorA-vs-flipB-varying-size
[99.951084] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[100.127735] [012/133] (917s left) kms_rotation_crc (primary-rotation-90)
[101.648123] Starting subtest: primary-rotation-90
[101.649962] Subtest primary-rotation-90: SKIP (0.001s)
[101.826540] [013/133] (915s left) syncobj_wait (reset-multiple-signaled)
[101.905260] Starting subtest: reset-multiple-signaled
[101.906182] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[102.098066] [014/133] (915s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[103.596701] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[103.598423] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[103.866686] [015/133] (914s left) gem_softpin (noreloc-s3)
[103.952057] Starting subtest: noreloc-S3
[125.108023] Subtest noreloc-S3: SUCCESS (5.397s)
[130.322468] [016/133] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[131.913237] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[134.859237] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.880s)
[135.125818] [017/133] (888s left) gem_ctx_param (invalid-ctx-set)
[135.193897] Starting subtest: invalid-ctx-set
[135.195856] Subtest invalid-ctx-set: SUCCESS (0.001s)
[135.395574] [018/133] (887s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[135.464928] Starting subtest: single-wait-all-for-submit-unsubmitted
[135.571945] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[135.757670] [019/133] (887s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[137.302804] Starting subtest: x-tiled-64bpp-rotate-90
[137.369387] Subtest x-tiled-64bpp-rotate-90: SKIP (0.064s)
[137.624235] [020/133] (885s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[137.692406] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[137.764953] [021/133] (885s left) kms_psr (fbc-psr-cursor-plane-move)
[139.289069] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[139.347959] [022/133] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[140.876489] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[142.181641] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.294s)
[142.425151] [023/133] (881s left) kms_flip (2x-flip-vs-rmfb)
[143.946398] Starting subtest: 2x-flip-vs-rmfb
[143.961741] Subtest 2x-flip-vs-rmfb: SKIP (0.016s)
[144.139878] [024/133] (879s left) kms_plane_cursor (viewport)
[145.668550] Starting subtest: viewport
[145.670344] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[148.914584] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (3.232s)
[148.994955] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[152.257980] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (3.265s)
[152.337897] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[155.630528] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (3.299s)
[155.768489] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[159.024548] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (3.261s)
[159.083064] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[162.294982] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (3.217s)
[162.353830] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[165.581446] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (3.233s)
[165.681702] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[168.948440] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (3.273s)
[169.037512] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[172.317492] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (3.315s)
[172.391449] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[175.635712] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (3.266s)
[175.757608] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[178.972958] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (3.223s)
[179.030912] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[182.238961] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (3.217s)
[182.316751] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[185.571979] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (3.282s)
[185.646521] Subtest viewport: SUCCESS (39.930s)
[185.871272] [025/133] (837s left) kms_cdclk (mode-transition)
[187.374107] Starting subtest: mode-transition
[187.376400] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.427606] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.051s)
[187.437553] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.439393] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[187.449260] Starting dynamic subtest: pipe-C-HDMI-A-1
[187.451026] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[187.460761] Starting dynamic subtest: pipe-D-HDMI-A-1
[187.462534] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[187.464351] Subtest mode-transition: SKIP (0.064s)
[187.657946] [026/133] (836s left) gem_exec_balancer (fairslice)
[187.738812] Starting subtest: fairslice
[193.368889] Subtest fairslice: SUCCESS (5.630s)
[193.865770] [027/133] (830s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[195.367592] Starting subtest: basic-flip-before-cursor-varying-size
[196.408156] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.040s)
[196.660804] [028/133] (827s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[198.167328] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[198.169649] Starting dynamic subtest: pipe-A-valid-mode
[198.222566] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[198.224361] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.054s)
[198.436471] [029/133] (825s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[199.943578] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[199.944504] Starting dynamic subtest: pipe-A-valid-mode
[200.809954] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.866s)
[200.810840] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.868s)
[201.076758] [030/133] (823s left) core_getstats (basic)
[201.146748] Starting subtest: basic
[201.147729] Subtest basic: SUCCESS (0.000s)
[201.300232] [031/133] (822s left) kms_rmfb (close-fd)
[202.815622] Starting subtest: close-fd
[202.816521] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.002635] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.187s)
[203.019098] Starting dynamic subtest: pipe-B-HDMI-A-1
[203.199712] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.193s)
[203.211364] Starting dynamic subtest: pipe-C-HDMI-A-1
[203.401314] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.200s)
[203.418378] Starting dynamic subtest: pipe-D-HDMI-A-1
[203.611244] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.207s)
[203.612331] Subtest close-fd: SUCCESS (0.797s)
[203.884689] [032/133] (820s left) gem_exec_reloc (basic-gtt-wc)
[203.962833] Subtest basic-gtt-wc: SKIP (0.000s)
[204.036683] [033/133] (820s left) kms_properties (crtc-properties-legacy)
[205.540609] Starting subtest: crtc-properties-legacy
[205.541566] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.847505] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.306s)
[205.867030] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.130338] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.279s)
[206.142233] Starting dynamic subtest: pipe-C-HDMI-A-1
[206.397306] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.265s)
[206.409460] Starting dynamic subtest: pipe-D-HDMI-A-1
[206.664677] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.264s)
[206.665673] Subtest crtc-properties-legacy: SUCCESS (1.124s)
[206.915287] [034/133] (817s left) kms_invalid_mode (zero-hdisplay)
[208.415399] Starting subtest: zero-hdisplay
[208.416300] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.467314] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[208.486853] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.488065] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[208.499506] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.500509] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[208.512722] Starting dynamic subtest: pipe-D-HDMI-A-1
[208.513676] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[208.514634] Subtest zero-hdisplay: SUCCESS (0.060s)
[208.715211] [035/133] (815s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[210.224610] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[210.225554] Starting dynamic subtest: pipe-A
[211.869636] Dynamic subtest pipe-A: SUCCESS (1.645s)
[211.890901] Starting dynamic subtest: pipe-B
[213.511519] Dynamic subtest pipe-B: SUCCESS (1.639s)
[213.539710] Starting dynamic subtest: pipe-C
[213.753128] Dynamic subtest pipe-C: SUCCESS (0.239s)
[213.771219] Starting dynamic subtest: pipe-D
[213.994656] Dynamic subtest pipe-D: SUCCESS (0.240s)
[213.998409] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.771s)
[214.262701] [036/133] (810s left) kms_pm_rpm (legacy-planes-dpms)
[217.798999] Starting subtest: legacy-planes-dpms
[217.804921] Starting dynamic subtest: plane-63
[224.684352] Dynamic subtest plane-63: SUCCESS (6.880s)
[224.732535] Starting dynamic subtest: plane-93
[232.370628] Dynamic subtest plane-93: SUCCESS (7.679s)
[232.418865] Starting dynamic subtest: plane-123
[239.258927] Dynamic subtest plane-123: SUCCESS (6.882s)
[239.307684] Starting dynamic subtest: plane-133
[246.133016] Dynamic subtest plane-133: SUCCESS (6.868s)
[246.138707] Subtest legacy-planes-dpms: SUCCESS (28.327s)
[247.170775] [037/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[248.680498] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[248.682305] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.906374] [038/133] (775s left) kms_dirtyfb (default-dirtyfb-ioctl)
[250.414190] Starting subtest: default-dirtyfb-ioctl
[250.416463] Starting dynamic subtest: A-HDMI-A-1
[251.803605] Dynamic subtest A-HDMI-A-1: SUCCESS (1.389s)
[251.804499] Subtest default-dirtyfb-ioctl: SUCCESS (1.390s)
[252.033292] [039/133] (772s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[253.534592] Starting subtest: cursorB-vs-flipA-legacy
[253.537545] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[253.721952] [040/133] (771s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[253.801673] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[253.802781] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[253.993733] [041/133] (771s left) kms_prime (basic-crc-vgem)
[255.546910] Subtest basic-crc-vgem: SKIP (0.000s)
[255.767203] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[255.769877] [042/133] (769s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[255.850483] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[255.933578] [043/133] (769s left) i915_drm_fdinfo (busy)
[256.004047] Starting subtest: busy
[256.004941] Starting dynamic subtest: rcs0
[256.006744] Dynamic subtest rcs0: SKIP (0.000s)
[256.017041] Starting dynamic subtest: bcs0
[256.019232] Dynamic subtest bcs0: SKIP (0.000s)
[256.029544] Starting dynamic subtest: vcs0
[256.031345] Dynamic subtest vcs0: SKIP (0.000s)
[256.041471] Starting dynamic subtest: vcs1
[256.043883] Dynamic subtest vcs1: SKIP (0.000s)
[256.054105] Starting dynamic subtest: vecs0
[256.056462] Dynamic subtest vecs0: SKIP (0.001s)
[256.066374] Starting dynamic subtest: vecs1
[256.068443] Dynamic subtest vecs1: SKIP (0.012s)
[256.078214] Starting dynamic subtest: ccs0
[256.080500] Dynamic subtest ccs0: SKIP (0.000s)
[256.082673] Subtest busy: SKIP (0.021s)
[256.145735] [044/133] (769s left) gem_userptr_blits (nohangcheck)
[256.244646] Starting subtest: nohangcheck
[256.579179] Subtest nohangcheck: SUCCESS (0.333s)
[256.751514] [045/133] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[258.272512] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[258.964654] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[259.244610] [046/133] (766s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[260.757593] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[260.759375] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[261.022238] [047/133] (764s left) kms_scaling_modes (scaling-mode-full)
[262.534827] Starting subtest: scaling-mode-full
[262.540158] Subtest scaling-mode-full: SKIP (0.001s)
[262.756208] [048/133] (762s left) kms_psr (fbc-pr-basic)
[264.277516] Subtest fbc-pr-basic: SKIP (0.000s)
[264.347306] [049/133] (761s left) gem_ringfill (basic-all)
[264.792584] Starting subtest: basic-all
[266.677165] Subtest basic-all: SUCCESS (1.885s)
[266.899248] [050/133] (758s left) gem_exec_whisper (basic-fds-forked-all)
[266.996845] Starting subtest: basic-fds-forked-all
[289.765094] Subtest basic-fds-forked-all: SUCCESS (22.766s)
[290.062742] [051/133] (735s left) api_intel_bb (full-batch)
[290.148060] Starting subtest: full-batch
[290.178560] Subtest full-batch: SUCCESS (0.030s)
[290.398065] [052/133] (735s left) kms_cursor_crc (cursor-sliding-256x85)
[292.159654] Starting subtest: cursor-sliding-256x85
[292.164622] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.576670] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.411s)
[296.614817] Starting dynamic subtest: pipe-D-HDMI-A-1
[300.887202] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.282s)
[300.888082] Subtest cursor-sliding-256x85: SUCCESS (8.726s)
[301.271165] [053/133] (724s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[302.783877] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[302.786206] Starting dynamic subtest: pipe-A-HDMI-A-1
[302.807903] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[302.818846] Starting dynamic subtest: pipe-B-HDMI-A-1
[302.840229] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[302.851094] Starting dynamic subtest: pipe-C-HDMI-A-1
[302.876163] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[302.887515] Starting dynamic subtest: pipe-D-HDMI-A-1
[302.910464] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[302.912303] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.015s)
[303.121045] [054/133] (723s left) gen9_exec_parse (allowed-single)
[303.203558] Subtest allowed-single: SKIP (0.000s)
[303.294344] [055/133] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[304.818189] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[304.819857] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.059641] [056/133] (721s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[306.583442] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[306.585371] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[306.799457] [057/133] (719s left) gem_exec_fence (expired-history)
[307.382790] Starting subtest: expired-history
[313.973870] Subtest expired-history: SUCCESS (6.589s)
[316.003207] [058/133] (710s left) kms_psr (fbc-psr-sprite-plane-move)
[317.519240] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[317.575232] [059/133] (709s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[319.090392] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[319.092255] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[319.333688] [060/133] (707s left) gem_ctx_bad_destroy (double-destroy)
[319.411081] Starting subtest: double-destroy
[319.411913] Subtest double-destroy: SUCCESS (0.000s)
[319.593022] [061/133] (707s left) syncobj_timeline (invalid-signal-illegal-handle)
[319.670610] Starting subtest: invalid-signal-illegal-handle
[319.671525] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[319.857206] [062/133] (707s left) kms_chamelium_hpd (common-hpd-after-suspend)
[321.406653] Subtest common-hpd-after-suspend: SKIP (0.000s)
[321.510664] [063/133] (705s left) kms_frontbuffer_tracking (fbc-tiling-4)
[323.033499] Starting subtest: fbc-tiling-4
[325.724563] Subtest fbc-tiling-4: SUCCESS (2.691s)
[325.989309] [064/133] (701s left) gem_cs_tlb (engines)
[326.072816] Starting subtest: engines
[326.073746] Starting dynamic subtest: rcs0
[328.227833] Dynamic subtest rcs0: SUCCESS (2.153s)
[328.238678] Starting dynamic subtest: bcs0
[330.382371] Dynamic subtest bcs0: SUCCESS (2.153s)
[330.393608] Starting dynamic subtest: vcs0
[332.538043] Dynamic subtest vcs0: SUCCESS (2.154s)
[332.549121] Starting dynamic subtest: vcs1
[334.692119] Dynamic subtest vcs1: SUCCESS (2.152s)
[334.703094] Starting dynamic subtest: vecs0
[336.845446] Dynamic subtest vecs0: SUCCESS (2.152s)
[336.856812] Starting dynamic subtest: vecs1
[338.999360] Dynamic subtest vecs1: SUCCESS (2.152s)
[339.010504] Starting dynamic subtest: ccs0
[341.154679] Dynamic subtest ccs0: SUCCESS (2.154s)
[341.155540] Subtest engines: SUCCESS (15.077s)
[341.320831] [065/133] (685s left) gem_mmap_gtt (hang-busy)
[341.397454] Subtest hang-busy: SKIP (0.000s)
[341.487515] [066/133] (685s left) kms_psr (psr2-sprite-plane-onoff)
[342.999552] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[343.056785] [067/133] (684s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[344.579372] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[345.328979] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.749s)
[345.581252] [068/133] (681s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[347.106490] Starting subtest: y-tiled-64bpp-rotate-270
[347.108257] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[347.339924] [069/133] (680s left) gem_bad_reloc (negative-reloc-lut)
[347.423761] Subtest negative-reloc-lut: SKIP (0.000s)
[347.510767] [070/133] (679s left) gem_ctx_persistence (engines-mixed)
[347.597590] Starting subtest: engines-mixed
[347.598517] Starting dynamic subtest: rcs0
[347.713712] Dynamic subtest rcs0: SUCCESS (0.116s)
[347.728724] Starting dynamic subtest: bcs0
[347.761514] Dynamic subtest bcs0: SUCCESS (0.046s)
[347.777655] Starting dynamic subtest: vcs0
[347.803604] Dynamic subtest vcs0: SUCCESS (0.041s)
[347.828098] Starting dynamic subtest: vcs1
[347.852637] Dynamic subtest vcs1: SUCCESS (0.047s)
[347.877503] Starting dynamic subtest: vecs0
[347.924292] Dynamic subtest vecs0: SUCCESS (0.069s)
[347.967263] Starting dynamic subtest: vecs1
[348.016966] Dynamic subtest vecs1: SUCCESS (0.089s)
[348.050009] Starting dynamic subtest: ccs0
[348.062585] Dynamic subtest ccs0: SUCCESS (0.043s)
[348.063582] Subtest engines-mixed: SUCCESS (0.466s)
[348.280401] [071/133] (679s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[349.790830] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[349.791752] Starting dynamic subtest: pipe-A
[349.880553] Dynamic subtest pipe-A: SUCCESS (0.089s)
[349.898674] Starting dynamic subtest: pipe-B
[350.026343] Dynamic subtest pipe-B: SUCCESS (0.144s)
[350.041135] Starting dynamic subtest: pipe-C
[350.152162] Dynamic subtest pipe-C: SUCCESS (0.125s)
[350.163695] Starting dynamic subtest: pipe-D
[350.277657] Dynamic subtest pipe-D: SUCCESS (0.124s)
[350.278578] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.487s)
[350.555136] [072/133] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[352.069153] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[352.070760] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[352.308889] [073/133] (675s left) gem_exec_schedule (semaphore-noskip)
[352.397895] Starting subtest: semaphore-noskip
[353.234059] Subtest semaphore-noskip: SUCCESS (0.835s)
[353.688807] [074/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[355.206184] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[355.207888] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[355.430263] [075/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[356.947154] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[356.948773] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[357.170030] [076/133] (670s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[358.699032] Starting subtest: 4-tiled-16bpp-rotate-0
[360.440166] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.740s)
[360.689077] [077/133] (667s left) gem_exec_basic (basic)
[360.773216] Starting subtest: basic
[360.774112] Starting dynamic subtest: rcs0-smem
[360.777352] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[360.788659] Starting dynamic subtest: bcs0-smem
[360.789614] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[360.800889] Starting dynamic subtest: vcs0-smem
[360.801940] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[360.812674] Starting dynamic subtest: vcs1-smem
[360.813891] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[360.824409] Starting dynamic subtest: vecs0-smem
[360.825282] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[360.835953] Starting dynamic subtest: vecs1-smem
[360.837070] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[360.847633] Starting dynamic subtest: ccs0-smem
[360.848695] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[360.859205] Starting dynamic subtest: rcs0-lmem0
[360.860266] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[360.870918] Starting dynamic subtest: bcs0-lmem0
[360.872013] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[360.882634] Starting dynamic subtest: vcs0-lmem0
[360.883861] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[360.894404] Starting dynamic subtest: vcs1-lmem0
[360.895460] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[360.906362] Starting dynamic subtest: vecs0-lmem0
[360.907429] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[360.918399] Starting dynamic subtest: vecs1-lmem0
[360.919476] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[360.930443] Starting dynamic subtest: ccs0-lmem0
[360.931525] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[360.932454] Subtest basic: SUCCESS (0.023s)
[361.061138] [078/133] (667s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[362.579484] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[362.581307] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[362.823114] [079/133] (665s left) gem_mmap (short-mmap)
[362.906603] Subtest short-mmap: SKIP (0.000s)
[362.988725] [080/133] (665s left) gem_exec_reloc (basic-gtt-wc-active)
[363.075043] Subtest basic-gtt-wc-active: SKIP (0.000s)
[363.155044] [081/133] (665s left) gem_ctx_shared (create-shared-gtt)
[363.249093] Starting subtest: create-shared-gtt
[365.400204] Subtest create-shared-gtt: SUCCESS (2.150s)
[367.481071] [082/133] (661s left) gem_exec_reloc (basic-write-wc)
[367.566941] Subtest basic-write-wc: SKIP (0.000s)
[367.660108] [083/133] (661s left) gem_eio (wait-immediate)
[367.984150] Starting subtest: wait-immediate
[368.588395] Subtest wait-immediate: SUCCESS (0.605s)
[370.239651] [084/133] (658s left) gem_ctx_persistence (legacy-engines-mixed)
[370.325880] Starting subtest: legacy-engines-mixed
[370.326780] Starting dynamic subtest: render
[370.452871] Dynamic subtest render: SUCCESS (0.126s)
[370.474702] Starting dynamic subtest: bsd1
[370.536419] Dynamic subtest bsd1: SUCCESS (0.081s)
[370.553449] Starting dynamic subtest: bsd2
[370.592664] Dynamic subtest bsd2: SUCCESS (0.052s)
[370.615607] Starting dynamic subtest: blt
[370.667645] Dynamic subtest blt: SUCCESS (0.072s)
[370.712262] Starting dynamic subtest: vebox
[370.753764] Dynamic subtest vebox: SUCCESS (0.082s)
[370.754836] Subtest legacy-engines-mixed: SUCCESS (0.429s)
[370.986963] [085/133] (657s left) perf_pmu (semaphore-busy)
[371.057458] Starting subtest: semaphore-busy
[371.058433] Starting dynamic subtest: rcs0
[372.736078] Dynamic subtest rcs0: SUCCESS (1.675s)
[372.753544] Starting dynamic subtest: bcs0
[374.380095] Dynamic subtest bcs0: SUCCESS (1.640s)
[374.397493] Starting dynamic subtest: vcs0
[376.025508] Dynamic subtest vcs0: SUCCESS (1.641s)
[376.044574] Starting dynamic subtest: vcs1
[377.674465] Dynamic subtest vcs1: SUCCESS (1.644s)
[377.695388] Starting dynamic subtest: vecs0
[379.320157] Dynamic subtest vecs0: SUCCESS (1.641s)
[379.341040] Starting dynamic subtest: vecs1
[380.969175] Dynamic subtest vecs1: SUCCESS (1.644s)
[380.990562] Starting dynamic subtest: ccs0
[382.615920] Dynamic subtest ccs0: SUCCESS (1.642s)
[382.617817] Subtest semaphore-busy: SUCCESS (11.561s)
[382.847143] [086/133] (646s left) gem_exec_schedule (pi-common)
[383.067804] Starting subtest: pi-common
[383.068731] Starting dynamic subtest: rcs0
[383.110162] Dynamic subtest rcs0: SUCCESS (0.042s)
[383.125367] Starting dynamic subtest: bcs0
[383.147712] Dynamic subtest bcs0: SUCCESS (0.036s)
[383.161713] Starting dynamic subtest: vcs0
[383.179693] Dynamic subtest vcs0: SUCCESS (0.031s)
[383.193877] Starting dynamic subtest: vcs1
[383.211190] Dynamic subtest vcs1: SUCCESS (0.030s)
[383.223912] Starting dynamic subtest: vecs0
[383.243728] Dynamic subtest vecs0: SUCCESS (0.032s)
[383.257842] Starting dynamic subtest: vecs1
[383.275190] Dynamic subtest vecs1: SUCCESS (0.030s)
[383.288052] Starting dynamic subtest: ccs0
[383.305242] Dynamic subtest ccs0: SUCCESS (0.029s)
[383.306401] Subtest pi-common: SUCCESS (0.238s)
[383.620258] [087/133] (645s left) i915_hangman (engine-error-state-capture)
[383.713120] Starting subtest: engine-error-state-capture
[383.713950] Starting dynamic subtest: rcs0
[386.365758] Dynamic subtest rcs0: SUCCESS (2.652s)
[386.379629] Starting dynamic subtest: bcs0
[390.345919] Dynamic subtest bcs0: SUCCESS (3.980s)
[390.358928] Starting dynamic subtest: vcs0
[394.281687] Dynamic subtest vcs0: SUCCESS (3.935s)
[394.295290] Starting dynamic subtest: vcs1
[398.319554] Dynamic subtest vcs1: SUCCESS (4.037s)
[398.333191] Starting dynamic subtest: vecs0
[402.282701] Dynamic subtest vecs0: SUCCESS (3.962s)
[402.296436] Starting dynamic subtest: vecs1
[406.336694] Dynamic subtest vecs1: SUCCESS (4.053s)
[406.351901] Starting dynamic subtest: ccs0
[410.304592] Dynamic subtest ccs0: SUCCESS (3.967s)
[410.305506] Subtest engine-error-state-capture: SUCCESS (26.595s)
[410.538326] [088/133] (618s left) syncobj_timeline (wait-for-submit-snapshot)
[410.620783] Starting subtest: wait-for-submit-snapshot
[410.705508] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[410.905845] [089/133] (618s left) kms_color (ctm-blue-to-red)
[412.415100] Starting subtest: ctm-blue-to-red
[412.415950] Starting dynamic subtest: pipe-A-HDMI-A-1
[413.128617] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.712s)
[413.142136] Starting dynamic subtest: pipe-B-HDMI-A-1
[413.621930] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.492s)
[413.634479] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.117912] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.495s)
[414.130255] Starting dynamic subtest: pipe-D-HDMI-A-1
[414.635257] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.517s)
[414.636229] Subtest ctm-blue-to-red: SUCCESS (2.220s)
[414.870561] [090/133] (614s left) prime_vgem (basic-gtt)
[414.972109] Starting subtest: basic-gtt
[414.974459] Subtest basic-gtt: SKIP (0.000s)
[415.184291] [091/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[416.702474] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[416.704261] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[416.933902] [092/133] (612s left) api_intel_allocator (default-alignment)
[417.013870] Starting subtest: default-alignment
[417.020692] Subtest default-alignment: SUCCESS (0.008s)
[417.231162] [093/133] (612s left) i915_pm_rps (fence-order)
[417.316301] Starting subtest: fence-order
[421.696359] Subtest fence-order: SUCCESS (4.379s)
[421.899335] [094/133] (607s left) kms_vblank (query-busy)
[423.425583] Starting subtest: query-busy
[423.426630] Starting dynamic subtest: pipe-A-HDMI-A-1
[425.923719] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.496s)
[425.941245] Starting dynamic subtest: pipe-D-HDMI-A-1
[428.294931] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.368s)
[428.295780] Subtest query-busy: SUCCESS (4.871s)
[428.524380] [095/133] (601s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[430.050308] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[430.052219] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[430.293381] [096/133] (599s left) kms_addfb_basic (invalid-get-prop-any)
[430.373837] Starting subtest: invalid-get-prop-any
[430.374712] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[432.028271] [097/133] (597s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[433.542902] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[433.612340] [098/133] (596s left) kms_flip (2x-blocking-absolute-wf_vblank)
[435.128928] Starting subtest: 2x-blocking-absolute-wf_vblank
[435.143373] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.015s)
[435.338283] [099/133] (594s left) kms_cursor_crc (cursor-onscreen-256x85)
[437.107643] Starting subtest: cursor-onscreen-256x85
[437.112549] Starting dynamic subtest: pipe-A-HDMI-A-1
[439.854516] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.742s)
[439.892185] Starting dynamic subtest: pipe-D-HDMI-A-1
[442.411637] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.530s)
[442.412547] Subtest cursor-onscreen-256x85: SUCCESS (5.303s)
[442.744367] [100/133] (587s left) kms_flip (2x-modeset-vs-vblank-race)
[444.256531] Starting subtest: 2x-modeset-vs-vblank-race
[444.272513] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s)
[444.469314] [101/133] (585s left) kms_atomic_interruptible (atomic-setmode)
[445.985594] Starting subtest: atomic-setmode
[445.986503] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.167747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.181s)
[452.168601] Subtest atomic-setmode: SUCCESS (6.183s)
[452.397201] [102/133] (578s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[453.915500] Starting subtest: psr-argb161616f-draw-render
[453.917470] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[454.139975] [103/133] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[455.658286] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[455.660144] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[455.886028] [104/133] (574s left) kms_plane_scaling (invalid-num-scalers)
[457.399064] Starting subtest: invalid-num-scalers
[457.404279] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[457.425586] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.021s)
[457.443757] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[457.466834] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.036s)
[457.483496] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[457.508910] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.036s)
[457.525539] Starting dynamic subtest: pipe-D-HDMI-A-1-invalid-num-scalers
[457.549474] Dynamic subtest pipe-D-HDMI-A-1-invalid-num-scalers: SUCCESS (0.036s)
[457.550306] Subtest invalid-num-scalers: SUCCESS (0.150s)
[457.726709] [105/133] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[459.252242] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[459.254160] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[459.492609] [106/133] (571s left) sw_sync (alloc_fence_invalid_timeline)
[459.541303] Starting subtest: alloc_fence_invalid_timeline
[459.542738] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[459.696010] [107/133] (571s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[459.777793] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[459.884075] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[460.055243] [108/133] (571s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[461.574821] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[461.579477] Starting dynamic subtest: A-HDMI-A1
[469.591954] Dynamic subtest A-HDMI-A1: SUCCESS (8.011s)
[469.607536] Starting dynamic subtest: B-HDMI-A1
[477.543057] Dynamic subtest B-HDMI-A1: SUCCESS (7.948s)
[477.557376] Starting dynamic subtest: C-HDMI-A1
[485.493254] Dynamic subtest C-HDMI-A1: SUCCESS (7.948s)
[485.508366] Starting dynamic subtest: D-HDMI-A1
[493.443073] Dynamic subtest D-HDMI-A1: SUCCESS (7.947s)
[493.445482] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.866s)
[493.706067] [109/133] (537s left) kms_addfb_basic (size-max)
[495.218633] Starting subtest: size-max
[495.219598] Subtest size-max: SUCCESS (0.000s)
[495.448592] [110/133] (535s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[497.189622] Starting subtest: cursor-rapid-movement-256x256
[497.194615] Starting dynamic subtest: pipe-A-HDMI-A-1
[497.591911] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.397s)
[497.627611] Starting dynamic subtest: pipe-D-HDMI-A-1
[497.914288] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.298s)
[497.915250] Subtest cursor-rapid-movement-256x256: SUCCESS (0.724s)
[498.329588] [111/133] (533s left) gem_exec_whisper (basic-queues-all)
[498.421102] Starting subtest: basic-queues-all
[520.222850] Subtest basic-queues-all: SUCCESS (21.796s)
[520.479202] [112/133] (510s left) kms_dsc (dsc-fractional-bpp)
[521.989304] Starting subtest: dsc-fractional-bpp
[521.994468] Subtest dsc-fractional-bpp: SKIP (0.000s)
[522.186273] [113/133] (509s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[523.700107] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[523.702342] Starting dynamic subtest: pipe-A-valid-mode
[523.740377] Dynamic subtest pipe-A-valid-mode: SKIP (0.037s)
[523.742122] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.039s)
[523.956164] [114/133] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[525.474494] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[525.476284] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[525.695111] [115/133] (506s left) gem_softpin (evict-prime)
[525.786380] Starting subtest: evict-prime
[525.787308] Starting dynamic subtest: rcs0
[527.044683] Dynamic subtest rcs0: SUCCESS (1.258s)
[527.057231] Starting dynamic subtest: bcs0
[528.248707] Dynamic subtest bcs0: SUCCESS (1.203s)
[528.264592] Starting dynamic subtest: vcs0
[529.391886] Dynamic subtest vcs0: SUCCESS (1.142s)
[529.404534] Starting dynamic subtest: vcs1
[530.548729] Dynamic subtest vcs1: SUCCESS (1.155s)
[530.565672] Starting dynamic subtest: vecs0
[531.689796] Dynamic subtest vecs0: SUCCESS (1.140s)
[531.706416] Starting dynamic subtest: vecs1
[532.872861] Dynamic subtest vecs1: SUCCESS (1.182s)
[532.891815] Starting dynamic subtest: ccs0
[534.044204] Dynamic subtest ccs0: SUCCESS (1.170s)
[534.057226] Starting dynamic subtest: all
[535.184652] Dynamic subtest all: SUCCESS (1.139s)
[535.185850] Subtest evict-prime: SUCCESS (9.397s)
[535.380198] [116/133] (496s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[536.898308] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[536.900232] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[537.127716] [117/133] (494s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[538.639194] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[538.881124] [118/133] (493s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[538.958884] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[539.074236] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[539.252058] [119/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[540.776481] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[540.778372] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[541.007149] [120/133] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[542.530500] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[545.774211] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.244s)
[546.039074] [121/133] (486s left) gem_mmap_wc (bad-size)
[546.118458] Subtest bad-size: SKIP (0.000s)
[546.222830] [122/133] (486s left) kms_hdr (static-toggle-suspend)
[547.738279] Starting subtest: static-toggle-suspend
[547.740888] Subtest static-toggle-suspend: SKIP (0.000s)
[547.969226] [123/133] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[549.488270] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[549.490140] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[549.734854] [124/133] (483s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[551.262165] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[551.322800] [125/133] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[552.845584] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[552.847331] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[553.112805] [126/133] (479s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[554.652884] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[554.655055] Starting dynamic subtest: pipe-A-HDMI-A-1
[554.663472] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[554.675869] Starting dynamic subtest: pipe-B-HDMI-A-1
[554.684305] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[554.696547] Starting dynamic subtest: pipe-C-HDMI-A-1
[554.705270] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[554.717697] Starting dynamic subtest: pipe-D-HDMI-A-1
[554.728105] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[554.730297] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[554.941763] [127/133] (478s left) syncobj_timeline (single-wait-all-available-submitted)
[555.026599] Starting subtest: single-wait-all-available-submitted
[555.027515] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[555.234507] [128/133] (477s left) gem_exec_parallel (userptr)
[555.319966] Starting subtest: userptr
[555.320822] Starting dynamic subtest: rcs0
[556.878689] Dynamic subtest rcs0: SUCCESS (1.558s)
[556.893991] Starting dynamic subtest: bcs0
[558.347863] Dynamic subtest bcs0: SUCCESS (1.468s)
[558.363064] Starting dynamic subtest: vcs0
[559.851946] Dynamic subtest vcs0: SUCCESS (1.503s)
[559.868383] Starting dynamic subtest: vcs1
[561.346650] Dynamic subtest vcs1: SUCCESS (1.493s)
[561.364504] Starting dynamic subtest: vecs0
[562.809575] Dynamic subtest vecs0: SUCCESS (1.461s)
[562.826908] Starting dynamic subtest: vecs1
[564.281785] Dynamic subtest vecs1: SUCCESS (1.471s)
[564.296843] Starting dynamic subtest: ccs0
[565.747427] Dynamic subtest ccs0: SUCCESS (1.464s)
[565.748527] Subtest userptr: SUCCESS (10.426s)
[566.075210] [129/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[567.587430] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[567.589434] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[567.835818] [130/133] (465s left) i915_selftest (mock)
[568.946546] Starting subtest: mock
[568.947515] Starting dynamic subtest: sanitycheck
[569.830461] Dynamic subtest sanitycheck: SUCCESS (0.875s)
[569.839887] Starting dynamic subtest: shmem
[570.651514] Dynamic subtest shmem: SUCCESS (0.824s)
[570.690195] Starting dynamic subtest: fence
[578.789208] Dynamic subtest fence: SUCCESS (8.132s)
[578.801216] Starting dynamic subtest: scatterlist
[580.629001] Dynamic subtest scatterlist: SUCCESS (1.836s)
[580.645909] Starting dynamic subtest: syncmap
[583.508627] Dynamic subtest syncmap: SUCCESS (2.875s)
[583.525363] Starting dynamic subtest: uncore
[584.337426] Dynamic subtest uncore: SUCCESS (0.825s)
[584.374556] Starting dynamic subtest: ring
[585.219169] Dynamic subtest ring: SUCCESS (0.877s)
[585.250876] Starting dynamic subtest: engine
[586.061361] Dynamic subtest engine: SUCCESS (0.837s)
[586.099495] Starting dynamic subtest: timelines
[590.737533] Dynamic subtest timelines: SUCCESS (4.671s)
[590.751916] Starting dynamic subtest: requests
[593.570237] Dynamic subtest requests: SUCCESS (2.830s)
[593.579751] Starting dynamic subtest: objects
[594.542801] Dynamic subtest objects: SUCCESS (0.970s)
[594.579883] Starting dynamic subtest: phys
[595.561274] Dynamic subtest phys: SUCCESS (1.015s)
[595.573751] Starting dynamic subtest: dmabuf
[596.541567] Dynamic subtest dmabuf: SUCCESS (0.979s)
[596.561166] Starting dynamic subtest: vma
[604.786266] Dynamic subtest vma: SUCCESS (8.241s)
[604.797967] Starting dynamic subtest: evict
[606.633571] Dynamic subtest evict: SUCCESS (1.845s)
[606.643568] Starting dynamic subtest: gtt
[610.623756] Dynamic subtest gtt: SUCCESS (3.988s)
[610.651175] Starting dynamic subtest: hugepages
[611.788365] Dynamic subtest hugepages: SUCCESS (1.162s)
[611.798438] Starting dynamic subtest: memory_region
[615.423301] Dynamic subtest memory_region: SUCCESS (3.633s)
[615.424395] Subtest mock: SUCCESS (46.467s)
[615.463712] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[615.464669] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[615.466438] [131/133] (417s left) gem_mmap_gtt (basic-write-read)
[618.972795] Subtest basic-write-read: SKIP (0.000s)
[619.050729] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[619.054005] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[619.057224] [132/133] (414s left) perf (gen12-group-exclusive-stream-sample-oa)
[619.499701] Starting subtest: gen12-group-exclusive-stream-sample-oa
[619.522885] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[619.579870] [133/133] (413s left) perf_pmu (busy-double-start)
[619.653610] Starting subtest: busy-double-start
[619.654497] Starting dynamic subtest: rcs0
[623.308628] Dynamic subtest rcs0: SUCCESS (3.654s)
[623.323494] Starting dynamic subtest: bcs0
[626.901430] Dynamic subtest bcs0: SUCCESS (3.587s)
[626.915957] Starting dynamic subtest: vcs0
[630.506690] Dynamic subtest vcs0: FAIL (3.581s)
[630.518566] Starting dynamic subtest: vcs1
[634.074806] Dynamic subtest vcs1: FAIL (3.566s)
[634.087241] Starting dynamic subtest: vecs0
[637.639758] Dynamic subtest vecs0: FAIL (3.566s)
[637.652932] Starting dynamic subtest: vecs1
[641.206435] Dynamic subtest vecs1: FAIL (3.567s)
[641.219377] Starting dynamic subtest: ccs0
[644.778511] Dynamic subtest ccs0: SUCCESS (3.598s)
[644.783054] Subtest busy-double-start: FAIL (25.137s)
[644.961138] 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.