[56.523187] Initializing watchdogs
[56.523356]   /dev/watchdog0
[56.538578] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.542838] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.545418] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.549118] [001/156] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[56.681140] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[56.685395] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[56.783382] [002/156] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[56.886878] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[63.135534] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.163s)
[64.346829] [003/156] (952s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[64.452906] Starting subtest: fbc-rgb565-draw-render
[68.659888] Subtest fbc-rgb565-draw-render: SUCCESS (4.188s)
[69.873828] [004/156] (947s left) gem_exec_balancer (bonded-semaphore)
[69.932667] Starting subtest: bonded-semaphore
[69.937048] Subtest bonded-semaphore: SKIP (0.000s)
[70.234084] [005/156] (946s left) api_intel_bb (intel-bb-blit-none)
[70.282106] Starting subtest: intel-bb-blit-none
[74.390074] Subtest intel-bb-blit-none: SUCCESS (4.097s)
[74.500190] [006/156] (942s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[74.601054] Starting subtest: yf-tiled-32bpp-rotate-180
[74.605481] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[74.698805] [007/156] (942s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[75.085701] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[75.893110] [008/156] (941s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[75.942751] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[76.005790] [009/156] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[76.093468] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[80.004775] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.911s)
[81.213627] [010/156] (936s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[81.308433] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[81.312457] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[81.395552] [011/156] (936s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[81.493619] Starting subtest: psr-rgb101010-draw-mmap-wc
[88.583954] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.092s)
[88.706282] [012/156] (928s left) gem_mmap_offset (clear-via-pagefault)
[88.766989] Starting subtest: clear-via-pagefault
[88.769263] Starting dynamic subtest: smem0
[142.704357] [013/156] (874s left) i915_suspend (basic-s2idle-without-i915)
[142.820862] Starting subtest: basic-s2idle-without-i915
[163.326979] Subtest basic-s2idle-without-i915: SUCCESS (5.805s)
[163.484211] [014/156] (854s left) i915_drm_fdinfo (isolation)
[163.530219] Starting subtest: isolation
[163.532417] Starting dynamic subtest: rcs0
[163.563351] Dynamic subtest rcs0: SKIP (0.027s)
[163.575257] Starting dynamic subtest: bcs0
[163.579750] Dynamic subtest bcs0: SKIP (0.000s)
[163.589312] Starting dynamic subtest: vcs0
[163.593611] Dynamic subtest vcs0: SKIP (0.000s)
[163.602180] Starting dynamic subtest: vcs1
[163.606437] Dynamic subtest vcs1: SKIP (0.000s)
[163.615207] Starting dynamic subtest: vecs0
[163.619588] Dynamic subtest vecs0: SKIP (0.000s)
[163.629538] Starting dynamic subtest: ccs0
[163.633820] Dynamic subtest ccs0: SKIP (0.000s)
[163.638141] Subtest isolation: SKIP (0.030s)
[163.674924] [015/156] (853s left) gem_watchdog (default-virtual)
[163.744184] Starting subtest: default-virtual
[170.023297] Subtest default-virtual: SUCCESS (6.130s)
[170.116287] [016/156] (847s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[170.231660] Starting subtest: psr-farfromfence-mmap-gtt
[170.235791] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[170.337063] [017/156] (847s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[170.434633] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[170.439228] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[170.520386] [018/156] (847s left) kms_atomic_transition (plane-all-modeset-transition)
[170.617741] Starting subtest: plane-all-modeset-transition
[170.621771] Subtest plane-all-modeset-transition: SKIP (0.000s)
[170.690869] [019/156] (847s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[170.747403] Starting subtest: multi-wait-all-for-submit-unsubmitted
[170.856025] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[170.930458] [020/156] (846s left) api_intel_allocator (fork-simple-once)
[170.990638] Starting subtest: fork-simple-once
[171.011257] Subtest fork-simple-once: SUCCESS (0.020s)
[171.122378] [021/156] (846s left) kms_psr (psr2-sprite-mmap-gtt)
[171.213944] Starting subtest: psr2-sprite-mmap-gtt
[171.216366] Starting dynamic subtest: eDP-1
[172.745595] Dynamic subtest eDP-1: SKIP (1.509s)
[172.750364] Subtest psr2-sprite-mmap-gtt: SKIP (1.510s)
[172.887014] [022/156] (844s left) kms_color (ctm-0-75)
[172.981664] Starting subtest: ctm-0-75
[172.984074] Starting dynamic subtest: pipe-A-eDP-1
[177.970442] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.945s)
[177.987943] Starting dynamic subtest: pipe-B-eDP-1
[183.611030] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.617s)
[183.621085] Starting dynamic subtest: pipe-C-eDP-1
[189.028355] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.402s)
[189.039085] Starting dynamic subtest: pipe-D-eDP-1
[194.386074] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.350s)
[194.388024] Subtest ctm-0-75: SUCCESS (21.317s)
[195.204922] [023/156] (822s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[195.329164] Starting subtest: cursorB-vs-flipB-varying-size
[195.333875] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[195.474902] [024/156] (822s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[195.571295] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[195.575706] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.683227] [025/156] (822s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[195.788629] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[195.793064] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[195.879838] [026/156] (822s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[196.422199] Starting subtest: syncobj-timeline-invalid-flags
[196.424802] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[198.015596] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[198.019838] [027/156] (820s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[198.127384] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[198.131595] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[198.224440] [028/156] (819s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[198.322504] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[198.327862] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[198.421366] [029/156] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[198.511920] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[198.515828] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[198.601310] [030/156] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[198.695877] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[198.699821] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.792094] [031/156] (819s left) syncobj_timeline (multi-wait-for-submit-signaled)
[198.839594] Starting subtest: multi-wait-for-submit-signaled
[198.841907] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[198.940475] [032/156] (819s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[199.049562] Starting subtest: cursorA-vs-flipA-toggle
[210.195763] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.139s)
[211.043923] [033/156] (807s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[211.149107] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[211.153436] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[211.240270] [034/156] (807s left) kms_cursor_crc (cursor-onscreen-512x512)
[211.519564] Starting subtest: cursor-onscreen-512x512
[211.523728] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[211.681360] [035/156] (806s left) gem_close_race (multigpu-basic-threads)
[211.766504] Starting subtest: multigpu-basic-threads
[211.771198] Subtest multigpu-basic-threads: SKIP (0.000s)
[211.988169] [036/156] (806s left) gem_ctx_persistence (many-contexts)
[212.047250] Starting subtest: many-contexts
[257.239644] Subtest many-contexts: SUCCESS (45.170s)
[257.317416] [037/156] (761s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[257.412378] Starting subtest: async-flip-with-page-flip-events-linear
[258.501188] Starting dynamic subtest: pipe-A-eDP-1
[260.994796] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.443s)
[261.307585] Starting dynamic subtest: pipe-B-eDP-1
[264.117678] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[264.435261] Starting dynamic subtest: pipe-C-eDP-1
[267.246424] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[267.570406] Starting dynamic subtest: pipe-D-eDP-1
[270.376847] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[270.379117] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.919s)
[271.509864] [038/156] (747s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.610876] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.615270] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[271.710895] [039/156] (746s left) perf_pmu (busy-check-all)
[271.745624] Starting subtest: busy-check-all
[271.748008] Starting dynamic subtest: rcs0
[272.297222] Dynamic subtest rcs0: SUCCESS (0.551s)
[272.313526] Starting dynamic subtest: bcs0
[272.847616] Dynamic subtest bcs0: SUCCESS (0.547s)
[272.861295] Starting dynamic subtest: vcs0
[273.989598] Dynamic subtest vcs0: SUCCESS (1.139s)
[274.005203] Starting dynamic subtest: vcs1
[275.971401] Dynamic subtest vcs1: SUCCESS (1.979s)
[275.984633] Starting dynamic subtest: vecs0
[277.956154] Dynamic subtest vecs0: SUCCESS (1.982s)
[277.969889] Starting dynamic subtest: ccs0
[278.512157] Dynamic subtest ccs0: SUCCESS (0.555s)
[278.514713] Subtest busy-check-all: SUCCESS (6.769s)
[278.630669] [040/156] (739s left) gem_fenced_exec_thrash (no-spare-fences)
[278.693340] Subtest no-spare-fences: SKIP (0.000s)
[278.764671] [041/156] (739s left) kms_cursor_crc (cursor-sliding-max-size)
[279.063850] Starting subtest: cursor-sliding-max-size
[279.070353] Subtest cursor-sliding-max-size: SKIP (0.000s)
[279.190339] [042/156] (739s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[279.296946] Starting subtest: 4-tiled-8bpp-rotate-90
[279.317983] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[279.432000] [043/156] (739s left) kms_flip (2x-plain-flip-ts-check)
[279.533546] Starting subtest: 2x-plain-flip-ts-check
[279.543766] Subtest 2x-plain-flip-ts-check: SKIP (0.012s)
[279.654430] [044/156] (739s left) gem_spin_batch (legacy-resubmit-new)
[279.714606] Starting subtest: legacy-resubmit-new
[279.716300] Starting dynamic subtest: default
[279.721469] Dynamic subtest default: SUCCESS (0.008s)
[279.737290] Starting dynamic subtest: render
[279.739266] Dynamic subtest render: SUCCESS (0.003s)
[279.748713] Starting dynamic subtest: bsd
[279.750311] Dynamic subtest bsd: SUCCESS (0.005s)
[279.759705] Starting dynamic subtest: bsd1
[279.761438] Dynamic subtest bsd1: SUCCESS (0.007s)
[279.770661] Starting dynamic subtest: bsd2
[279.772464] Dynamic subtest bsd2: SUCCESS (0.004s)
[279.781860] Starting dynamic subtest: blt
[279.783611] Dynamic subtest blt: SUCCESS (0.003s)
[279.792857] Starting dynamic subtest: vebox
[279.794636] Dynamic subtest vebox: SUCCESS (0.003s)
[279.796383] Subtest legacy-resubmit-new: SUCCESS (0.038s)
[281.015532] [045/156] (737s left) gem_softpin (evict-active)
[281.082484] Starting subtest: evict-active
[281.087832] Subtest evict-active: SUCCESS (0.005s)
[281.230908] [046/156] (737s left) prime_vgem (basic-fence-mmap)
[281.310073] Starting subtest: basic-fence-mmap
[281.314795] Subtest basic-fence-mmap: SKIP (0.000s)
[281.399441] [047/156] (737s left) gem_userptr_blits (unsync-unmap)
[281.464428] Subtest unsync-unmap: SKIP (0.000s)
[281.594498] [048/156] (737s left) dumb_buffer (create-valid-dumb)
[281.643134] Starting subtest: create-valid-dumb
[281.645306] Subtest create-valid-dumb: SUCCESS (0.000s)
[281.752961] [049/156] (737s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[281.855679] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[281.859865] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[281.943517] [050/156] (737s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[281.994111] Starting subtest: etime-multi-wait-all-available-unsubmitted
[282.104043] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.109s)
[282.193301] [051/156] (736s left) gem_mmap_gtt (basic-write-gtt)
[282.244010] Subtest basic-write-gtt: SKIP (0.000s)
[282.317458] [052/156] (736s left) syncobj_basic (bad-pad-handle-to-fd)
[282.371575] Starting subtest: bad-pad-handle-to-fd
[282.373703] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[282.489578] [053/156] (736s left) gem_exec_reloc (basic-write-gtt)
[282.545724] Subtest basic-write-gtt: SKIP (0.000s)
[282.622158] [054/156] (736s left) kms_joiner (invalid-modeset-ultra-joiner)
[282.730083] Starting subtest: invalid-modeset-ultra-joiner
[282.734517] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[282.802639] [055/156] (736s left) gem_render_copy (linear)
[282.861702] Starting subtest: linear
[282.864041] Starting dynamic subtest: smem
[282.905277] Dynamic subtest smem: SUCCESS (0.043s)
[282.907651] Subtest linear: SUCCESS (0.044s)
[283.133683] [056/156] (736s left) kms_psr (fbc-pr-sprite-blt)
[283.221973] Starting subtest: fbc-pr-sprite-blt
[283.226543] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[283.299526] [057/156] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[283.402626] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[283.406634] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[283.509924] [058/156] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[283.603935] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[283.608714] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[283.712917] [059/156] (735s left) syncobj_timeline (invalid-wait-illegal-handle)
[283.763118] Starting subtest: invalid-wait-illegal-handle
[283.765307] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[283.863192] [060/156] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[283.975963] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[291.394353] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.424s)
[291.522406] [061/156] (727s left) gem_mmap_wc (bad-offset)
[291.584951] Subtest bad-offset: SKIP (0.000s)
[291.650559] [062/156] (727s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[291.735022] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[291.737335] Starting dynamic subtest: pipe-A-eDP-1
[291.760232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[291.772486] Starting dynamic subtest: pipe-B-eDP-1
[291.794150] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[291.804278] Starting dynamic subtest: pipe-C-eDP-1
[291.826030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[291.836320] Starting dynamic subtest: pipe-D-eDP-1
[291.858395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[291.862541] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[294.002350] [063/156] (725s left) gem_mmap (bad-size)
[294.058512] Subtest bad-size: SKIP (0.000s)
[294.119780] [064/156] (725s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[294.230210] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[294.234606] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[294.348271] [065/156] (725s left) kms_prime (basic-crc-vgem)
[294.437749] Starting subtest: basic-crc-vgem
[294.440094] Starting dynamic subtest: second-to-first
[295.403159] Dynamic subtest second-to-first: SUCCESS (0.970s)
[295.404985] Subtest basic-crc-vgem: SUCCESS (0.970s)
[295.507013] [066/156] (724s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[295.632243] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[295.635662] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[295.770379] [067/156] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[295.863736] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[295.867419] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.963063] [068/156] (723s left) gem_exec_schedule (preempt-queue-contexts)
[296.029370] Subtest preempt-queue-contexts: SKIP (0.000s)
[296.323861] [069/156] (723s left) gem_exec_balancer (sequential)
[296.378344] Starting subtest: sequential
[299.465109] Subtest sequential: SUCCESS (3.086s)
[299.801610] [070/156] (720s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[299.863866] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[299.868272] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[300.048618] [071/156] (719s left) kms_vblank (wait-forked-busy-hang)
[300.143603] Starting subtest: wait-forked-busy-hang
[300.145585] Starting dynamic subtest: pipe-A-eDP-1
[326.729018] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.580s)
[326.743615] Starting dynamic subtest: pipe-D-eDP-1
[341.717212] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.982s)
[341.719597] Subtest wait-forked-busy-hang: SUCCESS (41.567s)
[342.585978] [072/156] (677s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[342.684868] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[342.689091] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[342.776134] [073/156] (677s left) gem_exec_suspend (basic-s0)
[342.848514] Starting subtest: basic-S0
[342.850769] Starting dynamic subtest: smem
[363.025448] Dynamic subtest smem: SUCCESS (7.069s)
[363.027886] Subtest basic-S0: SUCCESS (7.070s)
[363.220526] [074/156] (656s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[363.341598] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[364.483968] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.101s)
[364.603468] [075/156] (655s left) kms_content_protection (dp-mst-type-0)
[364.742724] Starting subtest: dp-mst-type-0
[364.747594] Subtest dp-mst-type-0: SKIP (0.000s)
[364.878131] [076/156] (655s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[364.925512] Starting subtest: invalid-multi-wait-unsubmitted
[364.927458] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[365.043393] [077/156] (655s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[365.139320] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[365.142791] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[365.245569] [078/156] (654s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[365.335373] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[365.337251] Starting dynamic subtest: pipe-A
[365.353435] Dynamic subtest pipe-A: SKIP (0.017s)
[365.364806] Starting dynamic subtest: pipe-B
[365.385959] Dynamic subtest pipe-B: SKIP (0.029s)
[365.396747] Starting dynamic subtest: pipe-C
[365.414404] Dynamic subtest pipe-C: SKIP (0.029s)
[365.424786] Starting dynamic subtest: pipe-D
[365.444946] Dynamic subtest pipe-D: SKIP (0.028s)
[365.448130] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.106s)
[365.551564] [079/156] (654s left) sysfs_preempt_timeout (invalid)
[365.614615] Starting subtest: invalid
[365.616538] Starting dynamic subtest: vecs0
[365.618587] Dynamic subtest vecs0: SUCCESS (0.000s)
[365.629973] Starting dynamic subtest: ccs0
[365.631562] Dynamic subtest ccs0: SUCCESS (0.000s)
[365.642154] Starting dynamic subtest: vcs0
[365.643749] Dynamic subtest vcs0: SUCCESS (0.000s)
[365.654525] Starting dynamic subtest: bcs0
[365.656303] Dynamic subtest bcs0: SUCCESS (0.000s)
[365.667961] Starting dynamic subtest: rcs0
[365.669938] Dynamic subtest rcs0: SUCCESS (0.000s)
[365.680457] Starting dynamic subtest: vcs1
[365.682078] Dynamic subtest vcs1: SUCCESS (0.000s)
[365.683619] Subtest invalid: SUCCESS (0.006s)
[365.742482] [080/156] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[365.846581] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[365.850140] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[365.954373] [081/156] (654s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[366.076423] Starting subtest: basic-flip-before-cursor-varying-size
[367.032769] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.931s)
[367.875839] [082/156] (652s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[367.975621] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[367.979975] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[368.082411] [083/156] (652s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[368.169235] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[368.171561] Starting dynamic subtest: pipe-A-eDP-1
[368.194322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[368.205952] Starting dynamic subtest: pipe-B-eDP-1
[368.228056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[368.238900] Starting dynamic subtest: pipe-C-eDP-1
[368.260057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[368.270637] Starting dynamic subtest: pipe-D-eDP-1
[368.292102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[368.296087] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[370.492611] [084/156] (649s left) gem_ctx_param (set-priority-range)
[370.550575] Starting subtest: set-priority-range
[370.562427] Subtest set-priority-range: SUCCESS (0.012s)
[370.685524] [085/156] (649s left) kms_properties (get_properties-sanity-non-atomic)
[370.783104] Starting subtest: get_properties-sanity-non-atomic
[370.785490] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[370.895819] [086/156] (649s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[370.994134] Starting subtest: hdr-farfromfence-mmap-gtt
[370.998039] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[371.100006] [087/156] (649s left) prime_vgem (basic-gtt)
[371.176196] Starting subtest: basic-gtt
[371.180741] Subtest basic-gtt: SKIP (0.000s)
[371.281383] [088/156] (649s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[371.549398] Starting subtest: cursor-rapid-movement-512x512
[371.552701] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[371.692208] [089/156] (649s left) gem_ccs (block-copy-compressed)
[371.743778] Starting subtest: block-copy-compressed
[371.747782] Subtest block-copy-compressed: SKIP (0.000s)
[371.846181] [090/156] (648s left) gem_exec_whisper (basic-queues-priority-all)
[371.897258] Starting subtest: basic-queues-priority-all
[394.407870] Subtest basic-queues-priority-all: SUCCESS (22.405s)
[394.609023] [091/156] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[394.704255] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[402.053252] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.352s)
[402.179805] [092/156] (618s left) gem_userptr_blits (usage-restrictions)
[402.243464] Starting subtest: usage-restrictions
[402.245377] Subtest usage-restrictions: SUCCESS (0.000s)
[402.373511] [093/156] (618s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[402.431532] Starting subtest: yf-tiled-ccs-to-yf-tiled
[402.435728] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[402.630268] [094/156] (618s left) gem_exec_reloc (basic-write-gtt-noreloc)
[402.687809] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[402.761975] [095/156] (618s left) kms_pm_rpm (fences)
[404.286276] Starting subtest: fences
[404.291651] Subtest fences: SKIP (0.000s)
[405.083108] [096/156] (615s left) kms_setmode (basic)
[405.150506] Starting subtest: basic
[405.476467] Starting dynamic subtest: pipe-A-eDP-1
[407.586010] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s)
[407.928897] Starting dynamic subtest: pipe-B-eDP-1
[410.016209] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s)
[410.333617] Subtest basic: SUCCESS (5.177s)
[411.171597] [097/156] (609s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[411.556286] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[412.377718] [098/156] (608s left) kms_draw_crc (draw-method-blt)
[412.476158] Starting subtest: draw-method-blt
[412.477973] Starting dynamic subtest: xrgb8888-untiled
[412.729559] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s)
[412.741586] Starting dynamic subtest: rgb565-untiled
[412.941056] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[412.953772] Starting dynamic subtest: xrgb2101010-untiled
[413.141348] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[413.154428] Starting dynamic subtest: xbgr16161616f-untiled
[413.340770] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[413.352082] Starting dynamic subtest: xrgb8888-xtiled
[413.451844] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[413.463205] Starting dynamic subtest: rgb565-xtiled
[413.574501] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[413.586394] Starting dynamic subtest: xrgb2101010-xtiled
[413.674392] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[413.684966] Starting dynamic subtest: xbgr16161616f-xtiled
[413.774456] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[413.789146] Starting dynamic subtest: xrgb8888-4tiled
[413.885424] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[413.895921] Starting dynamic subtest: rgb565-4tiled
[413.986336] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[413.997676] Starting dynamic subtest: xrgb2101010-4tiled
[414.085878] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[414.096535] Starting dynamic subtest: xbgr16161616f-4tiled
[414.208073] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[414.209901] Subtest draw-method-blt: SUCCESS (1.734s)
[414.339602] [099/156] (606s left) kms_addfb_basic (too-high)
[414.430004] Starting subtest: too-high
[414.431953] Subtest too-high: SUCCESS (0.001s)
[414.556562] [100/156] (606s left) gem_exec_schedule (semaphore-noskip)
[414.619978] Starting subtest: semaphore-noskip
[415.025519] Subtest semaphore-noskip: SUCCESS (0.408s)
[415.375672] [101/156] (605s left) syncobj_timeline (transfer-timeline-point)
[415.422048] Starting subtest: transfer-timeline-point
[415.424307] Subtest transfer-timeline-point: SUCCESS (0.000s)
[415.519295] [102/156] (605s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[415.612686] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[415.615063] Starting dynamic subtest: pipe-A-default-mode
[418.352451] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[418.354347] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.739s)
[419.175063] [103/156] (602s left) kms_universal_plane (universal-plane-functional)
[419.267293] Starting subtest: universal-plane-functional
[419.269450] Starting dynamic subtest: pipe-A-eDP-1
[423.116635] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.848s)
[423.133543] Starting dynamic subtest: pipe-B-eDP-1
[427.509368] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.387s)
[427.521187] Starting dynamic subtest: pipe-C-eDP-1
[431.762465] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.253s)
[431.776006] Starting dynamic subtest: pipe-D-eDP-1
[435.967614] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.201s)
[435.970004] Subtest universal-plane-functional: SUCCESS (16.695s)
[436.802283] [104/156] (584s left) kms_async_flips (invalid-async-flip)
[436.897158] Starting subtest: invalid-async-flip
[437.274282] Starting dynamic subtest: pipe-A-eDP-1
[438.137163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s)
[438.496821] Starting dynamic subtest: pipe-B-eDP-1
[439.351997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.865s)
[439.715943] Starting dynamic subtest: pipe-C-eDP-1
[440.494473] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.788s)
[440.849811] Starting dynamic subtest: pipe-D-eDP-1
[441.629250] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.789s)
[441.631665] Subtest invalid-async-flip: SUCCESS (4.733s)
[442.793748] [105/156] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[442.895299] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[442.899255] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[443.000762] [106/156] (578s left) i915_pm_freq_api (freq-suspend)
[443.068004] Starting subtest: freq-suspend
[443.069859] Starting dynamic subtest: gt0
[458.763816] Dynamic subtest gt0: SUCCESS (1.209s)
[458.778969] Starting dynamic subtest: gt1
[474.780059] Dynamic subtest gt1: SUCCESS (1.190s)
[474.782086] Subtest freq-suspend: SUCCESS (2.404s)
[474.867304] [107/156] (546s left) gem_exec_reloc (basic-write-cpu)
[474.926836] Subtest basic-write-cpu: SKIP (0.000s)
[475.001562] [108/156] (546s left) prime_busy (before-wait)
[475.062439] Starting subtest: before-wait
[475.064803] Starting dynamic subtest: rcs0
[475.105592] Dynamic subtest rcs0: SUCCESS (0.042s)
[475.118781] Starting dynamic subtest: bcs0
[475.158972] Dynamic subtest bcs0: SUCCESS (0.052s)
[475.176153] Starting dynamic subtest: vcs0
[475.201498] Dynamic subtest vcs0: SUCCESS (0.040s)
[475.212319] Starting dynamic subtest: vcs1
[475.241874] Dynamic subtest vcs1: SUCCESS (0.039s)
[475.253188] Starting dynamic subtest: vecs0
[475.282718] Dynamic subtest vecs0: SUCCESS (0.038s)
[475.294014] Starting dynamic subtest: ccs0
[475.323598] Dynamic subtest ccs0: SUCCESS (0.039s)
[475.432082] Subtest before-wait: SUCCESS (0.360s)
[475.509790] [109/156] (546s left) gem_softpin (evict-snoop)
[475.569789] Starting subtest: evict-snoop
[475.573934] Subtest evict-snoop: SKIP (0.000s)
[475.687985] [110/156] (545s left) i915_pm_rpm (gem-idle)
[477.525431] Starting subtest: gem-idle
[483.704182] Subtest gem-idle: SUCCESS (6.040s)
[484.053082] [111/156] (537s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[485.358172] Starting subtest: short-flip-before-cursor-toggle
[486.281015] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[487.125449] [112/156] (534s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[487.208507] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[487.210779] Starting dynamic subtest: pipe-A-default-mode
[490.023853] Dynamic subtest pipe-A-default-mode: SUCCESS (2.790s)
[490.025996] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.792s)
[490.864775] [113/156] (530s left) kms_plane_multiple (2x-tiling-x)
[490.967822] Starting subtest: 2x-tiling-x
[490.972017] Subtest 2x-tiling-x: SKIP (0.000s)
[491.038906] [114/156] (530s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[491.149134] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[491.153353] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[491.216723] [115/156] (530s left) kms_getfb (getfb2-handle-not-fb)
[491.319404] Starting subtest: getfb2-handle-not-fb
[491.321701] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[491.443498] [116/156] (530s left) gem_tiled_wb
[491.583714] [117/156] (530s left) kms_psr (psr-sprite-mmap-gtt)
[491.689376] Starting subtest: psr-sprite-mmap-gtt
[491.691557] Starting dynamic subtest: eDP-1
[493.180799] Dynamic subtest eDP-1: SKIP (1.481s)
[493.186027] Subtest psr-sprite-mmap-gtt: SKIP (1.483s)
[493.341546] [118/156] (528s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[493.449073] Starting subtest: y-tiled-addfb-size-offset-overflow
[493.453109] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[493.549800] [119/156] (528s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[493.639405] Starting subtest: psr-dirtyfb-ioctl
[493.641848] Starting dynamic subtest: A-eDP-1
[497.622614] Dynamic subtest A-eDP-1: SUCCESS (3.967s)
[497.624843] Subtest psr-dirtyfb-ioctl: SUCCESS (3.968s)
[498.516390] [120/156] (523s left) gem_ctx_sseu (engines)
[498.578126] Subtest engines: SKIP (0.000s)
[498.649070] [121/156] (523s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[498.746286] Starting subtest: fbc-psr2-cursor-plane-onoff
[498.748682] Starting dynamic subtest: eDP-1
[498.752892] Dynamic subtest eDP-1: SKIP (0.000s)
[498.757142] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[498.834578] [122/156] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[498.944501] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[498.948837] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[499.040161] [123/156] (523s left) gem_ctx_param (invalid-set-no-zeromap)
[499.083162] Starting subtest: invalid-set-no-zeromap
[499.085539] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[499.150259] [124/156] (523s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[499.237545] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[499.239914] Starting dynamic subtest: pipe-A-eDP-1
[499.299554] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[499.310935] Starting dynamic subtest: pipe-B-eDP-1
[499.368051] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[499.379156] Starting dynamic subtest: pipe-C-eDP-1
[499.436072] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[499.447804] Starting dynamic subtest: pipe-D-eDP-1
[499.495880] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[499.499546] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[501.530656] [125/156] (520s left) kms_plane (planar-pixel-format-settings)
[501.632804] Starting subtest: planar-pixel-format-settings
[501.635276] Starting dynamic subtest: nv12-odd-width
[501.657137] Dynamic subtest nv12-odd-width: SUCCESS (0.024s)
[501.668904] Starting dynamic subtest: nv12-odd-height
[501.677122] Dynamic subtest nv12-odd-height: SUCCESS (0.021s)
[501.688830] Starting dynamic subtest: nv12-odd-horizontal-pan
[501.691183] Dynamic subtest nv12-odd-horizontal-pan: SUCCESS (0.010s)
[501.702549] Starting dynamic subtest: p016-odd-vertical-pan
[501.716112] Dynamic subtest p016-odd-vertical-pan: SUCCESS (0.026s)
[501.727686] Starting dynamic subtest: nv12-tile4-src-y
[501.731947] Dynamic subtest nv12-tile4-src-y: SKIP (0.000s)
[501.734125] Subtest planar-pixel-format-settings: SUCCESS (0.085s)
[501.842693] [126/156] (520s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[501.943898] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[501.947949] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[502.042998] [127/156] (520s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[502.090214] Starting subtest: wait-all-for-submit-delayed-submit
[502.194845] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[502.283988] [128/156] (520s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[502.390561] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[502.394930] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.500504] [129/156] (519s left) kms_psr (pr-cursor-blt)
[502.585383] Starting subtest: pr-cursor-blt
[502.589810] Subtest pr-cursor-blt: SKIP (0.000s)
[502.661192] [130/156] (519s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[502.765444] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[502.767724] Starting dynamic subtest: pipe-A-eDP-1
[502.790171] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[502.802323] Starting dynamic subtest: pipe-B-eDP-1
[502.822685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[502.833105] Starting dynamic subtest: pipe-C-eDP-1
[502.854501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[502.864949] Starting dynamic subtest: pipe-D-eDP-1
[502.886729] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[502.891106] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[505.071483] [131/156] (517s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[505.172032] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[505.176534] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[505.274493] [132/156] (517s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[505.360623] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[505.370440] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[505.466645] [133/156] (517s left) kms_fbcon_fbt (fbc)
[505.516695] Starting subtest: fbc
[512.022711] Subtest fbc: SUCCESS (6.502s)
[513.210063] [134/156] (509s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[513.303185] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[513.307334] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[513.402563] [135/156] (509s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[513.489691] Starting subtest: psrhdr-indfb-scaledprimary
[513.493845] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[513.582484] [136/156] (509s left) gen9_exec_parse (cmd-crossing-page)
[513.630565] Subtest cmd-crossing-page: SKIP (0.000s)
[513.720749] [137/156] (509s left) gem_exec_parallel (userptr)
[513.785267] Starting subtest: userptr
[513.787693] Starting dynamic subtest: rcs0
[515.229600] Dynamic subtest rcs0: SUCCESS (1.444s)
[515.241128] Starting dynamic subtest: bcs0
[516.712116] Dynamic subtest bcs0: SUCCESS (1.480s)
[516.723539] Starting dynamic subtest: vcs0
[518.370310] Dynamic subtest vcs0: SUCCESS (1.654s)
[518.382209] Starting dynamic subtest: vcs1
[520.267611] Dynamic subtest vcs1: SUCCESS (1.895s)
[520.282282] Starting dynamic subtest: vecs0
[522.316938] Dynamic subtest vecs0: SUCCESS (2.045s)
[522.331300] Starting dynamic subtest: ccs0
[523.828853] Dynamic subtest ccs0: SUCCESS (1.510s)
[523.831258] Subtest userptr: SUCCESS (10.041s)
[524.022894] [138/156] (498s left) prime_self_import (reimport-vs-gem_close-race)
[524.056405] Starting subtest: reimport-vs-gem_close-race
[529.165783] Subtest reimport-vs-gem_close-race: SUCCESS (5.090s)
[529.256504] [139/156] (493s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[529.360043] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[529.364478] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[529.469757] [140/156] (493s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[529.570335] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[529.574458] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[529.675777] [141/156] (493s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[529.771975] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[529.774291] Starting dynamic subtest: pipe-A-eDP-1
[540.456449] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.683s)
[540.468869] Starting dynamic subtest: pipe-B-eDP-1
[551.841881] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.380s)
[551.844147] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.066s)
[552.702586] [142/156] (470s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[552.806505] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[552.810891] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[552.931431] [143/156] (470s left) gem_exec_await (wide-all)
[553.162087] Starting subtest: wide-all
[576.117307] Subtest wide-all: SUCCESS (22.947s)
[576.316564] [144/156] (446s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[576.476344] Starting subtest: basic-max-pipe-crc-check
[576.480862] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[576.529860] [145/156] (446s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[576.627357] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[576.631818] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[576.729613] [146/156] (446s left) gem_exec_params (dr1-dirt)
[576.789268] Starting subtest: DR1-dirt
[576.791500] Subtest DR1-dirt: SUCCESS (0.000s)
[576.911479] [147/156] (446s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[577.006265] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[577.010463] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[577.082924] [148/156] (446s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[577.193562] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[577.983397] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[578.136458] [149/156] (445s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[578.230156] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[578.234369] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[578.324812] [150/156] (445s left) kms_plane_lowres (tiling-4)
[578.416373] Starting subtest: tiling-4
[578.418643] Starting dynamic subtest: pipe-A-eDP-1
[578.423128] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.711916] Starting dynamic subtest: pipe-B-eDP-1
[578.716601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.728722] Starting dynamic subtest: pipe-C-eDP-1
[578.733425] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.745318] Starting dynamic subtest: pipe-D-eDP-1
[578.749753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.754259] Subtest tiling-4: SKIP (0.292s)
[579.533529] [151/156] (443s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[579.637627] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[579.639968] Starting dynamic subtest: pipe-A
[580.684405] Dynamic subtest pipe-A: SUCCESS (1.050s)
[580.695862] Starting dynamic subtest: pipe-B
[582.836146] Dynamic subtest pipe-B: SUCCESS (2.151s)
[582.848265] Starting dynamic subtest: pipe-C
[584.044208] Dynamic subtest pipe-C: SUCCESS (1.205s)
[584.058297] Starting dynamic subtest: pipe-D
[585.271309] Dynamic subtest pipe-D: SUCCESS (1.228s)
[585.273544] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.638s)
[586.466807] [152/156] (437s left) perf_pmu (multi-client)
[586.510067] Starting subtest: multi-client
[586.512475] Starting dynamic subtest: rcs0
[587.574320] Dynamic subtest rcs0: SUCCESS (1.064s)
[587.589035] Starting dynamic subtest: bcs0
[588.624869] Dynamic subtest bcs0: SUCCESS (1.048s)
[588.638301] Starting dynamic subtest: vcs0
[589.676844] Dynamic subtest vcs0: SUCCESS (1.048s)
[589.691270] Starting dynamic subtest: vcs1
[591.364287] Dynamic subtest vcs1: SUCCESS (1.684s)
[591.378968] Starting dynamic subtest: vecs0
[593.348560] Dynamic subtest vecs0: SUCCESS (1.982s)
[593.362847] Starting dynamic subtest: ccs0
[595.331576] Dynamic subtest ccs0: SUCCESS (1.980s)
[595.334850] Subtest multi-client: SUCCESS (8.824s)
[595.461145] [153/156] (428s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[595.561988] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[602.378068] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.821s)
[602.503423] [154/156] (421s left) kms_flip (plain-flip-fb-recreate)
[602.605511] Starting subtest: plain-flip-fb-recreate
[602.607859] Starting dynamic subtest: A-eDP1
[611.438477] Dynamic subtest A-eDP1: SUCCESS (8.836s)
[611.450893] Starting dynamic subtest: B-eDP1
[620.276330] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[620.289019] Starting dynamic subtest: C-eDP1
[629.099137] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[629.111536] Starting dynamic subtest: D-eDP1
[637.934553] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[637.938732] Subtest plain-flip-fb-recreate: SUCCESS (35.331s)
[639.111344] [155/156] (384s left) kms_psr (psr2-cursor-mmap-gtt)
[639.198507] Starting subtest: psr2-cursor-mmap-gtt
[639.200856] Starting dynamic subtest: eDP-1
[640.894794] Dynamic subtest eDP-1: SUCCESS (1.694s)
[640.897092] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.695s)
[641.785508] [156/156] (381s left) kms_chamelium_color (ctm-blue-to-red)
[641.886570] Subtest ctm-blue-to-red: SKIP (0.000s)
[641.930066] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_chamelium_edid
results: parsing output: 7/ for test: kms_pipe_b_c_ivb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: i915_suspend
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: gem_watchdog
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_close_race
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: gem_fenced_exec_thrash
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_spin_batch
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: syncobj_basic
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_joiner
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_mmap
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_prime
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_suspend
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: sysfs_preempt_timeout
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_properties
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: prime_vgem
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ccs
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_setmode
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_draw_crc
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_universal_plane
results: parsing output: 103/ for test: kms_async_flips
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_pm_freq_api
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: gem_tiled_wb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_dirtyfb
results: parsing output: 119/ for test: gem_ctx_sseu
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_fbcon_fbt
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gen9_exec_parse
results: parsing output: 136/ for test: gem_exec_parallel
results: parsing output: 137/ for test: prime_self_import
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: gem_exec_await
results: parsing output: 143/ for test: kms_multipipe_modeset
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_params
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_plane_lowres
results: parsing output: 150/ for test: kms_plane_scaling
results: parsing output: 151/ for test: perf_pmu
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: kms_chamelium_color
Done.