[49.072870] Initializing watchdogs
[49.072937]   /dev/watchdog0
[49.088251] [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]
[49.093758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.096367] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.098187] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[49.190116] Starting subtest: wf_vblank-ts-check
[49.192086] Starting dynamic subtest: A-HDMI-A1
[67.911135] Dynamic subtest A-HDMI-A1: SUCCESS (18.897s)
[67.916541] Starting dynamic subtest: B-HDMI-A1
[75.810105] Dynamic subtest B-HDMI-A1: SUCCESS (7.897s)
[75.814925] Starting dynamic subtest: C-HDMI-A1
[83.669261] Dynamic subtest C-HDMI-A1: SUCCESS (7.886s)
[83.674373] Starting dynamic subtest: D-HDMI-A1
[91.507407] Dynamic subtest D-HDMI-A1: SUCCESS (7.812s)
[91.508094] Subtest wf_vblank-ts-check: SUCCESS (42.502s)
[91.649605] [002/133] (917s left) kms_cursor_crc (cursor-onscreen-256x256)
[91.744222] Starting subtest: cursor-onscreen-256x256
[91.759362] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.948764] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.190s)
[92.981821] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.116700] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.140s)
[94.117470] Subtest cursor-onscreen-256x256: SUCCESS (2.372s)
[94.269360] [003/133] (915s left) gem_mmap_gtt (big-copy-odd)
[94.304793] Starting subtest: big-copy-odd
[101.357770] Subtest big-copy-odd: SUCCESS (7.052s)
[101.419370] [004/133] (908s left) i915_pm_rpm (sysfs-read)
[102.886607] Starting subtest: sysfs-read
[104.094993] Subtest sysfs-read: SUCCESS (1.208s)
[104.268583] [005/133] (905s left) kms_universal_plane (disable-primary-vs-flip)
[104.354828] Starting subtest: disable-primary-vs-flip
[104.355626] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.709850] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.354s)
[104.716832] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.993754] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.283s)
[105.000802] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.278219] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.282s)
[105.285636] Starting dynamic subtest: pipe-D-HDMI-A-1
[105.562313] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.283s)
[105.563051] Subtest disable-primary-vs-flip: SUCCESS (1.208s)
[105.703833] [006/133] (904s left) perf (gen12-group-exclusive-stream-ctx-handle)
[105.804412] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[105.814919] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.010s)
[105.851530] [007/133] (903s left) kms_flip_event_leak (basic)
[105.937492] Starting subtest: basic
[105.938993] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.120088] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.181s)
[106.127712] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.271728] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.151s)
[106.280192] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.433950] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.161s)
[106.439793] Starting dynamic subtest: pipe-D-HDMI-A-1
[106.581951] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.147s)
[106.582694] Subtest basic: SUCCESS (0.644s)
[106.724122] [008/133] (903s left) gem_exec_fence (syncobj-wait)
[107.082040] Starting subtest: syncobj-wait
[107.132332] Subtest syncobj-wait: SUCCESS (0.050s)
[107.462542] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[107.464204] [009/133] (902s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[107.550549] Starting subtest: primary-y-tiled-reflect-x-90
[112.512047] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.961s)
[112.710455] [010/133] (897s left) kms_psr (fbc-psr-no-drrs)
[112.799237] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[112.839361] [011/133] (897s left) kms_chamelium_edid (hdmi-mode-timings)
[112.979408] Subtest hdmi-mode-timings: SKIP (0.000s)
[113.068766] [012/133] (896s left) gem_exec_flush (basic-wb-ro-before-default)
[113.114802] Starting subtest: basic-wb-ro-before-default
[118.547339] Subtest basic-wb-ro-before-default: SUCCESS (5.432s)
[118.750597] [013/133] (891s left) gem_ccs (block-multicopy-inplace)
[118.786986] Starting subtest: block-multicopy-inplace
[118.788364] Subtest block-multicopy-inplace: SKIP (0.000s)
[118.864660] [014/133] (891s left) kms_invalid_mode (clock-too-high)
[118.951284] Starting subtest: clock-too-high
[118.951979] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.011960] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s)
[119.018337] Starting dynamic subtest: pipe-B-HDMI-A-1
[119.021464] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.009s)
[119.028541] Starting dynamic subtest: pipe-C-HDMI-A-1
[119.032677] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[119.040509] Starting dynamic subtest: pipe-D-HDMI-A-1
[119.043187] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[119.043973] Subtest clock-too-high: SUCCESS (0.092s)
[119.170446] [015/133] (890s left) perf (invalid-remove-userspace-config)
[119.257197] Starting subtest: invalid-remove-userspace-config
[119.270633] Subtest invalid-remove-userspace-config: SUCCESS (0.013s)
[119.308769] [016/133] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[119.397704] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[119.399035] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.489298] [017/133] (890s left) gem_pxp (hw-rejects-pxp-buffer)
[119.590029] Starting subtest: hw-rejects-pxp-buffer
[119.592194] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[119.657181] [018/133] (890s left) vgem_basic (dmabuf-fence)
[119.694189] Starting subtest: dmabuf-fence
[119.694890] Subtest dmabuf-fence: SUCCESS (0.001s)
[119.744942] [019/133] (890s left) core_getclient (basic)
[119.777530] Starting subtest: basic
[119.778551] Subtest basic: SUCCESS (0.000s)
[119.844551] [020/133] (890s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[119.939347] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[120.618902] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.679s)
[120.737398] [021/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[120.822535] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[120.823928] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[120.876408] [022/133] (889s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[120.911885] Starting subtest: invalid-signal-one-illegal-handle
[120.912577] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[120.970215] [023/133] (889s left) kms_getfb (getfb-handle-not-fb)
[121.054749] Starting subtest: getfb-handle-not-fb
[121.055443] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[121.144873] [024/133] (889s left) kms_color (invalid-ctm-matrix-sizes)
[121.229797] Starting subtest: invalid-ctm-matrix-sizes
[121.230493] Starting dynamic subtest: pipe-A
[121.232938] Dynamic subtest pipe-A: SUCCESS (0.004s)
[121.239066] Starting dynamic subtest: pipe-B
[121.239811] Dynamic subtest pipe-B: SUCCESS (0.005s)
[121.245821] Starting dynamic subtest: pipe-C
[121.246502] Dynamic subtest pipe-C: SUCCESS (0.006s)
[121.252441] Starting dynamic subtest: pipe-D
[121.253123] Dynamic subtest pipe-D: SUCCESS (0.007s)
[121.253834] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.024s)
[121.312532] [025/133] (889s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[121.396752] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[121.397454] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.404160] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[121.410444] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.417234] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[121.423394] Starting dynamic subtest: pipe-C-HDMI-A-1
[121.430139] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[121.436361] Starting dynamic subtest: pipe-D-HDMI-A-1
[121.443154] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[121.444470] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[121.631480] [026/133] (888s left) i915_drm_fdinfo (memory-info-resident)
[121.670823] Starting subtest: memory-info-resident
[121.671555] Starting dynamic subtest: smem0
[123.014668] Dynamic subtest smem0: SUCCESS (1.344s)
[123.015831] Subtest memory-info-resident: SUCCESS (1.345s)
[123.079322] [027/133] (887s left) gem_pipe_control_store_loop (reused-buffer)
[123.116131] Starting subtest: reused-buffer
[125.276131] Subtest reused-buffer: SUCCESS (2.151s)
[125.386861] [028/133] (885s left) device_reset (unbind-reset-rebind)
[125.433258] Starting subtest: unbind-reset-rebind
[127.248069] Subtest unbind-reset-rebind: SUCCESS (1.806s)
[127.281335] [029/133] (883s left) kms_content_protection (lic-type-1)
[127.372065] Starting subtest: lic-type-1
[127.385883] Subtest lic-type-1: SKIP (0.011s)
[127.470695] [030/133] (883s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[127.563807] Starting subtest: 4-tiled-8bpp-rotate-90
[127.565151] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[127.667693] [031/133] (883s left) kms_rotation_crc (primary-rotation-270)
[127.751795] Starting subtest: primary-rotation-270
[132.703709] Subtest primary-rotation-270: SUCCESS (4.952s)
[132.897811] [032/133] (877s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[134.298865] Starting subtest: modeset-non-lpsp-stress-no-wait
[134.392887] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.094s)
[134.500068] [033/133] (876s left) kms_async_flips (async-flip-hang)
[134.586689] Starting subtest: async-flip-hang
[134.719714] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.602139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.874s)
[149.736827] Starting dynamic subtest: pipe-B-HDMI-A-1
[164.475361] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.711s)
[164.571609] Starting dynamic subtest: pipe-C-HDMI-A-1
[179.835560] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (15.236s)
[179.922570] Starting dynamic subtest: pipe-D-HDMI-A-1
[194.683181] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.733s)
[194.683947] Subtest async-flip-hang: SUCCESS (60.063s)
[194.879441] [034/133] (815s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[194.973917] Starting subtest: cursorB-vs-flipB-legacy
[194.976238] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[195.034906] [035/133] (815s left) kms_lease (master-vs-lease)
[195.121544] Starting subtest: master-vs-lease
[195.122307] Subtest master-vs-lease: SUCCESS (0.001s)
[195.176314] [036/133] (815s left) kms_plane_multiple (tiling-y)
[195.261942] Starting subtest: tiling-y
[195.262687] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.854744] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.592s)
[195.865238] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.478306] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.622s)
[196.486513] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.130316] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.650s)
[197.139547] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.751925] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.620s)
[197.752643] Subtest tiling-y: SUCCESS (2.492s)
[197.903352] [037/133] (813s left) i915_hangman (engine-engine-hang)
[197.951931] Starting subtest: engine-engine-hang
[197.952643] Starting dynamic subtest: rcs0
[198.522973] Dynamic subtest rcs0: SUCCESS (0.570s)
[198.532782] Starting dynamic subtest: bcs0
[199.096664] Dynamic subtest bcs0: SUCCESS (0.571s)
[199.107371] Starting dynamic subtest: vcs0
[199.668817] Dynamic subtest vcs0: SUCCESS (0.570s)
[199.681442] Starting dynamic subtest: vcs1
[200.239824] Dynamic subtest vcs1: SUCCESS (0.569s)
[200.250329] Starting dynamic subtest: vecs0
[200.807014] Dynamic subtest vecs0: SUCCESS (0.564s)
[200.808205] Subtest engine-engine-hang: SUCCESS (2.856s)
[200.882126] [038/133] (810s left) gem_media_fill (media-fill)
[200.921333] Starting subtest: media-fill
[200.922049] Starting dynamic subtest: smem
[200.926120] Dynamic subtest smem: SUCCESS (0.004s)
[200.926826] Subtest media-fill: SUCCESS (0.005s)
[201.140643] [039/133] (809s left) kms_flip (2x-busy-flip)
[201.228548] Starting subtest: 2x-busy-flip
[201.237300] Subtest 2x-busy-flip: SKIP (0.009s)
[201.315238] [040/133] (809s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[201.408213] Starting subtest: yf-tiled-16bpp-rotate-90
[201.409692] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[201.504233] [041/133] (809s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[201.640455] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[201.732723] [042/133] (809s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[202.190342] Starting subtest: syncobj-timeline-invalid-wait
[202.191333] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[202.381521] [043/133] (808s left) gem_workarounds (basic-read)
[202.430150] Starting subtest: basic-read
[202.437930] Subtest basic-read: SUCCESS (0.007s)
[202.549338] [044/133] (808s left) syncobj_eventfd (invalid-illegal-eventfd)
[202.583825] Starting subtest: invalid-illegal-eventfd
[202.584541] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[202.642814] [045/133] (808s left) kms_plane_alpha_blend (alpha-7efc)
[202.731175] Starting subtest: alpha-7efc
[202.798703] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.105194] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[203.135135] Starting dynamic subtest: pipe-D-HDMI-A-1
[203.572643] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.443s)
[203.573387] Subtest alpha-7efc: SUCCESS (0.842s)
[203.728251] [046/133] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[203.823216] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[203.824642] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[203.916168] [047/133] (807s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[204.000897] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[204.002702] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.669168] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.663s)
[204.682972] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.169798] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s)
[205.183785] Starting dynamic subtest: pipe-C-HDMI-A-1
[205.670312] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.496s)
[205.684283] Starting dynamic subtest: pipe-D-HDMI-A-1
[206.172945] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.498s)
[206.173889] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.169s)
[206.361307] [048/133] (805s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[206.456038] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[206.458843] Starting dynamic subtest: A-HDMI-A1
[207.164186] Dynamic subtest A-HDMI-A1: SUCCESS (0.705s)
[207.172216] Starting dynamic subtest: B-HDMI-A1
[207.760537] Dynamic subtest B-HDMI-A1: SUCCESS (0.595s)
[207.769604] Starting dynamic subtest: C-HDMI-A1
[208.378895] Dynamic subtest C-HDMI-A1: SUCCESS (0.617s)
[208.386866] Starting dynamic subtest: D-HDMI-A1
[208.995685] Dynamic subtest D-HDMI-A1: SUCCESS (0.615s)
[208.999517] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.543s)
[209.146371] [049/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[209.241722] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[209.243087] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[209.337089] [050/133] (802s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[209.423068] Starting subtest: fb-8bpc-vs-panel-8bpc
[209.423772] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.661603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.237s)
[209.662423] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.240s)
[209.803414] [051/133] (801s left) gem_pxp (fail-invalid-protected-context)
[209.900201] Starting subtest: fail-invalid-protected-context
[209.901353] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[209.967245] [052/133] (801s left) kms_force_connector_basic (prune-stale-modes)
[210.093029] Starting subtest: prune-stale-modes
[210.244039] Subtest prune-stale-modes: SUCCESS (0.152s)
[210.397506] [053/133] (801s left) gem_render_copy_redux (interruptible)
[210.435464] Starting subtest: interruptible
[210.768072] Subtest interruptible: SUCCESS (0.326s)
[210.870327] [054/133] (800s left) perf_pmu (faulting-read)
[210.907110] Starting subtest: faulting-read
[210.907853] Starting dynamic subtest: gtt
[210.910163] Dynamic subtest gtt: SUCCESS (0.001s)
[210.917621] Starting dynamic subtest: wb
[210.918306] Dynamic subtest wb: SUCCESS (0.001s)
[210.925354] Starting dynamic subtest: wc
[210.926034] Dynamic subtest wc: SUCCESS (0.001s)
[210.932885] Starting dynamic subtest: uc
[210.933573] Dynamic subtest uc: SUCCESS (0.000s)
[210.934243] Subtest faulting-read: SUCCESS (0.006s)
[211.006050] [055/133] (800s left) gem_ctx_isolation (clean)
[211.049499] Starting subtest: clean
[211.050228] Starting dynamic subtest: rcs0
[211.073807] Dynamic subtest rcs0: SUCCESS (0.023s)
[211.080886] Starting dynamic subtest: bcs0
[211.151336] Dynamic subtest bcs0: SUCCESS (0.077s)
[211.159417] Starting dynamic subtest: vcs0
[211.208580] Dynamic subtest vcs0: SUCCESS (0.056s)
[211.215626] Starting dynamic subtest: vcs1
[211.270776] Dynamic subtest vcs1: SUCCESS (0.061s)
[211.279401] Starting dynamic subtest: vecs0
[211.342644] Dynamic subtest vecs0: SUCCESS (0.071s)
[211.344684] Subtest clean: SUCCESS (0.294s)
[211.518974] [056/133] (800s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[211.606928] Starting subtest: flip-vs-cursor-busy-crc-atomic
[211.996468] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.389s)
[212.160687] [057/133] (799s left) gem_mmap_gtt (isolation)
[212.196045] Starting subtest: isolation
[212.198120] Subtest isolation: SUCCESS (0.002s)
[212.302336] [058/133] (799s left) prime_busy (hang)
[212.338616] Starting subtest: hang
[212.339348] Starting dynamic subtest: rcs0
[226.426996] Dynamic subtest rcs0: SUCCESS (14.052s)
[226.433857] Starting dynamic subtest: bcs0
[233.594858] Dynamic subtest bcs0: SUCCESS (7.166s)
[233.603368] Starting dynamic subtest: vcs0
[240.571159] Dynamic subtest vcs0: SUCCESS (6.975s)
[240.578084] Starting dynamic subtest: vcs1
[247.612744] Dynamic subtest vcs1: SUCCESS (7.039s)
[247.619723] Starting dynamic subtest: vecs0
[254.555290] Dynamic subtest vecs0: SUCCESS (6.975s)
[254.556035] Subtest hang: SUCCESS (42.214s)
[254.656979] [059/133] (757s left) kms_cursor_crc (cursor-sliding-512x512)
[254.757307] Starting subtest: cursor-sliding-512x512
[254.758762] Subtest cursor-sliding-512x512: SKIP (0.001s)
[254.854075] [060/133] (757s left) gem_exec_balancer (sequential)
[254.897319] Starting subtest: sequential
[258.405925] Subtest sequential: SUCCESS (3.509s)
[258.599414] [061/133] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[258.695224] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[258.696692] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[258.785975] [062/133] (753s left) gem_softpin (full)
[258.823877] Starting subtest: full
[258.829849] Subtest full: SUCCESS (0.006s)
[258.941115] [063/133] (753s left) kms_psr (pr-sprite-plane-move)
[259.027741] Subtest pr-sprite-plane-move: SKIP (0.000s)
[259.068667] [064/133] (752s left) gem_ctx_shared (q-in-order)
[259.110543] Starting subtest: Q-in-order
[259.111292] Starting dynamic subtest: rcs0
[259.159888] Dynamic subtest rcs0: SUCCESS (0.048s)
[259.172429] Starting dynamic subtest: bcs0
[259.213642] Dynamic subtest bcs0: SUCCESS (0.052s)
[259.228737] Starting dynamic subtest: vcs0
[259.268676] Dynamic subtest vcs0: SUCCESS (0.053s)
[259.282054] Starting dynamic subtest: vcs1
[259.321028] Dynamic subtest vcs1: SUCCESS (0.050s)
[259.335671] Starting dynamic subtest: vecs0
[259.371985] Dynamic subtest vecs0: SUCCESS (0.049s)
[259.373178] Subtest Q-in-order: SUCCESS (0.262s)
[259.561313] [065/133] (752s left) kms_chamelium_audio (hdmi-audio)
[259.704836] Subtest hdmi-audio: SKIP (0.000s)
[259.796273] [066/133] (752s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[259.832907] Starting subtest: single-wait-all-for-submit-available-submitted
[259.833633] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[259.896598] [067/133] (752s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[259.994392] Starting subtest: cursor-rapid-movement-512x170
[259.996909] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[260.099060] [068/133] (752s left) kms_big_fb (linear-64bpp-rotate-270)
[260.193931] Starting subtest: linear-64bpp-rotate-270
[260.241926] Subtest linear-64bpp-rotate-270: SKIP (0.047s)
[260.347098] [069/133] (751s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[260.433733] Starting subtest: flip-vs-cursor-atomic
[266.934300] Subtest flip-vs-cursor-atomic: SUCCESS (6.499s)
[267.071358] [070/133] (745s left) gem_exec_schedule (semaphore-power)
[267.244077] Starting subtest: semaphore-power
[268.308090] Subtest semaphore-power: SUCCESS (1.053s)
[268.468375] [071/133] (743s left) gem_ctx_persistence (legacy-engines-hang)
[268.506806] Starting subtest: legacy-engines-hang
[268.507566] Starting dynamic subtest: render
[268.561655] Dynamic subtest render: SUCCESS (0.054s)
[268.582378] Starting dynamic subtest: bsd1
[268.612563] Dynamic subtest bsd1: SUCCESS (0.048s)
[268.625604] Starting dynamic subtest: bsd2
[268.648727] Dynamic subtest bsd2: SUCCESS (0.033s)
[268.666629] Starting dynamic subtest: blt
[268.697572] Dynamic subtest blt: SUCCESS (0.046s)
[268.716350] Starting dynamic subtest: vebox
[268.751623] Dynamic subtest vebox: SUCCESS (0.051s)
[268.752803] Subtest legacy-engines-hang: SUCCESS (0.246s)
[268.829227] [072/133] (743s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[268.918852] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[268.919553] Starting dynamic subtest: pipe-A
[269.058946] Dynamic subtest pipe-A: SUCCESS (0.140s)
[269.075912] Starting dynamic subtest: pipe-B
[269.210970] Dynamic subtest pipe-B: SUCCESS (0.151s)
[269.227861] Starting dynamic subtest: pipe-C
[269.353414] Dynamic subtest pipe-C: SUCCESS (0.141s)
[269.362450] Starting dynamic subtest: pipe-D
[269.488379] Dynamic subtest pipe-D: SUCCESS (0.133s)
[269.489100] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.571s)
[269.660392] [073/133] (742s left) syncobj_timeline (multi-wait-for-submit-signaled)
[269.698298] Starting subtest: multi-wait-for-submit-signaled
[269.698995] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[269.759800] [074/133] (742s left) kms_atomic_interruptible (legacy-dpms)
[269.845479] Starting subtest: legacy-dpms
[269.847365] Starting dynamic subtest: pipe-A-HDMI-A-1
[276.080585] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.233s)
[276.081316] Subtest legacy-dpms: SUCCESS (6.236s)
[276.215458] [075/133] (736s left) syncobj_basic (bad-pad-handle-to-fd)
[276.253109] Starting subtest: bad-pad-handle-to-fd
[276.253876] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[276.313930] [076/133] (736s left) drm_read (short-buffer-nonblock)
[276.428143] Starting subtest: short-buffer-nonblock
[276.428904] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[276.549604] [077/133] (736s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[276.635550] Starting subtest: cursorB-vs-flipB-varying-size
[276.636976] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[276.697480] [078/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[276.786703] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[276.788048] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.881777] [079/133] (735s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[276.976989] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[277.635225] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.659s)
[277.756609] [080/133] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[277.846501] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[279.193985] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.348s)
[279.323532] [081/133] (733s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[279.413267] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[279.459753] [082/133] (733s left) kms_atomic (crtc-invalid-params)
[279.545970] Starting subtest: crtc-invalid-params
[279.547736] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.685385] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[279.686639] Subtest crtc-invalid-params: SUCCESS (0.141s)
[279.834426] [083/133] (732s left) kms_flip (busy-flip)
[279.923579] Starting subtest: busy-flip
[279.925941] Starting dynamic subtest: A-HDMI-A1
[280.592630] Dynamic subtest A-HDMI-A1: SUCCESS (0.666s)
[280.603712] Starting dynamic subtest: B-HDMI-A1
[281.249097] Dynamic subtest B-HDMI-A1: SUCCESS (0.650s)
[281.257527] Starting dynamic subtest: C-HDMI-A1
[281.914623] Dynamic subtest C-HDMI-A1: SUCCESS (0.661s)
[281.922197] Starting dynamic subtest: D-HDMI-A1
[282.570218] Dynamic subtest D-HDMI-A1: SUCCESS (0.654s)
[282.574457] Subtest busy-flip: SUCCESS (2.650s)
[282.742907] [084/133] (730s left) gem_exec_params (cliprects-invalid)
[282.790661] Starting subtest: cliprects-invalid
[282.791337] Subtest cliprects-invalid: SUCCESS (0.000s)
[282.882927] [085/133] (730s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[282.973681] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[284.122207] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.148s)
[284.240230] [086/133] (728s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[284.276319] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[284.277043] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[284.357498] [087/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[284.447388] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[284.448730] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[284.541395] [088/133] (728s left) syncobj_timeline (wait-zero-handles)
[284.575985] Starting subtest: wait-zero-handles
[284.576703] Subtest wait-zero-handles: SUCCESS (0.000s)
[284.657993] [089/133] (728s left) kms_psr (fbc-pr-sprite-plane-onoff)
[284.743811] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[284.785225] [090/133] (728s left) gen9_exec_parse (batch-without-end)
[284.822317] Subtest batch-without-end: SKIP (0.000s)
[284.867618] [091/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[284.960228] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[284.961678] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[285.051993] [092/133] (728s left) syncobj_wait (wait-for-submit-snapshot)
[285.088478] Starting subtest: wait-for-submit-snapshot
[285.170292] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[285.240054] [093/133] (727s left) gem_exec_suspend (basic-s0)
[285.282088] Starting subtest: basic-S0
[285.282918] Starting dynamic subtest: smem
[302.953629] Dynamic subtest smem: SUCCESS (2.685s)
[302.954367] Subtest basic-S0: SUCCESS (2.687s)
[311.194527] [094/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[311.286465] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[311.287840] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[311.364817] [095/133] (709s left) perf (invalid-open-flags)
[311.458734] Starting subtest: invalid-open-flags
[311.459477] Subtest invalid-open-flags: SUCCESS (0.000s)
[311.502622] [096/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[311.589870] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[311.591240] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[311.688286] [097/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[311.774736] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[311.776172] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[311.869691] [098/133] (709s left) kms_addfb_basic (unused-modifier)
[311.903661] Starting subtest: unused-modifier
[311.904337] Subtest unused-modifier: SUCCESS (0.000s)
[312.045476] [099/133] (709s left) perf (enable-disable)
[312.124228] Starting subtest: enable-disable
[312.126076] Starting dynamic subtest: 0-rcs0
[314.397803] Dynamic subtest 0-rcs0: SUCCESS (2.323s)
[314.398569] Subtest enable-disable: SUCCESS (2.324s)
[314.435282] [100/133] (707s left) gem_exec_whisper (basic-queues-forked-all)
[314.495191] Starting subtest: basic-queues-forked-all
[317.218858] Subtest basic-queues-forked-all: SUCCESS (2.773s)
[317.403486] [101/133] (704s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[317.442106] Starting subtest: y-tiled-to-vebox-yf-tiled
[317.442813] Starting dynamic subtest: smem
[317.507564] Dynamic subtest smem: SUCCESS (0.066s)
[317.509611] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.067s)
[317.718976] [102/133] (703s left) kms_addfb_basic (bad-pitch-0)
[317.752789] Starting subtest: bad-pitch-0
[317.753552] Subtest bad-pitch-0: SUCCESS (0.000s)
[317.886591] [103/133] (703s left) gem_ctx_engines (execute-one)
[317.927743] Starting subtest: execute-one
[319.170412] Subtest execute-one: SUCCESS (1.250s)
[319.346471] [104/133] (702s left) gem_wait (invalid-buf)
[319.382794] Starting subtest: invalid-buf
[319.383526] Subtest invalid-buf: SUCCESS (0.000s)
[319.598837] [105/133] (702s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[319.685939] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[319.729003] [106/133] (702s left) kms_pm_dc (dc3co-vpb-simulation)
[320.822080] Starting subtest: dc3co-vpb-simulation
[320.823579] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[320.878847] [107/133] (700s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[320.967628] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[322.173710] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.217s)
[322.309339] [108/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[322.399462] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[322.400813] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[322.491484] [109/133] (699s left) kms_plane_scaling (invalid-parameters)
[322.586442] Starting subtest: invalid-parameters
[322.587123] Starting dynamic subtest: less-than-1-height-src
[322.601300] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[322.609867] Starting dynamic subtest: less-than-1-width-src
[322.616855] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[322.617537] Subtest invalid-parameters: SUCCESS (0.031s)
[322.715098] [110/133] (699s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[322.809562] Starting subtest: yf-tiled-8bpp-rotate-0
[322.810897] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[322.895558] [111/133] (699s left) kms_psr (psr-cursor-plane-move)
[322.981692] Subtest psr-cursor-plane-move: SKIP (0.000s)
[323.024699] [112/133] (699s left) i915_suspend (basic-s3-without-i915)
[323.056736] Starting subtest: basic-s3-without-i915