[41.709581] Initializing watchdogs
[41.709660]   /dev/watchdog0
[41.717729] [001/133] (960s left) gem_exec_store (dword)
[41.815693] Starting subtest: dword
[41.818456] Starting dynamic subtest: rcs0
[41.883584] Dynamic subtest rcs0: SUCCESS (0.067s)
[41.901743] Starting dynamic subtest: bcs0
[41.934155] Dynamic subtest bcs0: SUCCESS (0.050s)
[41.948783] Starting dynamic subtest: vcs0
[43.463948] Dynamic subtest vcs0: SUCCESS (1.528s)
[43.477166] Starting dynamic subtest: vcs1
[45.447285] Dynamic subtest vcs1: SUCCESS (1.982s)
[45.459961] Starting dynamic subtest: vecs0
[47.494748] Dynamic subtest vecs0: SUCCESS (2.048s)
[47.508498] Starting dynamic subtest: ccs0
[47.547126] Dynamic subtest ccs0: SUCCESS (0.054s)
[47.550314] Subtest dword: SUCCESS (5.731s)
[47.725231] [002/133] (954s left) gem_shrink (reclaim)
[47.807682] Starting subtest: reclaim
[50.093771] Subtest reclaim: SUCCESS (2.288s)
[50.195656] [003/133] (952s left) gem_close_race (multigpu-basic-process)
[50.297781] Starting subtest: multigpu-basic-process
[50.302626] Subtest multigpu-basic-process: SKIP (0.000s)
[50.508340] [004/133] (951s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[50.621553] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[51.435654] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.819s)
[51.618954] [005/133] (950s left) gem_eio (execbuf)
[51.822106] Starting subtest: execbuf
[52.143611] Subtest execbuf: SUCCESS (0.322s)
[52.274513] [006/133] (950s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[52.352589] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[52.354974] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[52.424706] [007/133] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[52.503234] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[54.986842] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.487s)
[55.090742] [008/133] (947s left) kms_psr (psr-sprite-plane-onoff)
[55.201092] Starting subtest: psr-sprite-plane-onoff
[55.203462] Starting dynamic subtest: eDP-1
[57.048676] Dynamic subtest eDP-1: SUCCESS (1.847s)
[57.051277] Subtest psr-sprite-plane-onoff: SUCCESS (1.848s)
[57.980291] [009/133] (944s left) v3d/v3d_wait_bo (bad-pad)
[58.048328] Subtest bad-pad: SKIP (0.000s)
[58.097906] [010/133] (944s left) v3d/v3d_submit_cl (job-perfmon)
[58.198939] Subtest job-perfmon: SKIP (0.000s)
[58.248846] [011/133] (944s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[58.361823] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[58.364391] Starting dynamic subtest: pipe-A-default-mode
[58.652576] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[58.657657] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[59.586225] [012/133] (942s left) gem_spin_batch (engines)
[59.653018] Starting subtest: engines
[59.655549] Starting dynamic subtest: rcs0
[62.894806] Dynamic subtest rcs0: SUCCESS (3.237s)
[62.908555] Starting dynamic subtest: bcs0
[66.130364] Dynamic subtest bcs0: SUCCESS (3.236s)
[66.143212] Starting dynamic subtest: vcs0
[69.362706] Dynamic subtest vcs0: SUCCESS (3.231s)
[69.376257] Starting dynamic subtest: vcs1
[72.596623] Dynamic subtest vcs1: SUCCESS (3.234s)
[72.610854] Starting dynamic subtest: vecs0
[75.831082] Dynamic subtest vecs0: SUCCESS (3.234s)
[75.844477] Starting dynamic subtest: ccs0
[79.069399] Dynamic subtest ccs0: SUCCESS (3.237s)
[79.072178] Subtest engines: SUCCESS (19.411s)
[79.280317] [013/133] (923s left) kms_flip (2x-flip-vs-dpms)
[79.370873] Starting subtest: 2x-flip-vs-dpms
[79.380974] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[79.451390] [014/133] (923s left) gem_ctx_param (invalid-param-set)
[79.535077] Starting subtest: invalid-param-set
[79.537960] Subtest invalid-param-set: SUCCESS (0.000s)
[79.605330] [015/133] (922s left) gen9_exec_parse (bb-start-far)
[79.680804] Subtest bb-start-far: SKIP (0.000s)
[79.737980] [016/133] (922s left) gem_pread (exhaustion)
[79.792256] Subtest exhaustion: SKIP (0.000s)
[79.826842] [017/133] (922s left) kms_psr (pr-primary-mmap-gtt)
[79.902524] Starting subtest: pr-primary-mmap-gtt
[79.907578] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[79.966437] [018/133] (922s left) gem_pxp (hw-rejects-pxp-context)
[82.571305] Starting subtest: hw-rejects-pxp-context
[82.574392] Subtest hw-rejects-pxp-context: SUCCESS (0.002s)
[82.663249] [019/133] (920s left) i915_pm_rpm (system-suspend-execbuf)
[84.610464] Starting subtest: system-suspend-execbuf
[184.724314] Subtest system-suspend-execbuf: SUCCESS (84.847s)
[185.550806] [020/133] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[185.671473] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[185.676446] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[185.754840] [021/133] (832s left) kms_vblank (query-forked)
[185.852189] Starting subtest: query-forked
[185.854687] Starting dynamic subtest: pipe-A-eDP-1
[187.677592] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[187.694137] Starting dynamic subtest: pipe-D-eDP-1
[190.270268] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[190.272613] Subtest query-forked: SUCCESS (4.415s)
[191.196747] [022/133] (826s left) perf_pmu (busy-double-start)
[191.242073] Starting subtest: busy-double-start
[191.245191] Starting dynamic subtest: rcs0
[194.815123] Dynamic subtest rcs0: SUCCESS (3.575s)
[194.833133] Starting dynamic subtest: bcs0
[198.411783] Dynamic subtest bcs0: SUCCESS (3.597s)
[198.428753] Starting dynamic subtest: vcs0
[202.209881] Dynamic subtest vcs0: SUCCESS (3.796s)
[202.227382] Starting dynamic subtest: vcs1
[206.272751] Dynamic subtest vcs1: SUCCESS (4.065s)
[206.289502] Starting dynamic subtest: vecs0
[210.223931] Dynamic subtest vecs0: SUCCESS (3.951s)
[210.240173] Starting dynamic subtest: ccs0
[213.858452] Dynamic subtest ccs0: FAIL (3.586s)
[213.860849] Subtest busy-double-start: FAIL (22.570s)
[213.896612] [023/133] (804s left) debugfs_test (sysfs)
[213.967740] Starting subtest: sysfs
[214.006576] Subtest sysfs: SUCCESS (0.036s)
[214.075368] [024/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[214.184963] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[214.863588] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[215.021215] [025/133] (803s left) vc4/vc4_tiling (get-bad-handle)
[215.108806] Subtest get-bad-handle: SKIP (0.000s)
[215.158733] [026/133] (802s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[215.219251] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[215.259359] [027/133] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[215.363950] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[220.786907] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.426s)
[220.904144] [028/133] (797s left) kms_properties (get_properties-sanity-non-atomic)
[220.987433] Starting subtest: get_properties-sanity-non-atomic
[220.989914] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[221.055216] [029/133] (797s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[221.124723] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[221.176501] [030/133] (797s left) syncobj_wait (wait-any-interrupted)
[221.254596] Starting subtest: wait-any-interrupted
[221.362850] Subtest wait-any-interrupted: SUCCESS (0.106s)
[221.428911] [031/133] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[221.501473] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[221.506266] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[221.580256] [032/133] (796s left) kms_chamelium_hpd (vga-hpd)
[221.972452] Subtest vga-hpd: SKIP (0.000s)
[222.858824] [033/133] (795s left) kms_pm_backlight (basic-brightness)
[222.932356] Starting subtest: basic-brightness
[223.000178] Starting dynamic subtest: eDP-1
[223.533437] Dynamic subtest eDP-1: SUCCESS (0.532s)
[223.536390] Subtest basic-brightness: SUCCESS (0.603s)
[224.424311] [034/133] (793s left) kms_atomic_transition (modeset-transition-fencing)
[224.509362] Starting subtest: modeset-transition-fencing
[224.512195] Starting dynamic subtest: 1x-outputs
[236.672335] Dynamic subtest 1x-outputs: SUCCESS (12.162s)
[236.972787] Subtest modeset-transition-fencing: SUCCESS (12.463s)
[237.859043] [035/133] (780s left) gem_exec_fence (syncobj-timeline-signal)
[238.474959] Starting subtest: syncobj-timeline-signal
[238.488689] Subtest syncobj-timeline-signal: SUCCESS (0.015s)
[239.786329] [036/133] (778s left) gem_ctx_persistence (engines-hang)
[239.853155] Starting subtest: engines-hang
[239.855562] Starting dynamic subtest: rcs0
[239.904179] Dynamic subtest rcs0: SUCCESS (0.047s)
[239.920818] Starting dynamic subtest: bcs0
[239.984297] Dynamic subtest bcs0: SUCCESS (0.082s)
[240.002204] Starting dynamic subtest: vcs0
[240.058509] Dynamic subtest vcs0: SUCCESS (0.074s)
[240.076451] Starting dynamic subtest: vcs1
[240.173902] Dynamic subtest vcs1: SUCCESS (0.114s)
[240.192095] Starting dynamic subtest: vecs0
[240.260448] Dynamic subtest vecs0: SUCCESS (0.086s)
[240.277842] Starting dynamic subtest: ccs0
[240.347732] Dynamic subtest ccs0: SUCCESS (0.086s)
[240.350584] Subtest engines-hang: SUCCESS (0.494s)
[240.426200] [037/133] (778s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[240.515704] Starting subtest: cursorB-vs-flipA-atomic
[240.520517] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[240.611493] [038/133] (777s left) vgem_basic (mmap)
[240.679139] Starting subtest: mmap
[240.685368] Subtest mmap: SUCCESS (0.008s)
[240.725509] [039/133] (777s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[240.792594] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[240.794772] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[240.876083] [040/133] (777s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[240.956645] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[240.958921] Starting dynamic subtest: pipe-A-default-mode
[241.277643] Dynamic subtest pipe-A-default-mode: SKIP (0.320s)
[241.282717] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.321s)
[242.124221] [041/133] (776s left) gem_mmap_gtt (basic-write-gtt)
[242.191867] Subtest basic-write-gtt: SKIP (0.000s)
[242.242645] [042/133] (776s left) syncobj_timeline (invalid-transfer-illegal-handle)
[242.317332] Starting subtest: invalid-transfer-illegal-handle
[242.319998] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[242.397634] [043/133] (776s left) gem_userptr_blits (nohangcheck)
[242.503401] Starting subtest: nohangcheck
[242.761397] Subtest nohangcheck: SUCCESS (0.258s)
[242.864469] [044/133] (775s left) gem_exec_balancer (bonded-chain)
[242.930034] Starting subtest: bonded-chain
[249.677752] Subtest bonded-chain: SUCCESS (6.746s)
[250.760373] [045/133] (767s left) kms_psr (psr2-no-drrs)
[250.849070] Starting subtest: psr2-no-drrs
[250.851655] Starting dynamic subtest: eDP-1
[252.550715] Dynamic subtest eDP-1: SUCCESS (1.700s)
[252.553355] Subtest psr2-no-drrs: SUCCESS (1.700s)
[253.478297] [046/133] (765s left) syncobj_eventfd (binary-wait-before-signal)
[253.529609] Starting subtest: binary-wait-before-signal
[253.561221] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[253.625424] [047/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[253.740027] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[253.744030] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.815506] [048/133] (764s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[253.933650] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[258.413834] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.482s)
[258.538692] [049/133] (760s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[258.630028] Starting subtest: fbc-psr2-sprite-mmap-gtt
[258.632585] Starting dynamic subtest: eDP-1
[258.637589] Dynamic subtest eDP-1: SKIP (0.000s)
[258.642705] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[258.696903] [050/133] (760s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[258.806588] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[258.811343] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[258.892074] [051/133] (759s left) kms_color (gamma)
[258.982854] Starting subtest: gamma
[258.985082] Starting dynamic subtest: pipe-A
[259.760394] Dynamic subtest pipe-A: SUCCESS (0.779s)
[259.779055] Starting dynamic subtest: pipe-B
[261.286654] Dynamic subtest pipe-B: SUCCESS (1.527s)
[261.301520] Starting dynamic subtest: pipe-C
[262.745985] Dynamic subtest pipe-C: SUCCESS (1.456s)
[262.764081] Starting dynamic subtest: pipe-D
[264.211831] Dynamic subtest pipe-D: SUCCESS (1.464s)
[264.213964] Subtest gamma: SUCCESS (5.229s)
[265.116526] [052/133] (753s left) vgem_basic (second-client)
[265.184506] Starting subtest: second-client
[265.208118] Subtest second-client: SUCCESS (0.022s)
[265.261786] [053/133] (753s left) gem_exec_balancer (invalid-balancer)
[265.336223] Starting subtest: invalid-balancer
[265.937203] Subtest invalid-balancer: SUCCESS (0.599s)
[266.203596] [054/133] (752s left) syncobj_timeline (wait-any-complex)
[266.274601] Starting subtest: wait-any-complex
[266.338283] Subtest wait-any-complex: SUCCESS (0.063s)
[266.407396] [055/133] (752s left) kms_pm_rpm (modeset-non-lpsp)
[267.925668] Starting subtest: modeset-non-lpsp
[271.754290] Subtest modeset-non-lpsp: SKIP (3.825s)
[272.592948] [056/133] (746s left) gem_render_copy (y-tiled-ccs-to-linear)
[272.676262] Starting subtest: y-tiled-ccs-to-linear
[272.681088] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[272.860006] [057/133] (746s left) perf (polling-parameterized)
[272.994592] Starting subtest: polling-parameterized
[293.022884] Subtest polling-parameterized: SUCCESS (20.028s)
[293.064332] [058/133] (725s left) i915_hangman (engine-error-state-capture)
[293.142986] Starting subtest: engine-error-state-capture
[293.145438] Starting dynamic subtest: rcs0
[296.707900] Dynamic subtest rcs0: SUCCESS (3.565s)
[296.727403] Starting dynamic subtest: bcs0
[302.724876] Dynamic subtest bcs0: SUCCESS (6.015s)
[302.744067] Starting dynamic subtest: vcs0
[308.676123] Dynamic subtest vcs0: SUCCESS (5.951s)
[308.694935] Starting dynamic subtest: vcs1
[314.692165] Dynamic subtest vcs1: SUCCESS (6.015s)
[314.711001] Starting dynamic subtest: vecs0
[320.708091] Dynamic subtest vecs0: SUCCESS (6.015s)
[320.726534] Starting dynamic subtest: ccs0
[326.724448] Dynamic subtest ccs0: SUCCESS (6.016s)
[326.727307] Subtest engine-error-state-capture: SUCCESS (33.582s)
[326.808066] [059/133] (692s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[326.915319] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[326.917832] Starting dynamic subtest: pipe-A-eDP-1
[331.848705] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.935s)
[331.866888] Starting dynamic subtest: pipe-B-eDP-1
[337.878284] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.028s)
[337.899642] Starting dynamic subtest: pipe-C-eDP-1
[339.262368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[339.280285] Starting dynamic subtest: pipe-D-eDP-1
[340.647766] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[340.653195] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (13.736s)
[341.941069] [060/133] (677s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[342.040737] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[342.043252] Starting dynamic subtest: pipe-A-eDP-1
[342.048073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[342.064933] Starting dynamic subtest: pipe-B-eDP-1
[342.069575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[342.077739] Starting dynamic subtest: pipe-C-eDP-1
[342.082201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[342.088800] Starting dynamic subtest: pipe-D-eDP-1
[342.093312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[342.097724] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[342.115507] [061/133] (677s left) kms_psr (fbc-pr-primary-render)
[342.181160] Starting subtest: fbc-pr-primary-render
[342.185039] Subtest fbc-pr-primary-render: SKIP (0.000s)
[342.256076] [062/133] (676s left) kms_dsc (dsc-with-output-formats-with-bpc)
[342.367337] Starting subtest: dsc-with-output-formats-with-bpc
[342.372012] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[342.436594] [063/133] (676s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[342.553237] Starting subtest: psr-rgb565-draw-pwrite
[347.527676] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.982s)
[347.637984] [064/133] (671s left) gem_userptr_blits (input-checking)
[347.724712] Starting subtest: input-checking
[347.726997] Subtest input-checking: SUCCESS (0.000s)
[347.838222] [065/133] (671s left) kms_cursor_crc (cursor-sliding-max-size)
[348.136065] Starting subtest: cursor-sliding-max-size
[348.143831] Subtest cursor-sliding-max-size: SKIP (0.000s)
[348.249932] [066/133] (671s left) prime_udl
[348.353097] [067/133] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[348.438127] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[348.442148] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.526217] [068/133] (670s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[348.577286] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[348.579446] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[348.657199] [069/133] (670s left) kms_big_joiner (basic)
[348.746778] Subtest basic: SKIP (0.000s)
[348.773409] [070/133] (670s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[348.835828] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[348.838051] Starting dynamic subtest: pipe-A-eDP-1
[348.843913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.852735] Starting dynamic subtest: pipe-B-eDP-1
[348.858736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.873280] Starting dynamic subtest: pipe-C-eDP-1
[348.878887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.888481] Starting dynamic subtest: pipe-D-eDP-1
[348.894599] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.898446] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[348.916881] [071/133] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[349.007448] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[349.010923] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[349.083872] [072/133] (670s left) i915_pm_rps (min-max-config-loaded)
[349.173864] Starting subtest: min-max-config-loaded
[349.178841] Subtest min-max-config-loaded: SKIP (0.001s)
[349.216445] [073/133] (670s left) kms_chamelium_color (ctm-0-25)
[349.274137] Subtest ctm-0-25: SKIP (0.000s)
[349.305361] [074/133] (670s left) syncobj_wait (invalid-reset-one-illegal-handle)
[349.365682] Starting subtest: invalid-reset-one-illegal-handle
[349.367836] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[349.449836] [075/133] (670s left) gem_ctx_shared (exec-single-timeline)
[349.535252] Starting subtest: exec-single-timeline
[349.538013] Starting dynamic subtest: rcs0
[350.659251] Dynamic subtest rcs0: SUCCESS (1.122s)
[350.678477] Starting dynamic subtest: bcs0
[351.747207] Dynamic subtest bcs0: SUCCESS (1.085s)
[351.766721] Starting dynamic subtest: vcs0
[352.835139] Dynamic subtest vcs0: SUCCESS (1.086s)
[352.854721] Starting dynamic subtest: vcs1
[353.923239] Dynamic subtest vcs1: SUCCESS (1.086s)
[353.942415] Starting dynamic subtest: vecs0
[355.010950] Dynamic subtest vecs0: SUCCESS (1.086s)
[355.030565] Starting dynamic subtest: ccs0
[356.099178] Dynamic subtest ccs0: SUCCESS (1.086s)
[356.101833] Subtest exec-single-timeline: SUCCESS (6.563s)
[356.756898] [076/133] (662s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[356.844862] Starting subtest: yf-tiled-32bpp-rotate-90
[356.849079] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[356.930376] [077/133] (662s left) gem_mmap_gtt (zero-extend)
[357.001927] Subtest zero-extend: SKIP (0.000s)
[357.039758] [078/133] (662s left) kms_plane_lowres (tiling-x)
[357.124007] Starting subtest: tiling-x
[357.126344] Starting dynamic subtest: pipe-A-eDP-1
[357.130995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.428880] Starting dynamic subtest: pipe-B-eDP-1
[357.434071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.445011] Starting dynamic subtest: pipe-C-eDP-1
[357.449175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.455931] Starting dynamic subtest: pipe-D-eDP-1
[357.460168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.464431] Subtest tiling-x: SKIP (0.305s)
[358.314474] [079/133] (661s left) kms_lease (lease-unleased-crtc)
[358.396505] Starting subtest: lease-unleased-crtc
[358.399157] Starting dynamic subtest: pipe-A-eDP-1
[358.684387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[358.706519] Starting dynamic subtest: pipe-B-eDP-1
[359.517083] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.828s)
[359.541016] Starting dynamic subtest: pipe-C-eDP-1
[359.543747] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[359.555667] Starting dynamic subtest: pipe-D-eDP-1
[359.558160] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[359.560621] Subtest lease-unleased-crtc: SUCCESS (1.144s)
[359.864871] [080/133] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[359.966668] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[359.971334] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.063451] [081/133] (659s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[360.160419] Starting subtest: x-tiled-16bpp-rotate-0
[361.550370] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.391s)
[361.673112] [082/133] (658s left) gem_mmap_gtt (basic-small-copy)
[361.736158] Subtest basic-small-copy: SKIP (0.000s)
[361.771233] [083/133] (657s left) kms_frontbuffer_tracking (psr-1p-rte)
[361.878981] Starting subtest: psr-1p-rte
[365.384350] Subtest psr-1p-rte: SUCCESS (3.508s)
[365.494192] [084/133] (654s left) kms_flip (2x-wf_vblank-ts-check)
[365.596527] Starting subtest: 2x-wf_vblank-ts-check
[365.607219] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[365.685815] [085/133] (654s left) gem_exec_reloc (basic-cpu-wc-active)
[365.751579] Subtest basic-cpu-wc-active: SKIP (0.000s)
[365.807013] [086/133] (654s left) gem_exec_params (invalid-bsd-ring)
[365.865443] Starting subtest: invalid-bsd-ring
[365.867771] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[365.964148] [087/133] (653s left) kms_cursor_crc (cursor-alpha-opaque)
[366.039473] Starting subtest: cursor-alpha-opaque
[366.042200] Starting dynamic subtest: pipe-A-eDP-1
[366.783375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[366.802868] Starting dynamic subtest: pipe-D-eDP-1
[368.237440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.451s)
[368.239592] Subtest cursor-alpha-opaque: SUCCESS (2.199s)
[369.131697] [088/133] (650s left) gem_tiled_swapping (non-threaded)
[369.186733] Subtest non-threaded: SKIP (0.000s)
[369.231451] [089/133] (650s left) fbdev (pan)
[369.298042] Starting subtest: pan
[369.320459] Subtest pan: SUCCESS (0.026s)
[369.391772] [090/133] (650s left) gem_ppgtt (blt-vs-render-ctxn)
[369.472003] Starting subtest: blt-vs-render-ctxN
[402.500471] Subtest blt-vs-render-ctxN: SUCCESS (33.026s)
[402.637919] [091/133] (617s left) kms_psr (fbc-pr-no-drrs)
[402.795520] Starting subtest: fbc-pr-no-drrs
[402.799584] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[402.862350] [092/133] (617s left) perf_pmu (frequency)
[402.923431] Starting subtest: frequency
[402.928661] Starting dynamic subtest: gt0
[405.019223] Dynamic subtest gt0: SUCCESS (2.085s)
[405.037258] Starting dynamic subtest: idle-gt0
[405.539505] Dynamic subtest idle-gt0: SUCCESS (0.520s)
[405.559380] Starting dynamic subtest: gt1
[409.759197] Dynamic subtest gt1: SUCCESS (4.214s)
[409.779663] Starting dynamic subtest: idle-gt1
[410.262255] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[410.265694] Subtest frequency: SUCCESS (7.339s)
[410.353749] [093/133] (609s left) perf (non-system-wide-paranoid)
[410.486622] Starting subtest: non-system-wide-paranoid
[410.523692] Subtest non-system-wide-paranoid: SUCCESS (0.038s)
[410.563260] [094/133] (609s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[415.862426] Starting subtest: cursor-plane-move-continuous-exceed-fully-sf
[415.865764] Starting dynamic subtest: psr2-pipe-A-eDP-1
[427.674235] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (11.806s)
[427.691946] Starting dynamic subtest: psr2-pipe-B-eDP-1
[439.480724] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (11.806s)
[439.483884] Subtest cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.619s)
[440.422876] [095/133] (579s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[440.495606] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[440.499810] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[440.576368] [096/133] (579s left) kms_invalid_mode (bad-hsync-start)
[440.642523] Starting subtest: bad-hsync-start
[440.644852] Starting dynamic subtest: pipe-A-eDP-1
[440.925710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[440.939716] Starting dynamic subtest: pipe-B-eDP-1
[440.942294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[440.951835] Starting dynamic subtest: pipe-C-eDP-1
[440.954448] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[440.963052] Starting dynamic subtest: pipe-D-eDP-1
[440.965735] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[440.968338] Subtest bad-hsync-start: SUCCESS (0.297s)
[441.821843] [097/133] (578s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[441.884519] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[441.985520] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[442.063306] [098/133] (578s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[442.166834] Starting subtest: cursorB-vs-flipB-legacy
[442.171426] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[442.261704] [099/133] (578s left) gem_partial_pwrite_pread (reads-snoop)
[442.336990] Subtest reads-snoop: SKIP (0.000s)
[442.385060] [100/133] (577s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[442.439770] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[442.443344] Starting dynamic subtest: pipe-A-eDP-1
[442.445727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[442.465098] Starting dynamic subtest: pipe-B-eDP-1
[442.467846] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[442.481675] Starting dynamic subtest: pipe-C-eDP-1
[442.484624] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[442.494077] Starting dynamic subtest: pipe-D-eDP-1
[442.496330] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[442.498660] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[442.528669] [101/133] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[442.630508] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[442.635779] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.712674] [102/133] (577s left) gem_exec_balancer (sliced)
[442.798948] Starting subtest: sliced
[442.803873] Subtest sliced: SKIP (0.000s)
[443.078493] [103/133] (577s left) vgem_basic (dmabuf-fence-before)
[443.145451] Starting subtest: dmabuf-fence-before
[443.148062] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[443.200174] [104/133] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[443.309585] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[447.897414] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.591s)
[448.020738] [105/133] (572s left) gem_exec_whisper (basic-queues)
[448.101351] Starting subtest: basic-queues
[453.704528] Subtest basic-queues: SUCCESS (5.599s)
[453.888087] [106/133] (566s left) kms_vrr (flip-suspend)
[454.005929] Starting subtest: flip-suspend
[454.010214] Subtest flip-suspend: SKIP (0.000s)
[454.075846] [107/133] (566s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[454.184975] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[454.187733] Starting dynamic subtest: pipe-A-eDP-1
[454.193170] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[454.212691] Starting dynamic subtest: pipe-B-eDP-1
[454.217907] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[454.237267] Starting dynamic subtest: pipe-C-eDP-1
[454.241789] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[454.254667] Starting dynamic subtest: pipe-D-eDP-1
[454.259129] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[454.263628] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.013s)
[454.286413] [108/133] (566s left) api_intel_bb (destroy-bb)
[454.353898] Starting subtest: destroy-bb
[454.375437] Subtest destroy-bb: SUCCESS (0.021s)
[454.458789] [109/133] (566s left) v3d/v3d_perfmon (create-single-perfmon)
[454.533641] Subtest create-single-perfmon: SKIP (0.000s)
[454.584430] [110/133] (566s left) gem_exec_schedule (preempt-queue-contexts-chain)
[454.661852] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[454.958689] [111/133] (565s left) gem_create (create-ext-placement-sanity-check)
[455.144619] Starting subtest: create-ext-placement-sanity-check
[455.147577] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[455.238884] [112/133] (565s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[455.334695] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[455.339605] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[455.423447] [113/133] (565s left) gem_eio (in-flight-immediate)
[455.649424] Starting subtest: in-flight-immediate
[464.926147] Subtest in-flight-immediate: SUCCESS (9.277s)
[465.061497] [114/133] (555s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[465.158927] Starting subtest: addfb25-y-tiled-legacy
[465.160980] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[465.252209] [115/133] (555s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[465.342991] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[465.345686] Starting dynamic subtest: pipe-A-eDP-1
[465.370677] Dynamic subtest pipe-A-eDP-1: SKIP (0.020s)
[465.390660] Starting dynamic subtest: pipe-B-eDP-1
[465.395502] Dynamic subtest pipe-B-eDP-1: SKIP (0.020s)
[465.410158] Starting dynamic subtest: pipe-C-eDP-1
[465.414843] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[465.425616] Starting dynamic subtest: pipe-D-eDP-1
[465.429991] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s)
[465.434301] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.081s)
[465.498116] [116/133] (555s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[465.559135] Starting subtest: single-wait-for-submit-available-signaled
[465.561503] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[465.641274] [117/133] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[465.728747] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[465.733513] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[465.813525] [118/133] (555s left) core_auth (getclient-simple)
[465.863308] Starting subtest: getclient-simple
[465.874533] Subtest getclient-simple: SUCCESS (0.009s)
[465.974463] [119/133] (554s left) kms_cursor_crc (cursor-random-128x42)
[466.240537] Starting subtest: cursor-random-128x42
[466.270304] Subtest cursor-random-128x42: SKIP (0.026s)
[466.496899] [120/133] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[466.592025] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[466.595781] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.669073] [121/133] (554s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[466.739001] Starting subtest: invalid-bsd2-flag-on-vebox
[466.741063] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[466.821224] [122/133] (554s left) gem_eio (in-flight-suspend)
[467.070332] Starting subtest: in-flight-suspend
[511.051302] Subtest in-flight-suspend: SUCCESS (14.693s)
[511.178030] [123/133] (539s left) kms_cursor_legacy (torture-move)
[511.297926] Starting subtest: torture-move
[511.300612] Starting dynamic subtest: pipe-A
[516.980158] Dynamic subtest pipe-A: SUCCESS (5.679s)
[517.000801] Starting dynamic subtest: pipe-B
[523.021595] Dynamic subtest pipe-B: SUCCESS (6.039s)
[523.037017] Starting dynamic subtest: pipe-C
[529.741597] Dynamic subtest pipe-C: SUCCESS (6.720s)
[529.760912] Starting dynamic subtest: pipe-D
[536.294664] Dynamic subtest pipe-D: SUCCESS (6.553s)
[536.320528] Starting dynamic subtest: all-pipes
[543.219408] Dynamic subtest all-pipes: SUCCESS (6.923s)
[543.221999] Subtest torture-move: SUCCESS (31.920s)
[543.384065] [124/133] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[543.476250] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[543.480090] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[543.563330] [125/133] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[543.672047] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[543.676096] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[543.751027] [126/133] (506s left) gem_exec_fence (submit3)
[543.966200] Starting subtest: submit3
[543.971258] Subtest submit3: SKIP (0.000s)
[545.032157] [127/133] (505s left) kms_tiled_display (basic-test-pattern)
[545.143486] Subtest basic-test-pattern: SKIP (0.000s)
[545.174472] [128/133] (505s left) gem_userptr_blits (unsync-unmap-cycles)
[545.264851] Subtest unsync-unmap-cycles: SKIP (0.000s)
[545.373038] [129/133] (505s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[545.735719] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[546.603411] [130/133] (503s left) gem_exec_schedule (pi-ringfull)
[546.814606] Starting subtest: pi-ringfull
[546.817178] Starting dynamic subtest: rcs0
[546.902076] Dynamic subtest rcs0: SUCCESS (0.089s)
[546.931445] Starting dynamic subtest: bcs0
[546.988745] Dynamic subtest bcs0: SUCCESS (0.085s)
[547.018712] Starting dynamic subtest: vcs0
[547.075178] Dynamic subtest vcs0: SUCCESS (0.085s)
[547.102969] Starting dynamic subtest: vcs1
[547.161839] Dynamic subtest vcs1: SUCCESS (0.085s)
[547.190088] Starting dynamic subtest: vecs0
[547.248516] Dynamic subtest vecs0: SUCCESS (0.085s)
[547.275810] Starting dynamic subtest: ccs0
[547.334731] Dynamic subtest ccs0: SUCCESS (0.085s)
[547.337727] Subtest pi-ringfull: SUCCESS (0.524s)
[547.553431] [131/133] (502s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[547.623823] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[547.628767] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[547.810463] [132/133] (502s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[547.906939] Starting subtest: basic-flip-before-cursor-varying-size
[548.990324] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.084s)
[549.905995] [133/133] (500s left) kms_getfb (getfb2-handle-protection)
[549.973764] Starting subtest: getfb2-handle-protection
[549.996161] Subtest getfb2-handle-protection: SUCCESS (0.023s)
[550.095182] Closing watchdogs
Done.