[18.693882] Initializing watchdogs
[18.693939]   /dev/watchdog0
[18.698216] [001/137] (960s left) api_intel_bb (simple-bb)
[18.743472] Starting subtest: simple-bb
[18.747543] Subtest simple-bb: SUCCESS (0.004s)
[18.826461] [002/137] (960s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[18.978371] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[19.030518] [003/137] (960s left) kms_lease (lease_again)
[19.119928] Starting subtest: lease_again
[19.120701] Starting dynamic subtest: pipe-A-HDMI-A-1
[19.121440] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[19.125680] Starting dynamic subtest: pipe-B-HDMI-A-1
[19.126476] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[19.130615] Starting dynamic subtest: pipe-C-HDMI-A-1
[19.131387] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[19.135264] Starting dynamic subtest: pipe-D-HDMI-A-1
[19.136096] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[19.136863] Subtest lease_again: SUCCESS (0.007s)
[19.160293] [004/137] (960s left) kms_atomic_transition (modeset-transition-fencing)
[19.249554] Starting subtest: modeset-transition-fencing
[19.250413] Starting dynamic subtest: 1x-outputs
[22.569562] Dynamic subtest 1x-outputs: SUCCESS (3.321s)
[22.617522] Subtest modeset-transition-fencing: SUCCESS (3.368s)
[22.704556] [005/137] (956s left) gem_mmap_gtt (cpuset-big-copy-odd)
[22.749725] Starting subtest: cpuset-big-copy-odd
[37.128266] Subtest cpuset-big-copy-odd: SUCCESS (14.378s)
[37.186189] [006/137] (942s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[37.318239] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[37.560561] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.242s)
[37.677464] [007/137] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[37.768827] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[37.770981] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[37.827197] [008/137] (941s left) gem_exec_schedule (preempt-other-chain)
[37.883641] Starting subtest: preempt-other-chain
[37.884405] Starting dynamic subtest: rcs0
[37.916305] Dynamic subtest rcs0: SUCCESS (0.032s)
[37.921823] Starting dynamic subtest: bcs0
[37.947337] Dynamic subtest bcs0: SUCCESS (0.031s)
[37.952731] Starting dynamic subtest: vcs0
[37.976898] Dynamic subtest vcs0: SUCCESS (0.029s)
[37.982358] Starting dynamic subtest: vcs1
[38.006059] Dynamic subtest vcs1: SUCCESS (0.029s)
[38.011273] Starting dynamic subtest: vecs0
[38.034657] Dynamic subtest vecs0: SUCCESS (0.028s)
[38.035430] Subtest preempt-other-chain: SUCCESS (0.151s)
[38.287149] [009/137] (941s left) kms_busy (extended-modeset-hang-oldfb)
[38.387343] Starting subtest: extended-modeset-hang-oldfb
[38.388144] Starting dynamic subtest: pipe-A
[39.901974] Dynamic subtest pipe-A: SUCCESS (1.513s)
[39.909040] Starting dynamic subtest: pipe-D
[41.411870] Dynamic subtest pipe-D: SUCCESS (1.505s)
[41.412670] Subtest extended-modeset-hang-oldfb: SUCCESS (3.024s)
[41.521140] [010/137] (937s left) kms_flip (2x-flip-vs-dpms)
[41.607578] Starting subtest: 2x-flip-vs-dpms
[41.620041] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[41.660367] [011/137] (937s left) kms_scaling_modes (scaling-mode-full-aspect)
[41.748123] Starting subtest: scaling-mode-full-aspect
[41.750846] Subtest scaling-mode-full-aspect: SKIP (0.002s)
[41.785028] [012/137] (937s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[41.871266] Starting subtest: 2x-long-flip-vs-cursor-atomic
[41.874304] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[41.910206] [013/137] (937s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[42.001761] Starting subtest: fbc-tiling-linear
[43.007559] Subtest fbc-tiling-linear: SUCCESS (1.007s)
[43.098742] [014/137] (936s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[43.207655] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[43.766074] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.558s)
[43.852666] [015/137] (935s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[43.943092] Starting subtest: cursor-fb-leak-pipe-C
[44.204866] Subtest cursor-fb-leak-pipe-C: SUCCESS (0.262s)
[44.285885] [016/137] (935s left) vc4/vc4_label_bo (set-bad-name)
[44.349678] Subtest set-bad-name: SKIP (0.000s)
[44.377706] [017/137] (935s left) gem_userptr_blits (sync-unmap-after-close)
[44.430462] Starting subtest: sync-unmap-after-close
[44.438992] Subtest sync-unmap-after-close: SUCCESS (0.008s)
[44.511241] [018/137] (934s left) kms_flip (absolute-wf_vblank)
[44.586073] Starting subtest: absolute-wf_vblank
[44.589113] Starting dynamic subtest: A-HDMI-A1
[52.277010] Dynamic subtest A-HDMI-A1: SUCCESS (7.666s)
[52.281263] Starting dynamic subtest: B-HDMI-A1
[59.911639] Dynamic subtest B-HDMI-A1: SUCCESS (7.641s)
[59.915346] Starting dynamic subtest: C-HDMI-A1
[67.568460] Dynamic subtest C-HDMI-A1: SUCCESS (7.640s)
[67.575701] Starting dynamic subtest: D-HDMI-A1
[75.181318] Dynamic subtest D-HDMI-A1: SUCCESS (7.641s)
[75.182116] Subtest absolute-wf_vblank: SUCCESS (30.595s)
[75.311400] [019/137] (904s left) kms_vblank (pipe-a-query-forked)
[75.397958] Starting subtest: pipe-A-query-forked
[76.585995] Subtest pipe-A-query-forked: SUCCESS (1.188s)
[76.676139] [020/137] (902s left) gem_eio (hibernate)
[76.726360] Starting subtest: hibernate
[95.265318] Subtest hibernate: SUCCESS (18.539s)
[96.358590] [021/137] (884s left) perf (create-destroy-userspace-config)
[96.452501] Starting subtest: create-destroy-userspace-config
[96.467888] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[96.483216] [022/137] (883s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[96.573264] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[97.741468] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (1.170s)
[97.833282] [023/137] (882s left) gem_mmap_wc (read-write-distinct)
[97.886923] Starting subtest: read-write-distinct
[97.890036] Subtest read-write-distinct: SUCCESS (0.003s)
[97.940752] [024/137] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[98.035960] Starting subtest: fbcpsr-1p-rte
[98.037417] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[98.086957] [025/137] (882s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[98.172221] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[98.173015] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.248974] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.076s)
[98.255366] Starting dynamic subtest: pipe-B-HDMI-A-1
[98.374537] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.124s)
[98.379793] Starting dynamic subtest: pipe-C-HDMI-A-1
[98.490758] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.115s)
[98.496017] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.616280] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.124s)
[98.617069] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.445s)
[98.754740] [026/137] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[98.850764] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[98.852132] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.904110] [027/137] (881s left) kms_force_connector_basic (force-connector-state)
[99.037380] Starting subtest: force-connector-state
[99.359953] Subtest force-connector-state: SUCCESS (0.324s)
[99.645560] [028/137] (880s left) kms_big_fb (4-tiled-addfb-size-overflow)
[99.741416] Starting subtest: 4-tiled-addfb-size-overflow
[99.742958] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[99.785462] [029/137] (880s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[99.979575] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[99.981174] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[100.091117] [030/137] (880s left) vgem_basic (debugfs)
[100.161932] Starting subtest: debugfs
[100.162682] Subtest debugfs: SUCCESS (0.000s)
[100.191506] [031/137] (880s left) gem_spin_batch (resubmit)
[100.236635] Starting subtest: resubmit
[100.237428] Starting dynamic subtest: rcs0
[100.239235] Dynamic subtest rcs0: SUCCESS (0.002s)
[100.244313] Starting dynamic subtest: bcs0
[100.245120] Dynamic subtest bcs0: SUCCESS (0.002s)
[100.249971] Starting dynamic subtest: vcs0
[100.250732] Dynamic subtest vcs0: SUCCESS (0.001s)
[100.255278] Starting dynamic subtest: vcs1
[100.256012] Dynamic subtest vcs1: SUCCESS (0.001s)
[100.260320] Starting dynamic subtest: vecs0
[100.261059] Dynamic subtest vecs0: SUCCESS (0.001s)
[100.261790] Subtest resubmit: SUCCESS (0.009s)
[100.383091] [032/137] (880s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[100.469353] Starting subtest: cursorA-vs-flipA-toggle
[111.314728] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.844s)
[111.457900] [033/137] (869s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[111.552227] Starting subtest: fbc-indfb-scaledprimary
[114.237488] Subtest fbc-indfb-scaledprimary: SUCCESS (2.687s)
[114.330835] [034/137] (866s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[114.584352] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs
[114.585966] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[114.667092] [035/137] (865s left) gem_pxp (hw-rejects-pxp-buffer)
[117.232741] Starting subtest: hw-rejects-pxp-buffer
[117.233866] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[117.287251] [036/137] (863s left) kms_vblank (pipe-c-wait-busy-hang)
[117.378416] Starting subtest: pipe-C-wait-busy-hang
[131.596384] Subtest pipe-C-wait-busy-hang: SUCCESS (14.218s)
[131.700267] [037/137] (848s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[131.763596] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[131.791892] [038/137] (848s left) kms_vblank (pipe-b-ts-continuation-suspend)
[131.881483] Starting subtest: pipe-B-ts-continuation-suspend
[147.656438] Subtest pipe-B-ts-continuation-suspend: SUCCESS (1.310s)
[150.757603] [039/137] (847s left) gem_ctx_persistence (idempotent)
[150.812163] Starting subtest: idempotent
[150.812952] Subtest idempotent: SUCCESS (0.000s)
[150.846645] [040/137] (847s left) kms_vblank (pipe-b-accuracy-idle)
[150.933036] Starting subtest: pipe-B-accuracy-idle
[152.157304] Subtest pipe-B-accuracy-idle: SUCCESS (1.225s)
[152.252354] [041/137] (845s left) kms_hdr (bpc-switch)
[152.343545] Starting subtest: bpc-switch
[152.345044] Subtest bpc-switch: SKIP (0.000s)
[152.378191] [042/137] (845s left) gem_exec_fence (submit67)
[152.535729] Starting subtest: submit67
[152.536478] Starting dynamic subtest: rcs0
[153.488963] Dynamic subtest rcs0: SUCCESS (0.952s)
[153.495493] Starting dynamic subtest: bcs0
[153.968429] Dynamic subtest bcs0: SUCCESS (0.481s)
[153.974384] Starting dynamic subtest: vcs0
[154.460418] Dynamic subtest vcs0: SUCCESS (0.492s)
[154.466387] Starting dynamic subtest: vcs1
[154.953363] Dynamic subtest vcs1: SUCCESS (0.492s)
[154.959336] Starting dynamic subtest: vecs0
[155.467712] Dynamic subtest vecs0: SUCCESS (0.514s)
[155.468449] Subtest submit67: SUCCESS (2.932s)
[155.880017] [043/137] (842s left) gem_exec_schedule (timeslicing)
[155.939132] Starting subtest: timeslicing
[155.940005] Starting dynamic subtest: rcs0
[155.941948] Dynamic subtest rcs0: SUCCESS (0.003s)
[155.947383] Starting dynamic subtest: bcs0
[155.948147] Dynamic subtest bcs0: SUCCESS (0.002s)
[155.953212] Starting dynamic subtest: vcs0
[155.953914] Dynamic subtest vcs0: SUCCESS (0.002s)
[155.958568] Starting dynamic subtest: vcs1
[155.959289] Dynamic subtest vcs1: SUCCESS (0.002s)
[155.964145] Starting dynamic subtest: vecs0
[155.964929] Dynamic subtest vecs0: SUCCESS (0.002s)
[155.965700] Subtest timeslicing: SUCCESS (0.012s)
[156.220735] [044/137] (841s left) kms_addfb_basic (addfb25-bad-modifier)
[156.319481] Starting subtest: addfb25-bad-modifier
[156.320193] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[156.468310] [045/137] (841s left) gem_partial_pwrite_pread (reads-display)
[156.513118] Starting subtest: reads-display
[157.877510] Subtest reads-display: SUCCESS (1.364s)
[157.954012] [046/137] (840s left) prime_busy (hang)
[158.009550] Starting subtest: hang
[158.010253] Starting dynamic subtest: rcs0
[172.133514] Dynamic subtest rcs0: SUCCESS (14.122s)
[172.138212] Starting dynamic subtest: bcs0
[178.917253] Dynamic subtest bcs0: SUCCESS (6.783s)
[178.921814] Starting dynamic subtest: vcs0
[185.893217] Dynamic subtest vcs0: SUCCESS (6.976s)
[185.897888] Starting dynamic subtest: vcs1
[192.933275] Dynamic subtest vcs1: SUCCESS (7.040s)
[192.938169] Starting dynamic subtest: vecs0
[199.909120] Dynamic subtest vecs0: SUCCESS (6.976s)
[199.909888] Subtest hang: SUCCESS (41.899s)
[199.972795] [047/137] (798s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[200.063918] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[228.764474] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (28.701s)
[228.849932] [048/137] (769s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[228.942915] Starting subtest: y-tiled-64bpp-rotate-180
[230.328456] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.385s)
[230.465961] [049/137] (767s left) drm_fdinfo (virtual-busy)
[230.508503] Starting subtest: virtual-busy
[233.144314] Subtest virtual-busy: SUCCESS (2.635s)
[233.191150] [050/137] (765s left) syncobj_wait (signal)
[233.239542] Starting subtest: signal
[233.240454] Subtest signal: SUCCESS (0.000s)
[233.274799] [051/137] (765s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[233.423938] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[233.425414] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[233.587941] [052/137] (764s left) gem_exec_balancer (semaphore)
[233.635102] Starting subtest: semaphore
[234.434668] Subtest semaphore: SUCCESS (0.799s)
[234.669719] [053/137] (763s left) gem_ctx_param (non-root-set)
[234.715664] Starting subtest: non-root-set
[234.722704] Subtest non-root-set: SUCCESS (0.008s)
[234.772400] [054/137] (763s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[234.917620] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[234.978100] [055/137] (763s left) gem_exec_schedule (fairslice-all)
[235.028631] Starting subtest: fairslice-all
[237.053226] Subtest fairslice-all: SUCCESS (2.025s)
[237.325897] [056/137] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[237.427196] Starting subtest: psr-2p-primscrn-cur-indfb-move
[237.428542] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[237.475807] [057/137] (760s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[237.560878] Starting subtest: nonblocking-crc-frame-sequence
[237.561584] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.895372] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.333s)
[237.900409] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.190816] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.295s)
[238.196374] Starting dynamic subtest: pipe-C-HDMI-A-1
[238.483060] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s)
[238.488669] Starting dynamic subtest: pipe-D-HDMI-A-1
[238.778900] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.294s)
[238.779773] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.218s)
[238.850114] [058/137] (759s left) vc4/vc4_wait_bo (unused-bo-0ns)
[238.911877] Subtest unused-bo-0ns: SKIP (0.000s)
[238.941465] [059/137] (759s left) syncobj_timeline (single-wait-available-submitted)
[238.985048] Starting subtest: single-wait-available-submitted
[238.985812] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[239.024379] [060/137] (759s left) api_intel_allocator (fork-simple-once)
[239.065204] Starting subtest: fork-simple-once
[239.075946] Subtest fork-simple-once: SUCCESS (0.011s)
[239.151885] [061/137] (759s left) i915_getparams_basic (basic-eu-total)
[239.203832] Starting subtest: basic-eu-total
[239.205310] Subtest basic-eu-total: SUCCESS (0.000s)
[239.242203] [062/137] (759s left) kms_big_fb (y-tiled-addfb)
[239.347108] Starting subtest: y-tiled-addfb
[239.347858] Subtest y-tiled-addfb: SUCCESS (0.000s)
[239.407902] [063/137] (759s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[239.493964] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[239.494710] Starting dynamic subtest: pipe-A-HDMI-A-1
[239.586171] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.091s)
[239.591775] Starting dynamic subtest: pipe-B-HDMI-A-1
[239.720017] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.132s)
[239.725593] Starting dynamic subtest: pipe-C-HDMI-A-1
[239.843579] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.122s)
[239.849077] Starting dynamic subtest: pipe-D-HDMI-A-1
[239.975987] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.131s)
[239.976755] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.483s)
[240.096381] [064/137] (758s left) gem_softpin (evict-snoop-interruptible)
[240.139356] Starting subtest: evict-snoop-interruptible
[240.140763] Subtest evict-snoop-interruptible: SKIP (0.000s)
[240.179198] [065/137] (758s left) kms_cursor_crc (cursor-offscreen-64x64)
[240.266590] Starting subtest: cursor-offscreen-64x64
[240.272293] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.489367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.218s)
[241.514048] Starting dynamic subtest: pipe-B-HDMI-A-1
[242.704657] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.195s)
[242.727993] Starting dynamic subtest: pipe-C-HDMI-A-1
[243.913572] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.190s)
[243.940760] Starting dynamic subtest: pipe-D-HDMI-A-1
[245.131411] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.196s)
[245.132183] Subtest cursor-offscreen-64x64: SUCCESS (4.864s)
[245.230147] [066/137] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[245.323328] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[245.324712] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[245.379317] [067/137] (753s left) v3d/v3d_submit_cl (multiple-job-submission)
[245.441644] Subtest multiple-job-submission: SKIP (0.000s)
[245.470910] [068/137] (753s left) kms_cursor_crc (cursor-sliding-max-size)
[245.562468] Starting subtest: cursor-sliding-max-size
[245.564632] Subtest cursor-sliding-max-size: SKIP (0.000s)
[245.620122] [069/137] (752s left) kms_frontbuffer_tracking (fbc-2p-rte)
[245.709816] Starting subtest: fbc-2p-rte
[245.711329] Subtest fbc-2p-rte: SKIP (0.000s)
[245.762335] [070/137] (752s left) gem_vm_create (invalid-create)
[245.804874] Starting subtest: invalid-create
[245.805685] Subtest invalid-create: SUCCESS (0.000s)
[245.870617] [071/137] (752s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[245.923302] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[246.027024] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[246.074378] [072/137] (752s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[246.123458] Starting subtest: y-tiled-to-vebox-yf-tiled
[246.124235] Starting dynamic subtest: smem
[246.189729] Dynamic subtest smem: SUCCESS (0.066s)
[246.190518] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.066s)
[246.346878] [073/137] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[246.441904] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[246.443377] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[246.496079] [074/137] (752s left) kms_dsc (dsc-basic)
[246.583618] Starting subtest: dsc-basic
[246.585086] Subtest dsc-basic: SKIP (0.000s)
[246.622967] [075/137] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[246.715342] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[246.716949] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.764839] [076/137] (751s left) gem_mmap (bad-object)
[246.809483] Starting subtest: bad-object
[246.810365] Subtest bad-object: SUCCESS (0.000s)
[246.859055] [077/137] (751s left) syncobj_timeline (invalid-query-bad-pad)
[246.909894] Starting subtest: invalid-query-bad-pad
[246.910736] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[246.946374] [078/137] (751s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[246.999205] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[247.014301] [079/137] (751s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[247.104674] Starting subtest: pipe-D-wait-forked-busy-hang
[261.261580] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (14.158s)
[261.376233] [080/137] (737s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[261.467099] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[261.467851] Starting dynamic subtest: pipe-A-valid-mode
[261.517022] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[261.518441] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.050s)
[261.587457] [081/137] (737s left) kms_properties (crtc-properties-legacy)
[261.674637] Starting subtest: crtc-properties-legacy
[262.330100] Subtest crtc-properties-legacy: SUCCESS (0.656s)
[262.416269] [082/137] (736s left) gem_ctx_engines (execute-oneforall)
[262.463202] Starting subtest: execute-oneforall
[262.644174] Subtest execute-oneforall: SUCCESS (0.181s)
[262.784210] [083/137] (735s left) gem_lmem_swapping (parallel-random-engines)
[262.842384] Subtest parallel-random-engines: SKIP (0.000s)
[262.859167] [084/137] (735s left) i915_selftest (perf)
[263.626117] Starting subtest: perf
[263.627150] Starting dynamic subtest: engine_cs
[264.268280] Dynamic subtest engine_cs: SUCCESS (0.641s)
[264.272048] Starting dynamic subtest: request
[267.845330] Dynamic subtest request: SUCCESS (3.577s)
[267.849168] Starting dynamic subtest: migrate
[268.397288] Dynamic subtest migrate: SUCCESS (0.552s)
[268.401077] Starting dynamic subtest: region
[269.850243] Dynamic subtest region: SUCCESS (1.453s)
[269.851044] Subtest perf: SUCCESS (6.224s)
[269.858844] [085/137] (728s left) gem_ctx_param (invalid-param-set)
[270.263991] Starting subtest: invalid-param-set
[270.264907] Subtest invalid-param-set: SUCCESS (0.000s)
[270.321565] [086/137] (728s left) gem_userptr_blits (map-fixed-invalidate)
[270.372716] Starting subtest: map-fixed-invalidate
[270.373454] Starting dynamic subtest: gtt
[270.448483] Dynamic subtest gtt: SUCCESS (0.075s)
[270.453126] Starting dynamic subtest: wb
[270.502771] Dynamic subtest wb: SUCCESS (0.054s)
[270.507263] Starting dynamic subtest: wc
[270.560397] Dynamic subtest wc: SUCCESS (0.057s)
[270.564964] Starting dynamic subtest: uc
[270.617396] Dynamic subtest uc: SUCCESS (0.057s)
[270.618118] Subtest map-fixed-invalidate: SUCCESS (0.245s)
[270.691517] [087/137] (728s left) kms_psr (primary_page_flip)
[270.735177] Subtest primary_page_flip: SKIP (0.000s)
[270.750891] [088/137] (727s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[270.795067] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[270.795790] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[270.834993] [089/137] (727s left) kms_content_protection (dp-mst-lic-type-0)
[270.933796] Starting subtest: dp-mst-lic-type-0
[270.935236] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[270.993400] [090/137] (727s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[271.208163] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[271.209965] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[271.293089] [091/137] (727s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[271.382780] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[271.383527] Starting dynamic subtest: pipe-A-valid-mode
[272.110949] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.727s)
[272.111692] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.728s)
[272.206346] [092/137] (726s left) fbdev (read)
[272.251291] Starting subtest: read
[272.907661] Subtest read: SUCCESS (0.656s)
[272.939308] [093/137] (725s left) kms_cursor_crc (cursor-onscreen-512x170)
[273.033296] Starting subtest: cursor-onscreen-512x170
[273.035816] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[273.097513] [094/137] (725s left) api_intel_bb (blit-reloc-purge-cache)
[273.140137] Starting subtest: blit-reloc-purge-cache
[273.149810] Subtest blit-reloc-purge-cache: SUCCESS (0.010s)
[273.221727] [095/137] (725s left) perf_pmu (gt-awake)
[273.277864] Starting subtest: gt-awake
[276.297175] Subtest gt-awake: SUCCESS (3.018s)
[276.355463] [096/137] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[276.449927] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[276.451588] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[276.507044] [097/137] (722s left) perf (short-reads)
[276.578979] Starting subtest: short-reads
[276.592653] Subtest short-reads: SUCCESS (0.014s)
[276.611639] [098/137] (722s left) gem_exec_whisper (basic-fds-forked-all)
[276.658480] Starting subtest: basic-fds-forked-all
[300.041042] Subtest basic-fds-forked-all: SUCCESS (23.381s)
[300.197677] [099/137] (698s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[300.298112] Starting subtest: psr-1p-pri-indfb-multidraw
[300.299594] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[300.343749] [100/137] (698s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[300.515571] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[300.614991] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.099s)
[300.817992] [101/137] (698s left) i915_pm_rpm (pm-caching)
[312.342090] Starting subtest: pm-caching
[318.439761] Subtest pm-caching: SUCCESS (6.099s)
[318.544732] [102/137] (680s left) syncobj_basic (bad-handle-to-fd)
[318.586328] Starting subtest: bad-handle-to-fd
[318.587145] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[318.619961] [103/137] (680s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[318.710319] Starting subtest: psr-rgb101010-draw-mmap-gtt
[318.711707] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[318.761898] [104/137] (680s left) gem_ctx_shared (q-out-order)
[318.808534] Starting subtest: Q-out-order
[318.809322] Starting dynamic subtest: rcs0
[318.850624] Dynamic subtest rcs0: SUCCESS (0.041s)
[318.859708] Starting dynamic subtest: bcs0
[318.893671] Dynamic subtest bcs0: SUCCESS (0.042s)
[318.904687] Starting dynamic subtest: vcs0
[318.938622] Dynamic subtest vcs0: SUCCESS (0.044s)
[318.950137] Starting dynamic subtest: vcs1
[318.985015] Dynamic subtest vcs1: SUCCESS (0.046s)
[318.996478] Starting dynamic subtest: vecs0
[319.032041] Dynamic subtest vecs0: SUCCESS (0.046s)
[319.033156] Subtest Q-out-order: SUCCESS (0.223s)
[319.190838] [105/137] (679s left) kms_rotation_crc (bad-tiling)
[319.285641] Starting subtest: bad-tiling
[320.415321] Subtest bad-tiling: SUCCESS (1.130s)
[320.536954] [106/137] (678s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[320.627350] Starting subtest: cursorB-vs-flipA-toggle
[320.630310] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[320.670871] [107/137] (678s left) kms_plane_multiple (tiling-x)
[320.757518] Starting subtest: tiling-x
[320.758346] Starting dynamic subtest: pipe-A-HDMI-A-1
[321.250978] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.494s)
[321.257874] Starting dynamic subtest: pipe-B-HDMI-A-1
[321.741409] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.489s)
[321.748658] Starting dynamic subtest: pipe-C-HDMI-A-1
[322.265828] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.523s)
[322.271872] Starting dynamic subtest: pipe-D-HDMI-A-1
[322.766705] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.500s)
[322.767464] Subtest tiling-x: SUCCESS (2.010s)
[322.860163] [108/137] (676s left) i915_pm_dc (dc5-dpms)
[333.969581] Starting subtest: dc5-dpms
[345.085693] Subtest dc5-dpms: SUCCESS (11.115s)
[345.124677] [109/137] (653s left) syncobj_timeline (wait-for-submit-snapshot)
[345.169509] Starting subtest: wait-for-submit-snapshot
[345.252652] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[345.307062] [110/137] (653s left) i915_pm_rc6_residency (rc6-accuracy)
[345.526265] Starting subtest: rc6-accuracy
[348.528019] Subtest rc6-accuracy: SUCCESS (3.001s)
[348.566023] [111/137] (650s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[348.743806] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[348.745394] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[348.875658] [112/137] (650s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[349.070770] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[349.072377] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[349.202182] [113/137] (649s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[349.296119] Starting subtest: yf-tiled-32bpp-rotate-0
[349.297559] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[349.358686] [114/137] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[349.448805] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[349.450310] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[349.500817] [115/137] (649s left) gem_exec_params (secure-non-root)
[349.545301] Starting subtest: secure-non-root
[349.546742] Subtest secure-non-root: SKIP (0.000s)
[349.620202] [116/137] (649s left) gem_fence_thrash (bo-write-verify-x)
[349.670118] Starting subtest: bo-write-verify-x
[350.750806] Subtest bo-write-verify-x: SUCCESS (1.080s)
[350.820313] [117/137] (648s left) gem_exec_reloc (basic-write-cpu-noreloc)
[350.870022] Starting subtest: basic-write-cpu-noreloc
[350.871765] Subtest basic-write-cpu-noreloc: SUCCESS (0.002s)
[350.958708] [118/137] (648s left) syncobj_timeline (etime-single-wait-all-submitted)
[351.000329] Starting subtest: etime-single-wait-all-submitted
[351.107572] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[351.154911] [119/137] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[351.253092] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[351.254486] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[351.324712] [120/137] (647s left) gem_busy (busy)
[351.371319] Starting subtest: busy
[351.372099] Starting dynamic subtest: all-engines
[351.390679] Dynamic subtest all-engines: SUCCESS (0.019s)
[351.396525] Starting dynamic subtest: rcs0
[351.401737] Dynamic subtest rcs0: SUCCESS (0.011s)
[351.407299] Starting dynamic subtest: bcs0
[351.420904] Dynamic subtest bcs0: SUCCESS (0.018s)
[351.430627] Starting dynamic subtest: vcs0
[351.431380] Dynamic subtest vcs0: SUCCESS (0.010s)
[351.437332] Starting dynamic subtest: vcs1
[351.447949] Dynamic subtest vcs1: SUCCESS (0.016s)
[351.455898] Starting dynamic subtest: vecs0
[351.458381] Dynamic subtest vecs0: SUCCESS (0.010s)
[351.459111] Subtest busy: SUCCESS (0.087s)
[351.780982] [121/137] (647s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[351.834477] Starting subtest: x-tiled-to-vebox-y-tiled
[351.835356] Starting dynamic subtest: smem
[351.931763] Dynamic subtest smem: SUCCESS (0.097s)
[351.932541] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[352.082480] [122/137] (647s left) syncobj_wait (multi-wait-for-submit-submitted)
[352.122460] Starting subtest: multi-wait-for-submit-submitted
[352.227435] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[352.280292] [123/137] (646s left) v3d/v3d_submit_cl (bad-flag)
[352.346133] Subtest bad-flag: SKIP (0.000s)
[352.376287] [124/137] (646s left) gem_linear_blits (interruptible)
[352.672333] Starting subtest: interruptible
[355.945589] Subtest interruptible: SUCCESS (3.273s)
[356.027406] [125/137] (643s left) gem_userptr_blits (stress-mm)
[356.113730] Starting subtest: stress-mm
[361.484605] Subtest stress-mm: SUCCESS (5.370s)
[361.567842] [126/137] (637s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[361.800684] Starting subtest: pipe-D-random-ccs-data-y_tiled_ccs
[361.803017] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[361.887758] [127/137] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[361.978242] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[361.979653] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[362.038093] [128/137] (637s left) gem_exec_balancer (busy)
[362.085435] Starting subtest: busy
[362.515825] Subtest busy: SUCCESS (0.430s)
[362.745547] [129/137] (636s left) gem_exec_params (batch-first)
[362.795569] Starting subtest: batch-first
[362.797925] Subtest batch-first: SUCCESS (0.002s)
[362.872186] [130/137] (636s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[363.041532] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[363.202606] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SUCCESS (0.161s)
[363.412326] [131/137] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[363.502350] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[363.503795] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[363.565603] [132/137] (635s left) kms_vblank (pipe-d-accuracy-idle)
[363.653860] Starting subtest: pipe-D-accuracy-idle
[364.874145] Subtest pipe-D-accuracy-idle: SUCCESS (1.221s)
[364.963279] [133/137] (634s left) gem_exec_fair (basic-none)
[365.016909] Starting subtest: basic-none
[365.017664] Starting dynamic subtest: rcs0
[370.339673] Dynamic subtest rcs0: FAIL (5.306s)
[370.345369] Starting dynamic subtest: bcs0
[375.849738] Dynamic subtest bcs0: FAIL (5.509s)
[375.855611] Starting dynamic subtest: vcs0
[381.279880] Dynamic subtest vcs0: FAIL (5.430s)
[381.285533] Starting dynamic subtest: vcs1
[386.727701] Dynamic subtest vcs1: FAIL (5.449s)
[386.733371] Starting dynamic subtest: vecs0
[392.123091] Dynamic subtest vecs0: FAIL (5.384s)
[392.124221] Subtest basic-none: FAIL (27.081s)
[392.252467] [134/137] (607s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[392.354799] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[392.946022] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.591s)
[393.029198] [135/137] (606s left) kms_atomic (crtc-invalid-params)
[393.170281] Starting subtest: crtc-invalid-params
[393.203905] Subtest crtc-invalid-params: SUCCESS (0.034s)
[393.355210] [136/137] (606s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[393.585173] Starting subtest: pipe-D-bad-aux-stride-y_tiled_ccs
[393.586742] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[393.661545] [137/137] (605s left) gem_mmap_wc (pf-nonblock)
[393.707803] Starting subtest: pf-nonblock
[393.709584] Subtest pf-nonblock: SUCCESS (0.001s)
[393.767995] Closing watchdogs
Done.