[44.513176] Initializing watchdogs
[44.513426]   /dev/watchdog0
[44.547965] [001/137] (960s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[45.219716] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[45.260892] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[45.663339] [002/137] (959s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[46.073195] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[46.154423] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.044s)
[46.253414] [003/137] (958s left) i915_module_load (reload-no-display)
[46.515278] Starting subtest: reload-no-display
[49.373384] Subtest reload-no-display: SUCCESS (2.873s)
[49.449344] [004/137] (955s left) gem_sync (basic-store-each)
[51.208121] Starting subtest: basic-store-each
[53.779455] Subtest basic-store-each: SUCCESS (2.724s)
[53.984563] [005/137] (951s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[54.622408] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[54.958829] [006/137] (950s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[55.234341] Starting subtest: single-wait-all-for-submit-signaled
[55.266295] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[55.382709] [007/137] (950s left) gem_softpin (evict-active)
[55.930108] Starting subtest: evict-active
[55.954202] Subtest evict-active: SUCCESS (0.024s)
[56.111231] [008/137] (949s left) api_intel_allocator (reopen)
[56.392175] Starting subtest: reopen
[56.418907] Subtest reopen: SUCCESS (0.017s)
[56.520401] [009/137] (949s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[56.961789] Starting subtest: fbc-rgb565-draw-render
[59.096821] Subtest fbc-rgb565-draw-render: SUCCESS (2.223s)
[59.249374] [010/137] (946s left) v3d/v3d_get_param (get-bad-param)
[59.569687] Subtest get-bad-param: SKIP (0.000s)
[59.655225] [011/137] (946s left) debugfs_test (read_all_entries_display_on)
[60.027163] Starting subtest: read_all_entries_display_on
[60.442376] Subtest read_all_entries_display_on: SUCCESS (0.421s)
[60.597976] [012/137] (945s left) perf_pmu (invalid-init)
[60.864721] Starting subtest: invalid-init
[60.886036] Subtest invalid-init: SUCCESS (0.001s)
[60.990166] [013/137] (945s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[61.536320] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[61.600027] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[62.024364] [014/137] (944s left) syncobj_timeline (invalid-wait-illegal-handle)
[62.277336] Starting subtest: invalid-wait-illegal-handle
[62.298997] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[62.400243] [015/137] (943s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs)
[62.931417] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs
[62.976491] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[63.441133] [016/137] (942s left) gen3_render_tiledx_blits
[63.817515] [017/137] (942s left) gem_exec_whisper (basic-fds-priority-all)
[64.113393] Starting subtest: basic-fds-priority-all
[87.978147] Subtest basic-fds-priority-all: SUCCESS (23.880s)
[88.188451] [018/137] (918s left) kms_big_fb (linear-8bpp-rotate-90)
[88.570434] Starting subtest: linear-8bpp-rotate-90
[88.653211] Subtest linear-8bpp-rotate-90: SKIP (0.071s)
[88.760496] [019/137] (917s left) gem_workarounds (basic-read-context)
[89.044757] Starting subtest: basic-read-context
[89.084403] Subtest basic-read-context: SUCCESS (0.027s)
[89.224995] [020/137] (917s left) gem_madvise (dontneed-before-pwrite)
[89.472450] Starting subtest: dontneed-before-pwrite
[89.494508] Subtest dontneed-before-pwrite: SUCCESS (0.004s)
[89.585820] [021/137] (917s left) kms_addfb_basic (invalid-get-prop-any)
[89.843447] Starting subtest: invalid-get-prop-any
[89.864173] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[90.056812] [022/137] (916s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs)
[90.687909] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs
[90.751344] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[91.062258] [023/137] (915s left) perf (mi-rpc)
[91.499111] Starting subtest: mi-rpc
[91.560762] Subtest mi-rpc: SUCCESS (0.069s)
[91.705396] [024/137] (915s left) gem_mmap_wc (write-read-distinct)
[91.951292] Starting subtest: write-read-distinct
[91.972642] Subtest write-read-distinct: SUCCESS (0.030s)
[92.128118] [025/137] (915s left) gem_render_copy (y-tiled-ccs-to-linear)
[92.410994] Starting subtest: y-tiled-ccs-to-linear
[92.429914] Starting dynamic subtest: smem
[92.656732] Dynamic subtest smem: SUCCESS (0.267s)
[92.675423] Subtest y-tiled-ccs-to-linear: SUCCESS (0.267s)
[92.879208] [026/137] (914s left) gem_mmap_offset (bad-object)
[93.138854] Starting subtest: bad-object
[93.159684] Subtest bad-object: SUCCESS (0.004s)
[93.244187] [027/137] (914s left) gem_exec_fence (expired-history)
[94.011104] Starting subtest: expired-history
[99.810410] Subtest expired-history: SUCCESS (5.821s)
[100.424898] [028/137] (907s left) kms_dp_aux_dev
[101.287343] [029/137] (906s left) gem_exec_schedule (semaphore-user)
[101.720682] Starting subtest: semaphore-user
[101.741251] Subtest semaphore-user: SUCCESS (0.017s)
[101.964584] [030/137] (905s left) kms_chamelium_audio (dp-audio-edid)
[102.414451] Subtest dp-audio-edid: SKIP (0.000s)
[102.724359] [031/137] (905s left) kms_flip (busy-flip)
[103.083332] Starting subtest: busy-flip
[103.102174] Starting dynamic subtest: A-DP1
[104.117840] Dynamic subtest A-DP1: SUCCESS (1.062s)
[104.155305] Starting dynamic subtest: B-DP1
[105.074064] Dynamic subtest B-DP1: SUCCESS (0.952s)
[105.109645] Starting dynamic subtest: C-DP1
[106.034913] Dynamic subtest C-DP1: SUCCESS (0.963s)
[106.054100] Subtest busy-flip: SUCCESS (2.984s)
[106.468329] [032/137] (901s left) i915_suspend (basic-s2idle-without-i915)
[106.721218] Starting subtest: basic-s2idle-without-i915
[125.430394] Subtest basic-s2idle-without-i915: SUCCESS (18.718s)
[132.631773] [033/137] (882s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[132.985489] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[134.134126] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.138s)
[134.495715] [034/137] (880s left) kms_color (ctm-negative)
[134.841547] Starting subtest: ctm-negative
[134.860402] Starting dynamic subtest: pipe-A-DP-1
[135.353648] Dynamic subtest pipe-A-DP-1: SUCCESS (0.506s)
[135.391221] Starting dynamic subtest: pipe-B-DP-1
[136.147685] Dynamic subtest pipe-B-DP-1: SUCCESS (0.793s)
[136.182367] Starting dynamic subtest: pipe-C-DP-1
[137.074342] Dynamic subtest pipe-C-DP-1: SUCCESS (0.918s)
[137.093236] Subtest ctm-negative: SUCCESS (2.227s)
[137.426862] [035/137] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[137.840743] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[137.887517] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[137.989310] [036/137] (877s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[138.324880] Subtest bad-multisync-out-sync: SKIP (0.000s)
[138.432143] [037/137] (876s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[138.769323] Starting subtest: cursorB-vs-flipB-atomic
[138.807495] Subtest cursorB-vs-flipB-atomic: SKIP (0.002s)
[138.916515] [038/137] (876s left) kms_psr (psr2_sprite_render)
[139.182222] Subtest psr2_sprite_render: SKIP (0.000s)
[139.292154] [039/137] (876s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[139.606774] Subtest bad-seqno-1ns: SKIP (0.000s)
[139.706528] [040/137] (875s left) vc4/vc4_lookup_fail (bad-color-write)
[140.031667] Subtest bad-color-write: SKIP (0.000s)
[140.141118] [041/137] (875s left) i915_pm_rpm (system-suspend-modeset)
[141.977808] Starting subtest: system-suspend-modeset
[160.920132] Subtest system-suspend-modeset: SUCCESS (2.294s)
[166.284241] [042/137] (870s left) kms_big_fb (x-tiled-addfb-size-overflow)
[166.661887] Starting subtest: x-tiled-addfb-size-overflow
[166.680739] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[166.805479] [043/137] (870s left) kms_pipe_crc_basic (read-crc)
[167.148426] Starting subtest: read-crc
[167.167422] Starting dynamic subtest: pipe-A-DP-1
[167.702578] Dynamic subtest pipe-A-DP-1: SUCCESS (0.551s)
[167.743366] Starting dynamic subtest: pipe-B-DP-1
[168.556714] Dynamic subtest pipe-B-DP-1: SUCCESS (0.837s)
[168.599660] Starting dynamic subtest: pipe-C-DP-1
[169.490711] Dynamic subtest pipe-C-DP-1: SUCCESS (0.924s)
[169.510790] Subtest read-crc: SUCCESS (2.321s)
[169.810295] [044/137] (867s left) kms_flip (2x-flip-vs-panning-interruptible)
[170.170167] Starting subtest: 2x-flip-vs-panning-interruptible
[170.206943] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.004s)
[170.318925] [045/137] (867s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[170.737011] Starting subtest: fbc-rgb101010-draw-mmap-wc
[173.451994] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.680s)
[173.562664] [046/137] (863s left) kms_flip (nonblocking-read)
[173.918623] Starting subtest: nonblocking-read
[173.937656] Subtest nonblocking-read: SUCCESS (0.000s)
[174.046809] [047/137] (863s left) gem_spin_batch (legacy)
[174.321653] Starting subtest: legacy
[174.340654] Starting dynamic subtest: default
[177.846202] Dynamic subtest default: SUCCESS (3.324s)
[177.885396] Starting dynamic subtest: render
[181.239835] Dynamic subtest render: SUCCESS (3.322s)
[181.278686] Starting dynamic subtest: bsd
[184.491966] Dynamic subtest bsd: SUCCESS (3.323s)
[184.528583] Starting dynamic subtest: bsd1
[187.818033] Dynamic subtest bsd1: SUCCESS (3.321s)
[187.856297] Starting dynamic subtest: blt
[191.138659] Dynamic subtest blt: SUCCESS (3.324s)
[191.177607] Starting dynamic subtest: vebox
[194.464554] Dynamic subtest vebox: SUCCESS (3.321s)
[194.483560] Subtest legacy: SUCCESS (19.946s)
[194.569774] [048/137] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[194.993687] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[195.031366] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[195.143033] [049/137] (842s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[195.518891] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[195.599994] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.024s)
[195.712649] [050/137] (842s left) gem_basic (create-fd-close)
[195.963178] Starting subtest: create-fd-close
[196.004433] Subtest create-fd-close: SUCCESS (0.000s)
[196.091321] [051/137] (841s left) syncobj_timeline (wait-any-interrupted)
[196.344199] Starting subtest: wait-any-interrupted
[196.439685] Subtest wait-any-interrupted: SUCCESS (0.106s)
[196.556570] [052/137] (841s left) gem_ctx_param (invalid-ctx-set)
[196.814177] Starting subtest: invalid-ctx-set
[196.835771] Subtest invalid-ctx-set: SUCCESS (0.000s)
[196.928957] [053/137] (841s left) gem_caching (writes)
[197.187557] Starting subtest: writes
[211.398476] Subtest writes: SUCCESS (14.192s)
[211.520873] [054/137] (826s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[211.802070] Starting subtest: yf-tiled-ccs-to-yf-tiled
[211.821029] Starting dynamic subtest: smem
[212.198542] Dynamic subtest smem: SUCCESS (0.419s)
[212.217733] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.420s)
[212.426459] [055/137] (825s left) gen7_exec_parse (cmd-crossing-page)
[212.710601] Subtest cmd-crossing-page: SKIP (0.000s)
[212.801909] [056/137] (825s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[213.064192] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[213.159465] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[213.270924] [057/137] (825s left) syncobj_timeline (reset-multiple-signaled)
[213.549917] Starting subtest: reset-multiple-signaled
[213.574098] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[213.689702] [058/137] (824s left) gem_exec_balancer (nohangcheck)
[217.935014] Starting subtest: nohangcheck
[221.582955] Subtest nohangcheck: SUCCESS (3.654s)
[221.691619] [059/137] (817s left) i915_suspend (sysfs-reader)
[221.955600] Starting subtest: sysfs-reader
[241.264942] Subtest sysfs-reader: SUCCESS (3.239s)
[246.355306] [060/137] (813s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[246.775942] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[248.554506] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (1.857s)
[248.717891] [061/137] (811s left) gem_mmap_gtt (big-copy-odd)
[248.983213] Starting subtest: big-copy-odd
[261.436197] Subtest big-copy-odd: SUCCESS (12.471s)
[261.652884] [062/137] (798s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[262.065839] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[262.177116] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[262.292297] [063/137] (797s left) gem_busy (semaphore)
[262.716615] Starting subtest: semaphore
[262.735873] Starting dynamic subtest: rcs0
[262.754779] Dynamic subtest rcs0: SUCCESS (0.040s)
[262.800183] Starting dynamic subtest: bcs0
[262.819074] Dynamic subtest bcs0: SUCCESS (0.030s)
[262.861491] Starting dynamic subtest: vcs0
[262.883040] Dynamic subtest vcs0: SUCCESS (0.027s)
[262.924878] Starting dynamic subtest: vecs0
[262.946048] Dynamic subtest vecs0: SUCCESS (0.029s)
[262.964863] Subtest semaphore: SUCCESS (0.129s)
[263.083719] [064/137] (797s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[263.456295] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[263.477401] Starting dynamic subtest: pipe-A-DP-1
[263.806088] Dynamic subtest pipe-A-DP-1: SUCCESS (0.333s)
[263.867627] Starting dynamic subtest: pipe-B-DP-1
[264.200479] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s)
[264.256179] Starting dynamic subtest: pipe-C-DP-1
[264.589075] Dynamic subtest pipe-C-DP-1: SUCCESS (0.387s)
[264.611021] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.114s)
[265.019283] [065/137] (795s left) gem_lmem_swapping (parallel-random)
[265.304062] Subtest parallel-random: SKIP (0.000s)
[265.411413] [066/137] (795s left) gem_ppgtt (blt-vs-render-ctxn)
[265.664206] Starting subtest: blt-vs-render-ctxN
[298.393390] Subtest blt-vs-render-ctxN: SUCCESS (32.733s)
[298.533249] [067/137] (761s left) gem_pread (self)
[298.910623] Starting subtest: self
[298.952227] Subtest self: SUCCESS (0.061s)
[299.064299] [068/137] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[299.525637] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[299.566845] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[299.680513] [069/137] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[300.101636] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[300.142377] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[300.252195] [070/137] (760s left) gem_exec_params (cliprects-invalid)
[300.512931] Starting subtest: cliprects-invalid
[300.532067] Subtest cliprects-invalid: SUCCESS (0.001s)
[300.650245] [071/137] (760s left) kms_psr (sprite_mmap_gtt)
[300.905652] Subtest sprite_mmap_gtt: SKIP (0.000s)
[301.002811] [072/137] (759s left) gem_exec_schedule (preempt-other-chain)
[301.448594] Starting subtest: preempt-other-chain
[301.470738] Starting dynamic subtest: rcs0
[301.492311] Dynamic subtest rcs0: SUCCESS (0.099s)
[301.543713] Starting dynamic subtest: bcs0
[301.562745] Dynamic subtest bcs0: SUCCESS (0.102s)
[301.608361] Starting dynamic subtest: vcs0
[301.627463] Dynamic subtest vcs0: SUCCESS (0.100s)
[301.675517] Starting dynamic subtest: vecs0
[301.719728] Dynamic subtest vecs0: SUCCESS (0.098s)
[301.740373] Subtest preempt-other-chain: SUCCESS (0.403s)
[302.079389] [073/137] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[302.502337] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[302.539868] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[302.653550] [074/137] (758s left) perf (oa-exponents)
[303.052162] Starting subtest: oa-exponents
[303.072936] Starting dynamic subtest: 0-rcs0
[307.148589] Dynamic subtest 0-rcs0: SUCCESS (4.102s)
[307.167578] Subtest oa-exponents: SUCCESS (4.103s)
[307.302057] [075/137] (753s left) gem_exec_fence (basic-wait-all)
[307.595822] Starting subtest: basic-wait-all
[307.617092] Subtest basic-wait-all: SUCCESS (0.036s)
[308.400067] [076/137] (752s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[308.862779] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[309.184386] [077/137] (752s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[309.626520] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[309.665369] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[310.234186] [078/137] (751s left) gem_ctx_exec (basic-invalid-context)
[310.496430] Starting subtest: basic-invalid-context
[310.517556] Subtest basic-invalid-context: SUCCESS (0.005s)
[310.631268] [079/137] (751s left) gem_eio (create)
[310.937102] Starting subtest: create
[310.956238] Subtest create: SUCCESS (0.040s)
[311.180581] [080/137] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[311.631955] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[311.677956] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[311.822463] [081/137] (750s left) v3d/v3d_submit_csd (valid-submission)
[312.155607] Subtest valid-submission: SKIP (0.000s)
[312.269315] [082/137] (749s left) kms_cursor_edge_walk (256x256-left-edge)
[312.616241] Starting subtest: 256x256-left-edge
[312.635285] Starting dynamic subtest: pipe-A-DP-1
[316.433928] Dynamic subtest pipe-A-DP-1: SUCCESS (3.802s)
[316.478055] Starting dynamic subtest: pipe-C-DP-1
[319.864295] Dynamic subtest pipe-C-DP-1: SUCCESS (3.443s)
[319.883789] Subtest 256x256-left-edge: SUCCESS (7.251s)
[320.232600] [083/137] (741s left) gem_ctx_persistence (legacy-engines-queued)
[320.495968] Starting subtest: legacy-engines-queued
[320.517347] Starting dynamic subtest: render
[320.558654] Dynamic subtest render: SUCCESS (0.059s)
[320.601848] Starting dynamic subtest: bsd
[320.620767] Dynamic subtest bsd: SUCCESS (0.056s)
[320.672005] Starting dynamic subtest: blt
[320.751019] Dynamic subtest blt: SUCCESS (0.138s)
[320.797023] Starting dynamic subtest: vebox
[320.815826] Dynamic subtest vebox: SUCCESS (0.057s)
[320.834718] Subtest legacy-engines-queued: SUCCESS (0.318s)
[320.928366] [084/137] (741s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[321.201235] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[321.297469] [085/137] (741s left) kms_big_joiner (invalid-modeset)
[321.656448] Subtest invalid-modeset: SKIP (0.000s)
[321.769426] [086/137] (740s left) prime_busy (before)
[322.023331] Starting subtest: before
[322.042261] Starting dynamic subtest: rcs0
[322.060957] Dynamic subtest rcs0: SUCCESS (0.020s)
[322.104809] Starting dynamic subtest: bcs0
[322.126426] Dynamic subtest bcs0: SUCCESS (0.019s)
[322.170026] Starting dynamic subtest: vcs0
[322.191338] Dynamic subtest vcs0: SUCCESS (0.018s)
[322.235515] Starting dynamic subtest: vecs0
[322.254342] Dynamic subtest vecs0: SUCCESS (0.015s)
[322.273147] Subtest before: SUCCESS (0.198s)
[322.366891] [087/137] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[322.785962] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[322.823042] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[322.941576] [088/137] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[323.358316] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[323.400174] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[323.513646] [089/137] (739s left) kms_sequence (get-busy)
[323.857758] Starting subtest: get-busy
[323.879576] Starting dynamic subtest: DP-1-pipe-A
[326.337789] Dynamic subtest DP-1-pipe-A: SUCCESS (2.478s)
[326.387019] Starting dynamic subtest: DP-1-pipe-B
[329.125919] Dynamic subtest DP-1-pipe-B: SUCCESS (2.774s)
[329.185044] Starting dynamic subtest: DP-1-pipe-C
[332.030195] Dynamic subtest DP-1-pipe-C: SUCCESS (2.895s)
[332.051846] Subtest get-busy: SUCCESS (8.155s)
[332.369674] [090/137] (730s left) kms_cursor_crc (cursor-offscreen-512x170)
[332.746947] Starting subtest: cursor-offscreen-512x170
[332.788726] Subtest cursor-offscreen-512x170: SKIP (0.002s)
[332.900510] [091/137] (730s left) gem_lmem_swapping (verify)
[333.181490] Subtest verify: SKIP (0.000s)
[333.294864] [092/137] (729s left) vgem_basic (unload)
[333.556405] Starting subtest: unload
[362.547309] Subtest unload: SUCCESS (28.857s)
[362.647089] [093/137] (700s left) kms_vblank (pipe-a-wait-forked-busy)
[362.996704] Starting subtest: pipe-A-wait-forked-busy
[365.435393] Subtest pipe-A-wait-forked-busy: SUCCESS (2.436s)
[365.811105] [094/137] (697s left) drm_fdinfo (all-busy-check-all)
[366.067305] Starting subtest: all-busy-check-all
[366.599067] Subtest all-busy-check-all: SUCCESS (0.525s)
[366.698910] [095/137] (696s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[367.072424] Starting subtest: 4-tiled-32bpp-rotate-90
[367.115930] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[367.232278] [096/137] (696s left) kms_setmode (basic-clone-single-crtc)
[367.494430] Starting subtest: basic-clone-single-crtc
[367.553675] Subtest basic-clone-single-crtc: SKIP (0.000s)
[367.648432] [097/137] (695s left) feature_discovery (chamelium)
[368.010512] Starting subtest: chamelium
[368.049890] Subtest chamelium: SKIP (0.001s)
[368.162109] [098/137] (695s left) kms_vblank (pipe-a-ts-continuation-idle)
[368.500050] Starting subtest: pipe-A-ts-continuation-idle
[368.765551] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.251s)
[369.134170] [099/137] (694s left) gem_mmap_gtt (basic-write-read)
[369.393350] Starting subtest: basic-write-read
[369.434772] Subtest basic-write-read: SUCCESS (0.032s)
[369.579103] [100/137] (694s left) kms_chamelium_edid (dp-mode-timings)
[370.047804] Subtest dp-mode-timings: SKIP (0.000s)
[370.361414] [101/137] (693s left) gem_ctx_persistence (engines-hostile)
[370.610655] Starting subtest: engines-hostile
[370.629745] Starting dynamic subtest: rcs0
[370.712142] Dynamic subtest rcs0: SUCCESS (0.095s)
[370.754131] Starting dynamic subtest: bcs0
[370.818367] Dynamic subtest bcs0: SUCCESS (0.093s)
[370.864410] Starting dynamic subtest: vcs0
[370.916749] Dynamic subtest vcs0: SUCCESS (0.085s)
[370.968459] Starting dynamic subtest: vecs0
[370.995300] Dynamic subtest vecs0: SUCCESS (0.090s)
[371.023136] Subtest engines-hostile: SUCCESS (0.367s)
[371.159628] [102/137] (692s left) gem_eio (unwedge-stress)
[371.493277] Starting subtest: unwedge-stress
[404.943484] Subtest unwedge-stress: SUCCESS (33.490s)
[405.154044] [103/137] (659s left) kms_flip (2x-nonexisting-fb)
[405.517112] Starting subtest: 2x-nonexisting-fb
[405.555643] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[405.671119] [104/137] (658s left) kms_cursor_crc (cursor-onscreen-64x21)
[406.036196] Starting subtest: cursor-onscreen-64x21
[406.056015] Starting dynamic subtest: pipe-A-DP-1
[408.360869] Dynamic subtest pipe-A-DP-1: SUCCESS (2.323s)
[408.435505] Starting dynamic subtest: pipe-C-DP-1
[411.063788] Dynamic subtest pipe-C-DP-1: SUCCESS (2.651s)
[411.085403] Subtest cursor-onscreen-64x21: SUCCESS (5.043s)
[411.459805] [105/137] (652s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[411.823055] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[411.843783] Starting dynamic subtest: A-DP1
[422.752039] Dynamic subtest A-DP1: SUCCESS (10.774s)
[422.800724] Starting dynamic subtest: B-DP1
[433.277118] Dynamic subtest B-DP1: SUCCESS (10.697s)
[433.321907] Starting dynamic subtest: C-DP1
[444.163449] Dynamic subtest C-DP1: SUCCESS (10.720s)
[444.184688] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.200s)
[444.432804] [106/137] (620s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[444.697066] Starting subtest: invalid-multi-wait-unsubmitted
[444.715869] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[444.837728] [107/137] (619s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[445.182879] Starting subtest: primary-y-tiled-reflect-x-90
[445.220450] Subtest primary-y-tiled-reflect-x-90: SKIP (0.002s)
[445.342395] [108/137] (619s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[446.045135] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[446.368711] [109/137] (618s left) gem_exec_flush (basic-wb-ro-default)
[446.659574] Starting subtest: basic-wb-ro-default
[452.294386] Subtest basic-wb-ro-default: SUCCESS (5.465s)
[452.417181] [110/137] (612s left) kms_vblank (pipe-d-wait-idle)
[452.778443] Subtest pipe-D-wait-idle: SKIP (0.000s)
[452.940489] [111/137] (612s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[453.334207] Starting subtest: psr-shrfb-scaledprimary
[453.377583] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[453.495759] [112/137] (611s left) gem_exec_reloc (basic-cpu-wc-active)
[453.760446] Starting subtest: basic-cpu-wc-active
[453.874510] Subtest basic-cpu-wc-active: SUCCESS (0.141s)
[454.116484] [113/137] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[454.515413] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[454.556499] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[454.670900] [114/137] (610s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[455.259575] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[455.290182] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.001s)
[455.737498] [115/137] (609s left) perf_pmu (busy-no-semaphores)
[456.012102] Starting subtest: busy-no-semaphores
[456.033031] Starting dynamic subtest: rcs0
[456.523038] Dynamic subtest rcs0: SUCCESS (0.523s)
[456.565716] Starting dynamic subtest: bcs0
[457.041340] Dynamic subtest bcs0: SUCCESS (0.516s)
[457.086323] Starting dynamic subtest: vcs0
[457.562334] Dynamic subtest vcs0: SUCCESS (0.516s)
[457.606951] Starting dynamic subtest: vecs0
[458.079483] Dynamic subtest vecs0: SUCCESS (0.517s)
[458.098353] Subtest busy-no-semaphores: SUCCESS (2.080s)
[458.241891] [116/137] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[458.621695] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[458.661844] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[458.782474] [117/137] (606s left) kms_flip_event_leak (basic)
[459.118325] Starting subtest: basic
[459.137179] Starting dynamic subtest: pipe-A-DP-1
[459.420299] Dynamic subtest pipe-A-DP-1: SUCCESS (0.279s)
[459.474918] Starting dynamic subtest: pipe-B-DP-1
[459.966942] Dynamic subtest pipe-B-DP-1: SUCCESS (0.558s)
[460.020765] Starting dynamic subtest: pipe-C-DP-1
[460.654591] Dynamic subtest pipe-C-DP-1: SUCCESS (0.692s)
[460.676378] Subtest basic: SUCCESS (1.538s)
[461.024866] [118/137] (604s left) kms_big_fb (linear-16bpp-rotate-270)
[461.409095] Starting subtest: linear-16bpp-rotate-270
[461.491591] Subtest linear-16bpp-rotate-270: SKIP (0.078s)
[461.637854] [119/137] (604s left) kms_lease (lease-uevent)
[461.988926] Starting subtest: lease-uevent
[463.003536] Subtest lease-uevent: SUCCESS (1.020s)
[463.141099] [120/137] (602s left) gem_softpin (full)
[463.398870] Starting subtest: full
[463.417632] Subtest full: SUCCESS (0.019s)
[463.585432] [121/137] (602s left) gem_exec_params (larger-than-life-batch)
[463.836418] Starting subtest: larger-than-life-batch
[464.379871] Subtest larger-than-life-batch: SKIP (0.364s)
[464.520731] [122/137] (601s left) gem_exec_fence (submit3)
[465.040438] Starting subtest: submit3
[465.062070] Starting dynamic subtest: rcs0
[465.082382] Dynamic subtest rcs0: SUCCESS (0.013s)
[465.125284] Starting dynamic subtest: bcs0
[465.144140] Dynamic subtest bcs0: SUCCESS (0.012s)
[465.186417] Starting dynamic subtest: vcs0
[465.206584] Dynamic subtest vcs0: SUCCESS (0.009s)
[465.252789] Starting dynamic subtest: vecs0
[465.273912] Dynamic subtest vecs0: SUCCESS (0.011s)
[465.294718] Subtest submit3: SUCCESS (0.050s)
[465.751438] [123/137] (600s left) i915_pm_rpm (fences)
[467.811735] Starting subtest: fences
[470.712098] Subtest fences: SUCCESS (2.897s)
[470.982595] [124/137] (595s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[471.388797] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[471.431825] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[471.549170] [125/137] (594s left) kms_getfb (getfb2-into-addfb2)
[471.813698] Starting subtest: getfb2-into-addfb2
[471.833492] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[471.950352] [126/137] (594s left) kms_plane (plane-position-hole)
[472.292760] Starting subtest: plane-position-hole
[472.313806] Starting dynamic subtest: pipe-A-planes
[473.819810] Dynamic subtest pipe-A-planes: SUCCESS (1.501s)
[473.872266] Starting dynamic subtest: pipe-B-planes
[475.535855] Dynamic subtest pipe-B-planes: SUCCESS (1.716s)
[475.555878] Subtest plane-position-hole: SUCCESS (3.225s)
[475.891888] [127/137] (590s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[476.243835] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[476.263565] Starting dynamic subtest: pipe-A-valid-mode
[476.349302] Dynamic subtest pipe-A-valid-mode: SKIP (0.094s)
[476.412778] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.096s)
[476.705844] [128/137] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[477.173804] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[477.221218] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[477.361666] [129/137] (589s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[477.828220] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[477.879553] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[478.447942] [130/137] (588s left) kms_plane_scaling (plane-upscale-with-modifiers-factor-0-25)
[478.848236] Starting subtest: plane-upscale-with-modifiers-factor-0-25
[478.873680] Starting dynamic subtest: pipe-A-DP-1
[479.337107] Dynamic subtest pipe-A-DP-1: SUCCESS (0.498s)
[479.397193] Starting dynamic subtest: pipe-B-DP-1
[480.148857] Dynamic subtest pipe-B-DP-1: SUCCESS (0.803s)
[480.208634] Starting dynamic subtest: pipe-C-DP-1
[480.773956] Dynamic subtest pipe-C-DP-1: SUCCESS (0.632s)
[480.794913] Subtest plane-upscale-with-modifiers-factor-0-25: SUCCESS (1.943s)
[481.211694] [131/137] (585s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[481.760918] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[481.804660] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[482.271749] [132/137] (585s left) gen9_exec_parse (valid-registers)
[482.552069] Starting subtest: valid-registers
[482.704747] Subtest valid-registers: SUCCESS (0.167s)
[482.965424] [133/137] (584s left) kms_flip (flip-vs-panning)
[483.316274] Starting subtest: flip-vs-panning
[483.337154] Starting dynamic subtest: A-DP1
[493.906802] Dynamic subtest A-DP1: SUCCESS (10.587s)
[493.953153] Starting dynamic subtest: B-DP1
[504.432163] Dynamic subtest B-DP1: SUCCESS (10.538s)
[504.478321] Starting dynamic subtest: C-DP1
[514.967034] Dynamic subtest C-DP1: SUCCESS (10.523s)
[514.994339] Subtest flip-vs-panning: SUCCESS (31.658s)
[515.463183] [134/137] (552s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[515.926723] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[515.975484] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[516.117601] [135/137] (551s left) gem_tiled_wc
[519.028233] [136/137] (548s left) gem_readwrite (read-write)
[519.278816] Starting subtest: read-write
[519.356956] Subtest read-write: SUCCESS (0.001s)
[519.458525] [137/137] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[519.840887] Starting subtest: psr-2p-primscrn-spr-indfb-move
[519.883247] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[519.963621] Closing watchdogs
Done.