[38.123580] Initializing watchdogs
[38.123879]   /dev/watchdog0
[38.139092] [001/136] (960s left) gem_exec_suspend (basic-s4-devices)
[38.378684] Starting subtest: basic-S4-devices
[38.383285] Starting dynamic subtest: smem
[50.019434] Dynamic subtest smem: SUCCESS (11.642s)
[50.020611] Subtest basic-S4-devices: SUCCESS (11.642s)
[54.218219] [002/136] (948s left) kms_universal_plane (universal-plane-pipe-a-functional)
[54.508182] Starting subtest: universal-plane-pipe-A-functional
[57.048367] Subtest universal-plane-pipe-A-functional: SUCCESS (2.540s)
[57.427712] [003/136] (945s left) perf_pmu (semaphore-busy)
[57.622631] Starting subtest: semaphore-busy
[57.624305] Starting dynamic subtest: rcs0
[59.192573] Dynamic subtest rcs0: SUCCESS (1.568s)
[59.208503] Starting dynamic subtest: bcs0
[60.761638] Dynamic subtest bcs0: SUCCESS (1.569s)
[60.779765] Starting dynamic subtest: vcs0
[62.324403] Dynamic subtest vcs0: SUCCESS (1.560s)
[62.339637] Starting dynamic subtest: vecs0
[63.879636] Dynamic subtest vecs0: SUCCESS (1.554s)
[63.881053] Subtest semaphore-busy: SUCCESS (6.254s)
[63.977749] [004/136] (938s left) syncobj_wait (multi-wait-submitted)
[64.164288] Starting subtest: multi-wait-submitted
[64.267347] Subtest multi-wait-submitted: SUCCESS (0.102s)
[64.343873] [005/136] (938s left) gem_exec_schedule (smoketest)
[64.684320] Starting subtest: smoketest
[64.685660] Starting dynamic subtest: rcs0
[70.144725] Dynamic subtest rcs0: SUCCESS (5.455s)
[70.163746] Starting dynamic subtest: bcs0
[75.588078] Dynamic subtest bcs0: SUCCESS (5.443s)
[75.605208] Starting dynamic subtest: vcs0
[81.025303] Dynamic subtest vcs0: SUCCESS (5.437s)
[81.041830] Starting dynamic subtest: vecs0
[86.478250] Dynamic subtest vecs0: SUCCESS (5.452s)
[86.479686] Subtest smoketest: SUCCESS (21.789s)
[86.661457] [006/136] (916s left) api_intel_bb (crc32)
[86.842769] Starting subtest: crc32
[86.845296] Subtest crc32: SKIP (0.000s)
[86.928149] [007/136] (915s left) gem_wait (write-busy)
[87.136980] Starting subtest: write-busy
[87.138687] Starting dynamic subtest: all-engines
[87.752671] Dynamic subtest all-engines: SUCCESS (0.615s)
[87.775289] Starting dynamic subtest: rcs0
[88.279156] Dynamic subtest rcs0: SUCCESS (0.525s)
[88.296341] Starting dynamic subtest: bcs0
[88.802417] Dynamic subtest bcs0: SUCCESS (0.523s)
[88.820596] Starting dynamic subtest: vcs0
[89.321523] Dynamic subtest vcs0: SUCCESS (0.519s)
[89.338764] Starting dynamic subtest: vecs0
[89.839553] Dynamic subtest vecs0: SUCCESS (0.518s)
[89.840825] Subtest write-busy: SUCCESS (2.703s)
[90.062224] [008/136] (912s left) gem_eio (wait-1us)
[90.271586] Starting subtest: wait-1us
[90.361463] Subtest wait-1us: SUCCESS (0.090s)
[90.550030] [009/136] (912s left) i915_hangman (hangcheck-unterminated)
[90.752144] Starting subtest: hangcheck-unterminated
[100.769699] Subtest hangcheck-unterminated: SUCCESS (10.019s)
[100.897090] [010/136] (902s left) gem_exec_fence (syncobj-wait)
[101.513230] Starting subtest: syncobj-wait
[101.554122] Subtest syncobj-wait: SUCCESS (0.041s)
[101.883665] [011/136] (901s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[102.304238] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[102.315475] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.009s)
[102.403571] [012/136] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[102.703346] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[102.705860] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[102.797331] [013/136] (900s left) kms_atomic_interruptible (universal-setplane-primary)
[103.077400] Starting subtest: universal-setplane-primary
[103.080175] Starting dynamic subtest: DP-1-pipe-A
[109.610632] Dynamic subtest DP-1-pipe-A: SUCCESS (6.527s)
[109.615026] Subtest universal-setplane-primary: SUCCESS (6.530s)
[109.945982] [014/136] (893s left) gem_exec_whisper (basic-queues-forked)
[110.147986] Starting subtest: basic-queues-forked
[121.051074] Subtest basic-queues-forked: SUCCESS (10.901s)
[121.244717] [015/136] (881s left) gem_exec_params (no-blt)
[121.433359] Starting subtest: no-blt
[121.436896] Subtest no-blt: SUCCESS (0.003s)
[121.543029] [016/136] (881s left) gem_flink_basic (bad-flink)
[121.721321] Starting subtest: bad-flink
[121.722640] Subtest bad-flink: SUCCESS (0.000s)
[121.793329] [017/136] (881s left) v3d/v3d_get_param (base-params)
[122.028893] Subtest base-params: SKIP (0.000s)
[122.092981] [018/136] (881s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[122.279630] Starting subtest: no-spare-fences-busy
[124.444045] Subtest no-spare-fences-busy: SUCCESS (2.164s)
[124.812484] [019/136] (878s left) kms_flip (wf_vblank-ts-check-interruptible)
[125.082302] Starting subtest: wf_vblank-ts-check-interruptible
[125.085777] Starting dynamic subtest: A-DP1
[136.155193] Dynamic subtest A-DP1: SUCCESS (11.068s)
[136.174479] Starting dynamic subtest: B-DP1
[146.899453] Dynamic subtest B-DP1: SUCCESS (10.744s)
[146.918076] Starting dynamic subtest: C-DP1
[157.629467] Dynamic subtest C-DP1: SUCCESS (10.730s)
[157.631104] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.549s)
[158.037406] [020/136] (845s left) prime_mmap_coherency (read)
[158.228884] Starting subtest: read
[163.636035] Subtest read: SUCCESS (5.405s)
[163.753273] [021/136] (839s left) syncobj_timeline (single-wait-all-signaled)
[163.936744] Starting subtest: single-wait-all-signaled
[163.938901] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[164.018876] [022/136] (839s left) kms_vblank (pipe-d-wait-forked)
[164.297862] Subtest pipe-D-wait-forked: SKIP (0.000s)
[164.369285] [023/136] (838s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[164.932104] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[164.934812] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[165.322522] [024/136] (838s left) gem_ctx_shared (single-timeline)
[165.522212] Starting subtest: single-timeline
[165.539978] Subtest single-timeline: SUCCESS (0.018s)
[165.757442] [025/136] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[166.037932] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[168.237420] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.202s)
[168.371435] [026/136] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[168.658317] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[170.769812] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.114s)
[170.904744] [027/136] (832s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[171.429790] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[171.432290] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[171.833172] [028/136] (831s left) syncobj_basic (bad-destroy-pad)
[172.010110] Starting subtest: bad-destroy-pad
[172.011480] Subtest bad-destroy-pad: SUCCESS (0.000s)
[172.099687] [029/136] (831s left) kms_addfb_basic (bad-pitch-32)
[172.281131] Starting subtest: bad-pitch-32
[172.282501] Subtest bad-pitch-32: SUCCESS (0.000s)
[172.483466] [030/136] (831s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[172.777574] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[172.780139] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[172.866821] [031/136] (830s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[173.488239] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[173.493290] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.004s)
[173.807640] [032/136] (829s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[173.989511] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[174.043488] [033/136] (829s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[174.660834] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[174.975889] [034/136] (828s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[175.224404] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[175.293062] [035/136] (828s left) gem_eio (wait-wedge-1us)
[175.490966] Starting subtest: wait-wedge-1us
[175.563192] Subtest wait-wedge-1us: SUCCESS (0.072s)
[175.744899] [036/136] (828s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[176.045036] Starting subtest: extended-modeset-hang-newfb-with-reset
[176.047782] Starting dynamic subtest: pipe-A
[179.192100] Dynamic subtest pipe-A: SUCCESS (3.142s)
[179.212024] Starting dynamic subtest: pipe-C
[182.455728] Dynamic subtest pipe-C: SUCCESS (3.261s)
[182.457039] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (6.411s)
[182.805562] [037/136] (821s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[183.106263] Starting subtest: 4-tiled-32bpp-rotate-180
[183.109361] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[183.218907] [038/136] (820s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[183.507682] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[183.510204] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[183.601559] [039/136] (820s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[183.877883] Starting subtest: cursorA-vs-flipB-varying-size
[183.880405] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[183.968125] [040/136] (819s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[184.253106] Starting subtest: psr-rgb565-draw-render
[184.255715] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[184.351808] [041/136] (819s left) tools_test (tools_test)
[184.536370] Starting subtest: tools_test
[184.915662] Subtest tools_test: SUCCESS (0.388s)
[184.985438] [042/136] (819s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[185.267377] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[185.269207] Starting dynamic subtest: pipe-A-valid-mode
[185.920579] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.654s)
[185.921885] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.656s)
[186.237496] [043/136] (817s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[186.534258] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[186.536862] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[186.637688] [044/136] (817s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[186.829197] Starting subtest: yf-tiled-to-vebox-y-tiled
[186.831872] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[187.029857] [045/136] (817s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[187.224379] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[187.226932] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[187.421775] [046/136] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[187.705829] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[187.708435] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.804648] [047/136] (816s left) vc4/vc4_mmap (mmap-bo)
[188.035767] Subtest mmap-bo: SKIP (0.000s)
[188.104234] [048/136] (816s left) gen9_exec_parse (shadow-peek)
[188.301379] Starting subtest: shadow-peek
[188.306202] Subtest shadow-peek: SUCCESS (0.005s)
[188.521656] [049/136] (815s left) gem_spin_batch (spin-each)
[188.723632] Starting subtest: spin-each
[192.109859] Subtest spin-each: SUCCESS (3.386s)
[192.338179] [050/136] (811s left) gem_exec_reloc (basic-wc-read-noreloc)
[192.526695] Starting subtest: basic-wc-read-noreloc
[192.538665] Subtest basic-wc-read-noreloc: SUCCESS (0.011s)
[192.738152] [051/136] (811s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[193.012773] Starting subtest: cursorB-vs-flipA-toggle
[193.015302] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[193.104850] [052/136] (811s left) gem_exec_await (wide-contexts)
[193.470641] Starting subtest: wide-contexts
[216.428089] Subtest wide-contexts: SUCCESS (22.960s)
[216.651562] [053/136] (787s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[217.135476] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[217.428725] [054/136] (786s left) gem_tiled_blits (normal)
[217.799644] Starting subtest: normal
[267.578752] Subtest normal: SUCCESS (49.778s)
[267.691685] [055/136] (736s left) v3d/v3d_create_bo (create-bo-0)
[268.069233] Subtest create-bo-0: SKIP (0.000s)
[268.137112] [056/136] (736s left) i915_pm_rpm (gem-pread)
[270.186813] Starting subtest: gem-pread
[271.098415] Subtest gem-pread: SUCCESS (0.910s)
[271.330278] [057/136] (733s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[271.512438] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[271.618429] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[271.695265] [058/136] (732s left) gem_mmap_gtt (zero-extend)
[271.875543] Starting subtest: zero-extend
[271.876915] Subtest zero-extend: SUCCESS (0.001s)
[271.978382] [059/136] (732s left) gem_ctx_engines (execute-allforone)
[272.176402] Starting subtest: execute-allforone
[272.193781] Subtest execute-allforone: SUCCESS (0.017s)
[272.412715] [060/136] (732s left) gem_exercise_blt (fast-copy)
[272.597733] Starting subtest: fast-copy
[272.599347] Starting dynamic subtest: linear-smem-smem
[272.658403] Dynamic subtest linear-smem-smem: SUCCESS (0.060s)
[272.678990] Starting dynamic subtest: ymajor-smem-smem
[272.710631] Dynamic subtest ymajor-smem-smem: SUCCESS (0.051s)
[272.739122] Starting dynamic subtest: yfmajor-smem-smem
[272.758226] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.048s)
[272.783346] Starting dynamic subtest: tile64-smem-smem
[272.807286] Dynamic subtest tile64-smem-smem: SUCCESS (0.048s)
[272.809769] Subtest fast-copy: SUCCESS (0.210s)
[272.900494] [061/136] (731s left) kms_psr (psr2_suspend)
[273.082527] Subtest psr2_suspend: SKIP (0.000s)
[273.137749] [062/136] (731s left) gem_exec_balancer (bonded-true-hang)
[277.209118] Starting subtest: bonded-true-hang
[280.845291] Subtest bonded-true-hang: SUCCESS (3.637s)
[280.945458] [063/136] (723s left) fbdev (eof)
[281.142880] Starting subtest: eof
[281.144310] Subtest eof: SUCCESS (0.000s)
[281.211230] [064/136] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[281.497696] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[281.500341] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[281.595267] [065/136] (723s left) prime_vgem (fence-flip-hang)
[281.816446] Subtest fence-flip-hang: SKIP (0.000s)
[281.911922] [066/136] (722s left) gem_exec_fair (basic-throttle)
[282.115870] Starting subtest: basic-throttle
[282.118179] Starting dynamic subtest: rcs0
[287.051505] Dynamic subtest rcs0: SUCCESS (4.934s)
[287.052822] Subtest basic-throttle: SUCCESS (4.935s)
[287.246377] [067/136] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[287.533034] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[287.535621] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.629160] [068/136] (717s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[287.906080] Starting subtest: nonblocking-crc-frame-sequence
[287.907437] Starting dynamic subtest: pipe-A-DP-1
[288.502165] Dynamic subtest pipe-A-DP-1: SUCCESS (0.597s)
[288.526213] Starting dynamic subtest: pipe-B-DP-1
[289.389616] Dynamic subtest pipe-B-DP-1: SUCCESS (0.884s)
[289.413928] Starting dynamic subtest: pipe-C-DP-1
[290.385875] Dynamic subtest pipe-C-DP-1: SUCCESS (0.994s)
[290.387322] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.482s)
[290.694430] [069/136] (714s left) gem_create (create-ext-cpu-access-big)
[290.995854] Starting subtest: create-ext-cpu-access-big
[290.999281] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[291.077486] [070/136] (713s left) kms_vblank (pipe-b-query-forked-busy)
[291.351783] Starting subtest: pipe-B-query-forked-busy
[294.209822] Subtest pipe-B-query-forked-busy: SUCCESS (2.859s)
[294.551529] [071/136] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[294.835093] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[294.837791] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[294.933787] [072/136] (710s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[295.240846] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[295.264351] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.021s)
[295.384199] [073/136] (709s left) perf_pmu (invalid-init)
[295.574078] Starting subtest: invalid-init
[295.576391] Subtest invalid-init: SUCCESS (0.001s)
[295.667560] [074/136] (709s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[296.296418] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[296.604512] [075/136] (708s left) kms_big_fb (linear-16bpp-rotate-0)
[296.901493] Starting subtest: linear-16bpp-rotate-0
[301.347237] Subtest linear-16bpp-rotate-0: SUCCESS (4.445s)
[301.655748] [076/136] (703s left) perf (invalid-oa-exponent)
[301.976550] Starting subtest: invalid-oa-exponent
[302.053773] Subtest invalid-oa-exponent: SUCCESS (0.076s)
[302.104373] [077/136] (703s left) gem_exec_await (wide-all)
[302.467918] Starting subtest: wide-all
[324.349280] Subtest wide-all: SUCCESS (21.881s)
[324.574562] [078/136] (680s left) syncobj_wait (multi-wait-all-submitted-signaled)
[324.828163] Starting subtest: multi-wait-all-submitted-signaled
[324.931690] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[325.021986] [079/136] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[325.323272] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[327.848452] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.528s)
[327.988664] [080/136] (677s left) gem_tiled_wc
[330.720929] [081/136] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[331.012261] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[331.015166] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[331.123058] [082/136] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[331.411346] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[331.414081] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[331.521334] [083/136] (673s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[331.831582] Starting subtest: x-tiled-32bpp-rotate-90
[331.922969] Subtest x-tiled-32bpp-rotate-90: SKIP (0.089s)
[332.038572] [084/136] (673s left) kms_vblank (pipe-b-query-forked)
[332.326699] Starting subtest: pipe-B-query-forked
[335.048759] Subtest pipe-B-query-forked: SUCCESS (2.724s)
[335.377101] [085/136] (670s left) gem_exec_fence (syncobj-import)
[335.998356] Starting subtest: syncobj-import
[336.006127] Subtest syncobj-import: SUCCESS (0.008s)
[336.344234] [086/136] (669s left) kms_getfb (getfb-addfb-different-handles)
[336.529498] Starting subtest: getfb-addfb-different-handles
[336.530931] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[336.629706] [087/136] (669s left) kms_cursor_crc (cursor-offscreen-128x128)
[336.913568] Starting subtest: cursor-offscreen-128x128
[336.925781] Starting dynamic subtest: pipe-A-DP-1
[339.517400] Dynamic subtest pipe-A-DP-1: SUCCESS (2.594s)
[339.602255] Starting dynamic subtest: pipe-C-DP-1
[342.354824] Dynamic subtest pipe-C-DP-1: SUCCESS (2.780s)
[342.356248] Subtest cursor-offscreen-128x128: SUCCESS (5.443s)
[342.683604] [088/136] (663s left) kms_big_fb (y-tiled-addfb)
[342.994663] Starting subtest: y-tiled-addfb
[342.996360] Subtest y-tiled-addfb: SUCCESS (0.001s)
[343.097616] [089/136] (662s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[343.279135] Starting subtest: cpuset-basic-small-copy-odd
[350.740287] Subtest cpuset-basic-small-copy-odd: SUCCESS (7.460s)
[350.863503] [090/136] (654s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[351.267536] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[351.268921] Starting dynamic subtest: pipe-A-valid-mode
[351.942873] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.676s)
[351.944225] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.678s)
[352.281131] [091/136] (653s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[352.639626] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[352.929093] [092/136] (652s left) kms_prop_blob (invalid-get-prop-any)
[353.108216] Starting subtest: invalid-get-prop-any
[353.109816] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[353.202648] [093/136] (652s left) gem_exec_parallel (fds)
[353.406268] Starting subtest: fds
[353.407819] Starting dynamic subtest: rcs0
[357.957053] Dynamic subtest rcs0: SUCCESS (4.547s)
[357.979345] Starting dynamic subtest: bcs0
[363.021025] Dynamic subtest bcs0: SUCCESS (5.066s)
[363.043149] Starting dynamic subtest: vcs0
[367.397536] Dynamic subtest vcs0: SUCCESS (4.375s)
[367.421520] Starting dynamic subtest: vecs0
[371.783075] Dynamic subtest vecs0: SUCCESS (4.384s)
[371.784373] Subtest fds: SUCCESS (18.377s)
[371.988576] [094/136] (633s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs)
[372.615936] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.000s)
[372.923592] [095/136] (633s left) prime_vgem (coherency-gtt)
[373.132125] Starting subtest: coherency-gtt
[373.135594] Subtest coherency-gtt: SKIP (0.000s)
[373.223271] [096/136] (632s left) gem_exec_schedule (pi-distinct-iova)
[373.568270] Starting subtest: pi-distinct-iova
[373.569653] Starting dynamic subtest: rcs0
[373.640799] Dynamic subtest rcs0: SUCCESS (0.074s)
[373.669948] Starting dynamic subtest: bcs0
[373.716879] Dynamic subtest bcs0: SUCCESS (0.072s)
[373.748534] Starting dynamic subtest: vcs0
[373.772481] Dynamic subtest vcs0: SUCCESS (0.054s)
[373.799737] Starting dynamic subtest: vecs0
[373.831154] Dynamic subtest vecs0: SUCCESS (0.057s)
[373.832561] Subtest pi-distinct-iova: SUCCESS (0.266s)
[374.057201] [097/136] (631s left) kms_async_flips (async-flip-with-page-flip-events)
[374.343333] Starting subtest: async-flip-with-page-flip-events
[374.344625] Starting dynamic subtest: pipe-A-DP-1
[377.093836] Dynamic subtest pipe-A-DP-1: SUCCESS (2.751s)
[377.116991] Starting dynamic subtest: pipe-B-DP-1
[379.772984] Dynamic subtest pipe-B-DP-1: SUCCESS (2.675s)
[379.795390] Starting dynamic subtest: pipe-C-DP-1
[382.362232] Dynamic subtest pipe-C-DP-1: SUCCESS (2.582s)
[382.363569] Subtest async-flip-with-page-flip-events: SUCCESS (8.018s)
[382.916273] [098/136] (623s left) kms_plane (pixel-format-source-clamping)
[383.191743] Starting subtest: pixel-format-source-clamping
[383.193224] Starting dynamic subtest: pipe-A-planes
[389.585955] Dynamic subtest pipe-A-planes: SUCCESS (6.394s)
[389.617289] Starting dynamic subtest: pipe-B-planes
[396.113976] Dynamic subtest pipe-B-planes: SUCCESS (6.524s)
[396.115889] Subtest pixel-format-source-clamping: SUCCESS (12.925s)
[396.453339] [099/136] (609s left) syncobj_timeline (invalid-signal-zero-handles)
[396.640324] Starting subtest: invalid-signal-zero-handles
[396.641844] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[396.735913] [100/136] (609s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[397.219837] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[397.222486] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[397.707450] [101/136] (608s left) kms_cursor_crc (cursor-random-128x128)
[397.996885] Starting subtest: cursor-random-128x128
[398.006989] Starting dynamic subtest: pipe-A-DP-1
[402.047132] Dynamic subtest pipe-A-DP-1: SUCCESS (4.040s)
[402.133432] Starting dynamic subtest: pipe-C-DP-1
[406.239687] Dynamic subtest pipe-C-DP-1: SUCCESS (4.134s)
[406.241122] Subtest cursor-random-128x128: SUCCESS (8.242s)
[406.601404] [102/136] (599s left) gem_userptr_blits (forbidden-operations)
[406.801200] Starting subtest: forbidden-operations
[406.802807] Subtest forbidden-operations: SUCCESS (0.002s)
[406.947614] [103/136] (599s left) kms_plane_scaling (planes-downscale-factor-0-75)
[407.232876] Starting subtest: planes-downscale-factor-0-75
[407.234348] Starting dynamic subtest: pipe-A-DP-1
[407.338437] Dynamic subtest pipe-A-DP-1: SUCCESS (0.105s)
[407.364931] Starting dynamic subtest: pipe-B-DP-1
[407.721788] Dynamic subtest pipe-B-DP-1: SUCCESS (0.379s)
[407.757386] Starting dynamic subtest: pipe-C-DP-1
[407.808646] Dynamic subtest pipe-C-DP-1: SKIP (0.082s)
[407.810182] Subtest planes-downscale-factor-0-75: SUCCESS (0.577s)
[408.197451] [104/136] (598s left) gem_pxp (reject-modify-context-protection-on)
[410.896912] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[410.979639] [105/136] (595s left) kms_vblank (pipe-c-ts-continuation-modeset-hang)
[411.274719] Starting subtest: pipe-C-ts-continuation-modeset-hang
[418.558754] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (7.288s)
[418.902201] [106/136] (587s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[419.085435] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[419.137859] [107/136] (587s left) gem_ctx_persistence (heartbeat-hang)
[419.323987] Starting subtest: heartbeat-hang
[420.503660] Subtest heartbeat-hang: SUCCESS (1.180s)
[420.600885] [108/136] (585s left) debugfs_test (read_all_entries_display_off)
[420.895950] Starting subtest: read_all_entries_display_off
[421.223471] Subtest read_all_entries_display_off: SUCCESS (0.321s)
[421.542957] [109/136] (584s left) i915_query (engine-info)
[421.724701] Starting subtest: engine-info
[421.729193] Subtest engine-info: SUCCESS (0.003s)
[421.822109] [110/136] (584s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[422.135792] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[422.141834] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[422.239777] [111/136] (584s left) kms_cursor_legacy (single-bo)
[422.518464] Starting subtest: single-bo
[422.519822] Starting dynamic subtest: pipe-A
[444.021733] Dynamic subtest pipe-A: SUCCESS (21.505s)
[444.045354] Starting dynamic subtest: pipe-B
[465.526079] Dynamic subtest pipe-B: SUCCESS (21.503s)
[465.549931] Starting dynamic subtest: pipe-C
[487.032556] Dynamic subtest pipe-C: SUCCESS (21.505s)
[487.054746] Starting dynamic subtest: all-pipes
[508.537443] Dynamic subtest all-pipes: SUCCESS (21.504s)
[508.538887] Subtest single-bo: SUCCESS (86.022s)
[508.620764] [112/136] (498s left) kms_chamelium_frames (dp-crc-single)
[508.980657] Subtest dp-crc-single: SKIP (0.000s)
[509.243514] [113/136] (497s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[509.423772] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[509.425350] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[509.519484] [114/136] (497s left) syncobj_wait (multi-wait-signaled)
[509.702439] Starting subtest: multi-wait-signaled
[509.703724] Subtest multi-wait-signaled: SUCCESS (0.001s)
[509.785536] [115/136] (496s left) kms_hdr (invalid-metadata-sizes)
[510.066600] Starting subtest: invalid-metadata-sizes
[510.069385] Subtest invalid-metadata-sizes: SKIP (0.000s)
[510.153225] [116/136] (496s left) perf_pmu (gt-awake)
[510.340400] Starting subtest: gt-awake
[512.889577] Subtest gt-awake: SUCCESS (2.550s)
[513.001186] [117/136] (493s left) kms_flip (modeset-vs-vblank-race-interruptible)
[513.278036] Starting subtest: modeset-vs-vblank-race-interruptible
[513.282986] Starting dynamic subtest: A-DP1
[517.531520] Dynamic subtest A-DP1: SUCCESS (4.248s)
[517.556404] Starting dynamic subtest: B-DP1
[521.752134] Dynamic subtest B-DP1: SUCCESS (4.216s)
[521.776657] Starting dynamic subtest: C-DP1
[525.935071] Dynamic subtest C-DP1: SUCCESS (4.184s)
[525.936561] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.658s)
[526.338198] [118/136] (480s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs)
[526.738935] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs
[527.374052] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SUCCESS (0.637s)
[527.898713] [119/136] (479s left) gem_exec_params (sol-reset-invalid)
[528.086973] Starting subtest: sol-reset-invalid
[528.092128] Subtest sol-reset-invalid: SUCCESS (0.003s)
[528.196997] [120/136] (478s left) template (b)
[528.377734] Starting subtest: B
[528.379076] Subtest B: SUCCESS (0.000s)
[528.463317] [121/136] (478s left) i915_pm_rpm (drm-resources-equal)
[530.234418] Starting subtest: drm-resources-equal
[531.925126] Subtest drm-resources-equal: SUCCESS (1.690s)
[532.138372] [122/136] (474s left) gem_render_copy (y-tiled)
[532.335447] Starting subtest: y-tiled
[532.337093] Starting dynamic subtest: smem
[532.618488] Dynamic subtest smem: SUCCESS (0.281s)
[532.619933] Subtest y-tiled: SUCCESS (0.283s)
[532.820943] [123/136] (474s left) v3d/v3d_submit_csd (bad-perfmon)
[533.062268] Subtest bad-perfmon: SKIP (0.000s)
[533.136304] [124/136] (473s left) gem_exec_balancer (sequential)
[533.341168] Starting subtest: sequential
[536.985660] Subtest sequential: SUCCESS (3.647s)
[540.837181] [125/136] (466s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[541.126306] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[541.129148] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[541.236382] [126/136] (465s left) kms_cursor_edge_walk (128x128-top-bottom)
[541.513906] Starting subtest: 128x128-top-bottom
[541.515256] Starting dynamic subtest: pipe-A-DP-1
[545.137498] Dynamic subtest pipe-A-DP-1: SUCCESS (3.624s)
[545.162590] Starting dynamic subtest: pipe-C-DP-1
[548.601259] Dynamic subtest pipe-C-DP-1: SUCCESS (3.457s)
[548.603379] Subtest 128x128-top-bottom: SUCCESS (7.088s)
[548.919628] [127/136] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[549.216628] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[549.219220] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[549.317898] [128/136] (457s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[549.498662] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[549.500288] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[549.584716] [129/136] (457s left) kms_vblank (pipe-d-query-idle-hang)
[549.856125] Subtest pipe-D-query-idle-hang: SKIP (0.000s)
[549.935624] [130/136] (457s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs)
[550.444285] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs
[550.445919] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SUCCESS (0.001s)
[550.885731] [131/136] (456s left) core_setmaster (master-drop-set-root)
[552.698294] Starting subtest: master-drop-set-root
[552.708872] Subtest master-drop-set-root: SUCCESS (0.012s)
[552.750490] [132/136] (454s left) gem_exec_nop (basic-parallel)
[552.955844] Starting subtest: basic-parallel
[556.070850] Subtest basic-parallel: SUCCESS (3.115s)
[556.302755] [133/136] (451s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[556.705504] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[556.710352] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[557.233867] [134/136] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[557.533150] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[557.535843] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[557.633589] [135/136] (449s left) kms_lease (multimaster-lease)
[557.918718] Starting subtest: multimaster-lease
[557.923214] Subtest multimaster-lease: SUCCESS (0.007s)
[558.017972] [136/136] (449s left) drm_fdinfo (busy-idle-check-all)
[558.204029] Starting subtest: busy-idle-check-all
[558.209045] Starting dynamic subtest: rcs0
[558.835670] Dynamic subtest rcs0: SUCCESS (0.630s)
[558.862616] Starting dynamic subtest: bcs0
[559.465633] Dynamic subtest bcs0: SUCCESS (0.629s)
[559.492436] Starting dynamic subtest: vcs0
[560.093497] Dynamic subtest vcs0: SUCCESS (0.627s)
[560.118415] Starting dynamic subtest: vecs0
[560.717553] Dynamic subtest vecs0: SUCCESS (0.623s)
[560.718984] Subtest busy-idle-check-all: SUCCESS (2.513s)
[560.795632] Closing watchdogs
Done.