[58.142126] Initializing watchdogs
[58.142174]   /dev/watchdog0
[58.156508] [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]
[58.160957] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.163551] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.167343] [001/133] (960s left) perf (gen12-oa-tlb-invalidate)
[58.322454] Starting subtest: gen12-oa-tlb-invalidate
[58.324310] Starting dynamic subtest: 0-rcs0
[68.351043] Dynamic subtest 0-rcs0: SUCCESS (10.062s)
[68.358095] Starting dynamic subtest: 1-vecs0
[78.385874] Dynamic subtest 1-vecs0: SUCCESS (10.044s)
[78.388604] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.107s)
[78.432985] [002/133] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[78.530809] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[78.534818] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[78.626380] [003/133] (940s left) kms_vblank (ts-continuation-dpms-rpm)
[78.723988] Starting subtest: ts-continuation-dpms-rpm
[78.726907] Starting dynamic subtest: pipe-A-eDP-1
[81.303247] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.580s)
[81.317486] Starting dynamic subtest: pipe-D-eDP-1
[83.552465] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[83.554980] Subtest ts-continuation-dpms-rpm: SUCCESS (4.831s)
[84.432428] [004/133] (934s left) kms_cursor_legacy (forked-move)
[84.553355] Starting subtest: forked-move
[84.555791] Starting dynamic subtest: pipe-A
[90.017366] Dynamic subtest pipe-A: SUCCESS (5.460s)
[90.029637] Starting dynamic subtest: pipe-B
[95.486356] Dynamic subtest pipe-B: SUCCESS (5.468s)
[95.495403] Starting dynamic subtest: pipe-C
[100.964865] Dynamic subtest pipe-C: SUCCESS (5.477s)
[100.973918] Starting dynamic subtest: pipe-D
[106.445998] Dynamic subtest pipe-D: SUCCESS (5.480s)
[106.454546] Starting dynamic subtest: all-pipes
[111.949537] Dynamic subtest all-pipes: SUCCESS (5.502s)
[111.951913] Subtest forked-move: SUCCESS (27.393s)
[112.098344] [005/133] (906s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[112.173024] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[112.240214] [006/133] (906s left) gem_mmap_gtt (big-copy-xy)
[112.300294] Subtest big-copy-XY: SKIP (0.000s)
[112.354616] [007/133] (906s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[112.457716] Starting subtest: y-tiled-32bpp-rotate-180
[112.462304] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[112.546883] [008/133] (906s left) sw_sync (sync_merge_same)
[112.584389] Starting subtest: sync_merge_same
[112.586452] Subtest sync_merge_same: SUCCESS (0.000s)
[112.658158] [009/133] (906s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[113.034494] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[113.832557] [010/133] (905s left) kms_sequence (queue-busy)
[113.924473] Starting subtest: queue-busy
[113.926434] Starting dynamic subtest: pipe-A-eDP-1
[115.866702] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[115.875713] Starting dynamic subtest: pipe-B-eDP-1
[118.450202] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[118.460474] Starting dynamic subtest: pipe-C-eDP-1
[121.063313] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[121.072553] Starting dynamic subtest: pipe-D-eDP-1
[123.686623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[123.688901] Subtest queue-busy: SUCCESS (9.762s)
[124.472347] [011/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[124.568806] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[124.573086] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[124.665084] [012/133] (894s left) kms_cursor_crc (cursor-sliding-64x21)
[124.857836] Starting subtest: cursor-sliding-64x21
[124.906356] Subtest cursor-sliding-64x21: SKIP (0.046s)
[125.134587] [013/133] (893s left) i915_hangman (detector)
[125.195121] Starting subtest: detector
[125.197448] Starting dynamic subtest: rcs0
[136.884718] Dynamic subtest rcs0: SUCCESS (11.689s)
[136.896084] Starting dynamic subtest: bcs0
[148.853634] Dynamic subtest bcs0: SUCCESS (11.967s)
[148.863754] Starting dynamic subtest: vcs0
[159.797558] Dynamic subtest vcs0: SUCCESS (10.942s)
[159.808065] Starting dynamic subtest: vcs1
[169.909577] Dynamic subtest vcs1: SUCCESS (10.110s)
[169.919500] Starting dynamic subtest: vecs0
[181.813497] Dynamic subtest vecs0: SUCCESS (11.902s)
[181.825278] Starting dynamic subtest: ccs0
[193.909808] Dynamic subtest ccs0: SUCCESS (12.095s)
[193.912619] Subtest detector: SUCCESS (68.712s)
[193.990830] [014/133] (825s left) kms_prop_blob (basic)
[194.049967] Starting subtest: basic
[194.052064] Subtest basic: SUCCESS (0.000s)
[194.146627] [015/133] (825s left) gem_userptr_blits (dmabuf-sync)
[194.215211] Starting subtest: dmabuf-sync
[194.219581] Subtest dmabuf-sync: SKIP (0.002s)
[194.360146] [016/133] (824s left) perf (polling)
[194.441519] Starting subtest: polling
[194.443963] Starting dynamic subtest: 0-rcs0
[204.466760] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[204.475398] Starting dynamic subtest: 1-vcs1
[214.489734] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[214.492059] Subtest polling: SUCCESS (20.046s)
[214.534694] [017/133] (804s left) prime_vgem (wait)
[214.639912] Starting subtest: wait
[214.642367] Starting dynamic subtest: rcs0
[214.679478] Dynamic subtest rcs0: SUCCESS (0.040s)
[214.687298] Starting dynamic subtest: bcs0
[214.738381] Dynamic subtest bcs0: SUCCESS (0.058s)
[214.746429] Starting dynamic subtest: vcs0
[214.785166] Dynamic subtest vcs0: SUCCESS (0.046s)
[214.792803] Starting dynamic subtest: vcs1
[214.832623] Dynamic subtest vcs1: SUCCESS (0.047s)
[214.840651] Starting dynamic subtest: vecs0
[214.878982] Dynamic subtest vecs0: SUCCESS (0.046s)
[214.887141] Starting dynamic subtest: ccs0
[214.926694] Dynamic subtest ccs0: SUCCESS (0.047s)
[214.929064] Subtest wait: SUCCESS (0.287s)
[215.062649] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[215.065686] [018/133] (804s left) gem_exec_params (no-bsd)
[215.139304] Starting subtest: no-bsd
[215.141672] Subtest no-bsd: SUCCESS (0.003s)
[217.002701] [019/133] (802s left) kms_color (ctm-0-25)
[217.116368] Starting subtest: ctm-0-25
[217.118782] Starting dynamic subtest: pipe-A-eDP-1
[221.472890] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.354s)
[221.482070] Starting dynamic subtest: pipe-B-eDP-1
[225.220286] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.748s)
[225.229060] Starting dynamic subtest: pipe-C-eDP-1
[229.281402] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.061s)
[229.298806] Starting dynamic subtest: pipe-D-eDP-1
[233.276273] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[233.278468] Subtest ctm-0-25: SUCCESS (16.158s)
[234.103522] [020/133] (785s left) kms_cursor_crc (cursor-offscreen-512x170)
[234.413683] Starting subtest: cursor-offscreen-512x170
[234.420692] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[234.561311] [021/133] (784s left) kms_flip (dpms-off-confusion-interruptible)
[234.647915] Starting subtest: dpms-off-confusion-interruptible
[234.650321] Starting dynamic subtest: A-eDP1
[243.293447] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[243.304577] Starting dynamic subtest: B-eDP1
[251.917234] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[251.925601] Starting dynamic subtest: C-eDP1
[260.531838] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[260.539948] Starting dynamic subtest: D-eDP1
[269.166512] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[269.171381] Subtest dpms-off-confusion-interruptible: SUCCESS (34.523s)
[270.338099] [022/133] (749s left) gem_ctx_shared (exec-single-timeline)
[270.411474] Starting subtest: exec-single-timeline
[270.414012] Starting dynamic subtest: rcs0
[271.475639] Dynamic subtest rcs0: SUCCESS (1.062s)
[271.487703] Starting dynamic subtest: bcs0
[272.563903] Dynamic subtest bcs0: SUCCESS (1.086s)
[272.576031] Starting dynamic subtest: vcs0
[273.654478] Dynamic subtest vcs0: SUCCESS (1.088s)
[273.665975] Starting dynamic subtest: vcs1
[274.740393] Dynamic subtest vcs1: SUCCESS (1.084s)
[274.751704] Starting dynamic subtest: vecs0
[275.826066] Dynamic subtest vecs0: SUCCESS (1.085s)
[275.835256] Starting dynamic subtest: ccs0
[276.915452] Dynamic subtest ccs0: SUCCESS (1.087s)
[276.918629] Subtest exec-single-timeline: SUCCESS (6.504s)
[277.110105] [023/133] (742s left) kms_getfb (getfb-reject-nv12)
[277.200813] Starting subtest: getfb-reject-nv12
[277.203126] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[277.308485] [024/133] (742s left) gem_watchdog (default-physical)
[277.380835] Starting subtest: default-physical
[279.141857] Subtest default-physical: SUCCESS (1.769s)
[279.234082] [025/133] (740s left) kms_chamelium_frames (hdmi-crc-multiple)
[279.625917] Subtest hdmi-crc-multiple: SKIP (0.000s)
[280.456796] [026/133] (739s left) syncobj_timeline (multi-wait-signaled)
[280.516980] Starting subtest: multi-wait-signaled
[280.519673] Subtest multi-wait-signaled: SUCCESS (0.001s)
[280.611076] [027/133] (739s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[280.663290] Starting subtest: multi-wait-all-for-submit-available-submitted
[280.665668] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[280.769553] [028/133] (738s left) api_intel_bb (intel-bb-blit-x)
[280.829071] Starting subtest: intel-bb-blit-x
[284.828087] Subtest intel-bb-blit-x: SUCCESS (3.999s)
[284.949833] [029/133] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[285.065210] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[285.069309] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[285.165326] [030/133] (734s left) i915_drm_fdinfo (most-busy-idle-check-all)
[285.201821] Starting subtest: most-busy-idle-check-all
[285.204241] Starting dynamic subtest: rcs0
[285.208665] Dynamic subtest rcs0: SKIP (0.003s)
[285.216829] Starting dynamic subtest: bcs0
[285.221042] Dynamic subtest bcs0: SKIP (0.000s)
[285.229043] Starting dynamic subtest: vcs0
[285.233341] Dynamic subtest vcs0: SKIP (0.000s)
[285.240881] Starting dynamic subtest: vcs1
[285.245274] Dynamic subtest vcs1: SKIP (0.000s)
[285.252715] Starting dynamic subtest: vecs0
[285.257096] Dynamic subtest vecs0: SKIP (0.000s)
[285.264618] Starting dynamic subtest: ccs0
[285.269039] Dynamic subtest ccs0: SKIP (0.000s)
[285.273343] Subtest most-busy-idle-check-all: SKIP (0.007s)
[285.310759] [031/133] (734s left) kms_pm_backlight (fade-with-dpms)
[285.423947] Starting subtest: fade-with-dpms
[287.546448] Starting dynamic subtest: eDP-1
[290.041900] Dynamic subtest eDP-1: SUCCESS (2.495s)
[290.044513] Subtest fade-with-dpms: SUCCESS (4.619s)
[290.843042] [032/133] (729s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[290.949702] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[290.954241] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[291.050622] [033/133] (728s left) syncobj_wait (single-wait-all-for-submit-signaled)
[291.118735] Starting subtest: single-wait-all-for-submit-signaled
[291.120967] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[291.242674] [034/133] (728s left) kms_addfb_basic (basic-y-tiled-legacy)
[291.306428] Starting subtest: basic-y-tiled-legacy
[291.311065] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[291.448424] [035/133] (728s left) kms_psr (fbc-pr-dpms)
[291.543554] Starting subtest: fbc-pr-dpms
[291.547664] Subtest fbc-pr-dpms: SKIP (0.000s)
[291.614237] [036/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[291.710730] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[291.714811] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.808077] [037/133] (728s left) kms_dsc (dsc-with-output-formats-with-bpc)
[291.891388] Starting subtest: dsc-with-output-formats-with-bpc
[291.938679] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[291.978316] [038/133] (728s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[292.074481] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[292.078119] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[292.149461] [039/133] (728s left) gem_exec_schedule (submit-early-slice)
[292.218450] Starting subtest: submit-early-slice
[292.220223] Starting dynamic subtest: rcs0
[292.259222] Dynamic subtest rcs0: SUCCESS (0.046s)
[292.269406] Starting dynamic subtest: bcs0
[292.303508] Dynamic subtest bcs0: SUCCESS (0.044s)
[292.312496] Starting dynamic subtest: vcs0
[292.352771] Dynamic subtest vcs0: SUCCESS (0.048s)
[292.360694] Starting dynamic subtest: vcs1
[292.395761] Dynamic subtest vcs1: SUCCESS (0.042s)
[292.405383] Starting dynamic subtest: vecs0
[292.436213] Dynamic subtest vecs0: SUCCESS (0.040s)
[292.449457] Starting dynamic subtest: ccs0
[292.483660] Dynamic subtest ccs0: SUCCESS (0.047s)
[292.485697] Subtest submit-early-slice: SUCCESS (0.271s)
[294.005332] [040/133] (726s left) perf_pmu (busy-hang)
[294.047272] Starting subtest: busy-hang
[294.049618] Starting dynamic subtest: rcs0
[295.316655] Dynamic subtest rcs0: SUCCESS (1.267s)
[295.326672] Starting dynamic subtest: bcs0
[296.570637] Dynamic subtest bcs0: SUCCESS (1.252s)
[296.580864] Starting dynamic subtest: vcs0
[298.395165] Dynamic subtest vcs0: SUCCESS (1.825s)
[298.406287] Starting dynamic subtest: vcs1
[300.441226] Dynamic subtest vcs1: SUCCESS (2.044s)
[300.454210] Starting dynamic subtest: vecs0
[302.422330] Dynamic subtest vecs0: SUCCESS (1.980s)
[302.433869] Starting dynamic subtest: ccs0
[303.667531] Dynamic subtest ccs0: SUCCESS (1.241s)
[303.670049] Subtest busy-hang: SUCCESS (9.617s)
[303.781696] [041/133] (716s left) gem_exec_whisper (basic-fds)
[303.843854] Starting subtest: basic-fds
[313.849590] Subtest basic-fds: SUCCESS (10.000s)
[314.032318] [042/133] (706s left) kms_setmode (invalid-clone-single-crtc)
[314.108213] Starting subtest: invalid-clone-single-crtc
[314.114913] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[314.218188] [043/133] (706s left) kms_lease (lease-invalid-crtc)
[314.310832] Starting subtest: lease-invalid-crtc
[314.313133] Starting dynamic subtest: pipe-A-eDP-1
[314.315279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[314.324180] Starting dynamic subtest: pipe-B-eDP-1
[314.326466] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[314.335085] Starting dynamic subtest: pipe-C-eDP-1
[314.337213] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.345460] Starting dynamic subtest: pipe-D-eDP-1
[314.347859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.350060] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[314.389093] [044/133] (706s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[314.503391] Starting subtest: cursorB-vs-flipB-atomic
[314.508060] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[314.649514] [045/133] (705s left) gem_render_copy (linear)
[314.713901] Starting subtest: linear
[314.716197] Starting dynamic subtest: smem
[314.755343] Dynamic subtest smem: SUCCESS (0.043s)
[314.758054] Subtest linear: SUCCESS (0.044s)
[314.951625] [046/133] (705s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[315.041275] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[315.043655] Starting dynamic subtest: pipe-A-eDP-1
[315.067152] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.080078] Starting dynamic subtest: pipe-B-eDP-1
[315.101900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.110635] Starting dynamic subtest: pipe-C-eDP-1
[315.132489] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.140838] Starting dynamic subtest: pipe-D-eDP-1
[315.162827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.167068] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[317.311951] [047/133] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[317.414281] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[318.526682] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.113s)
[318.648750] [048/133] (701s left) fbdev (eof)
[318.690054] Starting subtest: eof
[318.691906] Subtest eof: SUCCESS (0.000s)
[318.756976] [049/133] (701s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[318.814070] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[318.818035] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[319.003842] [050/133] (701s left) kms_cursor_crc (cursor-sliding-128x128)
[319.233463] Starting subtest: cursor-sliding-128x128
[319.238362] Starting dynamic subtest: pipe-A-eDP-1
[322.463238] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.224s)
[322.491315] Starting dynamic subtest: pipe-D-eDP-1
[326.300775] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.816s)
[326.303420] Subtest cursor-sliding-128x128: SUCCESS (7.066s)
[327.186633] [051/133] (693s left) gem_exec_fence (long-history)
[327.639857] Starting subtest: long-history
[334.670519] Subtest long-history: SUCCESS (7.030s)
[335.162861] [052/133] (685s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[335.266605] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[335.270954] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[335.375559] [053/133] (685s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[335.471586] Starting subtest: fbc-shrfb-scaledprimary
[338.481422] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.013s)
[339.607442] [054/133] (681s left) gem_exec_params (dr1-dirt)
[339.670510] Starting subtest: DR1-dirt
[339.672861] Subtest DR1-dirt: SUCCESS (0.000s)
[339.766184] [055/133] (681s left) gem_exec_balancer (sequential)
[339.821565] Starting subtest: sequential
[342.923667] Subtest sequential: SUCCESS (3.102s)
[343.246365] [056/133] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[343.350694] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[350.221827] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.874s)
[350.347191] [057/133] (670s left) gem_exec_create (madvise)
[350.416262] Starting subtest: madvise
[350.418567] Starting dynamic subtest: smem
[372.004702] Dynamic subtest smem: SUCCESS (21.588s)
[372.007615] Subtest madvise: SUCCESS (21.590s)
[372.807339] [058/133] (648s left) device_reset (unbind-reset-rebind)
[372.858755] Starting subtest: unbind-reset-rebind
[378.780222] Subtest unbind-reset-rebind: SUCCESS (5.921s)
[378.828787] [059/133] (642s left) i915_query (query-topology-matches-eu-total)
[378.892822] Starting subtest: query-topology-matches-eu-total
[378.895082] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[378.999847] [060/133] (642s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[379.104199] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[379.106391] Starting dynamic subtest: pipe-A-eDP-1
[379.126361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[379.135704] Starting dynamic subtest: pipe-B-eDP-1
[379.155103] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[379.163906] Starting dynamic subtest: pipe-C-eDP-1
[379.183347] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[379.191970] Starting dynamic subtest: pipe-D-eDP-1
[379.211310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[379.213489] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[381.415572] [061/133] (639s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[381.515827] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[381.520201] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[381.586690] [062/133] (639s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[381.685709] Starting subtest: primary-y-tiled-reflect-x-180
[381.757382] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[381.860396] [063/133] (639s left) kms_flip (2x-flip-vs-suspend)
[381.968309] Starting subtest: 2x-flip-vs-suspend
[381.980081] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[382.063503] [064/133] (639s left) kms_prop_blob (blob-prop-core)
[382.120103] Starting subtest: blob-prop-core
[382.122581] Subtest blob-prop-core: SUCCESS (0.000s)
[382.246297] [065/133] (639s left) gem_lmem_swapping (massive)
[382.294084] Subtest massive: SKIP (0.000s)
[382.344793] [066/133] (639s left) gem_ctx_param (invalid-size-set)
[382.404641] Starting subtest: invalid-size-set
[382.406768] Subtest invalid-size-set: SUCCESS (0.001s)
[382.517494] [067/133] (638s left) gem_mmap_offset (mmap-boundaries)
[382.579949] Starting subtest: mmap-boundaries
[382.582032] Starting dynamic subtest: smem0
[382.867055] Dynamic subtest smem0: SUCCESS (0.288s)
[382.869886] Subtest mmap-boundaries: SUCCESS (0.289s)
[383.003597] [068/133] (638s left) gem_pipe_control_store_loop (reused-buffer)
[383.074006] Starting subtest: reused-buffer
[385.224065] Subtest reused-buffer: SUCCESS (2.151s)
[385.342218] [069/133] (636s left) syncobj_basic (bad-flags-handle-to-fd)
[385.400246] Starting subtest: bad-flags-handle-to-fd
[385.402592] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[385.491885] [070/133] (636s left) kms_busy (extended-modeset-hang-newfb)
[385.595025] Starting subtest: extended-modeset-hang-newfb
[385.596968] Starting dynamic subtest: pipe-A
[419.876774] Dynamic subtest pipe-A: SUCCESS (34.281s)
[419.886705] Starting dynamic subtest: pipe-D
[442.787449] Dynamic subtest pipe-D: SUCCESS (22.908s)
[442.789892] Subtest extended-modeset-hang-newfb: SUCCESS (57.195s)
[443.659942] [071/133] (577s left) gem_exec_balancer (bonded-chain)
[443.727865] Starting subtest: bonded-chain
[450.726046] Subtest bonded-chain: SUCCESS (6.996s)
[451.037736] [072/133] (570s left) gem_spin_batch (resubmit-new)
[451.097197] Starting subtest: resubmit-new
[451.099531] Starting dynamic subtest: rcs0
[451.112686] Dynamic subtest rcs0: SUCCESS (0.015s)
[451.122315] Starting dynamic subtest: bcs0
[451.124433] Dynamic subtest bcs0: SUCCESS (0.009s)
[451.133675] Starting dynamic subtest: vcs0
[451.136110] Dynamic subtest vcs0: SUCCESS (0.007s)
[451.145278] Starting dynamic subtest: vcs1
[451.147526] Dynamic subtest vcs1: SUCCESS (0.007s)
[451.156620] Starting dynamic subtest: vecs0
[451.158469] Dynamic subtest vecs0: SUCCESS (0.006s)
[451.167289] Starting dynamic subtest: ccs0
[451.169106] Dynamic subtest ccs0: SUCCESS (0.007s)
[451.170882] Subtest resubmit-new: SUCCESS (0.054s)
[452.926238] [073/133] (568s left) gem_ctx_param (invalid-get-no-zeromap)
[452.980720] Starting subtest: invalid-get-no-zeromap
[452.983126] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[453.080518] [074/133] (568s left) gem_exec_reloc (basic-cpu-read-noreloc)
[453.146481] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[453.210914] [075/133] (568s left) kms_flip (flip-vs-rmfb-interruptible)
[453.315379] Starting subtest: flip-vs-rmfb-interruptible
[453.317709] Starting dynamic subtest: A-eDP1
[461.963530] Dynamic subtest A-eDP1: SUCCESS (8.647s)
[461.975124] Starting dynamic subtest: B-eDP1
[470.598179] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[470.608743] Starting dynamic subtest: C-eDP1
[479.220207] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[479.233906] Starting dynamic subtest: D-eDP1
[487.854225] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[487.860110] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.545s)
[489.036377] [076/133] (532s left) gen7_exec_parse (chained-batch)
[489.092286] Subtest chained-batch: SKIP (0.000s)
[489.159787] [077/133] (532s left) kms_rotation_crc (sprite-rotation-180)
[489.250335] Starting subtest: sprite-rotation-180
[496.063873] Subtest sprite-rotation-180: SUCCESS (6.814s)
[497.231479] [078/133] (524s left) gem_exec_flush (basic-uc-set-default)
[497.291038] Starting subtest: basic-uc-set-default
[502.748678] Subtest basic-uc-set-default: SUCCESS (5.459s)
[502.932632] [079/133] (518s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[503.037379] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[503.041502] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[503.154268] [080/133] (518s left) gem_lmem_swapping (smem-oom)
[503.204490] Subtest smem-oom: SKIP (0.000s)
[503.251207] [081/133] (518s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[503.356044] Starting subtest: fbc-rgb565-draw-render
[507.536470] Subtest fbc-rgb565-draw-render: SUCCESS (4.184s)
[508.728696] [082/133] (513s left) perf (rc6-disable)
[508.858970] Starting subtest: rc6-disable
[509.040633] Subtest rc6-disable: SUCCESS (0.183s)
[509.084816] [083/133] (513s left) syncobj_timeline (host-signal-points)
[509.137993] Starting subtest: host-signal-points
[509.142844] Subtest host-signal-points: SUCCESS (0.004s)
[509.214682] [084/133] (512s left) gem_exec_schedule (implicit-read-write)
[509.292109] Starting subtest: implicit-read-write
[509.294036] Starting dynamic subtest: rcs0
[509.386998] Dynamic subtest rcs0: SUCCESS (0.105s)
[509.400907] Starting dynamic subtest: vcs0
[509.469193] Dynamic subtest vcs0: SUCCESS (0.081s)
[509.480296] Starting dynamic subtest: vcs1
[509.549515] Dynamic subtest vcs1: SUCCESS (0.079s)
[509.558658] Starting dynamic subtest: vecs0
[509.628625] Dynamic subtest vecs0: SUCCESS (0.078s)
[509.638681] Starting dynamic subtest: ccs0
[509.711701] Dynamic subtest ccs0: SUCCESS (0.083s)
[509.713612] Subtest implicit-read-write: SUCCESS (0.432s)
[510.953770] [085/133] (511s left) kms_joiner (invalid-modeset-force-big-joiner)
[511.067756] Starting subtest: invalid-modeset-force-big-joiner
[511.072136] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[511.155811] [086/133] (511s left) api_intel_bb (add-remove-objects)
[511.212113] Starting subtest: add-remove-objects
[511.216897] Subtest add-remove-objects: SUCCESS (0.006s)
[511.350998] [087/133] (510s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[511.467701] Starting subtest: flip-vs-cursor-atomic-transitions
[519.038353] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.568s)
[519.831468] [088/133] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[519.936244] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[527.258795] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.324s)
[527.400195] [089/133] (494s left) kms_psr (psr2-cursor-mmap-gtt)
[527.494150] Starting subtest: psr2-cursor-mmap-gtt
[527.496424] Starting dynamic subtest: eDP-1
[529.223310] Dynamic subtest eDP-1: SUCCESS (1.729s)
[529.225674] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.730s)
[530.099719] [090/133] (492s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[530.194530] Starting subtest: crc-primary-suspend-y-tiled-ccs
[530.196826] Starting dynamic subtest: pipe-A-eDP-1
[530.206028] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.217779] Starting dynamic subtest: pipe-B-eDP-1
[530.227065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.241725] Starting dynamic subtest: pipe-C-eDP-1
[530.250231] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.259145] Starting dynamic subtest: pipe-D-eDP-1
[530.267621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.271711] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[532.466208] [091/133] (489s left) kms_atomic_transition (modeset-transition)
[532.557422] Starting subtest: modeset-transition
[532.559667] Starting dynamic subtest: 1x-outputs
[543.369180] Dynamic subtest 1x-outputs: SUCCESS (10.811s)
[543.371769] Subtest modeset-transition: SUCCESS (10.813s)
[544.231710] [092/133] (478s left) sysfs_timeslice_duration (invalid)
[544.290747] Starting subtest: invalid
[544.293191] Starting dynamic subtest: vecs0
[544.295494] Dynamic subtest vecs0: SUCCESS (0.000s)
[544.307166] Starting dynamic subtest: ccs0
[544.309336] Dynamic subtest ccs0: SUCCESS (0.000s)
[544.318626] Starting dynamic subtest: vcs0
[544.321184] Dynamic subtest vcs0: SUCCESS (0.001s)
[544.335122] Starting dynamic subtest: bcs0
[544.336958] Dynamic subtest bcs0: SUCCESS (0.001s)
[544.346048] Starting dynamic subtest: rcs0
[544.348182] Dynamic subtest rcs0: SUCCESS (0.000s)
[544.357099] Starting dynamic subtest: vcs1
[544.359234] Dynamic subtest vcs1: SUCCESS (0.000s)
[544.361358] Subtest invalid: SUCCESS (0.009s)
[544.400231] [093/133] (478s left) kms_psr (fbc-psr-cursor-render)
[544.485558] Starting subtest: fbc-psr-cursor-render
[544.487867] Starting dynamic subtest: eDP-1
[544.492020] Dynamic subtest eDP-1: SKIP (0.000s)
[544.496198] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[544.561443] [094/133] (478s left) syncobj_wait (reset-during-wait-for-submit)
[544.625748] Starting subtest: reset-during-wait-for-submit
[544.727447] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[544.812742] [095/133] (477s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[544.882688] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[544.885031] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[544.996666] [096/133] (477s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[545.140298] Starting subtest: dp-mst-type-0-suspend-resume
[545.144290] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[545.253472] [097/133] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[545.342810] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[545.346066] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[545.441991] [098/133] (477s left) prime_mmap_kms (buffer-sharing)
[545.547538] Starting subtest: buffer-sharing
[546.006313] Subtest buffer-sharing: SUCCESS (0.459s)
[546.865151] [099/133] (475s left) syncobj_timeline (single-wait-available-signaled)
[546.930426] Starting subtest: single-wait-available-signaled
[546.932807] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[547.037424] [100/133] (475s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[547.145197] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[547.147545] Starting dynamic subtest: pipe-A-default-mode
[549.941618] Dynamic subtest pipe-A-default-mode: SUCCESS (2.796s)
[549.943856] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.797s)
[550.784266] [101/133] (472s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[550.890544] Starting subtest: fbc-tiling-linear
[554.580632] Subtest fbc-tiling-linear: SUCCESS (3.692s)
[555.793273] [102/133] (467s left) syncobj_wait (single-wait-all-submitted)
[555.842329] Starting subtest: single-wait-all-submitted
[555.946233] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[556.036577] [103/133] (466s left) kms_setmode (basic-clone-single-crtc)
[556.092189] Starting subtest: basic-clone-single-crtc
[556.098983] Subtest basic-clone-single-crtc: SKIP (0.000s)
[556.205279] [104/133] (466s left) syncobj_eventfd (timeline-wait-before-signal)
[556.266027] Starting subtest: timeline-wait-before-signal
[556.295506] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[556.374312] [105/133] (466s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[556.479783] Starting subtest: psr-rgb101010-draw-mmap-wc
[563.548996] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.073s)
[563.662132] [106/133] (459s left) kms_chamelium_color (ctm-negative)
[563.756044] Subtest ctm-negative: SKIP (0.000s)
[563.804300] [107/133] (459s left) syncobj_wait (multi-wait-all-signaled)
[563.867677] Starting subtest: multi-wait-all-signaled
[563.870096] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[563.976864] [108/133] (459s left) kms_psr (psr-primary-mmap-gtt)
[564.057953] Starting subtest: psr-primary-mmap-gtt
[564.060261] Starting dynamic subtest: eDP-1
[565.500053] Dynamic subtest eDP-1: SKIP (1.440s)
[565.505063] Subtest psr-primary-mmap-gtt: SKIP (1.442s)
[565.652555] [109/133] (457s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[565.745782] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[565.748063] Starting dynamic subtest: pipe-A-eDP-1
[565.769825] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.780354] Starting dynamic subtest: pipe-B-eDP-1
[565.801149] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.810186] Starting dynamic subtest: pipe-C-eDP-1
[565.832591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.843814] Starting dynamic subtest: pipe-D-eDP-1
[565.866018] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.870146] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[567.901778] [110/133] (455s left) gem_ctx_persistence (heartbeat-stop)
[567.957900] Starting subtest: heartbeat-stop
[567.962255] Subtest heartbeat-stop: SKIP (0.000s)
[568.064504] [111/133] (455s left) kms_psr (pr-sprite-render)
[568.168197] Starting subtest: pr-sprite-render
[568.172611] Subtest pr-sprite-render: SKIP (0.000s)
[568.243400] [112/133] (455s left) gem_ppgtt (shrink-vs-evict-pinned)
[568.292779] Starting subtest: shrink-vs-evict-pinned
[575.887231] Subtest shrink-vs-evict-pinned: SUCCESS (7.591s)
[575.990268] [113/133] (447s left) gem_exec_reloc (basic-write-gtt)
[576.056395] Subtest basic-write-gtt: SKIP (0.000s)
[576.146544] [114/133] (447s left) i915_pm_rps (thresholds-idle)
[576.204112] Starting subtest: thresholds-idle
[576.208802] Subtest thresholds-idle: SKIP (0.001s)
[576.302655] [115/133] (447s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[576.408171] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[577.012055] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.605s)
[577.184490] [116/133] (446s left) kms_plane (plane-position-covered)
[577.280203] Starting subtest: plane-position-covered
[577.802661] Starting dynamic subtest: pipe-A-plane-1
[579.063293] Dynamic subtest pipe-A-plane-1: SUCCESS (1.260s)
[579.073630] Starting dynamic subtest: pipe-A-plane-2
[580.386813] Dynamic subtest pipe-A-plane-2: SUCCESS (1.323s)
[580.400067] Starting dynamic subtest: pipe-A-plane-3
[581.721344] Dynamic subtest pipe-A-plane-3: SUCCESS (1.331s)
[581.732346] Starting dynamic subtest: pipe-A-plane-4
[583.020769] Dynamic subtest pipe-A-plane-4: SUCCESS (1.302s)
[583.040378] Starting dynamic subtest: pipe-A-plane-5
[583.050170] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[584.211487] Starting dynamic subtest: pipe-B-plane-1
[585.505699] Dynamic subtest pipe-B-plane-1: SUCCESS (1.303s)
[585.515893] Starting dynamic subtest: pipe-B-plane-2
[586.831730] Dynamic subtest pipe-B-plane-2: SUCCESS (1.324s)
[586.841830] Starting dynamic subtest: pipe-B-plane-3
[588.144478] Dynamic subtest pipe-B-plane-3: SUCCESS (1.311s)
[588.154800] Starting dynamic subtest: pipe-B-plane-4
[589.469237] Dynamic subtest pipe-B-plane-4: SUCCESS (1.327s)
[589.480077] Starting dynamic subtest: pipe-B-plane-5
[589.497307] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[589.499659] Subtest plane-position-covered: SUCCESS (12.217s)
[590.278352] [117/133] (433s left) gem_workarounds (suspend-resume-fd)
[590.341160] Starting subtest: suspend-resume-fd
[607.077530] Subtest suspend-resume-fd: SUCCESS (1.278s)
[607.229835] [118/133] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[607.342609] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[607.347151] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[607.469489] [119/133] (416s left) i915_pm_rpm (debugfs-read)
[609.499949] Starting subtest: debugfs-read
[610.652628] Subtest debugfs-read: SUCCESS (1.176s)
[611.020387] [120/133] (412s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[611.103637] Starting subtest: compare-crc-sanitycheck-nv12
[611.105991] Starting dynamic subtest: pipe-A-eDP-1
[611.810358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[611.821549] Starting dynamic subtest: pipe-B-eDP-1
[613.062995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.270s)
[613.074339] Starting dynamic subtest: pipe-C-eDP-1
[614.338915] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[614.350341] Starting dynamic subtest: pipe-D-eDP-1
[615.558058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[615.559949] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.513s)
[616.385846] [121/133] (407s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[616.466355] Starting subtest: pixel-format-linear-modifier-source-clamping
[616.492207] Starting dynamic subtest: pipe-A-plane-0
[620.033997] Dynamic subtest pipe-A-plane-0: SUCCESS (3.566s)
[620.046920] Starting dynamic subtest: pipe-A-plane-3
[621.648620] Dynamic subtest pipe-A-plane-3: SUCCESS (1.620s)
[622.712560] Starting dynamic subtest: pipe-B-plane-0
[626.391330] Dynamic subtest pipe-B-plane-0: SUCCESS (3.700s)
[626.404086] Starting dynamic subtest: pipe-B-plane-3
[628.054261] Dynamic subtest pipe-B-plane-3: SUCCESS (1.666s)
[628.363709] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.950s)
[629.161177] [122/133] (394s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[629.255854] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[629.260240] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[629.364538] [123/133] (394s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[629.459519] Starting subtest: fbc-pr-sprite-mmap-gtt
[629.463824] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[629.535384] [124/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[629.628448] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[629.632734] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[629.724404] [125/133] (394s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[629.812794] Starting subtest: plane-upscale-factor-0-25-with-rotation
[629.815064] Starting dynamic subtest: pipe-A
[630.038106] Dynamic subtest pipe-A: SUCCESS (0.227s)
[630.048354] Starting dynamic subtest: pipe-B
[631.337856] Dynamic subtest pipe-B: SUCCESS (1.301s)
[631.349059] Starting dynamic subtest: pipe-C
[632.668838] Dynamic subtest pipe-C: SUCCESS (1.332s)
[632.680031] Starting dynamic subtest: pipe-D
[633.995838] Dynamic subtest pipe-D: SUCCESS (1.328s)
[633.998232] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.192s)
[635.179523] [126/133] (388s left) gem_exec_gttfill (engines)
[635.243025] Starting subtest: engines
[635.245541] Starting dynamic subtest: rcs0
[658.260864] Dynamic subtest rcs0: SUCCESS (23.018s)
[658.272896] Starting dynamic subtest: bcs0
[681.558169] Dynamic subtest bcs0: SUCCESS (23.301s)
[681.571258] Starting dynamic subtest: vcs0
[704.831124] Dynamic subtest vcs0: SUCCESS (23.278s)
[704.841603] Starting dynamic subtest: vcs1
[728.132769] Dynamic subtest vcs1: SUCCESS (23.292s)
[728.148161] Starting dynamic subtest: vecs0
[751.429710] Dynamic subtest vecs0: SUCCESS (23.294s)
[751.443059] Starting dynamic subtest: ccs0
[774.715248] Dynamic subtest ccs0: SUCCESS (23.287s)
[774.717451] Subtest engines: SUCCESS (139.484s)
[774.922798] [127/133] (249s left) gem_create (create-ext-placement-each)
[775.136809] Starting subtest: create-ext-placement-each
[775.139140] Subtest create-ext-placement-each: SUCCESS (0.000s)
[775.243199] [128/133] (248s left) gem_render_copy (yf-tiled)
[775.319702] Starting subtest: yf-tiled
[775.324430] Subtest yf-tiled: SKIP (0.000s)
[775.514374] [129/133] (248s left) kms_rotation_crc (cursor-rotation-180)
[775.649829] Starting subtest: cursor-rotation-180
[777.128040] Subtest cursor-rotation-180: SUCCESS (1.478s)
[778.315716] [130/133] (245s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[778.421351] Starting subtest: yf-tiled-64bpp-rotate-0
[778.425684] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[778.543034] [131/133] (245s left) kms_big_fb (linear-32bpp-rotate-270)
[778.644676] Starting subtest: linear-32bpp-rotate-270
[778.665522] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[778.782009] [132/133] (245s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[778.870659] Starting subtest: fbc-rgb101010-draw-blt
[783.444408] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.577s)
[784.647959] [133/133] (239s left) syncobj_wait (reset-unsignaled)
[784.720861] Starting subtest: reset-unsignaled
[784.723274] Subtest reset-unsignaled: SUCCESS (0.000s)
[784.841607] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: kms_sequence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: i915_hangman
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: gem_watchdog
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_pm_backlight
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_dsc
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_lease
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_create
results: parsing output: 57/ for test: device_reset
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: gem_mmap_offset
results: parsing output: 67/ for test: gem_pipe_control_store_loop
results: parsing output: 68/ for test: syncobj_basic
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: sysfs_timeslice_duration
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_mmap_kms
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_setmode
results: parsing output: 103/ for test: syncobj_eventfd
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_color
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ppgtt
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_workarounds
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_exec_gttfill
results: parsing output: 126/ for test: gem_create
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.