[43.802855] Initializing watchdogs
[43.802918]   /dev/watchdog0
[43.818168] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.823582] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.826381] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.828175] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[43.918196] Starting subtest: wf_vblank-ts-check
[43.920261] Starting dynamic subtest: A-HDMI-A1
[51.768880] Dynamic subtest A-HDMI-A1: SUCCESS (7.848s)
[51.778803] Starting dynamic subtest: B-HDMI-A1
[59.590964] Dynamic subtest B-HDMI-A1: SUCCESS (7.794s)
[59.595819] Starting dynamic subtest: C-HDMI-A1
[67.404356] Dynamic subtest C-HDMI-A1: SUCCESS (7.812s)
[67.409441] Starting dynamic subtest: D-HDMI-A1
[75.174775] Dynamic subtest D-HDMI-A1: SUCCESS (7.794s)
[75.175564] Subtest wf_vblank-ts-check: SUCCESS (31.257s)
[75.347308] [002/133] (929s left) kms_cursor_crc (cursor-onscreen-256x256)
[75.442934] Starting subtest: cursor-onscreen-256x256
[75.457786] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.647210] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.190s)
[76.679199] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.823105] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.149s)
[77.823808] Subtest cursor-onscreen-256x256: SUCCESS (2.381s)
[77.959807] [003/133] (926s left) gem_mmap_gtt (big-copy-odd)
[77.996746] Starting subtest: big-copy-odd
[84.995129] Subtest big-copy-odd: SUCCESS (6.998s)
[85.065082] [004/133] (919s left) i915_pm_rpm (sysfs-read)
[86.533638] Starting subtest: sysfs-read
[87.742328] Subtest sysfs-read: SUCCESS (1.208s)
[87.907865] [005/133] (916s left) kms_universal_plane (disable-primary-vs-flip)
[87.994591] Starting subtest: disable-primary-vs-flip
[87.995295] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.295099] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.300s)
[88.301908] Starting dynamic subtest: pipe-B-HDMI-A-1
[88.565825] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.269s)
[88.572572] Starting dynamic subtest: pipe-C-HDMI-A-1
[88.884097] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.317s)
[88.890511] Starting dynamic subtest: pipe-D-HDMI-A-1
[89.191716] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.307s)
[89.192408] Subtest disable-primary-vs-flip: SUCCESS (1.198s)
[89.329155] [006/133] (915s left) perf (gen12-group-exclusive-stream-ctx-handle)
[89.440420] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[89.450727] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.010s)
[89.486730] [007/133] (915s left) kms_flip_event_leak (basic)
[89.572501] Starting subtest: basic
[89.573992] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.748669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.175s)
[89.755606] Starting dynamic subtest: pipe-B-HDMI-A-1
[89.904709] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.155s)
[89.911425] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.068768] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.162s)
[90.075113] Starting dynamic subtest: pipe-D-HDMI-A-1
[90.234167] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.164s)
[90.234913] Subtest basic: SUCCESS (0.662s)
[90.388194] [008/133] (914s left) gem_exec_fence (syncobj-wait)
[90.745280] Starting subtest: syncobj-wait
[90.800735] Subtest syncobj-wait: SUCCESS (0.055s)
[91.124989] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[91.126583] [009/133] (913s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[91.218401] Starting subtest: primary-y-tiled-reflect-x-90
[96.100216] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.882s)
[96.291486] [010/133] (908s left) kms_psr (fbc-psr-no-drrs)
[96.383603] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[96.428403] [011/133] (908s left) kms_chamelium_edid (hdmi-mode-timings)
[96.567019] Subtest hdmi-mode-timings: SKIP (0.000s)
[96.657952] [012/133] (908s left) gem_exec_flush (basic-wb-ro-before-default)
[96.707535] Starting subtest: basic-wb-ro-before-default
[102.133339] Subtest basic-wb-ro-before-default: SUCCESS (5.426s)
[102.350940] [013/133] (902s left) gem_ccs (block-multicopy-inplace)
[102.389597] Starting subtest: block-multicopy-inplace
[102.390986] Subtest block-multicopy-inplace: SKIP (0.000s)
[102.453908] [014/133] (902s left) kms_invalid_mode (clock-too-high)
[102.541019] Starting subtest: clock-too-high
[102.541713] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.604100] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.063s)
[102.613782] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.615822] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.010s)
[102.622797] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.625936] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[102.632370] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.636398] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[102.637122] Subtest clock-too-high: SUCCESS (0.096s)
[102.763699] [015/133] (902s left) perf (invalid-remove-userspace-config)
[102.846490] Starting subtest: invalid-remove-userspace-config
[102.858809] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[102.899946] [016/133] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[102.988559] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[102.989982] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.064633] [017/133] (901s left) gem_pxp (hw-rejects-pxp-buffer)
[103.165771] Starting subtest: hw-rejects-pxp-buffer
[103.167608] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[103.238469] [018/133] (901s left) vgem_basic (dmabuf-fence)
[103.275743] Starting subtest: dmabuf-fence
[103.276419] Subtest dmabuf-fence: SUCCESS (0.001s)
[103.333902] [019/133] (901s left) core_getclient (basic)
[103.366450] Starting subtest: basic
[103.367161] Subtest basic: SUCCESS (0.000s)
[103.435735] [020/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[103.533017] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[104.217807] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.684s)
[104.350673] [021/133] (900s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[104.438841] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[104.440265] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[104.494157] [022/133] (900s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[104.528747] Starting subtest: invalid-signal-one-illegal-handle
[104.529463] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[104.591429] [023/133] (900s left) kms_getfb (getfb-handle-not-fb)
[104.676010] Starting subtest: getfb-handle-not-fb
[104.676785] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[104.771726] [024/133] (900s left) kms_color (invalid-ctm-matrix-sizes)
[104.855929] Starting subtest: invalid-ctm-matrix-sizes
[104.856687] Starting dynamic subtest: pipe-A
[104.859946] Dynamic subtest pipe-A: SUCCESS (0.004s)
[104.868535] Starting dynamic subtest: pipe-B
[104.869287] Dynamic subtest pipe-B: SUCCESS (0.006s)
[104.877058] Starting dynamic subtest: pipe-C
[104.877788] Dynamic subtest pipe-C: SUCCESS (0.006s)
[104.885546] Starting dynamic subtest: pipe-D
[104.886283] Dynamic subtest pipe-D: SUCCESS (0.007s)
[104.887069] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.024s)
[104.933448] [025/133] (900s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[105.017718] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[105.018408] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.024957] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[105.031272] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.037880] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[105.044020] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.050489] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[105.056549] Starting dynamic subtest: pipe-D-HDMI-A-1
[105.063207] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[105.064526] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[105.246541] [026/133] (900s left) i915_drm_fdinfo (memory-info-resident)
[105.284531] Starting subtest: memory-info-resident
[105.285276] Starting dynamic subtest: smem0
[106.396140] Dynamic subtest smem0: SUCCESS (1.111s)
[106.396911] Subtest memory-info-resident: SUCCESS (1.112s)
[106.456410] [027/133] (898s left) gem_pipe_control_store_loop (reused-buffer)
[106.494995] Starting subtest: reused-buffer
[108.655220] Subtest reused-buffer: SUCCESS (2.151s)
[108.754117] [028/133] (896s left) device_reset (unbind-reset-rebind)
[108.801315] Starting subtest: unbind-reset-rebind
[110.571304] Subtest unbind-reset-rebind: SUCCESS (1.761s)
[110.604588] [029/133] (894s left) kms_content_protection (lic-type-1)
[110.697503] Starting subtest: lic-type-1
[110.710309] Subtest lic-type-1: SKIP (0.011s)
[110.791537] [030/133] (894s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[110.885240] Starting subtest: 4-tiled-8bpp-rotate-90
[110.886615] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[110.987762] [031/133] (894s left) kms_rotation_crc (primary-rotation-270)
[111.072720] Starting subtest: primary-rotation-270
[116.172154] Subtest primary-rotation-270: SUCCESS (5.099s)
[116.356305] [032/133] (889s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[117.755382] Starting subtest: modeset-non-lpsp-stress-no-wait
[117.845115] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.089s)
[117.949323] [033/133] (887s left) kms_async_flips (async-flip-hang)
[118.040040] Starting subtest: async-flip-hang
[118.185704] Starting dynamic subtest: pipe-A-HDMI-A-1
[132.731137] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.511s)
[132.831234] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.552218] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.719s)
[147.678735] Starting dynamic subtest: pipe-C-HDMI-A-1
[162.426198] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.722s)
[162.522579] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.786382] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (15.236s)
[177.787075] Subtest async-flip-hang: SUCCESS (59.713s)
[177.984207] [034/133] (827s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[178.081516] Starting subtest: cursorB-vs-flipB-legacy
[178.082838] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[178.140718] [035/133] (827s left) kms_lease (master-vs-lease)
[178.225265] Starting subtest: master-vs-lease
[178.227430] Subtest master-vs-lease: SUCCESS (0.001s)
[178.285853] [036/133] (827s left) kms_plane_multiple (tiling-y)
[178.371787] Starting subtest: tiling-y
[178.372459] Starting dynamic subtest: pipe-A-HDMI-A-1
[179.000784] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.627s)
[179.009519] Starting dynamic subtest: pipe-B-HDMI-A-1
[179.631973] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.629s)
[179.640366] Starting dynamic subtest: pipe-C-HDMI-A-1
[180.311452] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.678s)
[180.320464] Starting dynamic subtest: pipe-D-HDMI-A-1
[180.946288] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.633s)
[180.948177] Subtest tiling-y: SUCCESS (2.576s)
[181.128548] [037/133] (824s left) i915_hangman (engine-engine-hang)
[181.178676] Starting subtest: engine-engine-hang
[181.179419] Starting dynamic subtest: rcs0
[181.764882] Dynamic subtest rcs0: SUCCESS (0.585s)
[181.775679] Starting dynamic subtest: bcs0
[182.340909] Dynamic subtest bcs0: SUCCESS (0.574s)
[182.354384] Starting dynamic subtest: vcs0
[182.916956] Dynamic subtest vcs0: SUCCESS (0.574s)
[182.929684] Starting dynamic subtest: vcs1
[183.504939] Dynamic subtest vcs1: SUCCESS (0.586s)
[183.517675] Starting dynamic subtest: vecs0
[184.078814] Dynamic subtest vecs0: SUCCESS (0.572s)
[184.080055] Subtest engine-engine-hang: SUCCESS (2.901s)
[184.175138] [038/133] (821s left) gem_media_fill (media-fill)
[184.215826] Starting subtest: media-fill
[184.216508] Starting dynamic subtest: smem
[184.220796] Dynamic subtest smem: SUCCESS (0.006s)
[184.221474] Subtest media-fill: SUCCESS (0.007s)
[184.432240] [039/133] (821s left) kms_flip (2x-busy-flip)
[184.518384] Starting subtest: 2x-busy-flip
[184.527857] Subtest 2x-busy-flip: SKIP (0.009s)
[184.594316] [040/133] (821s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[184.687970] Starting subtest: yf-tiled-16bpp-rotate-90
[184.689393] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[184.767071] [041/133] (821s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[184.910777] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[185.003319] [042/133] (820s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[185.462724] Starting subtest: syncobj-timeline-invalid-wait
[185.463704] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[185.650181] [043/133] (820s left) gem_workarounds (basic-read)
[185.696599] Starting subtest: basic-read
[185.704878] Subtest basic-read: SUCCESS (0.008s)
[185.803195] [044/133] (820s left) syncobj_eventfd (invalid-illegal-eventfd)
[185.838123] Starting subtest: invalid-illegal-eventfd
[185.838889] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[185.904061] [045/133] (820s left) kms_plane_alpha_blend (alpha-7efc)
[185.990867] Starting subtest: alpha-7efc
[186.059867] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.366185] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[186.396171] Starting dynamic subtest: pipe-D-HDMI-A-1
[186.839093] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.449s)
[186.839821] Subtest alpha-7efc: SUCCESS (0.848s)
[186.985436] [046/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[187.081071] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[187.082462] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[187.188914] [047/133] (818s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[187.274112] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[187.274816] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.943891] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.665s)
[187.959722] Starting dynamic subtest: pipe-B-HDMI-A-1
[188.463046] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.514s)
[188.480107] Starting dynamic subtest: pipe-C-HDMI-A-1
[188.981711] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.513s)
[188.999093] Starting dynamic subtest: pipe-D-HDMI-A-1
[189.501814] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.514s)
[189.502918] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.226s)
[189.691694] [048/133] (816s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[189.784881] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[189.786736] Starting dynamic subtest: A-HDMI-A1
[190.461170] Dynamic subtest A-HDMI-A1: SUCCESS (0.666s)
[190.468091] Starting dynamic subtest: B-HDMI-A1
[191.086483] Dynamic subtest B-HDMI-A1: SUCCESS (0.631s)
[191.095431] Starting dynamic subtest: C-HDMI-A1
[191.706921] Dynamic subtest C-HDMI-A1: SUCCESS (0.620s)
[191.715051] Starting dynamic subtest: D-HDMI-A1
[192.331810] Dynamic subtest D-HDMI-A1: SUCCESS (0.623s)
[192.335181] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.551s)
[192.499945] [049/133] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[192.595183] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[192.596619] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[192.661577] [050/133] (813s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[192.747077] Starting subtest: fb-8bpc-vs-panel-8bpc
[192.747765] Starting dynamic subtest: pipe-A-HDMI-A-1
[192.943267] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.196s)
[192.944026] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.198s)
[193.075903] [051/133] (813s left) gem_pxp (fail-invalid-protected-context)
[193.171459] Starting subtest: fail-invalid-protected-context
[193.172603] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[193.234243] [052/133] (813s left) kms_force_connector_basic (prune-stale-modes)
[193.362583] Starting subtest: prune-stale-modes
[193.507064] Subtest prune-stale-modes: SUCCESS (0.150s)
[193.657220] [053/133] (812s left) gem_render_copy_redux (interruptible)
[193.696470] Starting subtest: interruptible
[194.045807] Subtest interruptible: SUCCESS (0.341s)
[194.144406] [054/133] (812s left) perf_pmu (faulting-read)
[194.182806] Starting subtest: faulting-read
[194.183476] Starting dynamic subtest: gtt
[194.184147] Dynamic subtest gtt: SUCCESS (0.001s)
[194.192921] Starting dynamic subtest: wb
[194.193620] Dynamic subtest wb: SUCCESS (0.001s)
[194.200593] Starting dynamic subtest: wc
[194.201260] Dynamic subtest wc: SUCCESS (0.001s)
[194.207809] Starting dynamic subtest: uc
[194.208463] Dynamic subtest uc: SUCCESS (0.000s)
[194.209128] Subtest faulting-read: SUCCESS (0.009s)
[194.287661] [055/133] (812s left) gem_ctx_isolation (clean)
[194.337918] Starting subtest: clean
[194.338607] Starting dynamic subtest: rcs0
[194.363073] Dynamic subtest rcs0: SUCCESS (0.025s)
[194.372018] Starting dynamic subtest: bcs0
[194.433316] Dynamic subtest bcs0: SUCCESS (0.069s)
[194.441310] Starting dynamic subtest: vcs0
[194.496448] Dynamic subtest vcs0: SUCCESS (0.062s)
[194.504729] Starting dynamic subtest: vcs1
[194.570032] Dynamic subtest vcs1: SUCCESS (0.072s)
[194.578733] Starting dynamic subtest: vecs0
[194.637814] Dynamic subtest vecs0: SUCCESS (0.066s)
[194.638569] Subtest clean: SUCCESS (0.300s)
[194.828690] [056/133] (811s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[194.914930] Starting subtest: flip-vs-cursor-busy-crc-atomic
[195.280725] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.366s)
[195.447850] [057/133] (811s left) gem_mmap_gtt (isolation)
[195.485406] Starting subtest: isolation
[195.487468] Subtest isolation: SUCCESS (0.001s)
[195.579040] [058/133] (810s left) prime_busy (hang)
[195.616448] Starting subtest: hang
[195.618229] Starting dynamic subtest: rcs0
[209.504445] Dynamic subtest rcs0: SUCCESS (13.877s)
[209.511659] Starting dynamic subtest: bcs0
[216.544051] Dynamic subtest bcs0: SUCCESS (7.038s)
[216.551185] Starting dynamic subtest: vcs0
[223.609083] Dynamic subtest vcs0: SUCCESS (7.039s)
[223.615733] Starting dynamic subtest: vcs1
[230.586052] Dynamic subtest vcs1: SUCCESS (6.976s)
[230.593152] Starting dynamic subtest: vecs0
[237.561896] Dynamic subtest vecs0: SUCCESS (6.974s)
[237.562861] Subtest hang: SUCCESS (41.911s)
[237.631866] [059/133] (768s left) kms_cursor_crc (cursor-sliding-512x512)
[237.728067] Starting subtest: cursor-sliding-512x512
[237.729480] Subtest cursor-sliding-512x512: SKIP (0.001s)
[237.817229] [060/133] (768s left) gem_exec_balancer (sequential)
[237.859844] Starting subtest: sequential
[241.329131] Subtest sequential: SUCCESS (3.469s)
[241.526318] [061/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[241.618782] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[241.620148] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[241.710948] [062/133] (764s left) gem_softpin (full)
[241.747905] Starting subtest: full
[241.753931] Subtest full: SUCCESS (0.006s)
[241.862918] [063/133] (764s left) kms_psr (pr-sprite-plane-move)
[241.949771] Subtest pr-sprite-plane-move: SKIP (0.000s)
[241.988729] [064/133] (764s left) gem_ctx_shared (q-in-order)
[242.032284] Starting subtest: Q-in-order
[242.033040] Starting dynamic subtest: rcs0
[242.082828] Dynamic subtest rcs0: SUCCESS (0.050s)
[242.095702] Starting dynamic subtest: bcs0
[242.136838] Dynamic subtest bcs0: SUCCESS (0.052s)
[242.151784] Starting dynamic subtest: vcs0
[242.191525] Dynamic subtest vcs0: SUCCESS (0.052s)
[242.206728] Starting dynamic subtest: vcs1
[242.247376] Dynamic subtest vcs1: SUCCESS (0.053s)
[242.259688] Starting dynamic subtest: vecs0
[242.300183] Dynamic subtest vecs0: SUCCESS (0.049s)
[242.303224] Subtest Q-in-order: SUCCESS (0.269s)
[242.489780] [065/133] (764s left) kms_chamelium_audio (hdmi-audio)
[242.625556] Subtest hdmi-audio: SKIP (0.000s)
[242.721639] [066/133] (764s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[242.758445] Starting subtest: single-wait-all-for-submit-available-submitted
[242.759157] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[242.824244] [067/133] (764s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[242.914476] Starting subtest: cursor-rapid-movement-512x170
[242.916932] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[243.014299] [068/133] (763s left) kms_big_fb (linear-64bpp-rotate-270)
[243.107955] Starting subtest: linear-64bpp-rotate-270
[243.157753] Subtest linear-64bpp-rotate-270: SKIP (0.048s)
[243.263986] [069/133] (763s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[243.349106] Starting subtest: flip-vs-cursor-atomic
[249.774570] Subtest flip-vs-cursor-atomic: SUCCESS (6.425s)
[249.925989] [070/133] (757s left) gem_exec_schedule (semaphore-power)
[250.098921] Starting subtest: semaphore-power
[251.164194] Subtest semaphore-power: SUCCESS (1.057s)
[251.330963] [071/133] (755s left) gem_ctx_persistence (legacy-engines-hang)
[251.369157] Starting subtest: legacy-engines-hang
[251.370934] Starting dynamic subtest: render
[251.418728] Dynamic subtest render: SUCCESS (0.048s)
[251.439365] Starting dynamic subtest: bsd1
[251.464621] Dynamic subtest bsd1: SUCCESS (0.043s)
[251.478074] Starting dynamic subtest: bsd2
[251.509709] Dynamic subtest bsd2: SUCCESS (0.042s)
[251.529161] Starting dynamic subtest: blt
[251.556487] Dynamic subtest blt: SUCCESS (0.044s)
[251.574914] Starting dynamic subtest: vebox
[251.603564] Dynamic subtest vebox: SUCCESS (0.044s)
[251.604786] Subtest legacy-engines-hang: SUCCESS (0.235s)
[251.684662] [072/133] (755s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[251.773970] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[251.774702] Starting dynamic subtest: pipe-A
[251.894558] Dynamic subtest pipe-A: SUCCESS (0.121s)
[251.910627] Starting dynamic subtest: pipe-B
[252.037234] Dynamic subtest pipe-B: SUCCESS (0.141s)
[252.050157] Starting dynamic subtest: pipe-C
[252.163138] Dynamic subtest pipe-C: SUCCESS (0.125s)
[252.174055] Starting dynamic subtest: pipe-D
[252.306648] Dynamic subtest pipe-D: SUCCESS (0.142s)
[252.308053] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.534s)
[252.489952] [073/133] (754s left) syncobj_timeline (multi-wait-for-submit-signaled)
[252.527119] Starting subtest: multi-wait-for-submit-signaled
[252.527808] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[252.587724] [074/133] (754s left) kms_atomic_interruptible (legacy-dpms)
[252.672717] Starting subtest: legacy-dpms
[252.674431] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.885369] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.210s)
[258.886168] Subtest legacy-dpms: SUCCESS (6.212s)
[259.036818] [075/133] (748s left) syncobj_basic (bad-pad-handle-to-fd)
[259.078381] Starting subtest: bad-pad-handle-to-fd
[259.079240] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[259.145964] [076/133] (748s left) drm_read (short-buffer-nonblock)
[259.264779] Starting subtest: short-buffer-nonblock
[259.265510] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[259.368966] [077/133] (747s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[259.455186] Starting subtest: cursorB-vs-flipB-varying-size
[259.457611] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[259.514931] [078/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[259.604752] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[259.606120] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.693753] [079/133] (747s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[259.791401] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[260.497889] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.707s)
[260.626934] [080/133] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[260.716718] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[262.056472] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.340s)
[262.188955] [081/133] (745s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[262.281251] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[262.321838] [082/133] (745s left) kms_atomic (crtc-invalid-params)
[262.407963] Starting subtest: crtc-invalid-params
[262.408749] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.530853] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.122s)
[262.532891] Subtest crtc-invalid-params: SUCCESS (0.125s)
[262.656873] [083/133] (744s left) kms_flip (busy-flip)
[262.745996] Starting subtest: busy-flip
[262.748138] Starting dynamic subtest: A-HDMI-A1
[263.425574] Dynamic subtest A-HDMI-A1: SUCCESS (0.677s)
[263.436859] Starting dynamic subtest: B-HDMI-A1
[264.083397] Dynamic subtest B-HDMI-A1: SUCCESS (0.651s)
[264.099439] Starting dynamic subtest: C-HDMI-A1
[264.748308] Dynamic subtest C-HDMI-A1: SUCCESS (0.665s)
[264.756395] Starting dynamic subtest: D-HDMI-A1
[265.406269] Dynamic subtest D-HDMI-A1: SUCCESS (0.655s)
[265.409455] Subtest busy-flip: SUCCESS (2.664s)
[265.565680] [084/133] (742s left) gem_exec_params (cliprects-invalid)
[265.606466] Starting subtest: cliprects-invalid
[265.607170] Subtest cliprects-invalid: SUCCESS (0.000s)
[265.698676] [085/133] (741s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[265.789381] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[266.880608] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.091s)
[267.000599] [086/133] (740s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[267.037440] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[267.038165] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[267.104828] [087/133] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[267.196831] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[267.198244] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[267.284911] [088/133] (740s left) syncobj_timeline (wait-zero-handles)
[267.319341] Starting subtest: wait-zero-handles
[267.320032] Subtest wait-zero-handles: SUCCESS (0.000s)
[267.382789] [089/133] (740s left) kms_psr (fbc-pr-sprite-plane-onoff)
[267.470703] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[267.517696] [090/133] (740s left) gen9_exec_parse (batch-without-end)
[267.554825] Subtest batch-without-end: SKIP (0.000s)
[267.601106] [091/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[267.692786] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[267.694174] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.792080] [092/133] (740s left) syncobj_wait (wait-for-submit-snapshot)
[267.826612] Starting subtest: wait-for-submit-snapshot
[267.908779] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[268.003719] [093/133] (739s left) gem_exec_suspend (basic-s0)
[268.046936] Starting subtest: basic-S0
[268.047624] Starting dynamic subtest: smem
[285.585568] Dynamic subtest smem: SUCCESS (2.770s)
[285.586303] Subtest basic-S0: SUCCESS (2.771s)
[293.822160] [094/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[293.926419] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[293.927857] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[294.013850] [095/133] (722s left) perf (invalid-open-flags)
[294.091329] Starting subtest: invalid-open-flags
[294.092019] Subtest invalid-open-flags: SUCCESS (0.000s)
[294.132221] [096/133] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[294.220842] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[294.222259] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[294.303965] [097/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[294.394961] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[294.396413] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[294.485215] [098/133] (721s left) kms_addfb_basic (unused-modifier)
[294.520176] Starting subtest: unused-modifier
[294.520880] Subtest unused-modifier: SUCCESS (0.000s)
[294.658893] [099/133] (721s left) perf (enable-disable)
[294.729295] Starting subtest: enable-disable
[294.730082] Starting dynamic subtest: 0-rcs0
[296.997013] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[296.997823] Subtest enable-disable: SUCCESS (2.258s)
[297.036311] [100/133] (719s left) gem_exec_whisper (basic-queues-forked-all)
[297.093730] Starting subtest: basic-queues-forked-all
[299.925210] Subtest basic-queues-forked-all: SUCCESS (2.822s)
[300.098042] [101/133] (716s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[300.137837] Starting subtest: y-tiled-to-vebox-yf-tiled
[300.138546] Starting dynamic subtest: smem
[300.205462] Dynamic subtest smem: SUCCESS (0.067s)
[300.206187] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[300.402366] [102/133] (715s left) kms_addfb_basic (bad-pitch-0)
[300.435478] Starting subtest: bad-pitch-0
[300.436190] Subtest bad-pitch-0: SUCCESS (0.000s)
[300.560740] [103/133] (715s left) gem_ctx_engines (execute-one)
[300.602323] Starting subtest: execute-one
[301.844998] Subtest execute-one: SUCCESS (1.233s)
[302.017343] [104/133] (714s left) gem_wait (invalid-buf)
[302.053546] Starting subtest: invalid-buf
[302.054292] Subtest invalid-buf: SUCCESS (0.000s)
[302.256167] [105/133] (714s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[302.344901] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[302.393384] [106/133] (714s left) kms_pm_dc (dc3co-vpb-simulation)
[303.484881] Starting subtest: dc3co-vpb-simulation
[303.486261] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[303.569678] [107/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[303.657889] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[304.887150] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.230s)
[305.005912] [108/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[305.099904] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[305.101343] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[305.198300] [109/133] (711s left) kms_plane_scaling (invalid-parameters)
[305.292451] Starting subtest: invalid-parameters
[305.293139] Starting dynamic subtest: less-than-1-height-src
[305.307950] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[305.316367] Starting dynamic subtest: less-than-1-width-src
[305.324960] Dynamic subtest less-than-1-width-src: SUCCESS (0.016s)
[305.325710] Subtest invalid-parameters: SUCCESS (0.033s)
[305.415241] [110/133] (711s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[305.510430] Starting subtest: yf-tiled-8bpp-rotate-0
[305.511769] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[305.600736] [111/133] (711s left) kms_psr (psr-cursor-plane-move)
[305.685269] Subtest psr-cursor-plane-move: SKIP (0.000s)
[305.728610] [112/133] (711s left) i915_suspend (basic-s3-without-i915)
[305.761625] Starting subtest: basic-s3-without-i915