[69.425314] Initializing watchdogs
[69.425382]   /dev/watchdog0
[69.440849] [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]
[69.446602] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.449366] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.451304] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[69.542884] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[69.544363] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[69.594978] [002/133] (960s left) kms_flip (flip-vs-expired-vblank-interruptible)
[69.684392] Starting subtest: flip-vs-expired-vblank-interruptible
[69.686902] Starting dynamic subtest: A-HDMI-A1
[77.389836] Dynamic subtest A-HDMI-A1: SUCCESS (7.689s)
[77.394996] Starting dynamic subtest: B-HDMI-A1
[85.004818] Dynamic subtest B-HDMI-A1: SUCCESS (7.631s)
[85.012014] Starting dynamic subtest: C-HDMI-A1
[92.638245] Dynamic subtest C-HDMI-A1: SUCCESS (7.631s)
[92.644373] Starting dynamic subtest: D-HDMI-A1
[100.299826] Dynamic subtest D-HDMI-A1: SUCCESS (7.637s)
[100.300577] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.597s)
[100.421616] [003/133] (929s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[100.525376] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[100.526809] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[100.601381] [004/133] (929s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[100.690518] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[102.340387] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (1.649s)
[102.465356] [005/133] (927s left) api_intel_bb (crc32)
[102.498123] Starting subtest: crc32
[102.499457] Subtest crc32: SKIP (0.000s)
[102.585293] [006/133] (927s left) gem_userptr_blits (usage-restrictions)
[102.625368] Starting subtest: usage-restrictions
[102.626080] Subtest usage-restrictions: SUCCESS (0.000s)
[102.732967] [007/133] (927s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[102.819522] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[102.820218] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.822878] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[102.828185] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.830823] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[102.836143] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.838762] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[102.843891] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.846511] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[102.847844] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[103.047441] [008/133] (927s left) kms_flip (2x-flip-vs-suspend-interruptible)
[103.139394] Starting subtest: 2x-flip-vs-suspend-interruptible
[103.148873] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.009s)
[103.208112] [009/133] (927s left) kms_sequence (get-busy)
[103.292779] Starting subtest: get-busy
[103.293471] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.574229] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.281s)
[104.581301] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.845795] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.271s)
[105.853766] Starting dynamic subtest: pipe-C-HDMI-A-1
[107.127785] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.281s)
[107.135290] Starting dynamic subtest: pipe-D-HDMI-A-1
[108.400245] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.272s)
[108.400999] Subtest get-busy: SUCCESS (5.108s)
[108.500640] [010/133] (921s left) kms_plane_scaling (planes-scaler-unity-scaling)
[108.587490] Starting subtest: planes-scaler-unity-scaling
[108.588227] Starting dynamic subtest: pipe-A
[108.651757] Dynamic subtest pipe-A: SUCCESS (0.065s)
[108.658029] Starting dynamic subtest: pipe-B
[108.786260] Dynamic subtest pipe-B: SUCCESS (0.134s)
[108.798224] Starting dynamic subtest: pipe-C
[108.920640] Dynamic subtest pipe-C: SUCCESS (0.134s)
[108.927076] Starting dynamic subtest: pipe-D
[109.047342] Dynamic subtest pipe-D: SUCCESS (0.126s)
[109.048051] Subtest planes-scaler-unity-scaling: SUCCESS (0.461s)
[109.221170] [011/133] (921s left) gem_exec_await (wide-all)
[109.330017] Starting subtest: wide-all
[131.281213] Subtest wide-all: SUCCESS (21.919s)
[131.441955] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[131.444963] [012/133] (898s left) kms_plane (pixel-format-linear-modifier)
[131.571616] Starting subtest: pixel-format-linear-modifier
[131.592309] Starting dynamic subtest: pipe-A-plane-0
[134.101244] Dynamic subtest pipe-A-plane-0: SUCCESS (2.509s)
[134.115052] Starting dynamic subtest: pipe-A-plane-3
[136.334935] Dynamic subtest pipe-A-plane-3: SUCCESS (2.233s)
[136.348592] Starting dynamic subtest: pipe-A-plane-5
[137.526964] Dynamic subtest pipe-A-plane-5: SUCCESS (1.191s)
[137.541426] Starting dynamic subtest: pipe-A-plane-7
[137.635123] Dynamic subtest pipe-A-plane-7: SUCCESS (0.108s)
[137.786511] Starting dynamic subtest: pipe-B-plane-0
[140.247509] Dynamic subtest pipe-B-plane-0: SUCCESS (2.467s)
[140.261233] Starting dynamic subtest: pipe-B-plane-3
[142.456356] Dynamic subtest pipe-B-plane-3: SUCCESS (2.208s)
[142.469140] Starting dynamic subtest: pipe-B-plane-5
[143.639724] Dynamic subtest pipe-B-plane-5: SUCCESS (1.182s)
[143.652747] Starting dynamic subtest: pipe-B-plane-7
[143.747979] Dynamic subtest pipe-B-plane-7: SUCCESS (0.107s)
[143.821018] Subtest pixel-format-linear-modifier: SUCCESS (12.249s)
[143.949623] [013/133] (886s left) syncobj_eventfd (binary-wait)
[143.993695] Starting subtest: binary-wait
[144.004357] Subtest binary-wait: SUCCESS (0.011s)
[144.072572] [014/133] (886s left) syncobj_timeline (etime-single-wait-submitted)
[144.106031] Starting subtest: etime-single-wait-submitted
[144.220258] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[144.286386] [015/133] (886s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[144.421889] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[144.513332] [016/133] (885s left) kms_properties (connector-properties-atomic)
[144.599397] Starting subtest: connector-properties-atomic
[144.600081] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.126856] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.526s)
[145.133497] Starting dynamic subtest: pipe-None-DP-1
[145.134853] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[145.141132] Starting dynamic subtest: pipe-None-DP-2
[145.142468] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[145.149261] Starting dynamic subtest: pipe-None-DP-3
[145.150625] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[145.156703] Starting dynamic subtest: pipe-None-DP-4
[145.158061] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[145.158773] Subtest connector-properties-atomic: SUCCESS (0.537s)
[145.252012] [017/133] (885s left) gem_exec_balancer (hang)
[145.420567] Starting subtest: hang
[146.713235] Subtest hang: SUCCESS (1.302s)
[146.778859] [018/133] (883s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[146.867508] Starting subtest: cursorB-vs-flipB-varying-size
[146.868902] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[146.921819] [019/133] (883s left) kms_addfb_basic (bad-pitch-256)
[146.954610] Starting subtest: bad-pitch-256
[146.955340] Subtest bad-pitch-256: SUCCESS (0.000s)
[147.083547] [020/133] (883s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[147.167579] Starting subtest: cursorB-vs-flipA-atomic-transitions
[147.169788] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[147.231627] [021/133] (883s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[147.315746] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[147.316455] Starting dynamic subtest: pipe-A
[147.729028] Dynamic subtest pipe-A: SUCCESS (0.414s)
[147.742835] Starting dynamic subtest: pipe-B
[148.173996] Dynamic subtest pipe-B: SUCCESS (0.444s)
[148.180576] Starting dynamic subtest: pipe-C
[148.607114] Dynamic subtest pipe-C: SUCCESS (0.433s)
[148.617487] Starting dynamic subtest: pipe-D
[149.040981] Dynamic subtest pipe-D: SUCCESS (0.433s)
[149.041861] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (1.726s)
[149.204573] [022/133] (881s left) vgem_basic (bad-handle)
[149.241815] Starting subtest: bad-handle
[149.242501] Subtest bad-handle: SUCCESS (0.000s)
[149.293404] [023/133] (881s left) gem_ctx_persistence (legacy-engines-persistence)
[149.329205] Starting subtest: legacy-engines-persistence
[149.329916] Starting dynamic subtest: render
[150.070520] Dynamic subtest render: SUCCESS (0.740s)
[150.083836] Starting dynamic subtest: bsd1
[150.836547] Dynamic subtest bsd1: SUCCESS (0.764s)
[150.846051] Starting dynamic subtest: bsd2
[151.606646] Dynamic subtest bsd2: SUCCESS (0.768s)
[151.617448] Starting dynamic subtest: blt
[152.378623] Dynamic subtest blt: SUCCESS (0.769s)
[152.389254] Starting dynamic subtest: vebox
[153.139815] Dynamic subtest vebox: SUCCESS (0.759s)
[153.141058] Subtest legacy-engines-persistence: SUCCESS (3.811s)
[153.210087] [024/133] (877s left) syncobj_wait (multi-wait-for-submit-submitted)
[153.243915] Starting subtest: multi-wait-for-submit-submitted
[153.350692] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[153.421318] [025/133] (877s left) i915_query (query-topology-matches-eu-total)
[153.454350] Starting subtest: query-topology-matches-eu-total
[153.455057] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[153.512205] [026/133] (877s left) kms_pm_rpm (cursor-dpms)
[154.911832] Starting subtest: cursor-dpms
[166.995101] Subtest cursor-dpms: SUCCESS (12.084s)
[167.188475] [027/133] (863s left) gem_close_race (basic-process)
[167.237693] Starting subtest: basic-process
[167.283876] Subtest basic-process: SUCCESS (0.046s)
[167.460875] [028/133] (863s left) gem_gpgpu_fill (basic)
[167.494128] Starting subtest: basic
[167.494816] Starting dynamic subtest: smem
[167.498858] Dynamic subtest smem: SUCCESS (0.004s)
[167.499540] Subtest basic: SUCCESS (0.005s)
[167.616545] [029/133] (863s left) gem_userptr_blits (forbidden-operations)
[167.653516] Starting subtest: forbidden-operations
[167.654199] Subtest forbidden-operations: SUCCESS (0.001s)
[167.771882] [030/133] (863s left) gem_exec_reloc (basic-wc-active)
[167.809139] Starting subtest: basic-wc-active
[167.935218] Subtest basic-wc-active: SUCCESS (0.120s)
[168.067452] [031/133] (863s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[168.151672] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[168.152334] Starting dynamic subtest: pipe-A-HDMI-A-1
[168.158784] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[168.165111] Starting dynamic subtest: pipe-B-HDMI-A-1
[168.171540] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[168.177812] Starting dynamic subtest: pipe-C-HDMI-A-1
[168.191208] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[168.197560] Starting dynamic subtest: pipe-D-HDMI-A-1
[168.204270] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[168.205690] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[168.400186] [032/133] (862s left) prime_busy (after-wait)
[168.437043] Starting subtest: after-wait
[168.441674] Starting dynamic subtest: rcs0
[168.468563] Dynamic subtest rcs0: SUCCESS (0.027s)
[168.477768] Starting dynamic subtest: bcs0
[168.483571] Dynamic subtest bcs0: SUCCESS (0.014s)
[168.493806] Starting dynamic subtest: vcs0
[168.498893] Dynamic subtest vcs0: SUCCESS (0.014s)
[168.506068] Starting dynamic subtest: vcs1
[168.511874] Dynamic subtest vcs1: SUCCESS (0.012s)
[168.518528] Starting dynamic subtest: vecs0
[168.534171] Dynamic subtest vecs0: SUCCESS (0.022s)
[168.642461] Subtest after-wait: SUCCESS (0.205s)
[168.720125] [033/133] (862s left) gem_eio (throttle)
[168.762279] Starting subtest: throttle
[168.804164] Subtest throttle: SUCCESS (0.041s)
[168.933016] [034/133] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[169.024723] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[169.026120] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[169.113665] [035/133] (862s left) gem_exec_fence (nb-await)
[169.279156] Starting subtest: nb-await
[169.280244] Starting dynamic subtest: rcs0
[169.341677] Dynamic subtest rcs0: SUCCESS (0.062s)
[169.359632] Starting dynamic subtest: bcs0
[169.411155] Dynamic subtest bcs0: SUCCESS (0.068s)
[169.426811] Starting dynamic subtest: vcs0
[169.475717] Dynamic subtest vcs0: SUCCESS (0.063s)
[169.491545] Starting dynamic subtest: vcs1
[169.540413] Dynamic subtest vcs1: SUCCESS (0.063s)
[169.555801] Starting dynamic subtest: vecs0
[169.605016] Dynamic subtest vecs0: SUCCESS (0.063s)
[169.605968] Subtest nb-await: SUCCESS (0.327s)
[170.071431] [036/133] (861s left) kms_psr (psr2-cursor-render)
[170.158494] Subtest psr2-cursor-render: SKIP (0.000s)
[170.200703] [037/133] (861s left) gem_userptr_blits (sync-unmap-after-close)
[170.244216] Starting subtest: sync-unmap-after-close
[170.260693] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[170.375236] [038/133] (860s left) kms_chamelium_color (degamma)
[170.460451] Subtest degamma: SKIP (0.000s)
[170.500800] [039/133] (860s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[170.596397] Starting subtest: x-tiled-16bpp-rotate-180
[171.745343] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.148s)
[171.863184] [040/133] (859s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[171.897352] Starting subtest: multi-wait-available-unsubmitted-signaled
[171.898127] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[171.955617] [041/133] (859s left) gem_workarounds (basic-read)
[172.002798] Starting subtest: basic-read
[172.011215] Subtest basic-read: SUCCESS (0.008s)
[172.125176] [042/133] (859s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[172.215630] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[172.216983] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[172.315738] [043/133] (859s left) gem_exec_whisper (basic-fds-priority)
[172.357914] Starting subtest: basic-fds-priority
[175.591008] Subtest basic-fds-priority: SUCCESS (3.224s)
[175.769793] [044/133] (855s left) kms_cursor_crc (cursor-onscreen-max-size)
[175.865938] Starting subtest: cursor-onscreen-max-size
[175.867958] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[175.970995] [045/133] (855s left) gem_mmap_offset (bad-object)
[176.003916] Starting subtest: bad-object
[176.005620] Subtest bad-object: SUCCESS (0.001s)
[176.099900] [046/133] (855s left) kms_psr (fbc-psr-sprite-plane-onoff)
[176.186945] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[176.246895] [047/133] (855s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[176.340251] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[176.937972] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.597s)
[177.050920] [048/133] (854s left) kms_cursor_crc (cursor-sliding-256x256)
[177.139802] Starting subtest: cursor-sliding-256x256
[177.144755] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.981110] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.837s)
[179.023265] Starting dynamic subtest: pipe-D-HDMI-A-1
[180.826479] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.813s)
[180.827264] Subtest cursor-sliding-256x256: SUCCESS (3.688s)
[180.965369] [049/133] (850s left) gem_eio (context-create)
[181.007737] Starting subtest: context-create
[181.034303] Subtest context-create: SUCCESS (0.026s)
[181.149700] [050/133] (850s left) sw_sync (sync_merge_invalid)
[181.182828] Starting subtest: sync_merge_invalid
[181.184225] Subtest sync_merge_invalid: SUCCESS (0.002s)
[181.230427] [051/133] (850s left) gem_spin_batch (spin-all-new)
[181.271469] Starting subtest: spin-all-new
[181.282276] Subtest spin-all-new: SUCCESS (0.011s)
[181.471601] [052/133] (850s left) gem_exec_reloc (basic-gtt)
[181.507112] Starting subtest: basic-gtt
[181.513644] Subtest basic-gtt: SUCCESS (0.007s)
[181.624956] [053/133] (850s left) gem_exec_schedule (pi-common)
[181.790511] Starting subtest: pi-common
[181.791533] Starting dynamic subtest: rcs0
[181.830821] Dynamic subtest rcs0: SUCCESS (0.040s)
[181.839819] Starting dynamic subtest: bcs0
[181.863182] Dynamic subtest bcs0: SUCCESS (0.031s)
[181.871877] Starting dynamic subtest: vcs0
[181.890382] Dynamic subtest vcs0: SUCCESS (0.026s)
[181.899435] Starting dynamic subtest: vcs1
[181.917294] Dynamic subtest vcs1: SUCCESS (0.026s)
[181.926149] Starting dynamic subtest: vecs0
[181.941698] Dynamic subtest vecs0: SUCCESS (0.023s)
[181.942435] Subtest pi-common: SUCCESS (0.152s)
[182.128620] [054/133] (849s left) gem_exec_fence (syncobj-timeline-unused-fence)
[182.569880] Starting subtest: syncobj-timeline-unused-fence
[182.570867] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[182.746963] [055/133] (849s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[182.836771] Starting subtest: plane-ctm3x4-lut1d
[182.923314] Starting dynamic subtest: pipe-A-plane-0
[183.022782] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[183.039297] Starting dynamic subtest: pipe-A-plane-1
[183.114311] Dynamic subtest pipe-A-plane-1: SUCCESS (0.090s)
[183.129828] Starting dynamic subtest: pipe-A-plane-2
[183.205994] Dynamic subtest pipe-A-plane-2: SUCCESS (0.090s)
[183.394470] Starting dynamic subtest: pipe-B-plane-0
[183.473118] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[183.487974] Starting dynamic subtest: pipe-B-plane-1
[183.564509] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[183.579223] Starting dynamic subtest: pipe-B-plane-2
[183.656194] Dynamic subtest pipe-B-plane-2: SUCCESS (0.090s)
[183.861068] Starting dynamic subtest: pipe-C-plane-0
[183.935353] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[183.948856] Starting dynamic subtest: pipe-C-plane-1
[184.026818] Dynamic subtest pipe-C-plane-1: SUCCESS (0.090s)
[184.040422] Starting dynamic subtest: pipe-C-plane-2
[184.126783] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[184.348738] Starting dynamic subtest: pipe-D-plane-0
[184.440601] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s)
[184.456784] Starting dynamic subtest: pipe-D-plane-1
[184.548716] Dynamic subtest pipe-D-plane-1: SUCCESS (0.105s)
[184.561609] Starting dynamic subtest: pipe-D-plane-2
[184.648692] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[184.697905] Subtest plane-ctm3x4-lut1d: SUCCESS (1.861s)
[184.805247] [056/133] (847s left) kms_cursor_legacy (torture-move)
[184.903369] Starting subtest: torture-move
[184.904112] Starting dynamic subtest: pipe-A
[190.415598] Dynamic subtest pipe-A: SUCCESS (5.477s)
[190.425930] Starting dynamic subtest: pipe-B
[195.893145] Dynamic subtest pipe-B: SUCCESS (5.498s)
[195.904166] Starting dynamic subtest: pipe-C
[201.419417] Dynamic subtest pipe-C: SUCCESS (5.504s)
[201.429137] Starting dynamic subtest: pipe-D
[206.892749] Dynamic subtest pipe-D: SUCCESS (5.472s)
[206.910130] Starting dynamic subtest: all-pipes
[212.379086] Dynamic subtest all-pipes: SUCCESS (5.485s)
[212.379998] Subtest torture-move: SUCCESS (27.442s)
[212.438807] [057/133] (819s left) kms_getfb (getfb2-handle-closed)
[212.528267] Starting subtest: getfb2-handle-closed
[212.529047] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[212.619171] [058/133] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[212.710119] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[212.711483] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[212.799779] [059/133] (819s left) kms_prime (basic-crc-vgem)
[212.897534] Starting subtest: basic-crc-vgem
[212.898275] Starting dynamic subtest: second-to-first
[213.580489] Dynamic subtest second-to-first: SUCCESS (0.683s)
[213.581610] Subtest basic-crc-vgem: SUCCESS (0.685s)
[213.687425] [060/133] (818s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[213.789308] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[213.790707] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[213.887936] [061/133] (818s left) kms_vrr (flipline)
[213.973109] Starting subtest: flipline
[213.975193] Subtest flipline: SKIP (0.000s)
[214.045804] [062/133] (818s left) gem_userptr_blits (probe)
[214.096509] Starting subtest: probe
[214.207739] Subtest probe: SUCCESS (0.110s)
[214.302791] [063/133] (818s left) kms_psr (fbc-pr-cursor-plane-onoff)
[214.387889] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[214.429096] [064/133] (818s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[214.513877] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[214.515219] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[214.672093] [065/133] (817s left) kms_3d (basic)
[214.705952] Starting subtest: basic
[216.203087] Subtest basic: SUCCESS (1.497s)
[216.404832] [066/133] (816s left) kms_lease (lease-invalid-connector)
[216.499858] Starting subtest: lease-invalid-connector
[216.500598] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.501343] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[216.510997] Starting dynamic subtest: pipe-B-HDMI-A-1
[216.511759] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[216.519234] Starting dynamic subtest: pipe-C-HDMI-A-1
[216.519968] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[216.527202] Starting dynamic subtest: pipe-D-HDMI-A-1
[216.527877] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[216.528620] Subtest lease-invalid-connector: SUCCESS (0.010s)
[216.581333] [067/133] (815s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[216.676120] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[216.677924] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.728374] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s)
[216.787985] Starting dynamic subtest: pipe-B-HDMI-A-1
[216.962887] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.182s)
[217.013424] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.337s)
[217.160501] [068/133] (815s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[217.252685] Starting subtest: stress-xrgb8888-xtiled
[223.658717] Subtest stress-xrgb8888-xtiled: SUCCESS (6.406s)
[223.791230] [069/133] (808s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[223.895344] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[224.205507] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.311s)
[224.343641] [070/133] (808s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[224.429018] Starting subtest: 2x-flip-vs-cursor-atomic
[224.431884] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[224.492732] [071/133] (808s left) kms_cursor_crc (cursor-random-256x256)
[224.582853] Starting subtest: cursor-random-256x256
[224.587621] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.489270] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.902s)
[226.529781] Starting dynamic subtest: pipe-D-HDMI-A-1
[228.419734] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.897s)
[228.421268] Subtest cursor-random-256x256: SUCCESS (3.838s)
[228.567539] [072/133] (804s left) gem_ppgtt (shrink-vs-evict-pinned)
[228.611220] Starting subtest: shrink-vs-evict-pinned
[233.723486] Subtest shrink-vs-evict-pinned: SUCCESS (5.078s)
[233.782709] [073/133] (799s left) syncobj_timeline (invalid-transfer-bad-pad)
[233.816330] Starting subtest: invalid-transfer-bad-pad
[233.817063] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[233.878141] [074/133] (798s left) gem_exec_balancer (sequential)
[233.919385] Starting subtest: sequential
[237.370904] Subtest sequential: SUCCESS (3.450s)
[237.553106] [075/133] (795s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[237.586513] Starting subtest: cpuset-basic-small-copy-odd
[241.150562] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.564s)
[241.210821] [076/133] (791s left) kms_flip (2x-flip-vs-panning-interruptible)
[241.346517] Starting subtest: 2x-flip-vs-panning-interruptible
[241.356039] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.009s)
[241.415021] [077/133] (791s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[241.506583] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[241.507972] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[241.587812] [078/133] (791s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[241.673958] Starting subtest: cursor-vs-flip-toggle
[273.567516] Subtest cursor-vs-flip-toggle: SUCCESS (31.893s)
[273.701875] [079/133] (759s left) gem_flink_race (flink_name)
[273.740544] Starting subtest: flink_name
[279.150032] Subtest flink_name: SUCCESS (5.376s)
[279.241819] [080/133] (753s left) gem_mmap (bad-object)
[279.276897] Starting subtest: bad-object
[279.277591] Subtest bad-object: SUCCESS (0.000s)
[279.359685] [081/133] (753s left) gem_mmap_gtt (basic-small-copy-xy)
[279.392524] Starting subtest: basic-small-copy-XY
[281.975060] Subtest basic-small-copy-XY: SUCCESS (2.582s)
[282.046645] [082/133] (751s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[282.181454] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[283.441503] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.259s)
[283.544654] [083/133] (749s left) kms_vblank (wait-busy)
[283.633837] Starting subtest: wait-busy
[283.635667] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.907956] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.271s)
[284.920038] Starting dynamic subtest: pipe-D-HDMI-A-1
[286.149164] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.239s)
[286.149850] Subtest wait-busy: SUCCESS (2.516s)
[286.305475] [084/133] (746s left) gen7_exec_parse (batch-without-end)
[286.351032] Subtest batch-without-end: SKIP (0.000s)
[286.401586] [085/133] (746s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[286.500119] Starting subtest: 4-tiled-64bpp-rotate-90
[286.501568] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[286.571453] [086/133] (746s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[286.669443] Starting subtest: y-tiled-64bpp-rotate-0
[288.051085] Subtest y-tiled-64bpp-rotate-0: SUCCESS (1.381s)
[288.174871] [087/133] (745s left) kms_draw_crc (draw-method-render)
[288.267362] Starting subtest: draw-method-render
[288.268135] Starting dynamic subtest: xrgb8888-untiled
[288.434081] Dynamic subtest xrgb8888-untiled: SUCCESS (0.166s)
[288.453273] Starting dynamic subtest: rgb565-untiled
[288.608960] Dynamic subtest rgb565-untiled: SUCCESS (0.171s)
[288.626117] Starting dynamic subtest: xrgb2101010-untiled
[288.767361] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[288.783547] Starting dynamic subtest: xbgr16161616f-untiled
[288.934070] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.164s)
[288.947601] Starting dynamic subtest: xrgb8888-xtiled
[289.025757] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[289.041840] Starting dynamic subtest: rgb565-xtiled
[289.109200] Dynamic subtest rgb565-xtiled: SUCCESS (0.080s)
[289.128312] Starting dynamic subtest: xrgb2101010-xtiled
[289.192508] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[289.210854] Starting dynamic subtest: xbgr16161616f-xtiled
[289.284076] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[289.302255] Starting dynamic subtest: xrgb8888-ytiled
[289.375909] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s)
[289.396463] Starting dynamic subtest: rgb565-ytiled
[289.467523] Dynamic subtest rgb565-ytiled: SUCCESS (0.088s)
[289.483997] Starting dynamic subtest: xrgb2101010-ytiled
[289.550927] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[289.572497] Starting dynamic subtest: xbgr16161616f-ytiled
[289.642576] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.088s)
[289.647063] Subtest draw-method-render: SUCCESS (1.377s)
[289.738948] [088/133] (743s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[289.842579] Starting subtest: verify-pxp-stale-buf-optout-execution
[290.909527] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.066s)
[291.013835] [089/133] (742s left) gem_ringfill (engines-basic)
[291.228691] Starting subtest: engines-basic
[291.231521] Starting dynamic subtest: rcs0
[291.257722] Dynamic subtest rcs0: SUCCESS (0.027s)
[291.276761] Starting dynamic subtest: bcs0
[291.287202] Dynamic subtest bcs0: SUCCESS (0.027s)
[291.301161] Starting dynamic subtest: vcs0
[291.307027] Dynamic subtest vcs0: SUCCESS (0.018s)
[291.316873] Starting dynamic subtest: vcs1
[291.323932] Dynamic subtest vcs1: SUCCESS (0.016s)
[291.333185] Starting dynamic subtest: vecs0
[291.340842] Dynamic subtest vecs0: SUCCESS (0.016s)
[291.341569] Subtest engines-basic: SUCCESS (0.113s)
[291.417151] [090/133] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[291.511262] Starting subtest: psr-2p-primscrn-cur-indfb-move
[291.512799] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[291.598304] [091/133] (741s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[291.687850] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[291.732995] [092/133] (741s left) gen9_exec_parse (unaligned-access)
[291.770066] Subtest unaligned-access: SKIP (0.000s)
[291.827895] [093/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[291.917831] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[293.135319] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.218s)
[293.253236] [094/133] (740s left) kms_joiner (invalid-modeset-big-joiner)
[293.346942] Starting subtest: invalid-modeset-big-joiner
[293.348819] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[293.404326] [095/133] (740s left) kms_plane_cursor (primary)
[293.490084] Starting subtest: primary
[293.492559] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[294.701912] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.210s)
[294.743092] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[295.943839] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.216s)
[295.984795] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[297.185616] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.216s)
[297.269588] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[298.513809] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.252s)
[298.545139] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[299.747346] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.216s)
[299.779275] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[300.980963] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.216s)
[301.054444] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[302.306636] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.259s)
[302.336783] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[303.540159] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.216s)
[303.568969] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[304.773687] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.216s)
[304.847281] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[306.096522] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.256s)
[306.124324] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[307.321835] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.208s)
[307.349384] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[308.546972] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.208s)
[308.613591] Subtest primary: SUCCESS (15.123s)
[308.721409] [096/133] (724s left) gem_busy (busy)
[308.768294] Starting subtest: busy
[308.769013] Starting dynamic subtest: all-engines
[308.813553] Dynamic subtest all-engines: SUCCESS (0.045s)
[308.822668] Starting dynamic subtest: rcs0
[308.831796] Dynamic subtest rcs0: SUCCESS (0.017s)
[308.844251] Starting dynamic subtest: bcs0
[308.848215] Dynamic subtest bcs0: SUCCESS (0.015s)
[308.857315] Starting dynamic subtest: vcs0
[308.860655] Dynamic subtest vcs0: SUCCESS (0.011s)
[308.869452] Starting dynamic subtest: vcs1
[308.875277] Dynamic subtest vcs1: SUCCESS (0.014s)
[308.884257] Starting dynamic subtest: vecs0
[308.898745] Dynamic subtest vecs0: SUCCESS (0.022s)
[308.899541] Subtest busy: SUCCESS (0.131s)
[309.242286] [097/133] (724s left) gem_exec_reloc (basic-wc-read)
[309.278981] Starting subtest: basic-wc-read
[309.284285] Subtest basic-wc-read: SUCCESS (0.005s)
[309.404425] [098/133] (724s left) kms_flip (flip-vs-fences)
[309.490688] Starting subtest: flip-vs-fences
[309.492415] Starting dynamic subtest: A-HDMI-A1
[317.179919] Dynamic subtest A-HDMI-A1: SUCCESS (7.687s)
[317.188973] Starting dynamic subtest: B-HDMI-A1
[324.865376] Dynamic subtest B-HDMI-A1: SUCCESS (7.655s)
[324.872636] Starting dynamic subtest: C-HDMI-A1
[332.531185] Dynamic subtest C-HDMI-A1: SUCCESS (7.664s)
[332.540106] Starting dynamic subtest: D-HDMI-A1
[340.194575] Dynamic subtest D-HDMI-A1: SUCCESS (7.691s)
[340.198603] Subtest flip-vs-fences: SUCCESS (30.709s)
[340.355931] [099/133] (693s left) gem_mmap_gtt (basic-copy)
[340.392369] Starting subtest: basic-copy
[340.861880] Subtest basic-copy: SUCCESS (0.462s)
[340.948207] [100/133] (692s left) gem_exec_schedule (u-semaphore-codependency)
[341.001174] Starting subtest: u-semaphore-codependency
[341.009019] Subtest u-semaphore-codependency: SUCCESS (0.008s)
[341.314776] [101/133] (692s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[341.404853] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[341.407063] Starting dynamic subtest: pipe-A-HDMI-A-1
[341.413997] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[341.421840] Starting dynamic subtest: pipe-B-HDMI-A-1
[341.428364] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[341.435916] Starting dynamic subtest: pipe-C-HDMI-A-1
[341.442446] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[341.450109] Starting dynamic subtest: pipe-D-HDMI-A-1
[341.456767] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[341.458078] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[341.645266] [102/133] (692s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[341.737335] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[341.739807] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[341.801562] [103/133] (692s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[341.887794] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[341.890099] Starting dynamic subtest: pipe-A-HDMI-A-1
[341.897851] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[341.909208] Starting dynamic subtest: pipe-B-HDMI-A-1
[341.916767] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[341.927419] Starting dynamic subtest: pipe-C-HDMI-A-1
[341.934954] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[341.942843] Starting dynamic subtest: pipe-D-HDMI-A-1
[341.950472] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[341.951872] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[342.135805] [104/133] (691s left) i915_pm_rc6_residency (rc6-idle)
[342.171209] Starting subtest: rc6-idle
[342.175079] Subtest rc6-idle: SKIP (0.004s)
[342.237284] [105/133] (691s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[342.322988] Starting subtest: primary-y-tiled-reflect-x-0
[347.196664] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.874s)
[347.382976] [106/133] (686s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[347.473064] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[347.475541] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[347.532479] [107/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[347.621675] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[347.623009] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[347.706096] [108/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[347.794877] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[347.796257] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[347.892704] [109/133] (686s left) kms_psr (pr-cursor-plane-move)
[347.977747] Subtest pr-cursor-plane-move: SKIP (0.000s)
[348.018905] [110/133] (686s left) gem_create (create-ext-set-pat)
[348.164707] Starting subtest: create-ext-set-pat
[348.166916] Subtest create-ext-set-pat: SKIP (0.000s)
[348.252562] [111/133] (686s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[348.341721] Starting subtest: psr-rgb565-draw-mmap-wc
[348.343062] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[348.432113] [112/133] (685s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[348.521876] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[349.728855] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.207s)
[349.858229] [113/133] (684s left) kms_psr (psr-suspend)
[349.949560] Subtest psr-suspend: SKIP (0.000s)
[349.994630] [114/133] (684s left) kms_atomic_transition (plane-all-transition-nonblocking)
[350.081851] Starting subtest: plane-all-transition-nonblocking
[350.084061] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.053831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.970s)
[352.127067] Starting dynamic subtest: pipe-B-HDMI-A-1
[354.191774] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.072s)
[354.241463] Subtest plane-all-transition-nonblocking: SUCCESS (4.159s)
[354.410962] [115/133] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[354.505819] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[354.507198] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[354.601115] [116/133] (679s left) i915_drm_fdinfo (virtual-busy-hang-all)
[354.637559] Starting subtest: virtual-busy-hang-all
[355.662558] Subtest virtual-busy-hang-all: SUCCESS (1.024s)
[355.731155] [117/133] (678s left) syncobj_timeline (single-wait-all-available-submitted)
[355.765120] Starting subtest: single-wait-all-available-submitted
[355.765826] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[355.827295] [118/133] (678s left) gem_exec_flush (basic-uc-pro-default)
[355.869851] Starting subtest: basic-uc-pro-default
[361.296038] Subtest basic-uc-pro-default: SUCCESS (5.427s)
[361.497880] [119/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[361.594780] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[361.596116] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.684399] [120/133] (673s left) kms_prop_blob (blob-prop-lifetime)
[361.718037] Starting subtest: blob-prop-lifetime
[361.718751] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[361.783065] [121/133] (672s left) perf_pmu (most-busy-idle-check-all)
[361.819330] Starting subtest: most-busy-idle-check-all
[361.820100] Starting dynamic subtest: rcs0
[362.438110] Dynamic subtest rcs0: SUCCESS (0.617s)
[362.449711] Starting dynamic subtest: bcs0
[363.057181] Dynamic subtest bcs0: SUCCESS (0.617s)
[363.068427] Starting dynamic subtest: vcs0
[363.677762] Dynamic subtest vcs0: SUCCESS (0.617s)
[363.687604] Starting dynamic subtest: vcs1
[364.297211] Dynamic subtest vcs1: SUCCESS (0.619s)
[364.308890] Starting dynamic subtest: vecs0
[364.918105] Dynamic subtest vecs0: SUCCESS (0.617s)
[364.919120] Subtest most-busy-idle-check-all: SUCCESS (3.099s)
[364.989841] [122/133] (669s left) gem_ctx_freq (sysfs)
[365.027956] Starting subtest: sysfs
[365.028686] Starting dynamic subtest: gt0
[370.011205] Dynamic subtest gt0: SUCCESS (4.983s)
[370.014142] Subtest sysfs: SUCCESS (4.985s)
[370.082836] [123/133] (664s left) kms_getfb (getfb-handle-closed)
[370.171909] Starting subtest: getfb-handle-closed
[370.172639] Subtest getfb-handle-closed: SUCCESS (0.000s)
[370.271866] [124/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[370.360881] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[370.362305] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.440532] [125/133] (664s left) api_intel_bb (object-reloc-keep-cache)
[370.473870] Starting subtest: object-reloc-keep-cache
[370.477236] Subtest object-reloc-keep-cache: SUCCESS (0.004s)
[370.589974] [126/133] (664s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[370.684540] Starting subtest: 4-tiled-16bpp-rotate-0
[370.685978] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[370.777129] [127/133] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[370.867601] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[370.869055] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[370.954683] [128/133] (664s left) i915_suspend (basic-s3-without-i915)
[370.987256] Starting subtest: basic-s3-without-i915