[38.567408] Initializing watchdogs
[38.567738]   /dev/watchdog0
[38.583173] [001/137] (960s left) gem_ctx_persistence (engines-queued)
[38.796982] Starting subtest: engines-queued
[38.798527] Starting dynamic subtest: rcs0
[38.850432] Dynamic subtest rcs0: SUCCESS (0.053s)
[38.865683] Starting dynamic subtest: bcs0
[38.993827] Dynamic subtest bcs0: SUCCESS (0.142s)
[39.009777] Starting dynamic subtest: vcs0
[39.054436] Dynamic subtest vcs0: SUCCESS (0.061s)
[39.067694] Starting dynamic subtest: vecs0
[39.112150] Dynamic subtest vecs0: SUCCESS (0.058s)
[39.113739] Subtest engines-queued: SUCCESS (0.315s)
[39.203154] [002/137] (959s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[39.670279] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[39.675893] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.006s)
[40.233039] [003/137] (958s left) prime_vgem (fence-wait)
[40.525796] Starting subtest: fence-wait
[40.527705] Starting dynamic subtest: rcs0
[41.570570] Dynamic subtest rcs0: SUCCESS (1.040s)
[41.584313] Starting dynamic subtest: vcs0
[42.602458] Dynamic subtest vcs0: SUCCESS (1.035s)
[42.615437] Starting dynamic subtest: vecs0
[43.630803] Dynamic subtest vecs0: SUCCESS (1.028s)
[43.632739] Subtest fence-wait: SUCCESS (3.104s)
[43.733541] [004/137] (955s left) kms_atomic (plane-immutable-zpos)
[44.400083] Starting subtest: plane-immutable-zpos
[44.634562] Subtest plane-immutable-zpos: SUCCESS (0.236s)
[45.048503] [005/137] (954s left) kms_flip (nonexisting-fb-interruptible)
[45.320094] Starting subtest: nonexisting-fb-interruptible
[45.323610] Starting dynamic subtest: A-DP1
[45.838664] Dynamic subtest A-DP1: SUCCESS (0.512s)
[45.854249] Starting dynamic subtest: B-DP1
[46.338915] Dynamic subtest B-DP1: SUCCESS (0.501s)
[46.354136] Starting dynamic subtest: C-DP1
[46.779070] Dynamic subtest C-DP1: SUCCESS (0.440s)
[46.780985] Subtest nonexisting-fb-interruptible: SUCCESS (1.461s)
[47.174904] [006/137] (952s left) kms_vblank (pipe-d-accuracy-idle)
[47.452983] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[47.520822] [007/137] (951s left) gem_userptr_blits (map-fixed-invalidate-busy)
[47.732574] Starting subtest: map-fixed-invalidate-busy
[47.734083] Starting dynamic subtest: gtt
[51.087976] Dynamic subtest gtt: SUCCESS (3.354s)
[51.102173] Starting dynamic subtest: wb
[54.520676] Dynamic subtest wb: SUCCESS (3.432s)
[54.534862] Starting dynamic subtest: wc
[57.912980] Dynamic subtest wc: SUCCESS (3.392s)
[57.928219] Starting dynamic subtest: uc
[61.357315] Dynamic subtest uc: SUCCESS (3.444s)
[61.358620] Subtest map-fixed-invalidate-busy: SUCCESS (13.623s)
[61.488875] [008/137] (937s left) kms_setmode (invalid-clone-single-crtc-stealing)
[61.668347] Starting subtest: invalid-clone-single-crtc-stealing
[61.672833] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[61.752612] [009/137] (937s left) i915_suspend (basic-s3-without-i915)
[61.924808] Starting subtest: basic-s3-without-i915
[81.677690] Subtest basic-s3-without-i915: SUCCESS (3.888s)
[86.862723] [010/137] (933s left) perf_pmu (all-busy-idle-check-all)
[87.072557] Starting subtest: all-busy-idle-check-all
[87.723962] Subtest all-busy-idle-check-all: SUCCESS (0.652s)
[87.811779] [011/137] (932s left) gem_ctx_shared (q-promotion)
[88.009530] Starting subtest: Q-promotion
[88.010959] Starting dynamic subtest: rcs0
[88.126398] Dynamic subtest rcs0: SUCCESS (0.116s)
[88.160516] Starting dynamic subtest: bcs0
[88.255733] Dynamic subtest bcs0: SUCCESS (0.128s)
[88.283554] Starting dynamic subtest: vcs0
[88.354538] Dynamic subtest vcs0: SUCCESS (0.100s)
[88.376233] Starting dynamic subtest: vecs0
[88.454426] Dynamic subtest vecs0: SUCCESS (0.099s)
[88.455829] Subtest Q-promotion: SUCCESS (0.444s)
[88.676415] [012/137] (931s left) i915_pm_backlight (fade)
[88.956589] Subtest fade: SKIP (0.000s)
[88.997301] [013/137] (931s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[89.554543] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[89.557096] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[89.936613] [014/137] (930s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[90.222362] Starting subtest: fbc-rgb101010-draw-mmap-wc
[92.867787] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.647s)
[92.985276] [015/137] (927s left) gem_exec_balancer (indices)
[93.187353] Starting subtest: indices
[96.945346] Subtest indices: SUCCESS (3.759s)
[100.852919] [016/137] (919s left) gem_userptr_blits (sync-unmap-after-close)
[101.060243] Starting subtest: sync-unmap-after-close
[101.096757] Subtest sync-unmap-after-close: SUCCESS (0.037s)
[101.220644] [017/137] (919s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-0-25)
[101.490997] Starting subtest: planes-downscale-factor-0-75-upscale-0-25
[101.492668] Starting dynamic subtest: pipe-A-DP-1
[101.665612] Dynamic subtest pipe-A-DP-1: SUCCESS (0.175s)
[101.686074] Starting dynamic subtest: pipe-B-DP-1
[102.096502] Dynamic subtest pipe-B-DP-1: SUCCESS (0.428s)
[102.116843] Starting dynamic subtest: pipe-C-DP-1
[102.224546] Dynamic subtest pipe-C-DP-1: SKIP (0.124s)
[102.225844] Subtest planes-downscale-factor-0-75-upscale-0-25: SUCCESS (0.735s)
[102.623126] [018/137] (917s left) kms_big_fb (linear-8bpp-rotate-90)
[102.921400] Starting subtest: linear-8bpp-rotate-90
[103.000394] Subtest linear-8bpp-rotate-90: SKIP (0.076s)
[103.122854] [019/137] (917s left) kms_properties (get_properties-sanity-atomic)
[103.399868] Starting subtest: get_properties-sanity-atomic
[103.403070] Subtest get_properties-sanity-atomic: SUCCESS (0.006s)
[103.488770] [020/137] (917s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[103.782963] Starting subtest: x-tiled-8bpp-rotate-90
[103.868476] Subtest x-tiled-8bpp-rotate-90: SKIP (0.084s)
[103.972062] [021/137] (916s left) sw_sync (sync_busy_fork)
[104.144776] Starting subtest: sync_busy_fork
[105.171618] Subtest sync_busy_fork: SUCCESS (1.026s)
[105.239271] [022/137] (915s left) gem_exec_schedule (u-semaphore-noskip)
[105.442514] Starting subtest: u-semaphore-noskip
[105.679584] Subtest u-semaphore-noskip: SUCCESS (0.237s)
[106.022718] [023/137] (914s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs)
[106.604828] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs
[106.612269] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[106.983053] [024/137] (913s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[107.283615] Starting subtest: cursor-rapid-movement-512x512
[107.287868] Subtest cursor-rapid-movement-512x512: SKIP (0.003s)
[107.383490] [025/137] (913s left) kms_chamelium_frames (dp-frame-dump)
[107.746621] Subtest dp-frame-dump: SKIP (0.000s)
[108.028049] [026/137] (912s left) gem_exec_params (secure-non-master)
[108.209128] Starting subtest: secure-non-master
[108.212347] Subtest secure-non-master: SKIP (0.000s)
[108.321070] [027/137] (912s left) gem_mmap_gtt (medium-copy)
[108.496436] Starting subtest: medium-copy
[114.876913] Subtest medium-copy: SUCCESS (6.380s)
[115.025555] [028/137] (905s left) gem_ctx_isolation (preservation-s3)
[115.351411] Starting subtest: preservation-S3
[115.352862] Starting dynamic subtest: rcs0
[133.798715] Dynamic subtest rcs0: SUCCESS (2.636s)
[133.824965] Starting dynamic subtest: bcs0
[152.738667] Dynamic subtest bcs0: SUCCESS (2.564s)
[152.763381] Starting dynamic subtest: vcs0
[171.626883] Dynamic subtest vcs0: SUCCESS (2.197s)
[171.648147] Starting dynamic subtest: vecs0
[190.617529] Dynamic subtest vecs0: SUCCESS (2.264s)
[190.620118] Subtest preservation-S3: SUCCESS (9.663s)
[194.914462] [029/137] (895s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[195.109769] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[195.112342] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[195.299466] [030/137] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[195.582618] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[195.585314] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[195.683168] [031/137] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[195.960199] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[195.962901] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[196.050393] [032/137] (894s left) kms_vblank (pipe-a-query-forked)
[196.320348] Starting subtest: pipe-A-query-forked
[198.641171] Subtest pipe-A-query-forked: SUCCESS (2.324s)
[198.967602] [033/137] (891s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[199.245109] Starting subtest: primary-4-tiled-reflect-x-180
[199.247929] Subtest primary-4-tiled-reflect-x-180: SKIP (0.002s)
[199.333452] [034/137] (891s left) gem_create (create-ext-cpu-access-sanity-check)
[199.621958] Starting subtest: create-ext-cpu-access-sanity-check
[199.624769] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[199.700569] [035/137] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[199.971673] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[202.077096] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.110s)
[202.216364] [036/137] (888s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[202.585345] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[202.588083] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[203.153453] [037/137] (887s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[203.769080] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[204.080894] [038/137] (886s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[204.370170] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[204.372745] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[204.464001] [039/137] (886s left) api_intel_bb (object-noreloc-purge-cache-simple)
[204.640629] Starting subtest: object-noreloc-purge-cache-simple
[204.646756] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.008s)
[204.763283] [040/137] (886s left) perf_pmu (busy-idle-no-semaphores)
[204.943475] Starting subtest: busy-idle-no-semaphores
[204.945127] Starting dynamic subtest: rcs0
[205.567795] Dynamic subtest rcs0: SUCCESS (0.623s)
[205.591872] Starting dynamic subtest: bcs0
[206.190713] Dynamic subtest bcs0: SUCCESS (0.623s)
[206.214420] Starting dynamic subtest: vcs0
[206.811966] Dynamic subtest vcs0: SUCCESS (0.620s)
[206.838664] Starting dynamic subtest: vecs0
[207.434401] Dynamic subtest vecs0: SUCCESS (0.622s)
[207.436069] Subtest busy-idle-no-semaphores: SUCCESS (2.490s)
[207.545833] [041/137] (883s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[207.815720] Starting subtest: 2x-flip-vs-cursor-legacy
[207.818368] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[207.898274] [042/137] (883s left) drm_fdinfo (most-busy-idle-check-all)
[208.078519] Starting subtest: most-busy-idle-check-all
[208.079989] Starting dynamic subtest: rcs0
[208.708439] Dynamic subtest rcs0: SUCCESS (0.629s)
[208.734898] Starting dynamic subtest: bcs0
[209.332630] Dynamic subtest bcs0: SUCCESS (0.623s)
[209.358239] Starting dynamic subtest: vcs0
[209.953602] Dynamic subtest vcs0: SUCCESS (0.620s)
[209.976588] Starting dynamic subtest: vecs0
[210.573335] Dynamic subtest vecs0: SUCCESS (0.620s)
[210.574589] Subtest most-busy-idle-check-all: SUCCESS (2.495s)
[210.662603] [043/137] (880s left) syncobj_timeline (invalid-signal-bad-pad)
[210.848034] Starting subtest: invalid-signal-bad-pad
[210.849574] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[210.928526] [044/137] (880s left) kms_pipe_crc_basic (suspend-read-crc)
[211.204081] Starting subtest: suspend-read-crc
[211.205543] Starting dynamic subtest: pipe-A-DP-1
[230.006784] Dynamic subtest pipe-A-DP-1: SUCCESS (2.549s)
[230.028576] Starting dynamic subtest: pipe-B-DP-1
[249.021321] Dynamic subtest pipe-B-DP-1: SUCCESS (2.684s)
[249.048496] Starting dynamic subtest: pipe-C-DP-1
[268.174046] Dynamic subtest pipe-C-DP-1: SUCCESS (2.972s)
[268.175924] Subtest suspend-read-crc: SUCCESS (8.213s)
[271.230481] [045/137] (871s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[271.521263] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[271.523804] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[272.207448] [046/137] (870s left) gem_exec_whisper (basic-forked)
[272.403349] Starting subtest: basic-forked
[285.756807] Subtest basic-forked: SUCCESS (13.353s)
[285.956320] [047/137] (856s left) gem_mmap_gtt (basic-small-copy)
[286.130594] Starting subtest: basic-small-copy
[289.024810] Subtest basic-small-copy: SUCCESS (2.892s)
[289.110516] [048/137] (853s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[289.418983] Starting subtest: writes-after-reads
[292.811682] Subtest writes-after-reads: SUCCESS (3.394s)
[292.921534] [049/137] (849s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[293.117216] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[293.118720] Starting dynamic subtest: smem
[293.576823] Dynamic subtest smem: SUCCESS (0.456s)
[293.578574] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.457s)
[293.773507] [050/137] (848s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[294.057173] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[294.058502] Starting dynamic subtest: pipe-A-valid-mode
[294.794265] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.734s)
[294.795558] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.737s)
[295.135350] [051/137] (847s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[295.413302] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[295.414675] Starting dynamic subtest: pipe-A-valid-mode
[295.838365] Dynamic subtest pipe-A-valid-mode: SKIP (0.422s)
[295.840948] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.424s)
[296.212387] [052/137] (846s left) gem_pxp (hw-rejects-pxp-context)
[298.907369] Starting subtest: hw-rejects-pxp-context
[298.908942] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[298.995479] [053/137] (843s left) kms_concurrent (pipe-a)
[299.272122] Starting subtest: pipe-A
[299.275837] Starting dynamic subtest: DP-1
[300.054050] Dynamic subtest DP-1: SUCCESS (0.778s)
[300.055536] Subtest pipe-A: SUCCESS (0.781s)
[300.359055] [054/137] (842s left) v3d/v3d_submit_csd (single-in-sync)
[300.602050] Subtest single-in-sync: SKIP (0.000s)
[300.674384] [055/137] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[300.952445] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[300.955015] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[301.059497] [056/137] (841s left) gem_eio (in-flight-immediate)
[301.268373] Starting subtest: in-flight-immediate
[302.187902] Subtest in-flight-immediate: SUCCESS (0.918s)
[302.376531] [057/137] (840s left) gem_exec_balancer (bonded-dual)
[302.570579] Starting subtest: bonded-dual
[306.375298] Subtest bonded-dual: SUCCESS (3.804s)
[310.257829] [058/137] (832s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[310.874251] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[311.192879] [059/137] (831s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[311.463164] Starting subtest: 2x-plain-flip-ts-check-interruptible
[311.467879] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.003s)
[311.556759] [060/137] (831s left) kms_addfb_basic (addfb25-modifier-no-flag)
[311.833053] Starting subtest: addfb25-modifier-no-flag
[311.834373] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[312.123557] [061/137] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[312.403933] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[312.406579] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[312.507255] [062/137] (830s left) i915_pm_rpm (debugfs-forcewake-user)
[314.600275] Starting subtest: debugfs-forcewake-user
[325.235280] Subtest debugfs-forcewake-user: SUCCESS (10.635s)
[325.707690] [063/137] (817s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[326.153106] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[326.155829] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[326.650518] [064/137] (816s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend)
[326.921819] Starting subtest: pipe-B-ts-continuation-dpms-suspend
[345.786477] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (2.555s)
[351.374073] [065/137] (813s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[351.668920] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[351.672431] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[351.785680] [066/137] (812s left) v3d/v3d_submit_cl (bad-extension)
[352.010074] Subtest bad-extension: SKIP (0.000s)
[352.084615] [067/137] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[352.361033] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[352.363720] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[352.468145] [068/137] (812s left) i915_hangman (engine-engine-error)
[352.663539] Starting subtest: engine-engine-error
[352.664830] Starting dynamic subtest: rcs0
[352.758223] Dynamic subtest rcs0: SUCCESS (0.093s)
[352.784156] Starting dynamic subtest: bcs0
[352.787134] Dynamic subtest bcs0: SKIP (0.003s)
[352.817437] Starting dynamic subtest: vcs0
[352.840198] Dynamic subtest vcs0: SUCCESS (0.077s)
[352.868335] Starting dynamic subtest: vecs0
[352.926149] Dynamic subtest vecs0: SUCCESS (0.085s)
[352.927554] Subtest engine-engine-error: SUCCESS (0.263s)
[353.050892] [069/137] (811s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[353.228330] Starting subtest: multi-wait-for-submit-submitted-signaled
[353.232727] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.003s)
[353.319112] [070/137] (811s left) gem_userptr_blits (unsync-unmap-cycles)
[353.502965] Subtest unsync-unmap-cycles: SKIP (0.000s)
[353.652027] [071/137] (811s left) kms_plane_scaling (i915-max-src-size)
[353.921897] Starting subtest: i915-max-src-size
[353.923213] Starting dynamic subtest: pipe-A-DP-1
[353.989646] Dynamic subtest pipe-A-DP-1: SUCCESS (0.066s)
[353.990971] Subtest i915-max-src-size: SUCCESS (0.067s)
[354.104001] [072/137] (810s left) gem_mmap_gtt (cpuset-big-copy-odd)
[354.279399] Starting subtest: cpuset-big-copy-odd
[377.136928] Subtest cpuset-big-copy-odd: SUCCESS (22.859s)
[377.568659] [073/137] (787s left) gem_exec_fence (basic-busy)
[378.011623] Starting subtest: basic-busy
[378.012949] Starting dynamic subtest: rcs0
[378.044180] Dynamic subtest rcs0: SUCCESS (0.032s)
[378.070910] Starting dynamic subtest: bcs0
[378.080369] Dynamic subtest bcs0: SUCCESS (0.035s)
[378.106044] Starting dynamic subtest: vcs0
[378.116874] Dynamic subtest vcs0: SUCCESS (0.036s)
[378.142307] Starting dynamic subtest: vecs0
[378.145756] Dynamic subtest vecs0: SUCCESS (0.026s)
[378.147227] Subtest basic-busy: SUCCESS (0.134s)
[378.784551] [074/137] (786s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[379.027179] Subtest bad-multisync-in-sync: SKIP (0.000s)
[379.102250] [075/137] (785s left) kms_atomic (plane-cursor-legacy)
[379.751546] Starting subtest: plane-cursor-legacy
[379.819261] Subtest plane-cursor-legacy: SUCCESS (0.068s)
[380.206804] [076/137] (784s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[380.562839] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[380.842777] [077/137] (784s left) gem_softpin (evict-active-interruptible)
[381.021023] Starting subtest: evict-active-interruptible
[381.042820] Subtest evict-active-interruptible: SUCCESS (0.022s)
[381.150612] [078/137] (784s left) i915_pm_rpm (gem-idle)
[382.901877] Starting subtest: gem-idle
[388.495854] Subtest gem-idle: SUCCESS (5.593s)
[388.904837] [079/137] (776s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[389.188003] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[389.192974] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.003s)
[389.286095] [080/137] (775s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[389.566964] Starting subtest: fbcpsr-indfb-scaledprimary
[389.569538] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[389.669209] [081/137] (775s left) gem_exec_schedule (preempt-queue-contexts-chain)
[389.872606] Starting subtest: preempt-queue-contexts-chain
[389.874412] Starting dynamic subtest: rcs0
[390.894353] Dynamic subtest rcs0: SUCCESS (1.022s)
[390.925051] Starting dynamic subtest: bcs0
[391.936572] Dynamic subtest bcs0: SUCCESS (1.041s)
[391.971604] Starting dynamic subtest: vcs0
[392.944530] Dynamic subtest vcs0: SUCCESS (1.004s)
[392.975175] Starting dynamic subtest: vecs0
[393.976221] Dynamic subtest vecs0: SUCCESS (1.033s)
[393.977662] Subtest preempt-queue-contexts-chain: SUCCESS (4.106s)
[394.335724] [082/137] (771s left) gem_mmap_wc (write-gtt-read-wc)
[394.506489] Starting subtest: write-gtt-read-wc
[395.022258] Subtest write-gtt-read-wc: SUCCESS (0.515s)
[395.139635] [083/137] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[395.423232] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[395.426013] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[395.536052] [084/137] (769s left) dmabuf (all-tests)
[395.710190] Starting subtest: all-tests
[395.711645] Starting dynamic subtest: sanitycheck
[395.746253] Dynamic subtest sanitycheck: SUCCESS (0.035s)
[395.774821] Starting dynamic subtest: dma_fence
[395.901343] Dynamic subtest dma_fence: SUCCESS (0.153s)
[395.928939] Starting dynamic subtest: dma_fence_chain
[419.834459] Dynamic subtest dma_fence_chain: SUCCESS (23.931s)
[419.863860] Starting dynamic subtest: dma_fence_unwrap
[419.868562] Dynamic subtest dma_fence_unwrap: SUCCESS (0.032s)
[419.899515] Starting dynamic subtest: dma_resv
[419.902366] Dynamic subtest dma_resv: SUCCESS (0.030s)
[419.903657] Subtest all-tests: SUCCESS (24.189s)
[419.970156] [085/137] (745s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[420.249633] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[461.240416] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (40.985s)
[461.575233] [086/137] (703s left) dumb_buffer (create-clear)
[461.783431] Starting subtest: create-clear
[504.266187] Subtest create-clear: SUCCESS (42.482s)
[504.687524] [087/137] (660s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[504.866901] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[504.868768] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.001s)
[504.953363] [088/137] (660s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[505.233989] Starting subtest: fbc-1p-pri-indfb-multidraw
[520.346334] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (15.114s)
[520.470660] [089/137] (645s left) gem_lmem_swapping (massive)
[520.650661] Subtest massive: SKIP (0.000s)
[520.708080] [090/137] (644s left) gem_render_copy (y-tiled-ccs-to-linear)
[520.892296] Starting subtest: y-tiled-ccs-to-linear
[520.893867] Starting dynamic subtest: smem
[521.161043] Dynamic subtest smem: SUCCESS (0.267s)
[521.162329] Subtest y-tiled-ccs-to-linear: SUCCESS (0.268s)
[521.355353] [091/137] (644s left) kms_vblank (pipe-a-query-forked-hang)
[521.622717] Starting subtest: pipe-A-query-forked-hang
[529.059843] Subtest pipe-A-query-forked-hang: SUCCESS (7.436s)
[529.402348] [092/137] (636s left) gem_userptr_blits (process-exit)
[529.603772] Starting subtest: process-exit
[529.631083] Subtest process-exit: SUCCESS (0.027s)
[529.768942] [093/137] (636s left) gem_fenced_exec_thrash (too-many-fences)
[529.950015] Starting subtest: too-many-fences
[532.116839] Subtest too-many-fences: SUCCESS (2.165s)
[532.516521] [094/137] (633s left) drm_read (empty-block)
[532.910867] Starting subtest: empty-block
[533.911585] Subtest empty-block: SUCCESS (1.001s)
[534.035532] [095/137] (631s left) syncobj_wait (invalid-wait-illegal-handle)
[534.214611] Starting subtest: invalid-wait-illegal-handle
[534.216290] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[534.300182] [096/137] (631s left) gem_vm_create (isolation)
[534.480875] Starting subtest: isolation
[534.491680] Subtest isolation: SUCCESS (0.011s)
[534.600123] [097/137] (631s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[534.885874] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[534.889286] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[534.985191] [098/137] (631s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[535.254050] Starting subtest: basic-busy-flip-before-cursor-varying-size
[535.256588] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[535.335262] [099/137] (630s left) kms_psr (primary_mmap_cpu)
[535.509554] Subtest primary_mmap_cpu: SKIP (0.000s)
[535.570093] [100/137] (630s left) vc4/vc4_wait_bo (used-bo-1ns)
[535.791871] Subtest used-bo-1ns: SKIP (0.000s)
[535.866584] [101/137] (630s left) kms_psr2_su (page_flip-p010)
[536.042994] Subtest page_flip-P010: SKIP (0.000s)
[536.103464] [102/137] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[536.377816] Starting subtest: psr-2p-primscrn-cur-indfb-move
[536.380524] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[536.485187] [103/137] (629s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[536.790144] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[538.023258] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.233s)
[538.352794] [104/137] (627s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[538.624583] Starting subtest: primary-yf-tiled-reflect-x-180
[538.627645] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.003s)
[538.718464] [105/137] (627s left) gem_tiled_blits (interruptible)
[540.642605] Starting subtest: interruptible
[591.556857] Subtest interruptible: SUCCESS (50.913s)
[591.669786] [106/137] (574s left) vc4/vc4_mmap (mmap-bo)
[592.043655] Subtest mmap-bo: SKIP (0.000s)
[592.117322] [107/137] (574s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[592.583259] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[592.586133] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[593.071010] [108/137] (573s left) kms_getfb (getfb2-into-addfb2)
[593.249695] Starting subtest: getfb2-into-addfb2
[593.251210] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[593.340897] [109/137] (573s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[593.639995] Starting subtest: y-tiled-32bpp-rotate-270
[598.694447] Subtest y-tiled-32bpp-rotate-270: SUCCESS (5.052s)
[599.237424] [110/137] (567s left) kms_flip (dpms-off-confusion-interruptible)
[599.509508] Starting subtest: dpms-off-confusion-interruptible
[599.513326] Starting dynamic subtest: A-DP1
[610.038692] Dynamic subtest A-DP1: SUCCESS (10.525s)
[610.069552] Starting dynamic subtest: B-DP1
[620.464339] Dynamic subtest B-DP1: SUCCESS (10.422s)
[620.492748] Starting dynamic subtest: C-DP1
[630.910104] Dynamic subtest C-DP1: SUCCESS (10.439s)
[630.911615] Subtest dpms-off-confusion-interruptible: SUCCESS (31.402s)
[631.328513] [111/137] (535s left) kms_cursor_crc (cursor-offscreen-512x170)
[631.624313] Starting subtest: cursor-offscreen-512x170
[631.632101] Subtest cursor-offscreen-512x170: SKIP (0.002s)
[631.744071] [112/137] (534s left) gem_ctx_param (set-priority-range)
[631.915198] Starting subtest: set-priority-range
[631.967360] Subtest set-priority-range: SUCCESS (0.052s)
[632.075340] [113/137] (534s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[632.350510] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[632.351966] Starting dynamic subtest: pipe-A-DP-1
[632.529693] Dynamic subtest pipe-A-DP-1: SUCCESS (0.181s)
[632.559012] Starting dynamic subtest: pipe-B-DP-1
[632.921945] Dynamic subtest pipe-B-DP-1: SUCCESS (0.389s)
[632.951509] Starting dynamic subtest: pipe-C-DP-1
[633.053831] Dynamic subtest pipe-C-DP-1: SKIP (0.126s)
[633.055160] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.707s)
[633.458329] [114/137] (533s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[633.727315] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[635.999480] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (2.274s)
[636.474855] [115/137] (530s left) syncobj_timeline (single-wait-all-signaled)
[636.651169] Starting subtest: single-wait-all-signaled
[636.653603] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[636.741221] [116/137] (530s left) kms_content_protection (dp-mst-lic-type-1)
[637.045918] Starting subtest: dp-mst-lic-type-1
[637.048592] Subtest dp-mst-lic-type-1: SKIP (0.001s)
[637.141987] [117/137] (529s left) perf_pmu (idle-no-semaphores)
[637.323817] Starting subtest: idle-no-semaphores
[637.325426] Starting dynamic subtest: rcs0
[637.830148] Dynamic subtest rcs0: SUCCESS (0.505s)
[637.856360] Starting dynamic subtest: bcs0
[638.335902] Dynamic subtest bcs0: SUCCESS (0.504s)
[638.361965] Starting dynamic subtest: vcs0
[638.841610] Dynamic subtest vcs0: SUCCESS (0.504s)
[638.867295] Starting dynamic subtest: vecs0
[639.346458] Dynamic subtest vecs0: SUCCESS (0.504s)
[639.348444] Subtest idle-no-semaphores: SUCCESS (2.023s)
[639.442842] [118/137] (527s left) perf (blocking-parameterized)
[639.718593] Starting subtest: blocking-parameterized
[659.839133] Subtest blocking-parameterized: SUCCESS (20.119s)
[659.888005] [119/137] (507s left) gem_exec_params (invalid-fence-in-submit)
[660.062725] Starting subtest: invalid-fence-in-submit
[660.067827] Subtest invalid-fence-in-submit: SUCCESS (0.005s)
[660.175498] [120/137] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[660.467829] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[660.478172] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[660.565687] [121/137] (506s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[661.107522] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[661.110411] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[661.519682] [122/137] (505s left) kms_lease (lease_get)
[661.790444] Starting subtest: lease_get
[661.791846] Starting dynamic subtest: pipe-A-DP-1
[661.793479] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[661.819517] Starting dynamic subtest: pipe-B-DP-1
[661.820794] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[661.846548] Starting dynamic subtest: pipe-C-DP-1
[661.847832] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[661.849102] Subtest lease_get: SUCCESS (0.018s)
[661.919755] [123/137] (505s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[662.209914] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[662.211512] Starting dynamic subtest: pipe-A-valid-mode
[662.900186] Dynamic subtest pipe-A-valid-mode: SKIP (0.693s)
[662.902837] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.696s)
[663.310874] [124/137] (503s left) gem_exec_params (rsvd2-dirt)
[663.489503] Starting subtest: rsvd2-dirt
[663.492731] Subtest rsvd2-dirt: SKIP (0.000s)
[663.609125] [125/137] (503s left) syncobj_wait (wait-any-snapshot)
[663.783154] Starting subtest: wait-any-snapshot
[663.865864] Subtest wait-any-snapshot: SUCCESS (0.082s)
[663.958907] [126/137] (503s left) gem_mmap_wc (write-wc-read-gtt)
[664.132122] Starting subtest: write-wc-read-gtt
[664.661737] Subtest write-wc-read-gtt: SUCCESS (0.530s)
[664.773623] [127/137] (502s left) kms_cursor_crc (cursor-sliding-256x256)
[665.049054] Starting subtest: cursor-sliding-256x256
[665.060433] Starting dynamic subtest: pipe-A-DP-1
[668.735308] Dynamic subtest pipe-A-DP-1: SUCCESS (3.669s)
[668.816257] Starting dynamic subtest: pipe-B-DP-1
[672.642703] Dynamic subtest pipe-B-DP-1: SUCCESS (3.853s)
[672.738871] Starting dynamic subtest: pipe-C-DP-1
[676.731598] Dynamic subtest pipe-C-DP-1: SUCCESS (4.024s)
[676.735473] Subtest cursor-sliding-256x256: SUCCESS (11.680s)
[677.088711] [128/137] (490s left) gem_readwrite (new-obj)
[677.261936] Starting subtest: new-obj
[677.264735] Subtest new-obj: SUCCESS (0.000s)
[677.368082] [129/137] (489s left) gem_exec_fence (syncobj-export)
[677.969567] Starting subtest: syncobj-export
[677.977146] Subtest syncobj-export: SUCCESS (0.008s)
[678.334099] [130/137] (489s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[678.608320] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[678.611367] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[678.717062] [131/137] (488s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[679.348598] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[679.664349] [132/137] (487s left) kms_addfb_basic (unused-modifier)
[679.837538] Starting subtest: unused-modifier
[679.839009] Subtest unused-modifier: SUCCESS (0.000s)
[680.215608] [133/137] (487s left) gem_spin_batch (legacy-resubmit)
[680.407059] Starting subtest: legacy-resubmit
[680.411698] Starting dynamic subtest: default
[680.415576] Dynamic subtest default: SUCCESS (0.006s)
[680.453046] Starting dynamic subtest: render
[680.454556] Dynamic subtest render: SUCCESS (0.005s)
[680.480400] Starting dynamic subtest: bsd
[680.481835] Dynamic subtest bsd: SUCCESS (0.005s)
[680.506301] Starting dynamic subtest: bsd1
[680.507625] Dynamic subtest bsd1: SUCCESS (0.006s)
[680.532109] Starting dynamic subtest: blt
[680.533457] Dynamic subtest blt: SUCCESS (0.009s)
[680.557820] Starting dynamic subtest: vebox
[680.559175] Dynamic subtest vebox: SUCCESS (0.007s)
[680.560503] Subtest legacy-resubmit: SUCCESS (0.050s)
[680.681594] [134/137] (486s left) sysfs_preempt_timeout (idempotent)
[680.861470] Starting subtest: idempotent
[680.866546] Starting dynamic subtest: vecs0
[680.868215] Dynamic subtest vecs0: SUCCESS (0.003s)
[680.895983] Starting dynamic subtest: vcs0
[680.897335] Dynamic subtest vcs0: SUCCESS (0.002s)
[680.922466] Starting dynamic subtest: bcs0
[680.923796] Dynamic subtest bcs0: SUCCESS (0.002s)
[680.948844] Starting dynamic subtest: rcs0
[680.950122] Dynamic subtest rcs0: SUCCESS (0.002s)
[680.951483] Subtest idempotent: SUCCESS (0.018s)
[680.986767] [135/137] (486s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[681.277493] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[682.352244] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.075s)
[682.683444] [136/137] (484s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[682.865955] Starting subtest: basic-gtt-wc-noreloc
[682.876843] Subtest basic-gtt-wc-noreloc: SUCCESS (0.011s)
[683.064746] [137/137] (484s left) sw_sync (sync_multi_timeline_wait)
[683.233416] Starting subtest: sync_multi_timeline_wait
[683.234882] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[683.309908] Closing watchdogs
Done.