[43.633886] Initializing watchdogs
[43.634246]   /dev/watchdog0
[43.668516] [001/136] (960s left) kms_cursor_crc (cursor-random-128x128)
[44.167485] Starting subtest: cursor-random-128x128
[44.187171] Starting dynamic subtest: pipe-A-DP-1
[48.245301] Dynamic subtest pipe-A-DP-1: SUCCESS (4.045s)
[48.304589] Starting dynamic subtest: pipe-B-DP-1
[52.193160] Dynamic subtest pipe-B-DP-1: SUCCESS (3.887s)
[52.268825] Starting dynamic subtest: pipe-C-DP-1
[56.170060] Dynamic subtest pipe-C-DP-1: SUCCESS (3.907s)
[56.189731] Subtest cursor-random-128x128: SUCCESS (12.006s)
[56.582751] [002/136] (947s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[56.889851] Starting subtest: invalid-bsd2-flag-on-vebox
[56.908722] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[57.036848] [003/136] (947s left) api_intel_bb (offset-control)
[57.324178] Starting subtest: offset-control
[57.369321] Subtest offset-control: SUCCESS (0.042s)
[57.496772] [004/136] (946s left) gem_exec_balancer (parallel-ordering)
[62.611892] Subtest parallel-ordering: SKIP (0.000s)
[62.720736] [005/136] (941s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[63.095117] Starting subtest: basic-flip-after-cursor-legacy
[64.187745] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.099s)
[64.558341] [006/136] (940s left) prime_self_import (reimport-vs-gem_close-race)
[64.820309] Starting subtest: reimport-vs-gem_close-race
[70.047449] Subtest reimport-vs-gem_close-race: SUCCESS (5.027s)
[70.124720] [007/136] (934s left) kms_addfb_basic (bad-pitch-999)
[70.410629] Starting subtest: bad-pitch-999
[70.429525] Subtest bad-pitch-999: SUCCESS (0.000s)
[70.818447] [008/136] (934s left) i915_suspend (fence-restore-untiled)
[71.132254] Starting subtest: fence-restore-untiled
[91.309897] Subtest fence-restore-untiled: SUCCESS (4.333s)
[95.492163] [009/136] (929s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[96.008751] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[96.049656] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[96.432627] [010/136] (928s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[96.921669] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[97.407101] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.499s)
[97.915391] [011/136] (927s left) kms_flip (2x-plain-flip-fb-recreate)
[98.310325] Starting subtest: 2x-plain-flip-fb-recreate
[98.350254] Subtest 2x-plain-flip-fb-recreate: SKIP (0.004s)
[98.457852] [012/136] (926s left) kms_plane (plane-position-hole)
[98.848966] Starting subtest: plane-position-hole
[98.869304] Starting dynamic subtest: pipe-A-planes
[100.404379] Dynamic subtest pipe-A-planes: SUCCESS (1.566s)
[100.441294] Starting dynamic subtest: pipe-B-planes
[102.079880] Dynamic subtest pipe-B-planes: SUCCESS (1.664s)
[102.100908] Subtest plane-position-hole: SUCCESS (3.231s)
[102.450054] [013/136] (922s left) syncobj_wait (multi-wait-submitted-signaled)
[102.763266] Starting subtest: multi-wait-submitted-signaled
[102.782003] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[102.890026] [014/136] (922s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[103.191364] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[103.296167] [015/136] (922s left) api_intel_allocator (fork-simple-once)
[103.580808] Starting subtest: fork-simple-once
[103.621946] Subtest fork-simple-once: SUCCESS (0.048s)
[103.753863] [016/136] (921s left) gem_gpgpu_fill (basic)
[104.038422] Starting subtest: basic
[104.057087] Starting dynamic subtest: smem
[104.076930] Dynamic subtest smem: SUCCESS (0.017s)
[104.098274] Subtest basic: SUCCESS (0.017s)
[104.204367] [017/136] (921s left) syncobj_timeline (invalid-signal-bad-pad)
[104.490002] Starting subtest: invalid-signal-bad-pad
[104.511088] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[104.612619] [018/136] (921s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[105.063855] Starting subtest: psr-rgb101010-draw-pwrite
[105.101018] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[105.209854] [019/136] (920s left) gem_exec_schedule (u-submit-late-slice)
[105.651758] Starting subtest: u-submit-late-slice
[105.672306] Starting dynamic subtest: rcs0
[105.693839] Dynamic subtest rcs0: SUCCESS (0.073s)
[105.736559] Starting dynamic subtest: bcs0
[105.757341] Dynamic subtest bcs0: SUCCESS (0.060s)
[105.792323] Starting dynamic subtest: vcs0
[105.811021] Dynamic subtest vcs0: SUCCESS (0.055s)
[105.844509] Starting dynamic subtest: vecs0
[105.863177] Dynamic subtest vecs0: SUCCESS (0.056s)
[105.883322] Subtest u-submit-late-slice: SUCCESS (0.246s)
[106.150020] [020/136] (919s left) gem_mmap_offset (ptrace)
[106.443294] Starting subtest: ptrace
[106.462393] Starting dynamic subtest: smem0-gtt
[106.521932] Dynamic subtest smem0-gtt: SUCCESS (0.092s)
[106.556866] Starting dynamic subtest: smem0-wb
[106.609098] Dynamic subtest smem0-wb: SUCCESS (0.084s)
[106.644830] Starting dynamic subtest: smem0-wc
[106.692550] Dynamic subtest smem0-wc: SUCCESS (0.083s)
[106.726115] Starting dynamic subtest: smem0-uc
[106.778882] Dynamic subtest smem0-uc: SUCCESS (0.086s)
[106.800987] Subtest ptrace: SUCCESS (0.354s)
[106.920728] [021/136] (919s left) i915_selftest (mock)
[108.443600] Starting subtest: mock
[108.466170] Starting dynamic subtest: sanitycheck
[108.963300] Dynamic subtest sanitycheck: SUCCESS (0.518s)
[108.996619] Starting dynamic subtest: shmem
[109.443981] Dynamic subtest shmem: SUCCESS (0.483s)
[109.481129] Starting dynamic subtest: fence
[116.744027] Dynamic subtest fence: SUCCESS (7.297s)
[116.776077] Starting dynamic subtest: scatterlist
[118.224604] Dynamic subtest scatterlist: SUCCESS (1.480s)
[118.264327] Starting dynamic subtest: syncmap
[120.778188] Dynamic subtest syncmap: SUCCESS (2.554s)
[120.810622] Starting dynamic subtest: uncore
[121.256396] Dynamic subtest uncore: SUCCESS (0.480s)
[121.286237] Starting dynamic subtest: ring
[121.736746] Dynamic subtest ring: SUCCESS (0.478s)
[121.773256] Starting dynamic subtest: engine
[122.227735] Dynamic subtest engine: SUCCESS (0.489s)
[122.260545] Starting dynamic subtest: timelines
[133.847321] Dynamic subtest timelines: SUCCESS (11.619s)
[133.886543] Starting dynamic subtest: requests
[136.818731] Dynamic subtest requests: SUCCESS (2.973s)
[136.855092] Starting dynamic subtest: objects
[137.441707] Dynamic subtest objects: SUCCESS (0.622s)
[137.474575] Starting dynamic subtest: phys
[138.103174] Dynamic subtest phys: SUCCESS (0.664s)
[138.136053] Starting dynamic subtest: dmabuf
[138.745863] Dynamic subtest dmabuf: SUCCESS (0.642s)
[138.782685] Starting dynamic subtest: vma
[176.207849] Dynamic subtest vma: SUCCESS (37.459s)
[176.246587] Starting dynamic subtest: evict
[180.525183] Dynamic subtest evict: SUCCESS (4.320s)
[180.562121] Starting dynamic subtest: gtt
[185.927678] Dynamic subtest gtt: SUCCESS (5.399s)
[185.959741] Starting dynamic subtest: hugepages
[187.964676] Dynamic subtest hugepages: SUCCESS (2.040s)
[187.995303] Starting dynamic subtest: memory_region
[215.119847] Dynamic subtest memory_region: SUCCESS (27.147s)
[215.146112] Subtest mock: SUCCESS (106.669s)
[215.245551] [022/136] (810s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[219.096855] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[220.328497] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.242s)
[220.704057] [023/136] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[221.150855] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[221.188138] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[221.303758] [024/136] (804s left) gem_ctx_persistence (process)
[221.608444] Starting subtest: process
[221.741262] Subtest process: SUCCESS (0.140s)
[221.878421] [025/136] (804s left) gem_ctx_param (set-priority-range)
[222.156851] Starting subtest: set-priority-range
[222.221595] Subtest set-priority-range: SUCCESS (0.062s)
[222.354068] [026/136] (804s left) kms_cursor_crc (cursor-size-change)
[222.738638] Starting subtest: cursor-size-change
[222.758899] Starting dynamic subtest: pipe-A-DP-1
[223.489795] Dynamic subtest pipe-A-DP-1: SUCCESS (0.752s)
[223.532878] Starting dynamic subtest: pipe-B-DP-1
[224.322969] Dynamic subtest pipe-B-DP-1: SUCCESS (0.841s)
[224.379675] Starting dynamic subtest: pipe-C-DP-1
[225.160703] Dynamic subtest pipe-C-DP-1: SUCCESS (0.840s)
[225.180940] Subtest cursor-size-change: SUCCESS (2.434s)
[225.586262] [027/136] (800s left) kms_psr (psr2_cursor_mmap_gtt)
[225.915300] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[226.025089] [028/136] (800s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs)
[226.522140] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs
[227.051182] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.520s)
[227.513599] [029/136] (799s left) gem_exec_reloc (basic-softpin)
[227.824306] Starting subtest: basic-softpin
[227.844121] Subtest basic-softpin: SUCCESS (0.006s)
[228.047530] [030/136] (798s left) v3d/v3d_job_submission (array-job-submission)
[228.404199] Subtest array-job-submission: SKIP (0.000s)
[228.506852] [031/136] (798s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[228.888679] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[228.933332] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.004s)
[229.042604] [032/136] (798s left) i915_pm_rpm (legacy-planes-dpms)
[231.017602] Starting subtest: legacy-planes-dpms
[231.040477] Starting dynamic subtest: plane-39
[234.024901] Dynamic subtest plane-39: SUCCESS (3.008s)
[234.064437] Starting dynamic subtest: plane-47
[236.932067] Dynamic subtest plane-47: SUCCESS (2.906s)
[236.953087] Subtest legacy-planes-dpms: SUCCESS (5.916s)
[237.409816] [033/136] (789s left) vc4/vc4_tiling (get-after-free)
[237.800532] Subtest get-after-free: SKIP (0.000s)
[237.904936] [034/136] (789s left) kms_atomic_interruptible (legacy-pageflip)
[238.297974] Starting subtest: legacy-pageflip
[238.319402] Starting dynamic subtest: DP-1-pipe-A
[244.821012] Dynamic subtest DP-1-pipe-A: SUCCESS (6.526s)
[244.841608] Subtest legacy-pageflip: SUCCESS (6.527s)
[245.179603] [035/136] (782s left) i915_module_load (resize-bar)
[245.467259] Starting subtest: resize-bar
[245.508831] Subtest resize-bar: SKIP (0.015s)
[245.612140] [036/136] (781s left) kms_content_protection (atomic-dpms)
[246.055586] Starting subtest: atomic-dpms
[246.075223] Starting dynamic subtest: pipe-A-DP-1
[367.064863] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[374.475671] Closing watchdogs
[374.486004] Initializing watchdogs
[374.486224]   /dev/watchdog0
[374.546219] [037/136] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[374.969062] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[375.011685] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[375.125692] [038/136] (652s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[375.667295] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[376.007127] [039/136] (651s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[376.406283] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[376.426182] Starting dynamic subtest: pipe-A-valid-mode
[377.079329] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.691s)
[377.098094] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (0.692s)
[377.459264] [040/136] (650s left) v3d/v3d_submit_cl (multisync-out-syncs)
[377.814490] Subtest multisync-out-syncs: SKIP (0.000s)
[377.919900] [041/136] (650s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_ccs)
[378.405510] Starting subtest: pipe-B-random-ccs-data-y_tiled_ccs
[378.873683] Subtest pipe-B-random-ccs-data-y_tiled_ccs: SUCCESS (0.452s)
[379.325671] [042/136] (648s left) perf (non-system-wide-paranoid)
[379.724675] Starting subtest: non-system-wide-paranoid
[379.862297] Subtest non-system-wide-paranoid: SUCCESS (0.138s)
[379.987632] [043/136] (648s left) gem_exec_fence (syncobj-timeline-export)
[380.978850] Starting subtest: syncobj-timeline-export
[380.997666] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[381.258778] [044/136] (647s left) api_intel_allocator (reserve-simple)
[381.544916] Starting subtest: reserve-simple
[381.566171] Subtest reserve-simple: SUCCESS (0.004s)
[381.693539] [045/136] (646s left) perf_pmu (idle)
[381.981062] Starting subtest: idle
[382.000080] Starting dynamic subtest: rcs0
[382.490181] Dynamic subtest rcs0: SUCCESS (0.507s)
[382.530502] Starting dynamic subtest: bcs0
[382.995406] Dynamic subtest bcs0: SUCCESS (0.504s)
[383.032241] Starting dynamic subtest: vcs0
[383.500292] Dynamic subtest vcs0: SUCCESS (0.506s)
[383.537217] Starting dynamic subtest: vecs0
[384.030797] Dynamic subtest vecs0: SUCCESS (0.506s)
[384.052298] Subtest idle: SUCCESS (2.028s)
[384.158022] [046/136] (644s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[384.621570] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[387.337283] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.686s)
[387.449964] [047/136] (641s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[387.821586] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[387.936850] [048/136] (640s left) kms_cursor_crc (cursor-sliding-max-size)
[388.329223] Starting subtest: cursor-sliding-max-size
[388.385422] Subtest cursor-sliding-max-size: SKIP (0.000s)
[388.501207] [049/136] (640s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[388.778192] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[388.799702] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[388.909928] [050/136] (640s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[389.221693] Starting subtest: y-tiled-ccs-to-y-tiled
[389.240785] Starting dynamic subtest: smem
[389.515558] Dynamic subtest smem: SUCCESS (0.311s)
[389.534330] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.313s)
[389.764497] [051/136] (639s left) gem_exec_reloc (basic-wc-cpu-active)
[390.064636] Starting subtest: basic-wc-cpu-active
[390.193270] Subtest basic-wc-cpu-active: SUCCESS (0.150s)
[390.428848] [052/136] (638s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[390.794878] Starting subtest: cursorB-vs-flipA-atomic
[390.832483] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[390.952170] [053/136] (638s left) gem_partial_pwrite_pread (reads-snoop)
[391.259521] Starting subtest: reads-snoop
[398.731969] Subtest reads-snoop: SUCCESS (7.476s)
[398.857184] [054/136] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[399.312402] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[401.340255] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.113s)
[401.493823] [055/136] (627s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[401.866504] Starting subtest: disable-crc-after-crtc
[401.885493] Starting dynamic subtest: pipe-A-DP-1
[402.577408] Dynamic subtest pipe-A-DP-1: SUCCESS (0.698s)
[402.616012] Starting dynamic subtest: pipe-B-DP-1
[403.423426] Dynamic subtest pipe-B-DP-1: SUCCESS (0.845s)
[403.476214] Starting dynamic subtest: pipe-C-DP-1
[404.267621] Dynamic subtest pipe-C-DP-1: SUCCESS (0.853s)
[404.287938] Subtest disable-crc-after-crtc: SUCCESS (2.399s)
[404.636829] [056/136] (624s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[405.002060] Starting subtest: short-flip-before-cursor-atomic-transitions
[406.155178] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.141s)
[406.516433] [057/136] (623s left) syncobj_wait (invalid-signal-bad-pad)
[406.792691] Starting subtest: invalid-signal-bad-pad
[406.811566] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[406.927123] [058/136] (622s left) syncobj_timeline (multi-wait-for-submit-signaled)
[407.198737] Starting subtest: multi-wait-for-submit-signaled
[407.220561] Subtest multi-wait-for-submit-signaled: SUCCESS (0.003s)
[407.334766] [059/136] (622s left) gem_ppgtt (blt-vs-render-ctx0)
[407.618643] Starting subtest: blt-vs-render-ctx0
[442.433204] Subtest blt-vs-render-ctx0: SUCCESS (34.818s)
[442.569035] [060/136] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[443.195644] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[443.246924] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[443.385687] [061/136] (586s left) kms_psr (psr2_primary_page_flip)
[443.710484] Subtest psr2_primary_page_flip: SKIP (0.000s)
[443.807838] [062/136] (586s left) kms_chamelium_color (ctm-0-50)
[444.198481] Subtest ctm-0-50: SKIP (0.000s)
[444.314586] [063/136] (585s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[444.684846] Starting subtest: cursor-vs-flip-toggle
[488.807096] Subtest cursor-vs-flip-toggle: SUCCESS (44.110s)
[489.177999] [064/136] (541s left) gem_exec_reloc (basic-gtt-noreloc)
[489.486223] Starting subtest: basic-gtt-noreloc
[489.506803] Subtest basic-gtt-noreloc: SUCCESS (0.013s)
[489.734946] [065/136] (540s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[490.263696] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[490.326767] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[490.642813] [066/136] (539s left) gem_exec_create (legacy)
[490.946303] Starting subtest: legacy
[490.968214] Starting dynamic subtest: smem
[493.016479] Dynamic subtest smem: SUCCESS (2.067s)
[493.035263] Subtest legacy: SUCCESS (2.069s)
[493.239067] [067/136] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[493.659228] Starting subtest: psr-2p-primscrn-cur-indfb-move
[493.699297] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[493.820805] [068/136] (536s left) kms_vblank (pipe-d-wait-forked)
[494.218979] Subtest pipe-D-wait-forked: SKIP (0.000s)
[494.379749] [069/136] (536s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[494.816476] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[494.879342] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[494.988884] [070/136] (535s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[495.398124] Starting subtest: 4-tiled-64bpp-rotate-90
[495.437968] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[495.555000] [071/136] (535s left) kms_chamelium_color (gamma)
[495.939905] Subtest gamma: SKIP (0.000s)
[496.055624] [072/136] (535s left) syncobj_timeline (wait-any-snapshot)
[496.377514] Starting subtest: wait-any-snapshot
[496.462657] Subtest wait-any-snapshot: SUCCESS (0.083s)
[496.607561] [073/136] (534s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[497.028217] Starting subtest: fbcpsr-badstride
[497.071856] Subtest fbcpsr-badstride: SKIP (0.000s)
[497.190566] [074/136] (534s left) kms_rotation_crc (primary-rotation-270)
[497.567664] Starting subtest: primary-rotation-270
[503.929858] Subtest primary-rotation-270: SUCCESS (6.367s)
[504.387898] [075/136] (527s left) kms_chamelium_hpd (dp-hpd)
[504.882306] Subtest dp-hpd: SKIP (0.000s)
[505.211647] [076/136] (526s left) syncobj_wait (invalid-signal-illegal-handle)
[505.506869] Starting subtest: invalid-signal-illegal-handle
[505.533177] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[505.664280] [077/136] (526s left) gem_exec_whisper (basic-fds-priority)
[506.018422] Starting subtest: basic-fds-priority
[528.188479] Subtest basic-fds-priority: SUCCESS (22.174s)
[528.401355] [078/136] (503s left) gem_ctx_isolation (preservation-s3)
[528.707655] Starting subtest: preservation-S3
[528.726962] Starting dynamic subtest: rcs0
[548.257597] Dynamic subtest rcs0: SUCCESS (2.875s)
[548.298953] Starting dynamic subtest: bcs0
[567.329775] Dynamic subtest bcs0: SUCCESS (3.181s)
[567.375529] Starting dynamic subtest: vcs0
[586.246704] Dynamic subtest vcs0: SUCCESS (2.888s)
[586.295903] Starting dynamic subtest: vecs0
[605.193026] Dynamic subtest vecs0: SUCCESS (2.801s)
[605.214653] Subtest preservation-S3: SUCCESS (11.752s)
[611.653616] [079/136] (491s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[613.566054] Starting subtest: dpms-mode-unset-non-lpsp
[615.016938] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.447s)
[615.513463] [080/136] (487s left) gem_userptr_blits (nohangcheck)
[615.880636] Starting subtest: nohangcheck
[616.214030] Subtest nohangcheck: SUCCESS (0.364s)
[616.374291] [081/136] (486s left) perf (blocking)
[616.780216] Starting subtest: blocking
[627.054523] Subtest blocking: SUCCESS (10.087s)
[627.171202] [082/136] (476s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[627.631999] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[627.669240] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[627.791406] [083/136] (475s left) gem_mmap (big-bo)
[628.070694] Starting subtest: big-bo
[630.264246] Subtest big-bo: SUCCESS (2.203s)
[630.417963] [084/136] (472s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[631.079776] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[631.118896] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[631.463803] [085/136] (472s left) prime_self_import (basic-with_two_bos)
[631.749146] Starting subtest: basic-with_two_bos
[631.770684] Subtest basic-with_two_bos: SUCCESS (0.006s)
[631.906349] [086/136] (471s left) gem_ccs (suspend-resume)
[632.234342] Subtest suspend-resume: SKIP (0.000s)
[632.350444] [087/136] (471s left) gem_ctx_persistence (hang)
[632.632965] Starting subtest: hang
[632.673022] Subtest hang: SKIP (0.007s)
[632.793881] [088/136] (471s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[633.233399] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[633.276392] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[633.388716] [089/136] (470s left) gem_exec_fence (syncobj-unused-fence)
[634.155390] Starting subtest: syncobj-unused-fence
[634.174596] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[634.544733] [090/136] (469s left) kms_draw_crc (draw-method-mmap-gtt)
[635.081002] Starting subtest: draw-method-mmap-gtt
[635.103208] Starting dynamic subtest: xrgb8888-untiled
[635.590010] Dynamic subtest xrgb8888-untiled: SUCCESS (0.511s)
[635.636800] Starting dynamic subtest: xrgb8888-xtiled
[635.737925] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s)
[635.780923] Starting dynamic subtest: xrgb8888-ytiled
[635.889313] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.149s)
[635.933398] Starting dynamic subtest: rgb565-untiled
[636.154491] Dynamic subtest rgb565-untiled: SUCCESS (0.265s)
[636.198753] Starting dynamic subtest: rgb565-xtiled
[636.286990] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[636.328190] Starting dynamic subtest: rgb565-ytiled
[636.420638] Dynamic subtest rgb565-ytiled: SUCCESS (0.132s)
[636.464942] Starting dynamic subtest: xrgb2101010-untiled
[636.722315] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s)
[636.767938] Starting dynamic subtest: xrgb2101010-xtiled
[636.870621] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[636.913184] Starting dynamic subtest: xrgb2101010-ytiled
[637.023227] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.149s)
[637.045591] Subtest draw-method-mmap-gtt: SUCCESS (1.946s)
[637.172452] [091/136] (466s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[637.481027] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[637.499874] Starting dynamic subtest: smem
[637.943938] Dynamic subtest smem: SUCCESS (0.481s)
[637.962510] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.482s)
[638.174465] [092/136] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[638.607386] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[638.650902] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[638.770496] [093/136] (465s left) prime_busy (before-wait)
[639.056734] Starting subtest: before-wait
[639.077715] Starting dynamic subtest: rcs0
[639.108925] Dynamic subtest rcs0: SUCCESS (0.010s)
[639.156139] Starting dynamic subtest: bcs0
[639.180591] Dynamic subtest bcs0: SUCCESS (0.017s)
[639.225991] Starting dynamic subtest: vcs0
[639.249324] Dynamic subtest vcs0: SUCCESS (0.015s)
[639.297635] Starting dynamic subtest: vecs0
[639.321531] Dynamic subtest vecs0: SUCCESS (0.022s)
[639.347493] Subtest before-wait: SUCCESS (0.198s)
[639.458025] [094/136] (464s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[639.866760] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[639.889031] Starting dynamic subtest: pipe-A-valid-mode
[640.021785] Dynamic subtest pipe-A-valid-mode: SKIP (0.164s)
[640.064938] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.165s)
[640.395207] [095/136] (464s left) kms_prop_blob (basic)
[640.681912] Starting subtest: basic
[640.702926] Subtest basic: SUCCESS (0.000s)
[640.815433] [096/136] (463s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[641.270325] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[641.308001] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[641.425320] [097/136] (463s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[641.860996] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[641.903766] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[642.020285] [098/136] (462s left) kms_flip (2x-flip-vs-suspend)
[642.392611] Starting subtest: 2x-flip-vs-suspend
[642.431621] Subtest 2x-flip-vs-suspend: SKIP (0.004s)
[642.555243] [099/136] (462s left) vc4/vc4_label_bo (set-kernel-name)
[642.957372] Subtest set-kernel-name: SKIP (0.000s)
[643.069789] [100/136] (461s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[643.448829] Starting subtest: flip-vs-cursor-busy-crc-atomic
[644.450581] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.005s)
[644.854794] [101/136] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[645.276640] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[645.320361] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[645.440986] [102/136] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[645.873991] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[645.916021] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[646.031596] [103/136] (459s left) kms_vblank (pipe-c-query-forked)
[646.415830] Starting subtest: pipe-C-query-forked
[649.079628] Subtest pipe-C-query-forked: SUCCESS (2.653s)
[649.449774] [104/136] (456s left) kms_plane_scaling (planes-upscale-20x20)
[649.837393] Starting subtest: planes-upscale-20x20
[649.856391] Starting dynamic subtest: pipe-A-DP-1
[650.015257] Dynamic subtest pipe-A-DP-1: SUCCESS (0.174s)
[650.071088] Starting dynamic subtest: pipe-B-DP-1
[650.392663] Dynamic subtest pipe-B-DP-1: SUCCESS (0.375s)
[650.458493] Starting dynamic subtest: pipe-C-DP-1
[650.502664] Dynamic subtest pipe-C-DP-1: SKIP (0.092s)
[650.523445] Subtest planes-upscale-20x20: SUCCESS (0.646s)
[650.934147] [105/136] (454s left) gen9_exec_parse (batch-zero-length)
[651.237479] Starting subtest: batch-zero-length
[651.258388] Subtest batch-zero-length: SUCCESS (0.003s)
[651.495635] [106/136] (454s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[651.861771] Starting subtest: pipe-C-ts-continuation-idle-hang
[659.180104] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (7.314s)
[659.564393] [107/136] (446s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend)
[659.954814] Subtest pipe-D-ts-continuation-dpms-suspend: SKIP (0.000s)
[660.117496] [108/136] (445s left) drm_read (fault-buffer)
[660.656120] Starting subtest: fault-buffer
[660.677835] Subtest fault-buffer: SUCCESS (0.001s)
[660.817815] [109/136] (445s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[661.256274] Starting subtest: yf-tiled-16bpp-rotate-270
[661.318525] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.071s)
[661.439193] [110/136] (444s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[661.734647] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[661.774774] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[661.974667] [111/136] (444s left) gem_ctx_exec (basic)
[662.261730] Starting subtest: basic
[662.281022] Subtest basic: SUCCESS (0.007s)
[662.425380] [112/136] (443s left) kms_lease (empty_lease)
[662.801605] Starting subtest: empty_lease
[662.822314] Starting dynamic subtest: pipe-A-DP-1
[662.981468] Dynamic subtest pipe-A-DP-1: SUCCESS (0.166s)
[663.025454] Starting dynamic subtest: pipe-B-DP-1
[663.047027] Dynamic subtest pipe-B-DP-1: SUCCESS (0.019s)
[663.089713] Starting dynamic subtest: pipe-C-DP-1
[663.108588] Dynamic subtest pipe-C-DP-1: SUCCESS (0.019s)
[663.127224] Subtest empty_lease: SUCCESS (0.209s)
[663.371427] [113/136] (443s left) kms_cursor_crc (cursor-offscreen-256x256)
[663.777878] Starting subtest: cursor-offscreen-256x256
[663.798487] Starting dynamic subtest: pipe-A-DP-1
[666.289758] Dynamic subtest pipe-A-DP-1: SUCCESS (2.509s)
[666.409869] Starting dynamic subtest: pipe-B-DP-1
[668.974039] Dynamic subtest pipe-B-DP-1: SUCCESS (2.587s)
[669.055881] Starting dynamic subtest: pipe-C-DP-1
[671.607206] Dynamic subtest pipe-C-DP-1: SUCCESS (2.583s)
[671.636132] Subtest cursor-offscreen-256x256: SUCCESS (7.834s)
[672.022040] [114/136] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[672.475729] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[672.530042] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[672.676423] [115/136] (434s left) fbdev (info)
[672.973404] Starting subtest: info
[673.000413] Subtest info: SUCCESS (0.000s)
[673.137929] [116/136] (433s left) gem_exec_schedule (preempt-queue-chain)
[673.597201] Starting subtest: preempt-queue-chain
[673.618439] Starting dynamic subtest: rcs0
[674.078719] Dynamic subtest rcs0: SUCCESS (0.624s)
[674.129396] Starting dynamic subtest: bcs0
[674.712134] Dynamic subtest bcs0: SUCCESS (0.629s)
[674.766684] Starting dynamic subtest: vcs0
[675.329375] Dynamic subtest vcs0: SUCCESS (0.617s)
[675.377374] Starting dynamic subtest: vecs0
[675.966828] Dynamic subtest vecs0: SUCCESS (0.637s)
[675.986870] Subtest preempt-queue-chain: SUCCESS (2.515s)
[676.361957] [117/136] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[676.792556] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[676.834686] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[676.952399] [118/136] (430s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs)
[677.497609] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.000s)
[677.843058] [119/136] (429s left) gem_workarounds (basic-read)
[678.182101] Starting subtest: basic-read
[678.203084] Subtest basic-read: SUCCESS (0.025s)
[678.350358] [120/136] (428s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[678.786609] Starting subtest: x-tiled-32bpp-rotate-0
[684.295633] Subtest x-tiled-32bpp-rotate-0: SUCCESS (5.550s)
[684.921161] [121/136] (422s left) gem_mmap_gtt (close-race)
[685.203343] Starting subtest: close-race
[705.294720] Subtest close-race: SUCCESS (20.100s)
[705.432465] [122/136] (402s left) drm_fdinfo (virtual-busy-hang)
[705.721174] Starting subtest: virtual-busy-hang
[709.959126] Subtest virtual-busy-hang: SUCCESS (4.242s)
[710.085703] [123/136] (397s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[710.370279] Starting subtest: etime-multi-wait-all-for-submit-submitted
[710.468088] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[710.582391] [124/136] (397s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[710.937180] Starting subtest: plane-primary-toggle-with-vblank-wait
[710.958896] Starting dynamic subtest: pipe-A-DP-1
[711.142637] Dynamic subtest pipe-A-DP-1: SUCCESS (0.205s)
[711.309487] Starting dynamic subtest: pipe-B-DP-1
[711.711147] Dynamic subtest pipe-B-DP-1: SUCCESS (0.466s)
[711.851675] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.887s)
[712.209628] [125/136] (395s left) syncobj_wait (wait-delayed-signal)
[712.501528] Starting subtest: wait-delayed-signal
[712.594721] Subtest wait-delayed-signal: SUCCESS (0.104s)
[712.747998] [126/136] (395s left) gem_pxp (create-regular-buffer)
[715.737002] Subtest create-regular-buffer: SKIP (0.000s)
[715.892355] [127/136] (392s left) kms_vblank (pipe-b-query-forked-busy-hang)
[716.258257] Starting subtest: pipe-B-query-forked-busy-hang
[723.294697] Subtest pipe-B-query-forked-busy-hang: SUCCESS (6.909s)
[723.557314] [128/136] (384s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[723.954458] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[723.992634] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[724.450208] [129/136] (383s left) kms_vblank (pipe-c-query-forked-hang)
[724.818649] Starting subtest: pipe-C-query-forked-hang
[732.264506] Subtest pipe-C-query-forked-hang: SUCCESS (7.322s)
[732.526705] [130/136] (375s left) gem_basic (create-fd-close)
[732.830745] Starting subtest: create-fd-close
[732.869450] Subtest create-fd-close: SUCCESS (0.000s)
[732.985197] [131/136] (375s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[733.463105] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[733.504397] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[733.877259] [132/136] (374s left) gen7_exec_parse (chained-batch)
[734.194917] Subtest chained-batch: SKIP (0.000s)
[734.333611] [133/136] (374s left) gen3_render_mixed_blits
[734.766723] [134/136] (374s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[735.200268] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[736.678017] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.512s)
[737.109228] [135/136] (371s left) gem_eio (kms)
[737.575720] Starting subtest: kms
[750.140997] Subtest kms: SUCCESS (12.602s)
[750.605716] [136/136] (358s left) kms_invalid_mode (bad-hsync-end)
[751.035149] Starting subtest: bad-hsync-end
[751.057739] Starting dynamic subtest: DP-1-pipe-A
[751.085650] Dynamic subtest DP-1-pipe-A: SUCCESS (0.086s)
[751.134645] Starting dynamic subtest: DP-1-pipe-B
[751.159432] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[751.208968] Starting dynamic subtest: DP-1-pipe-C
[751.232304] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[751.256501] Subtest bad-hsync-end: SUCCESS (0.094s)
[751.430401] Closing watchdogs
Done.