[44.946902] Initializing watchdogs
[44.947065]   /dev/watchdog0
[44.960564] [001/132] (960s left) prime_vgem (busy)
[45.109839] Starting subtest: busy
[45.112662] Starting dynamic subtest: rcs0
[45.159052] Dynamic subtest rcs0: SUCCESS (0.049s)
[45.173045] Starting dynamic subtest: bcs0
[45.229167] Dynamic subtest bcs0: SUCCESS (0.070s)
[45.240127] Starting dynamic subtest: vcs0
[45.290184] Dynamic subtest vcs0: SUCCESS (0.060s)
[45.302093] Starting dynamic subtest: vcs1
[45.346312] Dynamic subtest vcs1: SUCCESS (0.056s)
[45.358394] Starting dynamic subtest: vecs0
[45.399370] Dynamic subtest vecs0: SUCCESS (0.054s)
[45.408022] Starting dynamic subtest: ccs0
[45.456889] Dynamic subtest ccs0: SUCCESS (0.057s)
[45.459570] Subtest busy: SUCCESS (0.347s)
[45.569083] [002/132] (959s left) prime_vgem (coherency-gtt)
[45.677317] Starting subtest: coherency-gtt
[45.681887] Subtest coherency-gtt: SKIP (0.000s)
[45.752725] [003/132] (959s left) kms_psr (fbc-pr-cursor-plane-onoff)
[45.858410] Starting subtest: fbc-pr-cursor-plane-onoff
[45.862377] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[45.917755] [004/132] (959s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[46.014466] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[46.019080] Starting dynamic subtest: A-eDP1
[49.971970] Dynamic subtest A-eDP1: SUCCESS (3.950s)
[49.984597] Starting dynamic subtest: B-eDP1
[53.432335] Dynamic subtest B-eDP1: SUCCESS (3.462s)
[53.444975] Starting dynamic subtest: C-eDP1
[56.885743] Dynamic subtest C-eDP1: SUCCESS (3.451s)
[56.898617] Starting dynamic subtest: D-eDP1
[60.340930] Dynamic subtest D-eDP1: SUCCESS (3.453s)
[60.346226] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (14.332s)
[61.239385] [005/132] (944s left) kms_flip (2x-nonexisting-fb)
[61.324359] Starting subtest: 2x-nonexisting-fb
[61.335579] Subtest 2x-nonexisting-fb: SKIP (0.013s)
[61.405490] [006/132] (944s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[61.488406] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[66.758487] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.275s)
[66.874903] [007/132] (938s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[66.977166] Starting subtest: y-tiled-16bpp-rotate-90
[66.981715] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[67.059348] [008/132] (938s left) kms_chamelium_audio (hdmi-audio)
[67.457444] Subtest hdmi-audio: SKIP (0.000s)
[68.317494] [009/132] (937s left) gem_eio (banned)
[68.502613] Starting subtest: banned
[68.984286] Subtest banned: SUCCESS (0.484s)
[69.090721] [010/132] (936s left) perf (gen12-group-concurrent-oa-buffer-read)
[69.225396] Starting subtest: gen12-group-concurrent-oa-buffer-read
[79.331861] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.055s)
[79.363153] [011/132] (926s left) kms_big_fb (linear-16bpp-rotate-0)
[79.460423] Starting subtest: linear-16bpp-rotate-0
[80.948417] Subtest linear-16bpp-rotate-0: SUCCESS (1.490s)
[81.075608] [012/132] (924s left) gem_exec_fence (submit)
[81.261733] Starting subtest: submit
[81.266390] Subtest submit: SKIP (0.000s)
[83.517383] [013/132] (922s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[83.602645] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[83.606528] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[83.686173] [014/132] (922s left) i915_query (query-topology-garbage-items)
[83.769429] Starting subtest: query-topology-garbage-items
[83.772050] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[83.843628] [015/132] (921s left) gem_create (create-ext-set-pat)
[84.014500] Starting subtest: create-ext-set-pat
[84.017385] Subtest create-ext-set-pat: SUCCESS (0.001s)
[84.100821] [016/132] (921s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[84.173460] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[88.994171] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.826s)
[89.100873] [017/132] (916s left) drm_fdinfo (busy-idle)
[89.150404] Starting subtest: busy-idle
[89.153100] Starting dynamic subtest: rcs0
[89.157668] Dynamic subtest rcs0: SKIP (0.000s)
[89.165447] Starting dynamic subtest: bcs0
[89.169760] Dynamic subtest bcs0: SKIP (0.000s)
[89.184139] Starting dynamic subtest: vcs0
[89.189599] Dynamic subtest vcs0: SKIP (0.000s)
[89.203356] Starting dynamic subtest: vcs1
[89.208622] Dynamic subtest vcs1: SKIP (0.000s)
[89.220258] Starting dynamic subtest: vecs0
[89.225302] Dynamic subtest vecs0: SKIP (0.000s)
[89.235282] Starting dynamic subtest: ccs0
[89.240239] Dynamic subtest ccs0: SKIP (0.000s)
[89.245244] Subtest busy-idle: SKIP (0.001s)
[89.265438] [018/132] (916s left) syncobj_wait (single-wait-for-submit-submitted)
[89.327803] Starting subtest: single-wait-for-submit-submitted
[89.432188] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[89.501407] [019/132] (916s left) kms_lease (possible-crtcs-filtering)
[89.598055] Starting subtest: possible-crtcs-filtering
[89.603537] Subtest possible-crtcs-filtering: SUCCESS (0.004s)
[89.686231] [020/132] (916s left) gem_exec_schedule (preempt)
[89.766855] Starting subtest: preempt
[89.769495] Starting dynamic subtest: rcs0
[89.781419] Dynamic subtest rcs0: SUCCESS (0.021s)
[89.792744] Starting dynamic subtest: bcs0
[89.797660] Dynamic subtest bcs0: SUCCESS (0.016s)
[89.812259] Starting dynamic subtest: vcs0
[89.817756] Dynamic subtest vcs0: SUCCESS (0.022s)
[89.831221] Starting dynamic subtest: vcs1
[89.839354] Dynamic subtest vcs1: SUCCESS (0.021s)
[89.853839] Starting dynamic subtest: vecs0
[89.862105] Dynamic subtest vecs0: SUCCESS (0.022s)
[89.874488] Starting dynamic subtest: ccs0
[89.880923] Dynamic subtest ccs0: SUCCESS (0.019s)
[89.883314] Subtest preempt: SUCCESS (0.123s)
[91.520363] [021/132] (914s left) kms_frontbuffer_tracking (basic)
[91.597040] Starting subtest: basic
[94.875908] Subtest basic: SUCCESS (3.283s)
[94.975117] [022/132] (911s left) api_intel_allocator (reloc-allocator)
[95.036357] Starting subtest: reloc-allocator
[95.038482] Starting dynamic subtest: basic
[95.042694] Dynamic subtest basic: SUCCESS (0.006s)
[95.056937] Starting dynamic subtest: parallel-one
[95.058801] Dynamic subtest parallel-one: SUCCESS (0.012s)
[95.071162] Starting dynamic subtest: print
[95.073547] Dynamic subtest print: SUCCESS (0.000s)
[95.086151] Starting dynamic subtest: reuse
[95.088119] Dynamic subtest reuse: SUCCESS (0.000s)
[95.100994] Starting dynamic subtest: fork-reopen-allocator
[95.102916] Dynamic subtest fork-reopen-allocator: SUCCESS (0.025s)
[95.104891] Subtest reloc-allocator: SUCCESS (0.045s)
[95.184631] [023/132] (910s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[95.279956] Starting subtest: fbc-rgb101010-draw-render
[98.956154] Subtest fbc-rgb101010-draw-render: SUCCESS (3.676s)
[99.050198] [024/132] (907s left) kms_cursor_crc (cursor-offscreen-128x128)
[99.265130] Starting subtest: cursor-offscreen-128x128
[99.267651] Starting dynamic subtest: pipe-A-eDP-1
[101.314482] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.044s)
[101.348895] Starting dynamic subtest: pipe-D-eDP-1
[104.052035] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.715s)
[104.054676] Subtest cursor-offscreen-128x128: SUCCESS (4.785s)
[104.935388] [025/132] (901s left) gem_exec_nop (basic-parallel)
[105.020566] Starting subtest: basic-parallel
[121.412570] Subtest basic-parallel: SUCCESS (16.397s)
[121.624312] [026/132] (884s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[121.721108] Starting subtest: yf-tiled-64bpp-rotate-90
[121.725446] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[121.801924] [027/132] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[121.901686] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[121.905671] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[121.987129] [028/132] (884s left) perf_pmu (module-unload)
[122.072518] Starting subtest: module-unload
[159.764185] Subtest module-unload: SUCCESS (37.690s)
[159.784289] [029/132] (846s left) kms_cursor_crc (cursor-random-512x170)
[161.697618] Starting subtest: cursor-random-512x170
[161.702441] Subtest cursor-random-512x170: SKIP (0.001s)
[161.790609] [030/132] (844s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[161.900582] Starting subtest: fbcpsr-stridechange
[166.281972] Subtest fbcpsr-stridechange: SUCCESS (4.388s)
[166.408966] [031/132] (839s left) perf_pmu (interrupts)
[166.473927] Starting subtest: interrupts
[167.551504] Subtest interrupts: SUCCESS (1.076s)
[167.649690] [032/132] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[167.763863] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[170.502631] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.745s)
[170.633534] [033/132] (835s left) gem_ppgtt (shrink-vs-evict-pinned)
[170.689888] Starting subtest: shrink-vs-evict-pinned
[178.489420] Subtest shrink-vs-evict-pinned: SUCCESS (7.746s)
[178.514518] [034/132] (827s left) kms_big_fb (linear-16bpp-rotate-90)
[178.624557] Starting subtest: linear-16bpp-rotate-90
[178.643069] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[178.718264] [035/132] (827s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[178.805498] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[178.807931] Starting dynamic subtest: pipe-A-default-mode
[180.027451] Dynamic subtest pipe-A-default-mode: SKIP (1.218s)
[180.033039] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.221s)
[180.162497] [036/132] (826s left) gem_spin_batch (resubmit)
[180.258201] Starting subtest: resubmit
[180.261139] Starting dynamic subtest: rcs0
[180.271926] Dynamic subtest rcs0: SUCCESS (0.014s)
[180.287544] Starting dynamic subtest: bcs0
[180.290171] Dynamic subtest bcs0: SUCCESS (0.005s)
[180.304688] Starting dynamic subtest: vcs0
[180.306848] Dynamic subtest vcs0: SUCCESS (0.005s)
[180.319574] Starting dynamic subtest: vcs1
[180.322158] Dynamic subtest vcs1: SUCCESS (0.006s)
[180.332146] Starting dynamic subtest: vecs0
[180.334676] Dynamic subtest vecs0: SUCCESS (0.005s)
[180.342846] Starting dynamic subtest: ccs0
[180.345134] Dynamic subtest ccs0: SUCCESS (0.005s)
[180.347486] Subtest resubmit: SUCCESS (0.045s)
[181.478407] [037/132] (824s left) gem_mmap_gtt (pf-nonblock)
[181.544048] Subtest pf-nonblock: SKIP (0.000s)
[181.579067] [038/132] (824s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[181.680305] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[182.324421] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.647s)
[182.478674] [039/132] (823s left) gem_media_vme
[182.621772] [040/132] (823s left) api_intel_bb (object-reloc-keep-cache)
[182.707036] Starting subtest: object-reloc-keep-cache
[182.714563] Subtest object-reloc-keep-cache: SKIP (0.006s)
[182.795233] [041/132] (823s left) kms_psr (pr-sprite-plane-onoff)
[182.882496] Starting subtest: pr-sprite-plane-onoff
[182.887318] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[182.957352] [042/132] (823s left) vc4/vc4_create_bo (create-bo-4096)
[183.054616] Subtest create-bo-4096: SKIP (0.000s)
[183.106992] [043/132] (823s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[183.198059] Starting subtest: flip-primary-invalidate-overlay
[194.626953] Subtest flip-primary-invalidate-overlay: SUCCESS (11.432s)
[194.782896] [044/132] (811s left) gem_exec_balancer (parallel-keep-in-fence)
[195.046992] Starting subtest: parallel-keep-in-fence
[195.921439] Subtest parallel-keep-in-fence: SUCCESS (0.875s)
[196.002037] [045/132] (810s left) kms_flip (2x-wf_vblank-ts-check)
[196.071046] Starting subtest: 2x-wf_vblank-ts-check
[196.082025] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[196.155465] [046/132] (810s left) syncobj_timeline (invalid-wait-illegal-handle)
[196.238614] Starting subtest: invalid-wait-illegal-handle
[196.240998] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[196.324493] [047/132] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[196.406882] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[196.410772] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[196.490128] [048/132] (810s left) gem_ctx_persistence (engines-mixed-process)
[196.562310] Starting subtest: engines-mixed-process
[196.565046] Starting dynamic subtest: rcs0
[198.465972] Dynamic subtest rcs0: SUCCESS (1.903s)
[198.482474] Starting dynamic subtest: bcs0
[200.434685] Dynamic subtest bcs0: SUCCESS (1.967s)
[200.450152] Starting dynamic subtest: vcs0
[202.435872] Dynamic subtest vcs0: SUCCESS (2.001s)
[202.451895] Starting dynamic subtest: vcs1
[204.419039] Dynamic subtest vcs1: SUCCESS (1.982s)
[204.435293] Starting dynamic subtest: vecs0
[206.450137] Dynamic subtest vecs0: SUCCESS (2.030s)
[206.466323] Starting dynamic subtest: ccs0
[208.435071] Dynamic subtest ccs0: SUCCESS (1.983s)
[208.437754] Subtest engines-mixed-process: SUCCESS (11.872s)
[208.525334] [049/132] (798s left) gem_fenced_exec_thrash (no-spare-fences)
[208.593179] Subtest no-spare-fences: SKIP (0.000s)
[208.635103] [050/132] (798s left) gem_exec_fair (basic-deadline)
[208.723161] Subtest basic-deadline: SKIP (0.000s)
[208.749793] [051/132] (798s left) kms_chamelium_frames (hdmi-crc-fast)
[209.151862] Subtest hdmi-crc-fast: SKIP (0.000s)
[210.025187] [052/132] (796s left) core_getstats
[210.186670] [053/132] (796s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[210.281649] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[215.029573] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.754s)
[215.176136] [054/132] (791s left) gem_render_copy (yf-tiled-to-vebox-linear)
[215.264043] Starting subtest: yf-tiled-to-vebox-linear
[215.268747] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[215.450793] [055/132] (791s left) gem_mmap_gtt (basic-read-write)
[215.522807] Subtest basic-read-write: SKIP (0.000s)
[215.575277] [056/132] (791s left) gem_lmem_evict (dontneed-evict-race)
[215.620746] Subtest dontneed-evict-race: SKIP (0.000s)
[215.652368] [057/132] (791s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[215.764428] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[215.769238] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[215.874508] [058/132] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[215.970111] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[215.973919] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.048613] [059/132] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[216.147543] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[216.152522] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.237412] [060/132] (790s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[216.321761] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[216.422847] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[216.495353] [061/132] (790s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[216.564292] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[216.566165] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[216.642615] [062/132] (790s left) perf (unprivileged-single-ctx-counters)
[216.761160] Starting subtest: unprivileged-single-ctx-counters
[216.764878] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[216.787715] [063/132] (790s left) i915_suspend (forcewake)
[216.834741] Starting subtest: forcewake
[249.819441] Subtest forcewake: SUCCESS (3.027s)
[249.899436] [064/132] (787s left) gem_set_tiling_vs_gtt
[249.987188] [065/132] (787s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[250.070426] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[250.072880] Starting dynamic subtest: pipe-A-eDP-1
[250.075155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[250.081976] Starting dynamic subtest: pipe-B-eDP-1
[250.084355] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[250.090897] Starting dynamic subtest: pipe-C-eDP-1
[250.093222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[250.099830] Starting dynamic subtest: pipe-D-eDP-1
[250.102077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.104346] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[250.146549] [066/132] (787s left) gem_pxp (reject-modify-context-protection-off-3)
[252.784355] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[252.819253] [067/132] (784s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[252.925135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[252.927497] Starting dynamic subtest: pipe-A-default-mode
[255.903892] Dynamic subtest pipe-A-default-mode: SUCCESS (2.976s)
[255.906884] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.978s)
[256.839028] [068/132] (780s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[256.938978] Starting subtest: fbc-dirtyfb-ioctl
[256.941790] Starting dynamic subtest: A-eDP-1
[258.534949] Dynamic subtest A-eDP-1: SUCCESS (1.594s)
[258.537605] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.597s)
[259.462552] [069/132] (777s left) gen9_exec_parse (basic-rejected-ctx-param)
[259.531807] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[259.573976] [070/132] (777s left) syncobj_wait (multi-wait-signaled)
[259.639848] Starting subtest: multi-wait-signaled
[259.642086] Subtest multi-wait-signaled: SUCCESS (0.000s)
[259.712924] [071/132] (777s left) kms_universal_plane (cursor-fb-leak)
[259.822045] Starting subtest: cursor-fb-leak
[259.824508] Starting dynamic subtest: pipe-A-eDP-1
[260.417647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[260.430157] Starting dynamic subtest: pipe-B-eDP-1
[261.689858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.272s)
[261.708969] Starting dynamic subtest: pipe-C-eDP-1
[262.955515] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.261s)
[262.975087] Starting dynamic subtest: pipe-D-eDP-1
[264.205149] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[264.208090] Subtest cursor-fb-leak: SUCCESS (4.383s)
[265.093036] [072/132] (772s left) gem_ctx_persistence (smoketest)
[265.180503] Starting subtest: smoketest
[296.412495] Subtest smoketest: SUCCESS (31.230s)
[296.489770] [073/132] (740s left) kms_vblank (ts-continuation-dpms-suspend)
[296.580058] Starting subtest: ts-continuation-dpms-suspend
[296.582839] Starting dynamic subtest: pipe-A-eDP-1
[313.393190] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[313.414008] Starting dynamic subtest: pipe-D-eDP-1
[331.365280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[331.368112] Subtest ts-continuation-dpms-suspend: SUCCESS (4.371s)
[332.311242] [074/132] (735s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[332.401873] Starting subtest: psr-rgb565-draw-mmap-cpu
[337.250734] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.854s)
[337.349597] [075/132] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[337.482017] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[337.487041] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[337.572051] [076/132] (730s left) kms_properties (get_properties-sanity-non-atomic)
[337.670210] Starting subtest: get_properties-sanity-non-atomic
[337.672895] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[337.741548] [077/132] (730s left) gem_userptr_blits (huge-split)
[337.824547] Starting subtest: huge-split
[337.834612] Subtest huge-split: SUCCESS (0.010s)
[337.928883] [078/132] (730s left) gem_exec_params (invalid-batch-start-offset)
[338.011667] Starting subtest: invalid-batch-start-offset
[338.018711] Subtest invalid-batch-start-offset: SUCCESS (0.004s)
[338.114392] [079/132] (729s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[338.181937] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[338.184101] Starting dynamic subtest: pipe-A-eDP-1
[339.331862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.147s)
[339.351166] Starting dynamic subtest: pipe-B-eDP-1
[341.708125] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.376s)
[341.729524] Starting dynamic subtest: pipe-C-eDP-1
[343.874576] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.161s)
[343.892113] Starting dynamic subtest: pipe-D-eDP-1
[346.072276] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.197s)
[346.074747] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (7.891s)
[347.366267] [080/132] (720s left) kms_flip (dpms-vs-vblank-race-interruptible)
[347.465261] Starting subtest: dpms-vs-vblank-race-interruptible
[347.467738] Starting dynamic subtest: A-eDP1
[351.516495] Dynamic subtest A-eDP1: SUCCESS (4.048s)
[351.538183] Starting dynamic subtest: B-eDP1
[355.175782] Dynamic subtest B-eDP1: SUCCESS (3.660s)
[355.195700] Starting dynamic subtest: C-eDP1
[358.816259] Dynamic subtest C-eDP1: SUCCESS (3.637s)
[358.835611] Starting dynamic subtest: D-eDP1
[362.461025] Dynamic subtest D-eDP1: SUCCESS (3.641s)
[362.467046] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.000s)
[363.351031] [081/132] (704s left) kms_flip (plain-flip-ts-check-interruptible)
[363.461726] Starting subtest: plain-flip-ts-check-interruptible
[363.464101] Starting dynamic subtest: A-eDP1
[372.459236] Dynamic subtest A-eDP1: SUCCESS (8.958s)
[372.479258] Starting dynamic subtest: B-eDP1
[381.416285] Dynamic subtest B-eDP1: SUCCESS (8.957s)
[381.436049] Starting dynamic subtest: C-eDP1
[390.328931] Dynamic subtest C-eDP1: SUCCESS (8.946s)
[390.345700] Starting dynamic subtest: D-eDP1
[399.337569] Dynamic subtest D-eDP1: SUCCESS (8.961s)
[399.340798] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.837s)
[400.541668] [082/132] (667s left) kms_flip_event_leak (basic)
[400.625157] Starting subtest: basic
[400.630231] Starting dynamic subtest: pipe-A-eDP-1
[401.078407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[401.096377] Starting dynamic subtest: pipe-B-eDP-1
[402.327047] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[402.346847] Starting dynamic subtest: pipe-C-eDP-1
[403.520382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[403.537113] Starting dynamic subtest: pipe-D-eDP-1
[404.749931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[404.752623] Subtest basic: SUCCESS (4.127s)
[405.654663] [083/132] (662s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[405.769974] Starting subtest: 4-tiled-64bpp-rotate-90
[405.789542] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[405.889673] [084/132] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[406.001948] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[406.006430] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[406.089162] [085/132] (662s left) syncobj_eventfd (timeline-wait)
[406.163834] Starting subtest: timeline-wait
[406.173538] Subtest timeline-wait: SUCCESS (0.011s)
[406.256520] [086/132] (661s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[406.359802] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[406.365023] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[406.440783] [087/132] (661s left) gem_close_race (basic-threads)
[406.532770] Starting subtest: basic-threads
[407.740299] Subtest basic-threads: SUCCESS (1.207s)
[407.926630] [088/132] (660s left) i915_pm_rpm (gem-mmap-type)
[410.001073] Starting subtest: gem-mmap-type
[410.004011] Starting dynamic subtest: gtt-smem0
[410.308889] Dynamic subtest gtt-smem0: SKIP (0.306s)
[410.329976] Starting dynamic subtest: wb-smem0
[416.515998] Dynamic subtest wb-smem0: SUCCESS (6.205s)
[416.531703] Starting dynamic subtest: wc-smem0
[418.830630] Dynamic subtest wc-smem0: SUCCESS (2.314s)
[418.847055] Starting dynamic subtest: uc-smem0
[421.133808] Dynamic subtest uc-smem0: SUCCESS (2.304s)
[421.136365] Subtest gem-mmap-type: SUCCESS (11.134s)
[421.251396] [089/132] (647s left) sw_sync (timeline_closed)
[421.309550] Starting subtest: timeline_closed
[421.312281] Subtest timeline_closed: SUCCESS (0.000s)
[421.366902] [090/132] (647s left) gem_exec_schedule (semaphore-power)
[421.591656] Subtest semaphore-power: SKIP (0.000s)
[421.768334] [091/132] (646s left) kms_atomic_interruptible (legacy-pageflip)
[421.855414] Starting subtest: legacy-pageflip
[421.857964] Starting dynamic subtest: pipe-A-eDP-1
[429.374989] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.520s)
[429.378716] Subtest legacy-pageflip: SUCCESS (7.521s)
[430.296310] [092/132] (638s left) kms_plane (plane-panning-bottom-right)
[430.393129] Starting subtest: plane-panning-bottom-right
[430.395614] Starting dynamic subtest: pipe-A
[432.153844] Dynamic subtest pipe-A: SUCCESS (1.760s)
[432.174662] Starting dynamic subtest: pipe-B
[434.627370] Dynamic subtest pipe-B: SUCCESS (2.471s)
[434.629924] Subtest plane-panning-bottom-right: SUCCESS (4.237s)
[435.543289] [093/132] (632s left) gem_userptr_blits (stress-mm-invalidate-close)
[435.629549] Starting subtest: stress-mm-invalidate-close
[437.980581] Subtest stress-mm-invalidate-close: SUCCESS (2.298s)
[438.568237] [094/132] (629s left) v3d/v3d_create_bo (create-bo-4096)
[438.671331] Subtest create-bo-4096: SKIP (0.000s)
[438.726637] [095/132] (629s left) vc4/vc4_mmap (mmap-bo)
[438.806831] Subtest mmap-bo: SKIP (0.000s)
[438.852638] [096/132] (629s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[438.963555] Starting subtest: 2x-cursor-vs-flip-atomic
[438.968707] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[439.098586] [097/132] (629s left) vgem_basic (sysfs)
[439.164703] Starting subtest: sysfs
[439.167306] Subtest sysfs: SUCCESS (0.001s)
[439.222966] [098/132] (629s left) kms_prop_blob (basic)
[439.299165] Starting subtest: basic
[439.301593] Subtest basic: SUCCESS (0.000s)
[439.392043] [099/132] (629s left) kms_plane_scaling (planes-downscale-factor-0-5)
[439.492083] Starting subtest: planes-downscale-factor-0-5
[439.494454] Starting dynamic subtest: pipe-A-eDP-1
[439.508312] Dynamic subtest pipe-A-eDP-1: SKIP (0.010s)
[439.528906] Starting dynamic subtest: pipe-B-eDP-1
[439.533048] Dynamic subtest pipe-B-eDP-1: SKIP (0.014s)
[439.550113] Starting dynamic subtest: pipe-C-eDP-1
[439.554124] Dynamic subtest pipe-C-eDP-1: SKIP (0.013s)
[439.565003] Starting dynamic subtest: pipe-D-eDP-1
[439.568436] Dynamic subtest pipe-D-eDP-1: SKIP (0.013s)
[439.571985] Subtest planes-downscale-factor-0-5: SKIP (0.056s)
[439.636093] [100/132] (629s left) kms_pm_backlight (basic-brightness)
[439.738501] Starting subtest: basic-brightness
[439.806005] Starting dynamic subtest: eDP-1
[440.340854] Dynamic subtest eDP-1: SUCCESS (0.532s)
[440.343655] Subtest basic-brightness: SUCCESS (0.603s)
[441.240524] [101/132] (627s left) kms_psr (psr2-primary-page-flip)
[441.302789] Starting subtest: psr2-primary-page-flip
[441.305671] Starting dynamic subtest: eDP-1
[443.124314] Dynamic subtest eDP-1: SUCCESS (1.822s)
[443.126798] Subtest psr2-primary-page-flip: SUCCESS (1.824s)
[444.056677] [102/132] (624s left) v3d/v3d_submit_csd (bad-multisync-pad)
[444.132759] Subtest bad-multisync-pad: SKIP (0.000s)
[444.171550] [103/132] (624s left) prime_vgem (basic-gtt)
[444.252853] Starting subtest: basic-gtt
[444.258321] Subtest basic-gtt: SKIP (0.000s)
[444.344708] [104/132] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[444.461195] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[449.648739] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.192s)
[449.770030] [105/132] (619s left) kms_psr (fbc-psr-cursor-render)
[449.863098] Starting subtest: fbc-psr-cursor-render
[449.865652] Starting dynamic subtest: eDP-1
[449.870597] Dynamic subtest eDP-1: SKIP (0.000s)
[449.875533] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[449.934132] [106/132] (618s left) kms_content_protection (atomic)
[450.061259] Starting subtest: atomic
[453.547800] Subtest atomic: SKIP (3.483s)
[454.806872] [107/132] (614s left) gem_ctx_shared (single-timeline)
[454.894850] Starting subtest: single-timeline
[454.926197] Subtest single-timeline: SUCCESS (0.027s)
[455.144597] [108/132] (613s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[455.215542] Starting subtest: primary-y-tiled-reflect-x-90
[455.220220] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[455.283441] [109/132] (613s left) gem_userptr_blits (unsync-overlap)
[455.363512] Subtest unsync-overlap: SKIP (0.000s)
[455.471752] [110/132] (613s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[455.543366] Starting subtest: single-wait-all-for-submit-signaled
[455.545938] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[455.639259] [111/132] (613s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[455.737122] Starting subtest: fbc-psr2-cursor-mmap-gtt
[455.739664] Starting dynamic subtest: eDP-1
[455.744113] Dynamic subtest eDP-1: SKIP (0.000s)
[455.748627] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[455.798010] [112/132] (613s left) kms_cursor_crc (cursor-sliding-64x21)
[455.953923] Starting subtest: cursor-sliding-64x21
[455.982531] Subtest cursor-sliding-64x21: SKIP (0.025s)
[456.205417] [113/132] (612s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[456.281980] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[456.283938] Starting dynamic subtest: pipe-A-eDP-1
[456.288204] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.295139] Starting dynamic subtest: pipe-B-eDP-1
[456.299661] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.313283] Starting dynamic subtest: pipe-C-eDP-1
[456.316856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.335466] Starting dynamic subtest: pipe-D-eDP-1
[456.339762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.343819] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[456.368230] [114/132] (612s left) gem_exec_params (cliprects-invalid)
[456.440061] Starting subtest: cliprects-invalid
[456.442401] Subtest cliprects-invalid: SUCCESS (0.000s)
[456.534189] [115/132] (612s left) kms_pm_rpm (modeset-pc8-residency-stress)
[458.103234] Starting subtest: modeset-pc8-residency-stress
[458.109527] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[458.895536] [116/132] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[458.993881] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[458.998621] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[459.089792] [117/132] (610s left) drm_fdinfo (virtual-idle)
[459.173354] Starting subtest: virtual-idle
[462.211193] Subtest virtual-idle: SUCCESS (3.032s)
[462.285879] [118/132] (606s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[462.371726] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[462.374161] Starting dynamic subtest: pipe-A-eDP-1
[462.378736] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[462.398087] Starting dynamic subtest: pipe-B-eDP-1
[462.402716] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[462.420916] Starting dynamic subtest: pipe-C-eDP-1
[462.426513] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[462.441505] Starting dynamic subtest: pipe-D-eDP-1
[462.446181] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[462.450761] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.013s)
[462.473359] [119/132] (606s left) syncobj_wait (multi-wait-for-submit-signaled)
[462.539962] Starting subtest: multi-wait-for-submit-signaled
[462.541988] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[462.623367] [120/132] (606s left) v3d/v3d_submit_cl (bad-flag)
[462.726343] Subtest bad-flag: SKIP (0.000s)
[462.780283] [121/132] (606s left) kms_invalid_mode (uint-max-clock)
[462.867227] Starting subtest: uint-max-clock
[462.869896] Starting dynamic subtest: pipe-A-eDP-1
[463.150920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[463.164838] Starting dynamic subtest: pipe-B-eDP-1
[463.166957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[463.175027] Starting dynamic subtest: pipe-C-eDP-1
[463.177501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[463.185201] Starting dynamic subtest: pipe-D-eDP-1
[463.187660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[463.190056] Subtest uint-max-clock: SUCCESS (0.294s)
[464.091043] [122/132] (605s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[464.152332] Starting subtest: invalid-multi-wait-all-unsubmitted
[464.155081] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[464.232538] [123/132] (605s left) kms_plane_multiple (tiling-y)
[464.332903] Starting subtest: tiling-y
[464.337902] Subtest tiling-y: SKIP (0.000s)
[464.391368] [124/132] (605s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[464.772134] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[465.660826] [125/132] (603s left) gem_exec_flush (basic-wb-rw-before-default)
[465.760738] Starting subtest: basic-wb-rw-before-default
[471.247650] Subtest basic-wb-rw-before-default: SUCCESS (5.471s)
[471.415976] [126/132] (598s left) gem_fence_thrash (bo-write-verify-threaded-y)
[471.479663] Starting subtest: bo-write-verify-threaded-y
[471.491544] Subtest bo-write-verify-threaded-y: SKIP (0.011s)
[471.547933] [127/132] (597s left) gem_exec_reloc (basic-wc)
[471.631850] Subtest basic-wc: SKIP (0.000s)
[471.690939] [128/132] (597s left) gem_exec_schedule (u-semaphore-noskip)
[471.789280] Starting subtest: u-semaphore-noskip
[472.334745] Subtest u-semaphore-noskip: SUCCESS (0.544s)
[472.675672] [129/132] (596s left) perf_pmu (all-busy-idle-check-all)
[472.731723] Starting subtest: all-busy-idle-check-all
[473.815873] Subtest all-busy-idle-check-all: SUCCESS (1.082s)
[473.911052] [130/132] (595s left) gem_exec_params (dr1-dirt)
[473.984331] Starting subtest: DR1-dirt
[473.987297] Subtest DR1-dirt: SUCCESS (0.000s)
[474.082680] [131/132] (595s left) i915_hangman (error-state-basic)
[474.185702] Starting subtest: error-state-basic
[474.327680] Subtest error-state-basic: SUCCESS (0.144s)
[474.399628] [132/132] (595s left) gem_busy (extended)
[474.621580] Starting subtest: extended
[474.624506] Starting dynamic subtest: rcs0
[474.712124] Dynamic subtest rcs0: SUCCESS (0.090s)
[474.732960] Starting dynamic subtest: bcs0
[474.761250] Dynamic subtest bcs0: SUCCESS (0.048s)
[474.781317] Starting dynamic subtest: vcs0
[475.862578] Dynamic subtest vcs0: SUCCESS (1.099s)
[475.882796] Starting dynamic subtest: vcs1
[477.846378] Dynamic subtest vcs1: SUCCESS (1.982s)
[477.866781] Starting dynamic subtest: vecs0
[479.830678] Dynamic subtest vecs0: SUCCESS (1.983s)
[479.850952] Starting dynamic subtest: ccs0
[479.880049] Dynamic subtest ccs0: SUCCESS (0.049s)
[479.883060] Subtest extended: SUCCESS (5.259s)
[480.107803] Closing watchdogs
Done.