[59.670284] Initializing watchdogs
[59.670332]   /dev/watchdog0
[59.684715] [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]
[59.689241] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.691616] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.695057] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[59.814707] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[59.819184] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[59.924211] [002/133] (960s left) kms_psr (pr-sprite-blt)
[60.014483] Starting subtest: pr-sprite-blt
[60.018920] Subtest pr-sprite-blt: SKIP (0.000s)
[60.086795] [003/133] (960s left) kms_feature_discovery (psr2)
[60.168910] Starting subtest: psr2
[60.171261] Subtest psr2: SUCCESS (0.000s)
[60.243650] [004/133] (960s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[60.332916] Starting subtest: pr-cursor-plane-update-sf
[60.337276] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[60.400966] [005/133] (959s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[60.496418] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[60.498527] Starting dynamic subtest: pipe-A-eDP-1
[71.897696] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.363s)
[71.906862] Starting dynamic subtest: pipe-B-eDP-1
[83.946535] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.038s)
[83.949011] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.403s)
[84.769205] [006/133] (935s left) i915_query (hwconfig_table)
[84.829067] Starting subtest: hwconfig_table
[85.129123] Subtest hwconfig_table: SUCCESS (0.001s)
[85.165302] [007/133] (935s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[85.269843] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[85.298485] Starting dynamic subtest: pipe-A-plane-0
[85.743185] Dynamic subtest pipe-A-plane-0: SUCCESS (0.445s)
[85.750472] Starting dynamic subtest: pipe-A-plane-3
[86.020892] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[87.171381] Starting dynamic subtest: pipe-B-plane-0
[87.597812] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[87.606522] Starting dynamic subtest: pipe-B-plane-3
[87.853354] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[88.173796] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.900s)
[89.061078] [008/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[89.161683] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[89.166307] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[89.267683] [009/133] (931s left) gen7_exec_parse (batch-without-end)
[89.328359] Subtest batch-without-end: SKIP (0.000s)
[89.392229] [010/133] (931s left) kms_flip (basic-plain-flip)
[89.488827] Starting subtest: basic-plain-flip
[89.491222] Starting dynamic subtest: A-eDP1
[91.159364] Dynamic subtest A-eDP1: SUCCESS (1.671s)
[91.167220] Starting dynamic subtest: B-eDP1
[92.888310] Dynamic subtest B-eDP1: SUCCESS (1.726s)
[92.898284] Starting dynamic subtest: C-eDP1
[94.506539] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[94.515072] Starting dynamic subtest: D-eDP1
[96.142638] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[96.147794] Subtest basic-plain-flip: SUCCESS (6.659s)
[97.323815] [011/133] (923s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[97.460178] Starting subtest: cursorB-vs-flipB-varying-size
[97.464784] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[97.601542] [012/133] (923s left) kms_plane_multiple (tiling-y)
[97.696944] Starting subtest: tiling-y
[97.701439] Subtest tiling-y: SKIP (0.000s)
[97.769721] [013/133] (922s left) gem_caching (read-writes)
[97.842786] Subtest read-writes: SKIP (0.000s)
[97.908161] [014/133] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[98.014458] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[104.662496] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.648s)
[104.809710] [015/133] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[104.910914] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[104.915180] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[105.006152] [016/133] (915s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[105.114444] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[105.118856] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[105.206587] [017/133] (915s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.299864] Starting subtest: primary-4-tiled-reflect-x-180
[112.385878] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.087s)
[113.550312] [018/133] (907s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[113.637841] Starting subtest: fbc-psr-cursor-mmap-cpu
[113.640128] Starting dynamic subtest: eDP-1
[113.644583] Dynamic subtest eDP-1: SKIP (0.000s)
[113.649129] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[113.710967] [019/133] (907s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[113.772521] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[113.774887] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[113.867895] [020/133] (907s left) kms_pm_rpm (dpms-non-lpsp)
[116.099755] Starting subtest: dpms-non-lpsp
[116.105157] Subtest dpms-non-lpsp: SKIP (0.001s)
[116.484475] [021/133] (904s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[116.579891] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[123.774734] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.198s)
[124.981771] [022/133] (896s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[125.083717] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[125.085862] Starting dynamic subtest: pipe-A-eDP-1
[125.143181] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[125.150787] Starting dynamic subtest: pipe-B-eDP-1
[125.206350] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[125.214986] Starting dynamic subtest: pipe-C-eDP-1
[125.272207] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[125.280877] Starting dynamic subtest: pipe-D-eDP-1
[125.338344] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[125.343499] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[127.279653] [023/133] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[127.394968] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[127.399616] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[127.485182] [024/133] (893s left) sriov_basic (bind-unbind-vf)
[127.540870] Starting subtest: bind-unbind-vf
[127.543540] Starting dynamic subtest: vf-1
[127.622220] Dynamic subtest vf-1: FAIL (0.034s)
[127.631705] Starting dynamic subtest: vf-2
[127.707059] Dynamic subtest vf-2: FAIL (0.004s)
[127.716619] Starting dynamic subtest: vf-3
[127.789910] Dynamic subtest vf-3: FAIL (0.004s)
[127.798300] Starting dynamic subtest: vf-4
[127.871579] Dynamic subtest vf-4: FAIL (0.004s)
[127.878496] Starting dynamic subtest: vf-5
[127.950971] Dynamic subtest vf-5: FAIL (0.003s)
[127.959936] Starting dynamic subtest: vf-6
[128.032699] Dynamic subtest vf-6: FAIL (0.004s)
[128.040954] Starting dynamic subtest: vf-7
[128.113647] Dynamic subtest vf-7: FAIL (0.004s)
[128.120146] Starting dynamic subtest: vf-random
[128.190830] Dynamic subtest vf-random: FAIL (0.004s)
[128.198596] Starting dynamic subtest: vf-last
[128.255916] Dynamic subtest vf-last: FAIL (0.505s)
[128.257694] Subtest bind-unbind-vf: FAIL (0.569s)
[128.288921] [025/133] (892s left) kms_properties (connector-properties-atomic)
[128.384331] Starting subtest: connector-properties-atomic
[128.386352] Starting dynamic subtest: pipe-A-eDP-1
[136.201246] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.814s)
[136.209770] Starting dynamic subtest: pipe-None-DP-1
[136.214288] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[136.220820] Starting dynamic subtest: pipe-None-HDMI-A-1
[136.225081] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[136.231880] Starting dynamic subtest: pipe-None-DP-2
[136.236248] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[136.243130] Starting dynamic subtest: pipe-None-HDMI-A-2
[136.247423] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[136.254505] Starting dynamic subtest: pipe-None-DP-3
[136.259177] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[136.268827] Starting dynamic subtest: pipe-None-DP-4
[136.273424] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[136.275709] Subtest connector-properties-atomic: SUCCESS (7.824s)
[137.060785] [026/133] (884s left) syncobj_eventfd (invalid-bad-pad)
[137.122128] Starting subtest: invalid-bad-pad
[137.124458] Subtest invalid-bad-pad: SUCCESS (0.000s)
[137.205602] [027/133] (884s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[137.263092] Starting subtest: single-wait-all-for-submit-available-signaled
[137.265520] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[137.368136] [028/133] (883s left) gem_exec_fence (syncobj-timeline-wait)
[137.947621] Starting subtest: syncobj-timeline-wait
[138.920834] Subtest syncobj-timeline-wait: SUCCESS (0.973s)
[139.165306] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[139.168327] [029/133] (882s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[139.284228] Starting subtest: plane-upscale-factor-0-25-with-rotation
[139.286145] Starting dynamic subtest: pipe-A
[139.515432] Dynamic subtest pipe-A: SUCCESS (0.231s)
[139.523112] Starting dynamic subtest: pipe-B
[140.838418] Dynamic subtest pipe-B: SUCCESS (1.322s)
[140.848207] Starting dynamic subtest: pipe-C
[142.159440] Dynamic subtest pipe-C: SUCCESS (1.320s)
[142.168825] Starting dynamic subtest: pipe-D
[143.494087] Dynamic subtest pipe-D: SUCCESS (1.333s)
[143.496532] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.211s)
[144.694523] [030/133] (876s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[144.802832] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[145.859775] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.057s)
[145.983112] [031/133] (875s left) i915_fb_tiling (basic-x-tiling)
[146.042956] Subtest basic-x-tiling: SKIP (0.000s)
[146.113232] [032/133] (875s left) gem_exec_endless (dispatch)
[146.176047] Starting subtest: dispatch
[146.178156] Starting dynamic subtest: rcs0
[146.185813] Dynamic subtest rcs0: SUCCESS (0.005s)
[146.199849] Starting dynamic subtest: bcs0
[146.203231] Dynamic subtest bcs0: SUCCESS (0.004s)
[146.214449] Starting dynamic subtest: vcs0
[146.218345] Dynamic subtest vcs0: SUCCESS (0.005s)
[146.227406] Starting dynamic subtest: vcs1
[146.230866] Dynamic subtest vcs1: SUCCESS (0.006s)
[146.237780] Starting dynamic subtest: vecs0
[146.241200] Dynamic subtest vecs0: SUCCESS (0.010s)
[146.247805] Starting dynamic subtest: ccs0
[146.251210] Dynamic subtest ccs0: SUCCESS (0.006s)
[146.252781] Subtest dispatch: SUCCESS (0.040s)
[147.900659] [033/133] (873s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[148.000227] Starting subtest: yf-tiled-16bpp-rotate-90
[148.004495] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[148.080359] [034/133] (873s left) gem_mmap_gtt (basic-short)
[148.141575] Subtest basic-short: SKIP (0.000s)
[148.205275] [035/133] (873s left) i915_drm_fdinfo (busy-hang)
[148.243063] Starting subtest: busy-hang
[148.245415] Starting dynamic subtest: rcs0
[148.263593] Dynamic subtest rcs0: SKIP (0.020s)
[148.273253] Starting dynamic subtest: bcs0
[148.277402] Dynamic subtest bcs0: SKIP (0.001s)
[148.285106] Starting dynamic subtest: vcs0
[148.289009] Dynamic subtest vcs0: SKIP (0.000s)
[148.296616] Starting dynamic subtest: vcs1
[148.300730] Dynamic subtest vcs1: SKIP (0.001s)
[148.308127] Starting dynamic subtest: vecs0
[148.312141] Dynamic subtest vecs0: SKIP (0.000s)
[148.319518] Starting dynamic subtest: ccs0
[148.323719] Dynamic subtest ccs0: SKIP (0.000s)
[148.327849] Subtest busy-hang: SKIP (0.025s)
[148.368092] [036/133] (873s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[148.434057] Starting subtest: x-tiled-to-vebox-y-tiled
[148.438390] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[148.637532] [037/133] (873s left) device_reset (unbind-cold-reset-rebind)
[148.685776] Starting subtest: unbind-cold-reset-rebind
[148.690287] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[148.760842] [038/133] (872s left) kms_big_fb (linear-32bpp-rotate-0)
[148.860058] Starting subtest: linear-32bpp-rotate-0
[150.388745] Subtest linear-32bpp-rotate-0: SUCCESS (1.527s)
[150.544046] [039/133] (871s left) gem_pxp (fail-invalid-protected-context)
[150.660787] Starting subtest: fail-invalid-protected-context
[150.663192] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[150.771542] [040/133] (871s left) gem_exec_suspend (basic)
[150.827228] Starting subtest: basic
[150.828820] Starting dynamic subtest: smem
[152.918030] Dynamic subtest smem: SUCCESS (2.090s)
[152.920628] Subtest basic: SUCCESS (2.092s)
[153.112035] [041/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[153.219434] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[153.223808] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[153.327694] [042/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[153.428310] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[153.432861] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[153.537342] [043/133] (868s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[153.649433] Starting subtest: flip-vs-cursor-crc-legacy
[154.344842] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.696s)
[155.204168] [044/133] (866s left) syncobj_timeline (invalid-query-bad-pad)
[155.265360] Starting subtest: invalid-query-bad-pad
[155.267325] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[155.358233] [045/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[155.457316] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[155.461619] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[155.541266] [046/133] (866s left) gem_exec_balancer (individual)
[155.600709] Starting subtest: individual
[156.865240] Subtest individual: SUCCESS (1.264s)
[157.176314] [047/133] (864s left) kms_cursor_crc (cursor-size-change)
[157.275758] Starting subtest: cursor-size-change
[157.277986] Starting dynamic subtest: pipe-A-eDP-1
[158.096216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[158.105676] Starting dynamic subtest: pipe-D-eDP-1
[159.571068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.475s)
[159.573521] Subtest cursor-size-change: SUCCESS (2.297s)
[160.368060] [048/133] (861s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[160.468252] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[160.472380] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[160.539411] [049/133] (861s left) kms_plane (plane-panning-top-left)
[160.637751] Starting subtest: plane-panning-top-left
[160.639940] Starting dynamic subtest: pipe-A
[162.353411] Dynamic subtest pipe-A: SUCCESS (1.715s)
[162.362350] Starting dynamic subtest: pipe-B
[164.779890] Dynamic subtest pipe-B: SUCCESS (2.424s)
[164.782315] Subtest plane-panning-top-left: SUCCESS (4.142s)
[165.606069] [050/133] (856s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[165.666621] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[165.724208] [051/133] (856s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[165.774984] Starting subtest: multi-wait-for-submit-available-submitted
[165.777384] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[165.901587] [052/133] (856s left) gem_ppgtt (blt-vs-render-ctxn)
[165.970935] Starting subtest: blt-vs-render-ctxN
[198.901574] Subtest blt-vs-render-ctxN: SUCCESS (32.927s)
[199.048947] [053/133] (823s left) prime_vgem (fence-write-hang)
[199.155685] Subtest fence-write-hang: SKIP (0.000s)
[199.268059] [054/133] (823s left) gem_cs_tlb (engines)
[199.323942] Starting subtest: engines
[199.325989] Starting dynamic subtest: rcs0
[201.480969] Dynamic subtest rcs0: SUCCESS (2.155s)
[201.491825] Starting dynamic subtest: bcs0
[203.635860] Dynamic subtest bcs0: SUCCESS (2.153s)
[203.646564] Starting dynamic subtest: vcs0
[205.787742] Dynamic subtest vcs0: SUCCESS (2.152s)
[205.798859] Starting dynamic subtest: vcs1
[207.940407] Dynamic subtest vcs1: SUCCESS (2.151s)
[207.950693] Starting dynamic subtest: vecs0
[210.092486] Dynamic subtest vecs0: SUCCESS (2.151s)
[210.102473] Starting dynamic subtest: ccs0
[212.246337] Dynamic subtest ccs0: SUCCESS (2.152s)
[212.248819] Subtest engines: SUCCESS (12.921s)
[212.356398] [055/133] (810s left) gem_ppgtt (flink-and-close-vma-leak)
[212.415667] Starting subtest: flink-and-close-vma-leak
[212.461309] Subtest flink-and-close-vma-leak: SUCCESS (0.048s)
[212.588441] [056/133] (809s left) prime_mmap (test_correct_cpu_write)
[212.643403] Starting subtest: test_correct_cpu_write
[212.645730] Starting dynamic subtest: test_correct_cpu_write-smem
[212.647976] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[212.649841] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[212.736214] [057/133] (809s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[212.852775] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[212.857279] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[212.952811] [058/133] (809s left) gem_softpin (evict-active)
[213.022444] Starting subtest: evict-active
[213.025249] Subtest evict-active: SUCCESS (0.006s)
[213.158973] [059/133] (809s left) kms_content_protection (uevent)
[213.313544] Starting subtest: uevent
[213.317456] Subtest uevent: SKIP (0.000s)
[213.430416] [060/133] (809s left) i915_pm_rpm (system-suspend-execbuf)
[215.069050] Starting subtest: system-suspend-execbuf
[272.333604] Subtest system-suspend-execbuf: SUCCESS (42.722s)
[272.737498] [061/133] (749s left) gem_sync (basic-store-each)
[272.815685] Starting subtest: basic-store-each
[275.099264] Subtest basic-store-each: SUCCESS (2.292s)
[275.299543] [062/133] (747s left) gem_busy (busy)
[275.363125] Starting subtest: busy
[275.365405] Starting dynamic subtest: all-engines
[275.450569] Dynamic subtest all-engines: SUCCESS (0.087s)
[275.466193] Starting dynamic subtest: rcs0
[277.126907] Dynamic subtest rcs0: SUCCESS (1.673s)
[277.140649] Starting dynamic subtest: bcs0
[277.177462] Dynamic subtest bcs0: SUCCESS (0.049s)
[277.187112] Starting dynamic subtest: vcs0
[277.218129] Dynamic subtest vcs0: SUCCESS (0.038s)
[277.227158] Starting dynamic subtest: vcs1
[279.171076] Dynamic subtest vcs1: SUCCESS (1.948s)
[279.182228] Starting dynamic subtest: vecs0
[281.154952] Dynamic subtest vecs0: SUCCESS (1.981s)
[281.165628] Starting dynamic subtest: ccs0
[283.138694] Dynamic subtest ccs0: SUCCESS (1.982s)
[283.140966] Subtest busy: SUCCESS (7.767s)
[283.487568] [063/133] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[283.606542] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[283.610648] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[283.697976] [064/133] (739s left) kms_pm_rpm (package-g7)
[285.238631] Starting subtest: package-g7
[285.243878] Subtest package-g7: SKIP (0.000s)
[285.974127] [065/133] (736s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[286.080149] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[286.082447] Starting dynamic subtest: pipe-A-eDP-1
[286.978211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.890s)
[286.990556] Starting dynamic subtest: pipe-B-eDP-1
[288.593515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.609s)
[288.604239] Starting dynamic subtest: pipe-C-eDP-1
[290.098667] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[290.109235] Starting dynamic subtest: pipe-D-eDP-1
[291.655091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.550s)
[291.657621] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.564s)
[292.887257] [066/133] (729s left) gem_workarounds (basic-read)
[292.950844] Starting subtest: basic-read
[292.961971] Subtest basic-read: SUCCESS (0.010s)
[293.090191] [067/133] (729s left) kms_vblank (ts-continuation-modeset-hang)
[293.180731] Starting subtest: ts-continuation-modeset-hang
[293.182947] Starting dynamic subtest: pipe-A-eDP-1
[319.931939] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.736s)
[319.948215] Starting dynamic subtest: pipe-D-eDP-1
[334.912842] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s)
[334.914824] Subtest ts-continuation-modeset-hang: SUCCESS (41.710s)
[335.780726] [068/133] (687s left) kms_cdclk (mode-transition-all-outputs)
[335.876025] Starting subtest: mode-transition-all-outputs
[336.164498] Subtest mode-transition-all-outputs: SKIP (0.287s)
[336.969062] [069/133] (686s left) gem_exec_reloc (basic-cpu-wc-active)
[337.038417] Subtest basic-cpu-wc-active: SKIP (0.000s)
[337.107533] [070/133] (685s left) gem_ctx_param (invalid-param-set)
[337.156811] Starting subtest: invalid-param-set
[337.159224] Subtest invalid-param-set: SUCCESS (0.000s)
[337.232919] [071/133] (685s left) gem_userptr_blits (input-checking)
[337.285728] Starting subtest: input-checking
[337.287917] Subtest input-checking: SUCCESS (0.000s)
[337.401685] [072/133] (685s left) gem_spin_batch (legacy)
[337.470959] Starting subtest: legacy
[337.473299] Starting dynamic subtest: default
[340.712365] Dynamic subtest default: SUCCESS (3.238s)
[340.723788] Starting dynamic subtest: render
[343.945268] Dynamic subtest render: SUCCESS (3.232s)
[343.957268] Starting dynamic subtest: bsd
[347.180471] Dynamic subtest bsd: SUCCESS (3.234s)
[347.190550] Starting dynamic subtest: bsd1
[350.413699] Dynamic subtest bsd1: SUCCESS (3.232s)
[350.425489] Starting dynamic subtest: bsd2
[353.649852] Dynamic subtest bsd2: SUCCESS (3.234s)
[353.660089] Starting dynamic subtest: blt
[356.887938] Dynamic subtest blt: SUCCESS (3.236s)
[356.899965] Starting dynamic subtest: vebox
[360.123455] Dynamic subtest vebox: SUCCESS (3.233s)
[360.125714] Subtest legacy: SUCCESS (22.659s)
[362.189320] [073/133] (661s left) gem_exercise_blt (fast-copy-emit)
[362.256238] Starting subtest: fast-copy-emit
[362.258183] Starting dynamic subtest: linear-smem-smem-emit
[362.284595] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.031s)
[362.294130] Starting dynamic subtest: xmajor-smem-smem-emit
[362.305227] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s)
[362.314666] Starting dynamic subtest: tile4-smem-smem-emit
[362.324238] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[362.333371] Starting dynamic subtest: tile64-smem-smem-emit
[362.342888] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[362.345066] Subtest fast-copy-emit: SUCCESS (0.089s)
[362.470666] [074/133] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[362.579226] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[362.583668] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[362.683233] [075/133] (660s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[362.783003] Starting subtest: psr-rgb101010-draw-blt
[370.127451] Subtest psr-rgb101010-draw-blt: SUCCESS (7.350s)
[370.266786] [076/133] (653s left) kms_cursor_crc (cursor-sliding-32x10)
[370.443042] Starting subtest: cursor-sliding-32x10
[370.489877] Subtest cursor-sliding-32x10: SKIP (0.043s)
[370.749709] [077/133] (652s left) kms_cursor_crc (cursor-random-512x170)
[371.026345] Starting subtest: cursor-random-512x170
[371.030888] Subtest cursor-random-512x170: SKIP (0.001s)
[371.189688] [078/133] (652s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[371.282250] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[371.284189] Starting dynamic subtest: pipe-A-default-mode
[372.459889] Dynamic subtest pipe-A-default-mode: SKIP (1.175s)
[372.464609] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.176s)
[372.594145] [079/133] (650s left) kms_properties (crtc-properties-legacy)
[372.687248] Starting subtest: crtc-properties-legacy
[372.689527] Starting dynamic subtest: pipe-A-eDP-1
[373.132166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[373.142204] Starting dynamic subtest: pipe-B-eDP-1
[374.300418] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[374.311766] Starting dynamic subtest: pipe-C-eDP-1
[375.430268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[375.440313] Starting dynamic subtest: pipe-D-eDP-1
[376.569242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[376.571578] Subtest crtc-properties-legacy: SUCCESS (3.883s)
[377.395699] [080/133] (646s left) kms_tv_load_detect (load-detect)
[377.468630] Subtest load-detect: SKIP (0.000s)
[377.537989] [081/133] (646s left) gem_ctx_persistence (engines-hang)
[377.595930] Starting subtest: engines-hang
[377.598299] Starting dynamic subtest: rcs0
[377.721814] Dynamic subtest rcs0: SUCCESS (0.123s)
[377.735457] Starting dynamic subtest: bcs0
[377.827085] Dynamic subtest bcs0: SUCCESS (0.106s)
[377.842155] Starting dynamic subtest: vcs0
[377.919711] Dynamic subtest vcs0: SUCCESS (0.091s)
[377.934452] Starting dynamic subtest: vcs1
[378.022699] Dynamic subtest vcs1: SUCCESS (0.101s)
[378.037796] Starting dynamic subtest: vecs0
[378.124816] Dynamic subtest vecs0: SUCCESS (0.099s)
[378.137152] Starting dynamic subtest: ccs0
[378.218839] Dynamic subtest ccs0: SUCCESS (0.092s)
[378.221317] Subtest engines-hang: SUCCESS (0.625s)
[378.302586] [082/133] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[378.397035] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[385.480237] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.084s)
[385.583280] [083/133] (638s left) gem_exec_fence (syncobj-signal)
[386.116249] Starting subtest: syncobj-signal
[386.121998] Subtest syncobj-signal: SUCCESS (0.004s)
[387.277218] [084/133] (636s left) kms_joiner (invalid-modeset-force-big-joiner)
[387.361466] Starting subtest: invalid-modeset-force-big-joiner
[387.365448] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[387.431750] [085/133] (636s left) kms_getfb (getfb-handle-valid)
[387.529375] Starting subtest: getfb-handle-valid
[387.531650] Subtest getfb-handle-valid: SUCCESS (0.000s)
[387.632720] [086/133] (636s left) kms_busy (extended-modeset-hang-newfb)
[387.735007] Starting subtest: extended-modeset-hang-newfb
[387.737227] Starting dynamic subtest: pipe-A
[422.801235] Dynamic subtest pipe-A: SUCCESS (35.054s)
[422.812499] Starting dynamic subtest: pipe-D
[445.056391] Dynamic subtest pipe-D: SUCCESS (22.248s)
[445.058841] Subtest extended-modeset-hang-newfb: SUCCESS (57.308s)
[445.859216] [087/133] (577s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[445.938820] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[445.943383] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[446.129400] [088/133] (577s left) gem_render_copy_redux (flink-interruptible)
[446.191806] Starting subtest: flink-interruptible
[446.958055] Subtest flink-interruptible: SUCCESS (0.769s)
[447.095660] [089/133] (576s left) gem_exec_schedule (u-submit-early-slice)
[447.167234] Starting subtest: u-submit-early-slice
[447.169212] Starting dynamic subtest: rcs0
[447.208585] Dynamic subtest rcs0: SUCCESS (0.046s)
[447.217909] Starting dynamic subtest: bcs0
[447.244329] Dynamic subtest bcs0: SUCCESS (0.035s)
[447.256132] Starting dynamic subtest: vcs0
[447.280242] Dynamic subtest vcs0: SUCCESS (0.036s)
[447.290573] Starting dynamic subtest: vcs1
[447.321660] Dynamic subtest vcs1: SUCCESS (0.041s)
[447.330955] Starting dynamic subtest: vecs0
[447.357062] Dynamic subtest vecs0: SUCCESS (0.035s)
[447.366697] Starting dynamic subtest: ccs0
[447.390264] Dynamic subtest ccs0: SUCCESS (0.032s)
[447.392233] Subtest u-submit-early-slice: SUCCESS (0.229s)
[449.227442] [090/133] (574s left) kms_sequence (get-busy)
[449.317109] Starting subtest: get-busy
[449.319299] Starting dynamic subtest: pipe-A-eDP-1
[451.251918] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[451.263025] Starting dynamic subtest: pipe-B-eDP-1
[453.840086] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.587s)
[453.850831] Starting dynamic subtest: pipe-C-eDP-1
[456.451767] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[456.461499] Starting dynamic subtest: pipe-D-eDP-1
[459.012683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[459.014949] Subtest get-busy: SUCCESS (9.694s)
[459.889812] [091/133] (564s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[459.998100] Starting subtest: plane-ctm3x4-lut1d
[460.144788] Starting dynamic subtest: pipe-A-plane-0
[460.496546] Dynamic subtest pipe-A-plane-0: FAIL (0.182s)
[460.508123] Starting dynamic subtest: pipe-A-plane-1
[460.715846] Dynamic subtest pipe-A-plane-1: FAIL (0.170s)
[460.726126] Starting dynamic subtest: pipe-A-plane-2
[460.947001] Dynamic subtest pipe-A-plane-2: FAIL (0.187s)
[461.887928] Starting dynamic subtest: pipe-B-plane-0
[462.314522] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[462.326215] Starting dynamic subtest: pipe-B-plane-1
[462.630213] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[462.642161] Starting dynamic subtest: pipe-B-plane-2
[462.937707] Dynamic subtest pipe-B-plane-2: FAIL (0.187s)
[463.630342] Starting dynamic subtest: pipe-C-plane-0
[464.124073] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[464.134498] Starting dynamic subtest: pipe-C-plane-1
[464.525768] Dynamic subtest pipe-C-plane-1: FAIL (0.154s)
[464.536833] Starting dynamic subtest: pipe-C-plane-2
[464.918865] Dynamic subtest pipe-C-plane-2: FAIL (0.174s)
[465.746248] Starting dynamic subtest: pipe-D-plane-0
[466.345983] Dynamic subtest pipe-D-plane-0: FAIL (0.153s)
[466.356352] Starting dynamic subtest: pipe-D-plane-1
[466.799971] Dynamic subtest pipe-D-plane-1: FAIL (0.622s)
[466.810718] Starting dynamic subtest: pipe-D-plane-2
[467.246934] Dynamic subtest pipe-D-plane-2: FAIL (0.555s)
[467.375012] Subtest plane-ctm3x4-lut1d: FAIL (7.373s)
[468.212671] [092/133] (555s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[468.336157] Starting subtest: cursor-vs-flip-varying-size
[499.280733] Subtest cursor-vs-flip-varying-size: SUCCESS (30.949s)
[500.149143] [093/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[500.250208] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[506.985953] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.740s)
[507.120672] [094/133] (516s left) gem_exec_flush (basic-wb-set-default)
[507.186948] Starting subtest: basic-wb-set-default
[512.648916] Subtest basic-wb-set-default: SUCCESS (5.462s)
[512.835883] [095/133] (511s left) kms_hdr (bpc-switch)
[512.940220] Starting subtest: bpc-switch
[513.973005] Starting dynamic subtest: pipe-A-eDP-1
[517.477972] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[517.480257] Subtest bpc-switch: SUCCESS (4.540s)
[517.573967] [096/133] (506s left) gem_ctx_persistence (heartbeat-hostile)
[517.628761] Starting subtest: heartbeat-hostile
[517.633587] Subtest heartbeat-hostile: SKIP (0.000s)
[517.728671] [097/133] (506s left) kms_cursor_crc (cursor-onscreen-32x10)
[517.903429] Starting subtest: cursor-onscreen-32x10
[517.956389] Subtest cursor-onscreen-32x10: SKIP (0.047s)
[518.236290] [098/133] (506s left) gem_mmap_wc (close)
[518.286728] Subtest close: SKIP (0.000s)
[518.353406] [099/133] (505s left) gem_mmap_offset (clear)
[518.402345] Starting subtest: clear
[518.404880] Starting dynamic subtest: smem0
[543.810084] Dynamic subtest smem0: SUCCESS (25.402s)
[543.812377] Subtest clear: SUCCESS (25.403s)
[543.922768] [100/133] (480s left) syncobj_wait (reset-signaled)
[544.028449] Starting subtest: reset-signaled
[544.030788] Subtest reset-signaled: SUCCESS (0.000s)
[544.115323] [101/133] (480s left) sysfs_preempt_timeout (timeout)
[544.168801] Starting subtest: timeout
[544.171092] Starting dynamic subtest: vecs0
[554.166195] Dynamic subtest vecs0: SUCCESS (9.992s)
[554.177872] Starting dynamic subtest: ccs0
[555.506806] Dynamic subtest ccs0: SUCCESS (1.340s)
[555.518469] Starting dynamic subtest: vcs0
[565.175937] Dynamic subtest vcs0: SUCCESS (9.664s)
[565.188464] Starting dynamic subtest: bcs0
[566.462250] Dynamic subtest bcs0: SUCCESS (1.285s)
[566.473497] Starting dynamic subtest: rcs0
[567.714403] Dynamic subtest rcs0: SUCCESS (1.249s)
[567.726430] Starting dynamic subtest: vcs1
[577.141211] Dynamic subtest vcs1: SUCCESS (9.424s)
[577.143704] Subtest timeout: SUCCESS (32.966s)
[577.219043] [102/133] (447s left) perf (polling)
[577.365026] Starting subtest: polling
[577.367422] Starting dynamic subtest: 0-rcs0
[587.386467] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[587.397100] Starting dynamic subtest: 1-vecs0
[597.411531] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[597.414240] Subtest polling: SUCCESS (20.043s)
[597.461559] [103/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[597.578419] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[597.582497] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[597.671313] [104/133] (426s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[597.766130] Starting subtest: fbcpsr-rgb565-draw-render
[604.864916] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.100s)
[605.028346] [105/133] (419s left) kms_debugfs (display-on-read-all)
[605.123226] Starting subtest: display-on-read-all
[605.317236] Subtest display-on-read-all: SUCCESS (0.195s)
[605.428868] [106/133] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[605.525345] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[605.529631] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[605.626100] [107/133] (419s left) kms_vrr (seamless-rr-switch-vrr)
[605.718214] Starting subtest: seamless-rr-switch-vrr
[605.724350] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[605.792154] [108/133] (418s left) gem_eio (wait-1us)
[605.997280] Starting subtest: wait-1us
[606.311901] Subtest wait-1us: SUCCESS (0.314s)
[606.465317] [109/133] (418s left) kms_chamelium_hpd (vga-hpd-fast)
[606.849422] Subtest vga-hpd-fast: SKIP (0.000s)
[607.654533] [110/133] (417s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[607.761739] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[607.765764] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[607.871062] [111/133] (416s left) gem_ctx_param (invalid-param-get)
[607.917076] Starting subtest: invalid-param-get
[607.919435] Subtest invalid-param-get: SUCCESS (0.001s)
[608.013510] [112/133] (416s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[608.123620] Starting subtest: short-flip-before-cursor-toggle
[609.039284] Subtest short-flip-before-cursor-toggle: SUCCESS (0.914s)
[609.900592] [113/133] (415s left) gem_exec_schedule (preemptive-hang)
[610.089648] Starting subtest: preemptive-hang
[610.092216] Starting dynamic subtest: rcs0
[619.301802] Dynamic subtest rcs0: SUCCESS (9.213s)
[619.314522] Starting dynamic subtest: bcs0
[628.325568] Dynamic subtest bcs0: SUCCESS (9.018s)
[628.337930] Starting dynamic subtest: vcs0
[637.347547] Dynamic subtest vcs0: SUCCESS (9.020s)
[637.358890] Starting dynamic subtest: vcs1
[646.310056] Dynamic subtest vcs1: SUCCESS (8.958s)
[646.322891] Starting dynamic subtest: vecs0
[655.264605] Dynamic subtest vecs0: SUCCESS (8.949s)
[655.276978] Starting dynamic subtest: ccs0
[664.298366] Dynamic subtest ccs0: SUCCESS (9.029s)
[664.300567] Subtest preemptive-hang: SUCCESS (54.199s)
[664.558579] [114/133] (360s left) kms_async_flips (async-flip-dpms)
[664.653970] Starting subtest: async-flip-dpms
[665.036908] Starting dynamic subtest: pipe-A-eDP-1
[668.936047] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.897s)
[669.318183] Starting dynamic subtest: pipe-B-eDP-1
[672.109294] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.797s)
[672.498375] Starting dynamic subtest: pipe-C-eDP-1
[675.270503] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[675.661303] Starting dynamic subtest: pipe-D-eDP-1
[678.445032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[678.447352] Subtest async-flip-dpms: SUCCESS (13.790s)
[679.639788] [115/133] (345s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[679.734068] Starting subtest: coverage-vs-premult-vs-constant
[680.011902] Starting dynamic subtest: pipe-A-eDP-1
[680.640665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[680.657954] Starting dynamic subtest: pipe-D-eDP-1
[681.963386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[681.965754] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.229s)
[682.822411] [116/133] (342s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[682.916018] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[682.918374] Starting dynamic subtest: pipe-A-eDP-1
[682.940768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[682.953471] Starting dynamic subtest: pipe-B-eDP-1
[682.975035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[682.984375] Starting dynamic subtest: pipe-C-eDP-1
[683.005467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[683.014597] Starting dynamic subtest: pipe-D-eDP-1
[683.037096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[683.041423] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[685.174780] [117/133] (339s left) kms_chamelium_edid (hdmi-edid-read)
[685.552268] Subtest hdmi-edid-read: SKIP (0.000s)
[686.386145] [118/133] (338s left) api_intel_bb (object-noreloc-keep-cache-simple)
[686.449059] Starting subtest: object-noreloc-keep-cache-simple
[686.452380] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[686.565354] [119/133] (338s left) kms_psr (fbc-pr-suspend)
[686.664216] Starting subtest: fbc-pr-suspend
[686.668433] Subtest fbc-pr-suspend: SKIP (0.000s)
[686.737709] [120/133] (338s left) gem_exec_params (invalid-bsd-ring)
[686.796713] Starting subtest: invalid-bsd-ring
[686.799201] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[686.919508] [121/133] (338s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[687.000220] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[687.004640] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[687.081477] [122/133] (338s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[687.178980] Starting subtest: bad-pixel-format-yf-tiled-ccs
[687.181417] Starting dynamic subtest: pipe-A-eDP-1
[687.204729] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[687.217045] Starting dynamic subtest: pipe-B-eDP-1
[687.238604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[687.247810] Starting dynamic subtest: pipe-C-eDP-1
[687.269570] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[687.278910] Starting dynamic subtest: pipe-D-eDP-1
[687.301026] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[687.305427] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[689.463937] [123/133] (335s left) gen7_exec_parse (basic-allowed)
[689.529591] Subtest basic-allowed: SKIP (0.000s)
[689.601212] [124/133] (335s left) gem_exec_whisper (basic-fds)
[689.673104] Starting subtest: basic-fds
[696.063144] Subtest basic-fds: SUCCESS (6.388s)
[696.255904] [125/133] (329s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[696.358693] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[703.849768] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.491s)
[703.990400] [126/133] (321s left) kms_flip (flip-vs-expired-vblank)
[704.085327] Starting subtest: flip-vs-expired-vblank
[704.087277] Starting dynamic subtest: A-eDP1
[712.788022] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[712.802341] Starting dynamic subtest: B-eDP1
[721.424662] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[721.435286] Starting dynamic subtest: C-eDP1
[730.053448] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[730.063584] Starting dynamic subtest: D-eDP1
[738.682535] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[738.687949] Subtest flip-vs-expired-vblank: SUCCESS (34.612s)
[739.860033] [127/133] (285s left) kms_lease (setcrtc-implicit-plane)
[739.955996] Starting subtest: setcrtc-implicit-plane
[739.958287] Starting dynamic subtest: pipe-A-eDP-1
[740.427068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[740.438241] Starting dynamic subtest: pipe-B-eDP-1
[741.585517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[741.596728] Starting dynamic subtest: pipe-C-eDP-1
[742.708153] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[742.718704] Starting dynamic subtest: pipe-D-eDP-1
[743.843991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[743.846251] Subtest setcrtc-implicit-plane: SUCCESS (3.889s)
[744.691743] [128/133] (280s left) kms_psr (psr-cursor-plane-onoff)
[744.793879] Starting subtest: psr-cursor-plane-onoff
[744.796029] Starting dynamic subtest: eDP-1
[746.476979] Dynamic subtest eDP-1: SUCCESS (1.683s)
[746.479285] Subtest psr-cursor-plane-onoff: SUCCESS (1.684s)
[747.349315] [129/133] (278s left) gem_mmap_gtt (big-copy)
[747.409887] Subtest big-copy: SKIP (0.000s)
[747.468442] [130/133] (278s left) kms_atomic (plane-primary-legacy)
[747.560464] Starting subtest: plane-primary-legacy
[747.562751] Starting dynamic subtest: pipe-A-eDP-1
[748.003844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[748.005980] Subtest plane-primary-legacy: SUCCESS (0.443s)
[748.866131] [131/133] (276s left) gem_exec_async (forked-writes)
[748.927524] Starting subtest: forked-writes
[748.929851] Starting dynamic subtest: rcs0
[748.954824] Dynamic subtest rcs0: SUCCESS (0.027s)
[748.968929] Starting dynamic subtest: bcs0
[748.979832] Dynamic subtest bcs0: SUCCESS (0.023s)
[748.990352] Starting dynamic subtest: vcs0
[749.002262] Dynamic subtest vcs0: SUCCESS (0.022s)
[749.012855] Starting dynamic subtest: vcs1
[749.026941] Dynamic subtest vcs1: SUCCESS (0.024s)
[749.037394] Starting dynamic subtest: vecs0
[749.052025] Dynamic subtest vecs0: SUCCESS (0.024s)
[749.062726] Starting dynamic subtest: ccs0
[749.075046] Dynamic subtest ccs0: SUCCESS (0.022s)
[749.077356] Subtest forked-writes: SUCCESS (0.149s)
[749.303945] [132/133] (276s left) syncobj_wait (invalid-reset-bad-pad)
[749.372912] Starting subtest: invalid-reset-bad-pad
[749.375337] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[749.478769] [133/133] (276s left) perf_pmu (most-busy-idle-check-all)
[749.524137] Starting subtest: most-busy-idle-check-all
[749.526329] Starting dynamic subtest: rcs0
[751.164526] Dynamic subtest rcs0: SUCCESS (1.641s)
[751.177954] Starting dynamic subtest: bcs0
[753.149205] Dynamic subtest bcs0: SUCCESS (1.983s)
[753.162485] Starting dynamic subtest: vcs0
[755.132534] Dynamic subtest vcs0: SUCCESS (1.982s)
[755.145307] Starting dynamic subtest: vcs1
[757.117279] Dynamic subtest vcs1: SUCCESS (1.982s)
[757.130698] Starting dynamic subtest: vecs0
[759.165092] Dynamic subtest vecs0: SUCCESS (2.046s)
[759.177461] Starting dynamic subtest: ccs0
[761.149146] Dynamic subtest ccs0: SUCCESS (1.982s)
[761.151876] Subtest most-busy-idle-check-all: SUCCESS (11.632s)
[761.246480] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_feature_discovery
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gen7_exec_parse
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_plane_multiple
results: parsing output: 12/ for test: gem_caching
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sriov_basic
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: syncobj_eventfd
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: i915_fb_tiling
results: parsing output: 31/ for test: gem_exec_endless
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: device_reset
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: gem_exec_suspend
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_ppgtt
results: parsing output: 52/ for test: prime_vgem
results: parsing output: 53/ for test: gem_cs_tlb
results: parsing output: 54/ for test: gem_ppgtt
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: i915_pm_rpm
results: parsing output: 60/ for test: gem_sync
results: parsing output: 61/ for test: gem_busy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: kms_cdclk
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: gem_exercise_blt
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: kms_tv_load_detect
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_joiner
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_render_copy_redux
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: kms_color_pipeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: sysfs_preempt_timeout
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_debugfs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_vrr
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_plane_alpha_blend
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: gem_exec_async
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: perf_pmu
Done.