[60.701986] Initializing watchdogs
[60.702066]   /dev/watchdog0
[60.707548] [001/130] (960s left) gem_ctx_persistence (process)
[60.754556] Starting subtest: process
[60.879570] Subtest process: SUCCESS (0.124s)
[60.966981] [002/130] (960s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[61.148069] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[61.207945] [003/130] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[61.322914] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[61.323630] Starting dynamic subtest: pipe-A-valid-mode
[61.381522] Dynamic subtest pipe-A-valid-mode: SKIP (0.056s)
[61.383172] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.057s)
[61.489969] [004/130] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[61.616013] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[61.617291] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[61.738597] [005/130] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[61.854350] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[61.855665] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.960566] [006/130] (959s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[62.084054] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[62.481463] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.400s)
[62.676411] [007/130] (958s left) gem_exec_balancer (parallel-ordering)
[62.840227] Subtest parallel-ordering: SKIP (0.000s)
[62.927268] [008/130] (958s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[63.052981] Starting subtest: 4-tiled-8bpp-rotate-180
[63.054296] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[63.174333] [009/130] (958s left) kms_lease (master-vs-lease)
[63.286832] Starting subtest: master-vs-lease
[63.288314] Subtest master-vs-lease: SUCCESS (0.001s)
[63.360419] [010/130] (958s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[63.475818] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[63.476486] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.479113] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[63.483443] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.486088] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[63.487406] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[63.738153] [011/130] (957s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[63.777305] Starting subtest: single-wait-for-submit-available-submitted
[63.778004] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[63.866662] [012/130] (957s left) gem_userptr_blits (dmabuf-unsync)
[63.913543] Subtest dmabuf-unsync: SKIP (0.000s)
[64.075016] [013/130] (957s left) gem_media_vme
[64.150980] [014/130] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[64.271334] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[64.272663] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[64.397238] [015/130] (957s left) gem_exec_fence (syncobj-unused-fence)
[64.760266] Starting subtest: syncobj-unused-fence
[64.762348] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[65.078344] [016/130] (956s left) gem_mmap_offset (mmap-boundaries)
[65.118340] Starting subtest: mmap-boundaries
[65.119800] Starting dynamic subtest: smem0
[65.388752] Dynamic subtest smem0: SUCCESS (0.271s)
[65.389441] Subtest mmap-boundaries: SUCCESS (0.272s)
[65.551151] [017/130] (956s left) gem_exec_schedule (u-semaphore-user)
[65.601602] Starting subtest: u-semaphore-user
[65.606828] Subtest u-semaphore-user: SUCCESS (0.005s)
[65.943164] [018/130] (955s left) gem_softpin (noreloc-interruptible)
[65.990227] Starting subtest: noreloc-interruptible
[71.399292] Subtest noreloc-interruptible: SUCCESS (5.420s)
[71.544863] [019/130] (950s left) gem_linear_blits (basic)
[71.789028] Starting subtest: basic
[71.798216] Subtest basic: SUCCESS (0.009s)
[71.952295] [020/130] (949s left) gem_spin_batch (spin-each)
[72.043155] Starting subtest: spin-each
[75.388988] Subtest spin-each: SUCCESS (3.350s)
[75.589281] [021/130] (946s left) gem_pipe_control_store_loop (fresh-buffer)
[75.629430] Starting subtest: fresh-buffer
[77.778529] Subtest fresh-buffer: SUCCESS (2.150s)
[77.895583] [022/130] (943s left) kms_psr (fbc-pr-primary-blt)
[78.017455] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[78.047823] [023/130] (943s left) syncobj_wait (invalid-signal-zero-handles)
[78.095765] Starting subtest: invalid-signal-zero-handles
[78.096461] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[78.184360] [024/130] (943s left) kms_psr (fbc-psr2-suspend)
[78.297452] Subtest fbc-psr2-suspend: SKIP (0.000s)
[78.311314] [025/130] (943s left) syncobj_basic (bad-destroy)
[78.350714] Starting subtest: bad-destroy
[78.351389] Subtest bad-destroy: SUCCESS (0.000s)
[78.422240] [026/130] (943s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[78.542838] Starting subtest: fbc-tiling-linear
[80.884177] Subtest fbc-tiling-linear: SUCCESS (2.343s)
[81.062665] [027/130] (940s left) vgem_basic (unload)
[81.102944] Starting subtest: unload
[110.271837] Subtest unload: SUCCESS (29.170s)
[110.402230] [028/130] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[110.528412] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[114.010789] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.483s)
[114.190478] [029/130] (907s left) drm_mm (drm_mm)
[114.229670] Starting subtest: drm_mm
[114.233265] Starting dynamic subtest: drm_test_mm_init
[114.350552] Dynamic subtest drm_test_mm_init: SUCCESS (0.117s)
[114.359534] Starting dynamic subtest: drm_test_mm_debug
[114.477217] Dynamic subtest drm_test_mm_debug: SUCCESS (0.126s)
[114.494951] Starting dynamic subtest: drm_test_mm_align32
[114.589431] Dynamic subtest drm_test_mm_align32: SUCCESS (0.112s)
[114.607215] Starting dynamic subtest: drm_test_mm_align64
[114.728734] Dynamic subtest drm_test_mm_align64: SUCCESS (0.138s)
[114.746227] Starting dynamic subtest: drm_test_mm_lowest
[114.849045] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.121s)
[114.866811] Starting dynamic subtest: drm_test_mm_highest
[114.986204] Dynamic subtest drm_test_mm_highest: SUCCESS (0.136s)
[114.987403] Subtest drm_mm: SUCCESS (0.756s)
[115.148806] [030/130] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[115.266356] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[115.267674] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[115.383817] [031/130] (906s left) gem_workarounds (suspend-resume)
[115.447524] Starting subtest: suspend-resume
[132.939714] Subtest suspend-resume: SUCCESS (17.491s)
[138.047440] [032/130] (888s left) gem_pread (self)
[138.094974] Subtest self: SKIP (0.000s)
[138.144614] [033/130] (888s left) gem_exec_capture (capture)
[138.185662] Starting subtest: capture
[138.186323] Starting dynamic subtest: rcs0-smem
[139.457854] Dynamic subtest rcs0-smem: SUCCESS (1.271s)
[139.463662] Starting dynamic subtest: bcs0-smem
[140.727548] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[140.733374] Starting dynamic subtest: vcs0-smem
[141.998760] Dynamic subtest vcs0-smem: SUCCESS (1.272s)
[142.004627] Starting dynamic subtest: vecs0-smem
[143.270910] Dynamic subtest vecs0-smem: SUCCESS (1.272s)
[143.271571] Subtest capture: SUCCESS (5.085s)
[143.405945] [034/130] (883s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[143.521814] Starting subtest: fb-8bpc-vs-panel-6bpc
[143.522506] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.569801] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.046s)
[143.571270] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.047s)
[143.741055] [035/130] (883s left) kms_invalid_mode (bad-vsync-end)
[143.855518] Starting subtest: bad-vsync-end
[143.856218] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.906612] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[143.915962] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.916870] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[143.917686] Subtest bad-vsync-end: SUCCESS (0.053s)
[144.082251] [036/130] (882s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[144.197851] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[144.232923] [037/130] (882s left) gem_ctx_param (invalid-param-get)
[144.271511] Starting subtest: invalid-param-get
[144.272208] Subtest invalid-param-get: SUCCESS (0.000s)
[144.350225] [038/130] (882s left) syncobj_basic (bad-flags-handle-to-fd)
[144.390246] Starting subtest: bad-flags-handle-to-fd
[144.390933] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[144.477227] [039/130] (882s left) kms_plane_cursor (primary)
[144.590773] Starting subtest: primary
[144.592116] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[147.330134] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.738s)
[147.405812] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[150.138298] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.751s)
[150.204493] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[152.927343] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.731s)
[153.017627] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[155.772341] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.760s)
[155.818763] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[158.542500] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.732s)
[158.589594] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[161.312708] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.732s)
[161.402201] Subtest primary: SUCCESS (16.810s)
[161.511743] [040/130] (865s left) drm_fdinfo (busy-hang)
[161.554782] Starting subtest: busy-hang
[161.555438] Starting dynamic subtest: rcs0
[162.586590] Dynamic subtest rcs0: SUCCESS (1.031s)
[162.594413] Starting dynamic subtest: bcs0
[163.620542] Dynamic subtest bcs0: SUCCESS (1.034s)
[163.628482] Starting dynamic subtest: vcs0
[164.656748] Dynamic subtest vcs0: SUCCESS (1.035s)
[164.663837] Starting dynamic subtest: vecs0
[165.687465] Dynamic subtest vecs0: SUCCESS (1.032s)
[165.688810] Subtest busy-hang: SUCCESS (4.132s)
[165.768265] [041/130] (861s left) kms_big_fb (linear-64bpp-rotate-180)
[165.889052] Starting subtest: linear-64bpp-rotate-180
[168.018424] Subtest linear-64bpp-rotate-180: SUCCESS (2.129s)
[168.200272] [042/130] (858s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[168.375410] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[168.439253] [043/130] (858s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[168.559182] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[168.560515] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[168.667283] [044/130] (858s left) gem_ctx_isolation (preservation)
[168.715242] Starting subtest: preservation
[168.715945] Starting dynamic subtest: rcs0
[168.803781] Dynamic subtest rcs0: SUCCESS (0.088s)
[168.809639] Starting dynamic subtest: bcs0
[168.963914] Dynamic subtest bcs0: SUCCESS (0.160s)
[168.969866] Starting dynamic subtest: vcs0
[169.100862] Dynamic subtest vcs0: SUCCESS (0.137s)
[169.106800] Starting dynamic subtest: vecs0
[169.267407] Dynamic subtest vecs0: SUCCESS (0.166s)
[169.268089] Subtest preservation: SUCCESS (0.552s)
[169.488269] [045/130] (857s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[169.607876] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[169.609276] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.616325] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[169.622083] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.629400] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[169.630817] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[169.844235] [046/130] (857s left) syncobj_wait (wait-for-submit-delayed-submit)
[169.878514] Starting subtest: wait-for-submit-delayed-submit
[169.981149] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[170.071039] [047/130] (857s left) gem_pxp (reject-modify-context-protection-off-3)
[291.090032] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[292.460522] Closing watchdogs
[292.463516] Initializing watchdogs
[292.463554]   /dev/watchdog0
[292.470552] [048/130] (734s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[292.580442] Starting subtest: fbcpsr-slowdraw
[292.581782] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[292.713422] [049/130] (734s left) gem_exec_params (invalid-ring)
[292.751909] Starting subtest: invalid-ring
[292.752868] Subtest invalid-ring: SUCCESS (0.000s)
[292.864896] [050/130] (734s left) gem_exec_schedule (preempt-engines)
[292.913636] Starting subtest: preempt-engines
[292.914487] Starting dynamic subtest: rcs0
[292.979168] Dynamic subtest rcs0: SUCCESS (0.065s)
[292.985209] Starting dynamic subtest: bcs0
[293.044547] Dynamic subtest bcs0: SUCCESS (0.065s)
[293.051278] Starting dynamic subtest: vcs0
[293.104746] Dynamic subtest vcs0: SUCCESS (0.060s)
[293.110947] Starting dynamic subtest: vecs0
[293.168627] Dynamic subtest vecs0: SUCCESS (0.064s)
[293.169359] Subtest preempt-engines: SUCCESS (0.255s)
[293.481753] [051/130] (733s left) gem_eio (wait-immediate)
[293.524017] Starting subtest: wait-immediate
[293.671199] Subtest wait-immediate: SUCCESS (0.145s)
[293.832168] [052/130] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[293.946401] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[293.947718] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[294.079756] [053/130] (733s left) gem_busy (extended)
[294.258339] Starting subtest: extended
[294.259105] Starting dynamic subtest: rcs0
[294.349518] Dynamic subtest rcs0: SUCCESS (0.090s)
[294.369554] Starting dynamic subtest: bcs0
[294.384387] Dynamic subtest bcs0: SUCCESS (0.034s)
[294.399540] Starting dynamic subtest: vcs0
[294.415125] Dynamic subtest vcs0: SUCCESS (0.030s)
[294.429734] Starting dynamic subtest: vecs0
[294.443044] Dynamic subtest vecs0: SUCCESS (0.027s)
[294.444122] Subtest extended: SUCCESS (0.185s)
[294.716302] [054/130] (732s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[294.829793] Starting subtest: psr-rgb101010-draw-mmap-gtt
[294.831207] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[294.971433] [055/130] (732s left) gem_userptr_blits (readonly-unsync)
[295.015207] Subtest readonly-unsync: SKIP (0.000s)
[295.171869] [056/130] (732s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[295.283865] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[295.284536] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.291021] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[295.297080] Starting dynamic subtest: pipe-B-HDMI-A-1
[295.303550] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[295.304864] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[295.487987] [057/130] (731s left) kms_cursor_crc (cursor-onscreen-512x170)
[295.604489] Starting subtest: cursor-onscreen-512x170
[295.605850] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[295.729252] [058/130] (731s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[295.849092] Starting subtest: 4-tiled-32bpp-rotate-90
[295.850406] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[295.965620] [059/130] (731s left) kms_flip (plain-flip-ts-check-interruptible)
[296.085222] Starting subtest: plain-flip-ts-check-interruptible
[296.086746] Starting dynamic subtest: A-HDMI-A1
[311.579135] Dynamic subtest A-HDMI-A1: SUCCESS (15.492s)
[311.588584] Starting dynamic subtest: B-HDMI-A1
[327.035473] Dynamic subtest B-HDMI-A1: SUCCESS (15.454s)
[327.039534] Subtest plain-flip-ts-check-interruptible: SUCCESS (30.952s)
[327.237569] [060/130] (700s left) kms_pm_rpm (pc8-residency)
[328.893379] Starting subtest: pc8-residency
[328.895596] Subtest pc8-residency: SKIP (0.000s)
[329.068155] [061/130] (698s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[329.110180] Starting subtest: multi-wait-available-unsubmitted-submitted
[329.110932] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[329.192200] [062/130] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[329.308439] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[329.309762] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[329.422233] [063/130] (698s left) kms_content_protection (atomic)
[329.542226] Starting subtest: atomic
[329.720239] Subtest atomic: SKIP (0.175s)
[329.908225] [064/130] (697s left) gem_exec_schedule (lateslice)
[329.953491] Starting subtest: lateslice
[329.954212] Starting dynamic subtest: rcs0
[329.968840] Dynamic subtest rcs0: SUCCESS (0.016s)
[329.975237] Starting dynamic subtest: bcs0
[329.982061] Dynamic subtest bcs0: SUCCESS (0.013s)
[329.988145] Starting dynamic subtest: vcs0
[329.994826] Dynamic subtest vcs0: SUCCESS (0.012s)
[330.001008] Starting dynamic subtest: vecs0
[330.006796] Dynamic subtest vecs0: SUCCESS (0.012s)
[330.007451] Subtest lateslice: SUCCESS (0.054s)
[330.319738] [065/130] (697s left) gem_exec_whisper (basic-contexts-priority)
[330.372103] Starting subtest: basic-contexts-priority
[332.705820] Subtest basic-contexts-priority: SUCCESS (2.333s)
[332.904748] [066/130] (694s left) sysfs_heartbeat_interval (mixed)
[332.944800] Starting subtest: mixed
[332.945470] Starting dynamic subtest: vecs0
[338.107234] Dynamic subtest vecs0: SUCCESS (5.161s)
[338.116294] Starting dynamic subtest: vcs0
[343.230322] Dynamic subtest vcs0: SUCCESS (5.122s)
[343.239342] Starting dynamic subtest: bcs0
[348.424171] Dynamic subtest bcs0: SUCCESS (5.192s)
[348.433784] Starting dynamic subtest: rcs0
[353.580233] Dynamic subtest rcs0: SUCCESS (5.154s)
[353.581476] Subtest mixed: SUCCESS (20.635s)
[353.665238] [067/130] (674s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[353.784517] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[353.785886] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[353.930470] [068/130] (673s left) api_intel_bb (crc32)
[353.968139] Starting subtest: crc32
[353.969457] Subtest crc32: SKIP (0.000s)
[354.092849] [069/130] (673s left) gem_partial_pwrite_pread (reads-display)
[354.138843] Subtest reads-display: SKIP (0.000s)
[354.219172] [070/130] (673s left) gen9_exec_parse (batch-zero-length)
[354.259446] Subtest batch-zero-length: SKIP (0.000s)
[354.282276] [071/130] (673s left) kms_vblank (wait-busy)
[354.428930] Starting subtest: wait-busy
[354.430730] Starting dynamic subtest: pipe-A-HDMI-A-1
[357.192493] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.762s)
[357.202517] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.852448] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.658s)
[359.853128] Subtest wait-busy: SUCCESS (5.423s)
[360.010013] [072/130] (667s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[360.119939] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[360.120674] Starting dynamic subtest: pipe-A-HDMI-A-1
[361.277784] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.153s)
[361.288715] Starting dynamic subtest: pipe-B-HDMI-A-1
[362.013872] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.732s)
[362.015378] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (1.890s)
[362.247688] [073/130] (665s left) gem_readwrite (write-bad-handle)
[362.282985] Subtest write-bad-handle: SKIP (0.000s)
[362.338444] [074/130] (665s left) kms_sequence (get-forked-busy)
[362.448885] Starting subtest: get-forked-busy
[362.449568] Starting dynamic subtest: pipe-A-HDMI-A-1
[365.262712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.812s)
[365.288915] Starting dynamic subtest: pipe-B-HDMI-A-1
[368.021792] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.756s)
[368.022719] Subtest get-forked-busy: SUCCESS (5.572s)
[368.159385] [075/130] (659s left) gem_lmem_evict (dontneed-evict-race)
[368.200370] Subtest dontneed-evict-race: SKIP (0.000s)
[368.215725] [076/130] (659s left) gem_set_tiling_vs_pwrite
[368.326307] [077/130] (659s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[368.441807] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[368.462963] [078/130] (659s left) gem_eio (in-flight-10ms)
[368.500885] Starting subtest: in-flight-10ms
[370.704282] Subtest in-flight-10ms: SUCCESS (2.204s)
[370.856820] [079/130] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[370.972500] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[370.973839] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[371.091246] [080/130] (656s left) perf_pmu (busy-no-semaphores)
[371.131849] Starting subtest: busy-no-semaphores
[371.132539] Starting dynamic subtest: rcs0
[371.702413] Dynamic subtest rcs0: SUCCESS (0.570s)
[371.713765] Starting dynamic subtest: bcs0
[372.229379] Dynamic subtest bcs0: SUCCESS (0.525s)
[372.240690] Starting dynamic subtest: vcs0
[372.752695] Dynamic subtest vcs0: SUCCESS (0.522s)
[372.764503] Starting dynamic subtest: vecs0
[373.275366] Dynamic subtest vecs0: SUCCESS (0.521s)
[373.276579] Subtest busy-no-semaphores: SUCCESS (2.144s)
[373.378080] [081/130] (654s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[373.420155] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[373.420856] Starting dynamic subtest: smem
[373.503935] Dynamic subtest smem: SUCCESS (0.083s)
[373.504639] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.084s)
[373.710904] [082/130] (654s left) kms_plane_scaling (2x-scaler-multi-pipe)
[373.830877] Starting subtest: 2x-scaler-multi-pipe
[373.832194] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[373.977697] [083/130] (654s left) kms_cursor_edge_walk (256x256-top-bottom)
[374.089921] Starting subtest: 256x256-top-bottom
[374.091465] Starting dynamic subtest: pipe-A-HDMI-A-1
[377.794824] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.704s)
[377.804045] Starting dynamic subtest: pipe-B-HDMI-A-1
[381.406204] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.609s)
[381.406943] Subtest 256x256-top-bottom: SUCCESS (7.316s)
[381.526976] [084/130] (646s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[381.635980] Starting subtest: bad-aux-stride-y-tiled-ccs
[381.636705] Starting dynamic subtest: pipe-A-HDMI-A-1
[381.643365] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[381.650539] Starting dynamic subtest: pipe-B-HDMI-A-1
[381.657220] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[381.658537] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.002s)
[381.876944] [085/130] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[381.989568] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[381.990874] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[382.106751] [086/130] (646s left) kms_addfb_basic (basic)
[382.144397] Starting subtest: basic
[382.145087] Subtest basic: SUCCESS (0.000s)
[382.354306] [087/130] (645s left) gen3_mixed_blits
[382.423986] [088/130] (645s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[382.535558] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[382.536923] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[382.676995] [089/130] (645s left) kms_async_flips (invalid-async-flip-atomic)
[382.787293] Starting subtest: invalid-async-flip-atomic
[382.981296] Starting dynamic subtest: pipe-A-HDMI-A-1
[383.156043] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.174s)
[383.312190] Starting dynamic subtest: pipe-B-HDMI-A-1
[383.412188] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.106s)
[383.412926] Subtest invalid-async-flip-atomic: SUCCESS (0.625s)
[383.685968] [090/130] (644s left) kms_chamelium_hpd (dp-hpd)
[383.854453] Subtest dp-hpd: SKIP (0.000s)
[383.922889] [091/130] (644s left) kms_flip (dpms-vs-vblank-race-interruptible)
[384.039400] Starting subtest: dpms-vs-vblank-race-interruptible
[384.041023] Starting dynamic subtest: A-HDMI-A1
[389.542890] Dynamic subtest A-HDMI-A1: SUCCESS (5.501s)
[389.553651] Starting dynamic subtest: B-HDMI-A1
[394.989685] Dynamic subtest B-HDMI-A1: SUCCESS (5.445s)
[394.991887] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (10.951s)
[395.183780] [092/130] (633s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[395.295070] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[395.295753] Starting dynamic subtest: pipe-A
[397.309277] Dynamic subtest pipe-A: SUCCESS (2.013s)
[397.328915] Starting dynamic subtest: pipe-B
[399.239156] Dynamic subtest pipe-B: SUCCESS (1.927s)
[399.243190] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.945s)
[399.463313] [093/130] (628s left) kms_flip (2x-wf_vblank-ts-check)
[399.573446] Starting subtest: 2x-wf_vblank-ts-check
[399.574809] Subtest 2x-wf_vblank-ts-check: SKIP (0.001s)
[399.690998] [094/130] (628s left) gem_close (many-handles-one-vma)
[399.730152] Starting subtest: many-handles-one-vma
[399.749030] Subtest many-handles-one-vma: SUCCESS (0.019s)
[399.879594] [095/130] (628s left) gem_ctx_param (set-priority-range)
[399.915508] Starting subtest: set-priority-range
[399.935619] Subtest set-priority-range: SUCCESS (0.021s)
[400.030676] [096/130] (628s left) syncobj_eventfd (timeline-wait-before-signal)
[400.068117] Starting subtest: timeline-wait-before-signal
[400.099359] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[400.203079] [097/130] (628s left) kms_addfb_basic (addfb25-4-tiled)
[400.313261] Starting subtest: addfb25-4-tiled
[400.313957] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[400.423672] [098/130] (628s left) kms_psr (psr-cursor-blt)
[400.536507] Subtest psr-cursor-blt: SKIP (0.000s)
[400.585899] [099/130] (627s left) perf_pmu (semaphore-wait)
[400.624696] Starting subtest: semaphore-wait
[400.625364] Starting dynamic subtest: rcs0
[401.133733] Dynamic subtest rcs0: SUCCESS (0.508s)
[401.145092] Starting dynamic subtest: bcs0
[401.645567] Dynamic subtest bcs0: SUCCESS (0.509s)
[401.657095] Starting dynamic subtest: vcs0
[402.158100] Dynamic subtest vcs0: SUCCESS (0.509s)
[402.169887] Starting dynamic subtest: vecs0
[402.670533] Dynamic subtest vecs0: SUCCESS (0.508s)
[402.672509] Subtest semaphore-wait: SUCCESS (2.047s)
[402.790612] [100/130] (625s left) i915_hangman (detector)
[402.830815] Starting subtest: detector
[402.831556] Starting dynamic subtest: rcs0
[412.018831] Dynamic subtest rcs0: SUCCESS (9.187s)
[412.041458] Starting dynamic subtest: bcs0
[422.034777] Dynamic subtest bcs0: SUCCESS (10.013s)
[422.056819] Starting dynamic subtest: vcs0
[432.047884] Dynamic subtest vcs0: SUCCESS (10.010s)
[432.073217] Starting dynamic subtest: vecs0
[441.040632] Dynamic subtest vecs0: SUCCESS (8.988s)
[441.044709] Subtest detector: SUCCESS (38.211s)
[441.148545] [101/130] (587s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[441.184489] Starting subtest: invalid-signal-one-illegal-handle
[441.185163] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[441.281745] [102/130] (587s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[441.395349] Starting subtest: cursorB-vs-flipA-varying-size
[441.397953] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[441.489774] [103/130] (587s left) i915_pm_rpm (gem-evict-pwrite)
[442.940118] Starting subtest: gem-evict-pwrite
[443.499903] Subtest gem-evict-pwrite: SUCCESS (0.560s)
[443.701803] [104/130] (585s left) kms_psr (psr-sprite-mmap-cpu)
[443.815590] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[443.837310] [105/130] (584s left) kms_writeback (writeback-fb-id-xrgb2101010)
[443.949429] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[443.990756] [106/130] (584s left) kms_psr (pr-primary-mmap-gtt)
[444.104572] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[444.154353] [107/130] (584s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[444.265776] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[444.267082] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[444.398468] [108/130] (584s left) gem_ctx_shared (q-smoketest-all)
[444.445985] Starting subtest: Q-smoketest-all
[476.750103] Subtest Q-smoketest-all: SUCCESS (32.295s)
[476.958008] [109/130] (551s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[477.068432] Starting subtest: primary-yf-tiled-reflect-x-90
[477.184083] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.114s)
[477.282928] [110/130] (551s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[477.393167] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[477.394870] Starting dynamic subtest: pipe-A-valid-mode
[478.106500] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.712s)
[478.107250] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.713s)
[478.279792] [111/130] (550s left) kms_frontbuffer_tracking (fbc-stridechange)
[478.394747] Starting subtest: fbc-stridechange
[480.431415] Subtest fbc-stridechange: SUCCESS (2.037s)
[480.642493] [112/130] (548s left) gem_render_copy_redux (flink)
[480.680327] Starting subtest: flink
[481.442236] Subtest flink: SUCCESS (0.762s)
[481.594048] [113/130] (547s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[481.631591] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[481.733472] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[481.828361] [114/130] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[481.939735] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[481.941078] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[482.060158] [115/130] (546s left) kms_cursor_crc (cursor-sliding-32x32)
[482.171856] Starting subtest: cursor-sliding-32x32
[482.205339] Subtest cursor-sliding-32x32: SKIP (0.032s)
[482.329828] [116/130] (546s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[482.439082] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[482.439765] Starting dynamic subtest: pipe-A
[482.892588] Dynamic subtest pipe-A: SKIP (0.451s)
[482.900268] Starting dynamic subtest: pipe-B
[483.561484] Dynamic subtest pipe-B: SKIP (0.668s)
[483.562799] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (1.120s)
[483.690033] [117/130] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[483.800793] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[486.313291] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.513s)
[486.505128] [118/130] (542s left) kms_rotation_crc (bad-tiling)
[486.615165] Starting subtest: bad-tiling
[488.754936] Subtest bad-tiling: SUCCESS (2.140s)
[488.950819] [119/130] (540s left) kms_pm_dc (dc6-psr)
[490.073683] Starting subtest: dc6-psr
[490.075039] Subtest dc6-psr: SKIP (0.000s)
[490.147922] [120/130] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[490.257718] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[490.259019] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[490.404281] [121/130] (538s left) gem_exec_flush (basic-uc-set-default)
[490.449487] Starting subtest: basic-uc-set-default
[495.936163] Subtest basic-uc-set-default: SUCCESS (5.487s)
[496.168368] [122/130] (533s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[496.299660] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[496.301336] Starting dynamic subtest: pipe-A-valid-mode
[496.361555] Dynamic subtest pipe-A-valid-mode: SKIP (0.060s)
[496.362926] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.062s)
[496.562592] [123/130] (532s left) gen7_exec_parse (batch-without-end)
[496.600897] Subtest batch-without-end: SKIP (0.000s)
[496.644224] [124/130] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[496.758707] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[496.759992] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[496.892067] [125/130] (532s left) gem_ctx_isolation (clean)
[496.936013] Starting subtest: clean
[496.936730] Starting dynamic subtest: rcs0
[496.955445] Dynamic subtest rcs0: SUCCESS (0.019s)
[496.964173] Starting dynamic subtest: bcs0
[497.032704] Dynamic subtest bcs0: SUCCESS (0.076s)
[497.040470] Starting dynamic subtest: vcs0
[497.126929] Dynamic subtest vcs0: SUCCESS (0.093s)
[497.134447] Starting dynamic subtest: vecs0
[497.217258] Dynamic subtest vecs0: SUCCESS (0.090s)
[497.218030] Subtest clean: SUCCESS (0.282s)
[497.407746] [126/130] (531s left) kms_addfb_basic (too-high)
[497.517121] Starting subtest: too-high
[497.517822] Subtest too-high: SUCCESS (0.001s)
[497.654894] [127/130] (531s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[497.689485] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[497.797663] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[497.901992] [128/130] (531s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[498.020222] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[498.429592] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.409s)
[498.657830] [129/130] (530s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[498.767615] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[498.812589] [130/130] (530s left) api_intel_bb (render)
[498.848584] Starting subtest: render
[498.849293] Starting dynamic subtest: render-none-512
[498.924857] Dynamic subtest render-none-512: SUCCESS (0.076s)
[498.932420] Starting dynamic subtest: render-none-1024
[499.243642] Dynamic subtest render-none-1024: SUCCESS (0.318s)
[499.251143] Starting dynamic subtest: render-x-512
[499.311975] Dynamic subtest render-x-512: SUCCESS (0.068s)
[499.319458] Starting dynamic subtest: render-x-1024
[499.600222] Dynamic subtest render-x-1024: SUCCESS (0.287s)
[499.607648] Starting dynamic subtest: render-y-512
[499.669051] Dynamic subtest render-y-512: SUCCESS (0.068s)
[499.676515] Starting dynamic subtest: render-y-1024
[499.957587] Dynamic subtest render-y-1024: SUCCESS (0.287s)
[499.958297] Subtest render: SUCCESS (1.110s)
[500.101347] Closing watchdogs
Done.