[40.522679] Initializing watchdogs
[40.522796]   /dev/watchdog0
[40.535926] [001/133] (960s left) gem_ctx_shared (disjoint-timelines)
[40.608806] Starting subtest: disjoint-timelines
[40.670117] Subtest disjoint-timelines: SUCCESS (0.064s)
[40.911245] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[41.043039] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[41.047606] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[41.115207] [003/133] (959s left) kms_psr (psr2-sprite-mmap-cpu)
[41.235951] Starting subtest: psr2-sprite-mmap-cpu
[41.238455] Starting dynamic subtest: eDP-1
[43.028059] Dynamic subtest eDP-1: SUCCESS (1.791s)
[43.030661] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.792s)
[43.941378] [004/133] (957s left) syncobj_timeline (wait-all-interrupted)
[44.026838] Starting subtest: wait-all-interrupted
[44.128369] Subtest wait-all-interrupted: SUCCESS (0.102s)
[44.190042] [005/133] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[44.296624] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[44.302041] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[44.365927] [006/133] (956s left) intel_hwmon (hwmon-write)
[44.433442] Subtest hwmon-write: SKIP (0.000s)
[44.483702] [007/133] (956s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[44.602789] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[44.605624] Starting dynamic subtest: pipe-A-default-mode
[44.908460] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[44.913193] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.302s)
[45.800227] [008/133] (955s left) gem_exec_balancer (persistence)
[46.062771] Starting subtest: persistence
[46.658855] Subtest persistence: SUCCESS (0.596s)
[46.764216] [009/133] (954s left) syncobj_timeline (invalid-signal-zero-handles)
[46.839550] Starting subtest: invalid-signal-zero-handles
[46.842276] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[46.908552] [010/133] (954s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[47.023901] Starting subtest: plane-upscale-factor-0-25-with-rotation
[47.026406] Starting dynamic subtest: pipe-A-eDP-1
[47.371845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.347s)
[47.382695] Starting dynamic subtest: pipe-B-eDP-1
[48.848341] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[48.855056] Starting dynamic subtest: pipe-C-eDP-1
[50.337680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s)
[50.343913] Starting dynamic subtest: pipe-D-eDP-1
[51.754700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s)
[51.757218] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.731s)
[53.032228] [011/133] (948s left) syncobj_wait (invalid-signal-illegal-handle)
[53.110528] Starting subtest: invalid-signal-illegal-handle
[53.113131] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[53.195947] [012/133] (948s left) core_auth (getclient-master-drop)
[53.243697] Starting subtest: getclient-master-drop
[53.264832] Subtest getclient-master-drop: SUCCESS (0.023s)
[53.359219] [013/133] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[53.492449] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[57.934066] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.445s)
[58.049345] [014/133] (943s left) v3d/v3d_create_bo (create-bo-zeroed)
[58.138997] Subtest create-bo-zeroed: SKIP (0.000s)
[58.182731] [015/133] (943s left) kms_psr (pr-dpms)
[58.305641] Starting subtest: pr-dpms
[58.311058] Subtest pr-dpms: SKIP (0.000s)
[58.365223] [016/133] (943s left) gem_exec_fair (basic-sync)
[58.458828] Subtest basic-sync: SKIP (0.000s)
[58.481563] [017/133] (942s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[58.585684] Starting subtest: 2x-absolute-wf_vblank-interruptible
[58.600629] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.015s)
[58.671119] [018/133] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[58.807494] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[58.812176] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.894855] [019/133] (942s left) v3d/v3d_wait_bo (map-bo-1ns)
[58.952245] Subtest map-bo-1ns: SKIP (0.000s)
[58.989389] [020/133] (942s left) gem_exec_reloc (basic-concurrent16)
[59.037780] Subtest basic-concurrent16: SKIP (0.000s)
[59.087141] [021/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[59.197204] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[59.200951] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[59.265593] [022/133] (942s left) kms_3d
[61.526442] [023/133] (939s left) gem_exec_reloc (basic-cpu-wc)
[61.614348] Subtest basic-cpu-wc: SKIP (0.000s)
[61.690206] [024/133] (939s left) gem_userptr_blits (sync-unmap)
[61.780024] Starting subtest: sync-unmap
[61.796505] Subtest sync-unmap: SUCCESS (0.024s)
[61.913235] [025/133] (939s left) i915_pm_rps (min-max-config-idle)
[61.993408] Starting subtest: min-max-config-idle
[61.999341] Subtest min-max-config-idle: SKIP (0.000s)
[62.044046] [026/133] (939s left) gem_ctx_param (set-priority-invalid-size)
[62.112882] Starting subtest: set-priority-invalid-size
[62.115477] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[62.167736] [027/133] (939s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[62.240897] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[62.243773] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[62.317500] [028/133] (939s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[62.441568] Starting subtest: psr-rgb565-draw-render
[67.427127] Subtest psr-rgb565-draw-render: SUCCESS (4.989s)
[67.563249] [029/133] (934s left) gem_cs_tlb (engines)
[67.632802] Starting subtest: engines
[67.635456] Starting dynamic subtest: rcs0
[69.840861] Dynamic subtest rcs0: SUCCESS (2.152s)
[69.853692] Starting dynamic subtest: bcs0
[71.938270] Dynamic subtest bcs0: SUCCESS (2.151s)
[71.949751] Starting dynamic subtest: vcs0
[74.143294] Dynamic subtest vcs0: SUCCESS (2.152s)
[74.151794] Starting dynamic subtest: vcs1
[76.295258] Dynamic subtest vcs1: SUCCESS (2.152s)
[76.308770] Starting dynamic subtest: vecs0
[78.395393] Dynamic subtest vecs0: SUCCESS (2.151s)
[78.404574] Starting dynamic subtest: ccs0
[80.601088] Dynamic subtest ccs0: SUCCESS (2.153s)
[80.603492] Subtest engines: SUCCESS (12.912s)
[80.654401] [030/133] (921s left) perf_pmu (init-sema)
[80.705198] Starting subtest: init-sema
[80.707169] Starting dynamic subtest: rcs0
[80.709493] Dynamic subtest rcs0: SUCCESS (0.003s)
[80.717657] Starting dynamic subtest: bcs0
[80.719633] Dynamic subtest bcs0: SUCCESS (0.001s)
[80.725580] Starting dynamic subtest: vcs0
[80.727690] Dynamic subtest vcs0: SUCCESS (0.001s)
[80.732780] Starting dynamic subtest: vcs1
[80.734983] Dynamic subtest vcs1: SUCCESS (0.001s)
[80.740110] Starting dynamic subtest: vecs0
[80.742300] Dynamic subtest vecs0: SUCCESS (0.001s)
[80.747379] Starting dynamic subtest: ccs0
[80.749706] Dynamic subtest ccs0: SUCCESS (0.000s)
[80.752192] Subtest init-sema: SUCCESS (0.007s)
[80.814053] [031/133] (920s left) gem_unfence_active_buffers
[80.996624] [032/133] (920s left) kms_psr (fbc-psr2-sprite-plane-move)
[81.123899] Starting subtest: fbc-psr2-sprite-plane-move
[81.126394] Starting dynamic subtest: eDP-1
[81.130729] Dynamic subtest eDP-1: SKIP (0.000s)
[81.135279] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[81.176233] [033/133] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[81.279271] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[81.284230] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[81.355963] [034/133] (920s left) kms_color (gamma)
[81.479440] Starting subtest: gamma
[81.481853] Starting dynamic subtest: pipe-A
[82.183676] Dynamic subtest pipe-A: SUCCESS (0.701s)
[82.198335] Starting dynamic subtest: pipe-B
[83.700318] Dynamic subtest pipe-B: SUCCESS (1.518s)
[83.713898] Starting dynamic subtest: pipe-C
[85.115854] Dynamic subtest pipe-C: SUCCESS (1.414s)
[85.130307] Starting dynamic subtest: pipe-D
[86.552426] Dynamic subtest pipe-D: SUCCESS (1.436s)
[86.554669] Subtest gamma: SUCCESS (5.069s)
[87.463176] [035/133] (914s left) gem_exec_whisper (basic-fds-priority-all)
[87.532470] Starting subtest: basic-fds-priority-all
[112.643463] Subtest basic-fds-priority-all: SUCCESS (25.107s)
[112.812768] [036/133] (888s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[112.948595] Starting subtest: fbc-pr-sprite-mmap-cpu
[112.953318] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[113.017226] [037/133] (888s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[113.087047] Starting subtest: y-tiled-to-vebox-yf-tiled
[113.092582] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[113.263091] [038/133] (888s left) gem_reg_read (bad-register)
[113.331976] Starting subtest: bad-register
[113.335211] Subtest bad-register: SUCCESS (0.000s)
[113.408816] [039/133] (888s left) kms_chamelium_frames (hdmi-crc-fast)
[113.811806] Subtest hdmi-crc-fast: SKIP (0.000s)
[114.705757] [040/133] (887s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[114.822867] Starting subtest: basic-max-pipe-crc-check
[114.828071] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[114.849969] [041/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[114.948094] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[114.953050] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[115.025721] [042/133] (886s left) gem_exec_params (mmapped)
[115.112449] Starting subtest: mmapped
[115.118626] Subtest mmapped: SUCCESS (0.004s)
[115.225309] [043/133] (886s left) kms_psr (psr-primary-blt)
[115.350685] Starting subtest: psr-primary-blt
[115.353303] Starting dynamic subtest: eDP-1
[117.211362] Dynamic subtest eDP-1: SUCCESS (1.859s)
[117.213795] Subtest psr-primary-blt: SUCCESS (1.861s)
[118.081951] [044/133] (883s left) gem_eio (unwedge-stress)
[118.334829] Starting subtest: unwedge-stress
[163.526365] Subtest unwedge-stress: SUCCESS (45.190s)
[165.461877] [045/133] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[165.592802] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[171.243917] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (5.655s)
[171.406630] [046/133] (830s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[171.520970] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[171.523442] Starting dynamic subtest: pipe-A-eDP-1
[171.528171] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[171.542950] Starting dynamic subtest: pipe-B-eDP-1
[171.547774] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[171.556209] Starting dynamic subtest: pipe-C-eDP-1
[171.560870] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[171.574642] Starting dynamic subtest: pipe-D-eDP-1
[171.579462] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[171.584530] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[171.605984] [047/133] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[171.722035] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[171.727064] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[171.801472] [048/133] (830s left) drm_fdinfo (busy-idle)
[171.855714] Starting subtest: busy-idle
[171.858548] Starting dynamic subtest: rcs0
[171.863795] Dynamic subtest rcs0: SKIP (0.000s)
[171.878617] Starting dynamic subtest: bcs0
[171.884453] Dynamic subtest bcs0: SKIP (0.000s)
[171.897936] Starting dynamic subtest: vcs0
[171.903322] Dynamic subtest vcs0: SKIP (0.000s)
[171.912070] Starting dynamic subtest: vcs1
[171.916229] Dynamic subtest vcs1: SKIP (0.000s)
[171.922561] Starting dynamic subtest: vecs0
[171.926741] Dynamic subtest vecs0: SKIP (0.000s)
[171.932841] Starting dynamic subtest: ccs0
[171.937060] Dynamic subtest ccs0: SKIP (0.000s)
[171.941250] Subtest busy-idle: SKIP (0.004s)
[171.956786] [049/133] (830s left) kms_addfb_basic (bad-pitch-65536)
[172.008711] Starting subtest: bad-pitch-65536
[172.010985] Subtest bad-pitch-65536: SUCCESS (0.000s)
[172.129755] [050/133] (830s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[172.242898] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[172.245233] Starting dynamic subtest: pipe-A-eDP-1
[172.257086] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[172.271031] Starting dynamic subtest: pipe-B-eDP-1
[172.275681] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[172.290288] Starting dynamic subtest: pipe-C-eDP-1
[172.294703] Dynamic subtest pipe-C-eDP-1: SKIP (0.019s)
[172.305630] Starting dynamic subtest: pipe-D-eDP-1
[172.309364] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[172.313070] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.061s)
[172.366861] [051/133] (829s left) sw_sync (sync_busy_fork)
[172.416979] Starting subtest: sync_busy_fork
[173.434267] Subtest sync_busy_fork: SUCCESS (1.016s)
[173.489909] [052/133] (828s left) gem_partial_pwrite_pread (writes-after-reads-display)
[173.569761] Subtest writes-after-reads-display: SKIP (0.000s)
[173.628894] [053/133] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[173.762404] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[173.767112] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[173.852175] [054/133] (828s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[173.973207] Starting subtest: primary-yf-tiled-reflect-x-180
[174.035807] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[174.127174] [055/133] (828s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[174.264289] Starting subtest: cursorA-vs-flipB-atomic
[174.269191] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[174.405472] [056/133] (827s left) gem_mmap_gtt (basic-read)
[174.477345] Subtest basic-read: SKIP (0.000s)
[174.530310] [057/133] (827s left) kms_cursor_legacy (torture-move)
[174.648918] Starting subtest: torture-move
[174.651244] Starting dynamic subtest: pipe-A
[180.824824] Dynamic subtest pipe-A: SUCCESS (6.171s)
[180.843273] Starting dynamic subtest: pipe-B
[188.065469] Dynamic subtest pipe-B: SUCCESS (7.237s)
[188.087538] Starting dynamic subtest: pipe-C
[195.059394] Dynamic subtest pipe-C: SUCCESS (6.997s)
[195.077962] Starting dynamic subtest: pipe-D
[202.041658] Dynamic subtest pipe-D: SUCCESS (6.982s)
[202.053181] Starting dynamic subtest: all-pipes
[208.975986] Dynamic subtest all-pipes: SUCCESS (6.931s)
[208.978751] Subtest torture-move: SUCCESS (34.323s)
[209.126244] [058/133] (793s left) kms_sequence (get-forked)
[209.231877] Starting subtest: get-forked
[209.234630] Starting dynamic subtest: pipe-A-eDP-1
[211.077586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.847s)
[211.095254] Starting dynamic subtest: pipe-B-eDP-1
[213.727453] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.646s)
[213.741941] Starting dynamic subtest: pipe-C-eDP-1
[216.319531] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.590s)
[216.335268] Starting dynamic subtest: pipe-D-eDP-1
[218.889720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[218.892231] Subtest get-forked: SUCCESS (9.659s)
[219.821527] [059/133] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[219.936310] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[219.940699] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[220.015519] [060/133] (782s left) gem_exec_gttfill (basic)
[220.096826] Starting subtest: basic
[222.474855] Subtest basic: SUCCESS (2.377s)
[222.647054] [061/133] (779s left) gem_exec_basic (basic)
[222.794563] Starting subtest: basic
[222.797173] Starting dynamic subtest: rcs0-smem
[222.799232] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[222.815337] Starting dynamic subtest: bcs0-smem
[222.817713] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[222.826745] Starting dynamic subtest: vcs0-smem
[222.828754] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[222.835512] Starting dynamic subtest: vcs1-smem
[222.837500] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[222.843405] Starting dynamic subtest: vecs0-smem
[222.845339] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[222.851339] Starting dynamic subtest: ccs0-smem
[222.853286] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[222.855220] Subtest basic: SUCCESS (0.021s)
[224.472164] [062/133] (777s left) gem_partial_pwrite_pread (reads)
[224.550229] Subtest reads: SKIP (0.000s)
[224.595621] [063/133] (777s left) gem_exec_schedule (semaphore-resolve)
[224.684871] Starting subtest: semaphore-resolve
[224.719819] Subtest semaphore-resolve: SUCCESS (0.040s)
[225.059288] [064/133] (777s left) fbdev (info)
[225.106822] Starting subtest: info
[225.109347] Subtest info: SUCCESS (0.000s)
[225.176255] [065/133] (777s left) syncobj_wait (signal)
[225.256240] Starting subtest: signal
[225.259035] Subtest signal: SUCCESS (0.000s)
[225.346539] [066/133] (777s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[225.469196] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[225.473418] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[225.553599] [067/133] (777s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[225.667796] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[226.848809] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.183s)
[226.976838] [068/133] (775s left) kms_chamelium_color (ctm-0-50)
[227.104511] Subtest ctm-0-50: SKIP (0.000s)
[227.133375] [069/133] (775s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[227.250147] Starting subtest: y-tiled-32bpp-rotate-270
[227.254366] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[227.340392] [070/133] (775s left) kms_frontbuffer_tracking (fbc-1p-rte)
[227.450684] Starting subtest: fbc-1p-rte
[231.969303] Subtest fbc-1p-rte: SUCCESS (4.522s)
[232.122175] [071/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[232.269444] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[232.273748] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[232.351687] [072/133] (770s left) kms_psr2_sf (fbc-overlay-plane-update-continuous-sf)
[237.555852] Starting subtest: fbc-overlay-plane-update-continuous-sf
[237.558564] Starting dynamic subtest: psr2-pipe-A-eDP-1
[238.403418] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.847s)
[238.420234] Starting dynamic subtest: psr2-pipe-B-eDP-1
[239.616954] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.209s)
[239.621059] Subtest fbc-overlay-plane-update-continuous-sf: SKIP (2.062s)
[240.865194] [073/133] (761s left) kms_vrr (flip-dpms)
[240.972997] Starting subtest: flip-dpms
[240.977708] Subtest flip-dpms: SKIP (0.000s)
[241.035785] [074/133] (761s left) kms_cursor_crc (cursor-onscreen-32x32)
[241.195717] Starting subtest: cursor-onscreen-32x32
[241.228069] Subtest cursor-onscreen-32x32: SKIP (0.028s)
[241.486402] [075/133] (761s left) gem_ccs (block-multicopy-compressed)
[241.546046] Starting subtest: block-multicopy-compressed
[241.549895] Subtest block-multicopy-compressed: SKIP (0.000s)
[241.642071] [076/133] (761s left) perf (whitelisted-registers-userspace-config)
[241.794686] Starting subtest: whitelisted-registers-userspace-config
[241.797402] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[241.812784] [077/133] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[241.923524] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[241.927776] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[242.010514] [078/133] (760s left) gen9_exec_parse (bb-large)
[242.101419] Subtest bb-large: SKIP (0.000s)
[242.160948] [079/133] (760s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[242.262220] Starting subtest: yf-tiled-16bpp-rotate-270
[242.266462] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[242.339139] [080/133] (760s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[242.423335] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[242.479669] [081/133] (760s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[242.613920] Starting subtest: 4-tiled-16bpp-rotate-180
[244.016787] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.402s)
[244.143259] [082/133] (758s left) gem_exec_whisper (basic-fds-forked-all)
[244.221157] Starting subtest: basic-fds-forked-all
[269.827503] Subtest basic-fds-forked-all: SUCCESS (25.601s)
[270.007534] [083/133] (732s left) kms_getfb (getfb-handle-closed)
[270.077312] Starting subtest: getfb-handle-closed
[270.079856] Subtest getfb-handle-closed: SUCCESS (0.000s)
[270.173144] [084/133] (732s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[270.613125] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[271.505490] [085/133] (731s left) kms_getfb (getfb2-handle-closed)
[271.570536] Starting subtest: getfb2-handle-closed
[271.573610] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[271.674041] [086/133] (731s left) syncobj_eventfd (invalid-illegal-handle)
[271.741065] Starting subtest: invalid-illegal-handle
[271.743263] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[271.813304] [087/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[271.937406] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[271.942268] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.015713] [088/133] (731s left) gem_userptr_blits (huge-split)
[272.102976] Starting subtest: huge-split
[272.109987] Subtest huge-split: SUCCESS (0.007s)
[272.225862] [089/133] (730s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[272.330942] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[272.333420] Starting dynamic subtest: pipe-A-eDP-1
[272.397518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[272.412229] Starting dynamic subtest: pipe-B-eDP-1
[272.495350] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.097s)
[272.510377] Starting dynamic subtest: pipe-C-eDP-1
[272.571825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.076s)
[272.585304] Starting dynamic subtest: pipe-D-eDP-1
[272.638848] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.066s)
[272.640987] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.308s)
[272.734232] [090/133] (730s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[272.867070] Starting subtest: fbcpsr-rgb101010-draw-render
[277.688361] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.821s)
[277.816844] [091/133] (725s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[277.976113] Starting subtest: cursor-rapid-movement-32x10
[278.005839] Subtest cursor-rapid-movement-32x10: SKIP (0.026s)
[278.254713] [092/133] (724s left) gem_ctx_persistence (heartbeat-hang)
[278.337783] Starting subtest: heartbeat-hang
[278.343055] Subtest heartbeat-hang: SKIP (0.000s)
[278.445570] [093/133] (724s left) i915_query (query-garbage)
[278.512304] Starting subtest: query-garbage
[278.514821] Subtest query-garbage: SUCCESS (0.000s)
[278.594872] [094/133] (724s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[278.714318] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[278.716477] Starting dynamic subtest: pipe-A-eDP-1
[278.720550] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[278.727968] Starting dynamic subtest: pipe-B-eDP-1
[278.731959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[278.738468] Starting dynamic subtest: pipe-C-eDP-1
[278.742321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[278.748824] Starting dynamic subtest: pipe-D-eDP-1
[278.752354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[278.755902] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[278.777158] [095/133] (724s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[278.856215] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[278.960462] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[279.033157] [096/133] (724s left) api_intel_bb (delta-check)
[279.097442] Starting subtest: delta-check
[279.103021] Subtest delta-check: SUCCESS (0.006s)
[279.184155] [097/133] (724s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[279.298265] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[279.303089] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[279.383430] [098/133] (723s left) vc4/vc4_wait_bo (unused-bo-0ns)
[279.479737] Subtest unused-bo-0ns: SKIP (0.000s)
[279.527960] [099/133] (723s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[279.645630] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[279.648861] Starting dynamic subtest: pipe-A-eDP-1
[279.653660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.669661] Starting dynamic subtest: pipe-B-eDP-1
[279.674667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.684228] Starting dynamic subtest: pipe-C-eDP-1
[279.689235] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.698794] Starting dynamic subtest: pipe-D-eDP-1
[279.704057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.709341] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[279.727650] [100/133] (723s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[282.328350] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[282.387650] [101/133] (721s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[282.447586] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[282.482464] [102/133] (720s left) i915_hangman (engine-engine-error)
[282.536159] Starting subtest: engine-engine-error
[282.538526] Starting dynamic subtest: rcs0
[284.436259] Dynamic subtest rcs0: SUCCESS (1.898s)
[284.451968] Starting dynamic subtest: bcs0
[286.417290] Dynamic subtest bcs0: SUCCESS (1.980s)
[286.435909] Starting dynamic subtest: vcs0
[288.400906] Dynamic subtest vcs0: SUCCESS (1.981s)
[288.417331] Starting dynamic subtest: vcs1
[290.450475] Dynamic subtest vcs1: SUCCESS (2.048s)
[290.466928] Starting dynamic subtest: vecs0
[292.433226] Dynamic subtest vecs0: SUCCESS (1.981s)
[292.449593] Starting dynamic subtest: ccs0
[294.417265] Dynamic subtest ccs0: SUCCESS (1.983s)
[294.420039] Subtest engine-engine-error: SUCCESS (11.881s)
[294.547389] [103/133] (708s left) prime_vgem (shrink)
[294.647141] Starting subtest: shrink
[294.678611] Subtest shrink: SUCCESS (0.032s)
[294.788770] [104/133] (708s left) kms_addfb_basic (basic)
[294.853825] Starting subtest: basic
[294.856286] Subtest basic: SUCCESS (0.000s)
[294.995991] [105/133] (708s left) v3d/v3d_submit_cl (bad-flag)
[295.088200] Subtest bad-flag: SKIP (0.000s)
[295.143107] [106/133] (708s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[295.260612] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[295.263213] Starting dynamic subtest: pipe-A-default-mode
[295.554055] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[295.559341] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[296.426443] [107/133] (707s left) kms_prime (basic-crc-hybrid)
[297.083727] Subtest basic-crc-hybrid: SKIP (0.000s)
[297.165473] [108/133] (706s left) gem_softpin (evict-single-offset)
[297.247813] Starting subtest: evict-single-offset
[325.426897] Subtest evict-single-offset: SUCCESS (28.178s)
[325.503899] [109/133] (678s left) perf (invalid-create-userspace-config)
[325.709925] Starting subtest: invalid-create-userspace-config
[325.712764] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[325.739432] [110/133] (677s left) gem_tiled_pread_pwrite
[325.867604] [111/133] (677s left) kms_vblank (wait-busy-hang)
[325.996549] Starting subtest: wait-busy-hang
[325.999211] Starting dynamic subtest: pipe-A-eDP-1
[352.189797] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.189s)
[352.201750] Starting dynamic subtest: pipe-D-eDP-1
[377.221940] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.029s)
[377.224581] Subtest wait-busy-hang: SUCCESS (51.226s)
[378.160153] [112/133] (625s left) gem_exec_balancer (bonded-true-hang)
[378.410455] Starting subtest: bonded-true-hang
[378.415637] Subtest bonded-true-hang: SKIP (0.000s)
[378.501647] [113/133] (625s left) kms_addfb_basic (bad-pitch-63)
[378.559730] Starting subtest: bad-pitch-63
[378.562173] Subtest bad-pitch-63: SUCCESS (0.000s)
[378.683918] [114/133] (625s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[383.965185] Starting subtest: overlay-plane-update-sf-dmg-area
[383.967832] Starting dynamic subtest: psr2-pipe-A-eDP-1
[390.778949] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (6.811s)
[390.793060] Starting dynamic subtest: psr2-pipe-B-eDP-1
[397.550893] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (6.770s)
[397.553025] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.587s)
[398.434684] [115/133] (605s left) syncobj_timeline (single-wait-all-signaled)
[398.499865] Starting subtest: single-wait-all-signaled
[398.502280] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[398.584316] [116/133] (605s left) kms_plane_cursor (viewport)
[398.699988] Starting subtest: viewport
[398.704747] Starting dynamic subtest: pipe-A-eDP-1-size-64
[401.570741] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.869s)
[401.637407] Starting dynamic subtest: pipe-A-eDP-1-size-128
[404.428213] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.804s)
[404.493994] Starting dynamic subtest: pipe-A-eDP-1-size-256
[407.373562] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.893s)
[407.747783] Starting dynamic subtest: pipe-B-eDP-1-size-64
[411.346345] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.618s)
[411.409229] Starting dynamic subtest: pipe-B-eDP-1-size-128
[414.235967] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.839s)
[414.300616] Starting dynamic subtest: pipe-B-eDP-1-size-256
[417.124888] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.837s)
[417.491904] Starting dynamic subtest: pipe-C-eDP-1-size-64
[420.517343] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.039s)
[420.556770] Starting dynamic subtest: pipe-C-eDP-1-size-128
[422.895919] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.347s)
[422.934598] Starting dynamic subtest: pipe-C-eDP-1-size-256
[425.206356] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.280s)
[425.547936] Starting dynamic subtest: pipe-D-eDP-1-size-64
[428.617031] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.085s)
[428.652744] Starting dynamic subtest: pipe-D-eDP-1-size-128
[431.005159] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.358s)
[431.046771] Starting dynamic subtest: pipe-D-eDP-1-size-256
[433.372308] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.335s)
[433.695999] Subtest viewport: SUCCESS (34.994s)
[434.603072] [117/133] (569s left) gem_mmap_gtt (cpuset-big-copy-xy)
[434.673065] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[434.709737] [118/133] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[434.832596] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[437.645267] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.818s)
[437.773999] [119/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[437.910130] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[437.914125] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[437.973978] [120/133] (565s left) gem_exec_params (dr4-dirt)
[438.040878] Starting subtest: DR4-dirt
[438.043086] Subtest DR4-dirt: SUCCESS (0.000s)
[438.128509] [121/133] (565s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[438.244710] Starting subtest: 4-tiled-8bpp-rotate-180
[439.429742] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.184s)
[439.536123] [122/133] (564s left) i915_pm_rps (thresholds)
[439.601091] Starting subtest: thresholds
[439.603689] Starting dynamic subtest: gt0
[439.608942] Dynamic subtest gt0: SKIP (0.003s)
[439.624368] Starting dynamic subtest: gt1
[439.629226] Dynamic subtest gt1: SKIP (0.000s)
[439.634178] Subtest thresholds: SKIP (0.004s)
[439.679960] [123/133] (564s left) kms_cursor_edge_walk (256x256-left-edge)
[439.827549] Starting subtest: 256x256-left-edge
[439.829641] Starting dynamic subtest: pipe-A-eDP-1
[443.357442] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.525s)
[443.366657] Starting dynamic subtest: pipe-D-eDP-1
[446.605392] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.248s)
[446.608752] Subtest 256x256-left-edge: SUCCESS (6.777s)
[447.533451] [124/133] (556s left) kms_invalid_mode (bad-vsync-end)
[447.635803] Starting subtest: bad-vsync-end
[447.638216] Starting dynamic subtest: pipe-A-eDP-1
[447.921713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[447.937189] Starting dynamic subtest: pipe-B-eDP-1
[447.939501] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[447.949044] Starting dynamic subtest: pipe-C-eDP-1
[447.951690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[447.959297] Starting dynamic subtest: pipe-D-eDP-1
[447.961937] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[447.964501] Subtest bad-vsync-end: SUCCESS (0.294s)
[448.816803] [125/133] (555s left) syncobj_wait (multi-wait-signaled)
[448.882879] Starting subtest: multi-wait-signaled
[448.885955] Subtest multi-wait-signaled: SUCCESS (0.000s)
[448.968732] [126/133] (555s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[449.114419] Starting subtest: basic-flip-after-cursor-legacy
[450.041742] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.928s)
[450.930698] [127/133] (553s left) kms_flip (nonexisting-fb)
[451.057192] Starting subtest: nonexisting-fb
[451.059631] Starting dynamic subtest: A-eDP1
[452.300879] Dynamic subtest A-eDP1: SUCCESS (1.243s)
[452.317356] Starting dynamic subtest: B-eDP1
[453.515152] Dynamic subtest B-eDP1: SUCCESS (1.213s)
[453.526248] Starting dynamic subtest: C-eDP1
[454.796974] Dynamic subtest C-eDP1: SUCCESS (1.280s)
[454.807766] Starting dynamic subtest: D-eDP1
[456.014759] Dynamic subtest D-eDP1: SUCCESS (1.213s)
[456.021394] Subtest nonexisting-fb: SUCCESS (4.963s)
[457.253821] [128/133] (546s left) gem_exec_nop (basic-sequential)
[457.333196] Starting subtest: basic-sequential
[473.577225] Subtest basic-sequential: SUCCESS (16.256s)
[473.791692] [129/133] (530s left) kms_plane_scaling (invalid-parameters)
[473.934340] Starting subtest: invalid-parameters
[473.936695] Starting dynamic subtest: less-than-1-height-src
[473.946251] Dynamic subtest less-than-1-height-src: SUCCESS (0.010s)
[473.960795] Starting dynamic subtest: less-than-1-width-src
[473.962822] Dynamic subtest less-than-1-width-src: SUCCESS (0.007s)
[473.964853] Subtest invalid-parameters: SUCCESS (0.018s)
[474.036092] [130/133] (530s left) kms_dsc (dsc-fractional-bpp)
[474.142313] Starting subtest: dsc-fractional-bpp
[474.147477] Subtest dsc-fractional-bpp: SKIP (0.000s)
[474.207451] [131/133] (530s left) gem_pxp (create-protected-buffer)
[476.806489] Subtest create-protected-buffer: SKIP (0.000s)
[476.872689] [132/133] (527s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[476.992295] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[477.006445] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.015s)
[477.074281] [133/133] (527s left) kms_big_fb (linear-64bpp-rotate-180)
[477.196696] Starting subtest: linear-64bpp-rotate-180
[478.851789] Subtest linear-64bpp-rotate-180: SUCCESS (1.656s)
[479.007094] Closing watchdogs
Done.