[58.924729] Initializing watchdogs
[58.924779]   /dev/watchdog0
[58.939186] [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.943595] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.945868] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.947789] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[59.052076] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[59.053892] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[59.150204] [002/133] (960s left) kms_psr (pr-sprite-blt)
[59.230835] Starting subtest: pr-sprite-blt
[59.232912] Subtest pr-sprite-blt: SKIP (0.000s)
[59.301011] [003/133] (960s left) kms_feature_discovery (psr2)
[59.392206] Starting subtest: psr2
[59.393084] Subtest psr2: SUCCESS (0.000s)
[59.454046] [004/133] (960s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[59.541603] Starting subtest: pr-cursor-plane-update-sf
[59.543339] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[59.610897] [005/133] (959s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[59.696733] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[59.697695] Starting dynamic subtest: pipe-A-eDP-1
[71.846479] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.152s)
[71.853205] Starting dynamic subtest: pipe-B-eDP-1
[83.421613] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.584s)
[83.422668] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.740s)
[84.273088] [006/133] (935s left) i915_query (hwconfig_table)
[84.317246] Starting subtest: hwconfig_table
[84.424206] Subtest hwconfig_table: SUCCESS (0.003s)
[84.449047] [007/133] (935s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[84.541374] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[84.569344] Starting dynamic subtest: pipe-A-plane-0
[84.991758] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[84.998844] Starting dynamic subtest: pipe-A-plane-3
[85.258251] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[86.353031] Starting dynamic subtest: pipe-B-plane-0
[86.780045] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[86.786911] Starting dynamic subtest: pipe-B-plane-3
[87.035414] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[87.348821] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.809s)
[88.146047] [008/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[88.247668] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[88.249517] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[88.337358] [009/133] (931s left) gen7_exec_parse (batch-without-end)
[88.392987] Subtest batch-without-end: SKIP (0.000s)
[88.444415] [010/133] (931s left) kms_flip (basic-plain-flip)
[88.527179] Starting subtest: basic-plain-flip
[88.528395] Starting dynamic subtest: A-eDP1
[90.262526] Dynamic subtest A-eDP1: SUCCESS (1.735s)
[90.269262] Starting dynamic subtest: B-eDP1
[91.999759] Dynamic subtest B-eDP1: SUCCESS (1.736s)
[92.008879] Starting dynamic subtest: C-eDP1
[93.703375] Dynamic subtest C-eDP1: SUCCESS (1.701s)
[93.711727] Starting dynamic subtest: D-eDP1
[95.432397] Dynamic subtest D-eDP1: SUCCESS (1.728s)
[95.433476] Subtest basic-plain-flip: SUCCESS (6.908s)
[96.591624] [011/133] (923s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[96.712382] Starting subtest: cursorB-vs-flipB-varying-size
[96.714143] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[96.848260] [012/133] (922s left) kms_plane_multiple (tiling-y)
[96.940888] Starting subtest: tiling-y
[96.942548] Subtest tiling-y: SKIP (0.000s)
[97.008360] [013/133] (922s left) gem_caching (read-writes)
[97.076898] Subtest read-writes: SKIP (0.000s)
[97.153821] [014/133] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[97.233775] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[103.952037] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.717s)
[104.073748] [015/133] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[104.165967] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[104.167728] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[104.258477] [016/133] (915s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[104.357388] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[104.359214] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[104.472674] [017/133] (915s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.557024] Starting subtest: primary-4-tiled-reflect-x-180
[111.683560] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.128s)
[112.893825] [018/133] (907s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[112.978255] Starting subtest: fbc-psr-cursor-mmap-cpu
[112.979350] Starting dynamic subtest: eDP-1
[112.981183] Dynamic subtest eDP-1: SKIP (0.000s)
[112.982925] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[113.067664] [019/133] (907s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[113.112560] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[113.113543] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[113.202646] [020/133] (906s left) kms_pm_rpm (dpms-non-lpsp)
[115.036198] Starting subtest: dpms-non-lpsp
[115.038269] Subtest dpms-non-lpsp: SKIP (0.001s)
[115.427892] [021/133] (904s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[115.517300] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[122.977626] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.460s)
[124.119436] [022/133] (896s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[124.208238] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[124.209129] Starting dynamic subtest: pipe-A-eDP-1
[124.230790] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[124.237190] Starting dynamic subtest: pipe-B-eDP-1
[124.258270] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[124.264112] Starting dynamic subtest: pipe-C-eDP-1
[124.284060] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[124.289769] Starting dynamic subtest: pipe-D-eDP-1
[124.309783] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[124.311351] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[126.371470] [023/133] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[126.478338] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[126.480259] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[126.555741] [024/133] (893s left) sriov_basic (bind-unbind-vf)
[126.600228] Starting subtest: bind-unbind-vf
[126.601276] Starting dynamic subtest: vf-1
[126.629680] Dynamic subtest vf-1: FAIL (0.009s)
[126.639919] Starting dynamic subtest: vf-2
[126.670385] Dynamic subtest vf-2: FAIL (0.004s)
[126.678391] Starting dynamic subtest: vf-3
[126.705610] Dynamic subtest vf-3: FAIL (0.003s)
[126.711534] Starting dynamic subtest: vf-4
[126.737669] Dynamic subtest vf-4: FAIL (0.003s)
[126.743655] Starting dynamic subtest: vf-5
[126.768968] Dynamic subtest vf-5: FAIL (0.003s)
[126.774914] Starting dynamic subtest: vf-6
[126.799924] Dynamic subtest vf-6: FAIL (0.004s)
[126.805425] Starting dynamic subtest: vf-7
[126.830618] Dynamic subtest vf-7: FAIL (0.004s)
[126.836111] Starting dynamic subtest: vf-random
[126.861176] Dynamic subtest vf-random: FAIL (0.003s)
[126.866650] Starting dynamic subtest: vf-last
[126.891691] Dynamic subtest vf-last: FAIL (0.003s)
[126.892483] Subtest bind-unbind-vf: FAIL (0.041s)
[126.917492] [025/133] (893s left) kms_properties (connector-properties-atomic)
[127.014821] Starting subtest: connector-properties-atomic
[127.015720] Starting dynamic subtest: pipe-A-eDP-1
[135.090038] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.073s)
[135.096468] Starting dynamic subtest: pipe-None-DP-1
[135.098258] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[135.103795] Starting dynamic subtest: pipe-None-HDMI-A-1
[135.105468] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[135.111074] Starting dynamic subtest: pipe-None-DP-2
[135.112762] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[135.118580] Starting dynamic subtest: pipe-None-HDMI-A-2
[135.120444] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[135.126240] Starting dynamic subtest: pipe-None-DP-3
[135.127844] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[135.133659] Starting dynamic subtest: pipe-None-DP-4
[135.135381] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[135.136415] Subtest connector-properties-atomic: SUCCESS (8.083s)
[135.942824] [026/133] (884s left) syncobj_eventfd (invalid-bad-pad)
[135.991082] Starting subtest: invalid-bad-pad
[135.992017] Subtest invalid-bad-pad: SUCCESS (0.000s)
[136.073088] [027/133] (884s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[136.124951] Starting subtest: single-wait-all-for-submit-available-signaled
[136.125930] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[136.216745] [028/133] (884s left) gem_exec_fence (syncobj-timeline-wait)
[136.803493] Starting subtest: syncobj-timeline-wait
[137.907580] Subtest syncobj-timeline-wait: SUCCESS (1.104s)
[138.113075] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[138.114975] [029/133] (882s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[138.211263] Starting subtest: plane-upscale-factor-0-25-with-rotation
[138.212166] Starting dynamic subtest: pipe-A
[138.437765] Dynamic subtest pipe-A: SUCCESS (0.227s)
[138.444690] Starting dynamic subtest: pipe-B
[139.732973] Dynamic subtest pipe-B: SUCCESS (1.294s)
[139.740289] Starting dynamic subtest: pipe-C
[141.066369] Dynamic subtest pipe-C: SUCCESS (1.333s)
[141.073635] Starting dynamic subtest: pipe-D
[142.407465] Dynamic subtest pipe-D: SUCCESS (1.340s)
[142.408374] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.197s)
[143.570315] [030/133] (876s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[143.666911] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[144.719457] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.046s)
[144.819516] [031/133] (875s left) i915_fb_tiling (basic-x-tiling)
[144.873757] Subtest basic-x-tiling: SKIP (0.000s)
[144.928682] [032/133] (875s left) gem_exec_endless (dispatch)
[144.998810] Starting subtest: dispatch
[144.999844] Starting dynamic subtest: rcs0
[145.004366] Dynamic subtest rcs0: SUCCESS (0.005s)
[145.014673] Starting dynamic subtest: bcs0
[145.016644] Dynamic subtest bcs0: SUCCESS (0.004s)
[145.022801] Starting dynamic subtest: vcs0
[145.024832] Dynamic subtest vcs0: SUCCESS (0.005s)
[145.032533] Starting dynamic subtest: vcs1
[145.034333] Dynamic subtest vcs1: SUCCESS (0.004s)
[145.040448] Starting dynamic subtest: vecs0
[145.042269] Dynamic subtest vecs0: SUCCESS (0.005s)
[145.048179] Starting dynamic subtest: ccs0
[145.049848] Dynamic subtest ccs0: SUCCESS (0.004s)
[145.050706] Subtest dispatch: SUCCESS (0.030s)
[146.947675] [033/133] (873s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[147.044991] Starting subtest: yf-tiled-16bpp-rotate-90
[147.046990] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[147.147790] [034/133] (873s left) gem_mmap_gtt (basic-short)
[147.197651] Subtest basic-short: SKIP (0.000s)
[147.249409] [035/133] (873s left) i915_drm_fdinfo (busy-hang)
[147.292218] Starting subtest: busy-hang
[147.293161] Starting dynamic subtest: rcs0
[147.324230] Dynamic subtest rcs0: SKIP (0.031s)
[147.331140] Starting dynamic subtest: bcs0
[147.332726] Dynamic subtest bcs0: SKIP (0.001s)
[147.338602] Starting dynamic subtest: vcs0
[147.340249] Dynamic subtest vcs0: SKIP (0.000s)
[147.345993] Starting dynamic subtest: vcs1
[147.347722] Dynamic subtest vcs1: SKIP (0.000s)
[147.353546] Starting dynamic subtest: vecs0
[147.355059] Dynamic subtest vecs0: SKIP (0.000s)
[147.360738] Starting dynamic subtest: ccs0
[147.362400] Dynamic subtest ccs0: SKIP (0.000s)
[147.364104] Subtest busy-hang: SKIP (0.038s)
[147.414293] [036/133] (873s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[147.472379] Starting subtest: x-tiled-to-vebox-y-tiled
[147.474130] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[147.659660] [037/133] (872s left) device_reset (unbind-cold-reset-rebind)
[147.707852] Starting subtest: unbind-cold-reset-rebind
[147.709654] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[147.781798] [038/133] (872s left) kms_big_fb (linear-32bpp-rotate-0)
[147.888206] Starting subtest: linear-32bpp-rotate-0
[149.367611] Subtest linear-32bpp-rotate-0: SUCCESS (1.480s)
[149.485927] [039/133] (871s left) gem_pxp (fail-invalid-protected-context)
[149.604042] Starting subtest: fail-invalid-protected-context
[149.605336] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[149.715646] [040/133] (871s left) gem_exec_suspend (basic)
[149.771216] Starting subtest: basic
[149.772101] Starting dynamic subtest: smem
[150.942428] Dynamic subtest smem: SUCCESS (1.163s)
[150.943569] Subtest basic: SUCCESS (1.164s)
[151.111482] [041/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[151.207736] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[151.209341] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.299663] [042/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[151.382008] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[151.383638] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[151.466249] [043/133] (869s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[151.579268] Starting subtest: flip-vs-cursor-crc-legacy
[152.262209] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.680s)
[153.096518] [044/133] (867s left) syncobj_timeline (invalid-query-bad-pad)
[153.168823] Starting subtest: invalid-query-bad-pad
[153.169637] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[153.259595] [045/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[153.342899] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[153.344541] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[153.433794] [046/133] (867s left) gem_exec_balancer (individual)
[153.497720] Starting subtest: individual
[154.908957] Subtest individual: SUCCESS (1.401s)
[155.228551] [047/133] (865s left) kms_cursor_crc (cursor-size-change)
[155.309278] Starting subtest: cursor-size-change
[155.310142] Starting dynamic subtest: pipe-A-eDP-1
[156.108520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[156.115421] Starting dynamic subtest: pipe-D-eDP-1
[157.589568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s)
[157.590446] Subtest cursor-size-change: SUCCESS (2.281s)
[158.464737] [048/133] (862s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[158.558956] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[158.560547] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[158.630360] [049/133] (862s left) kms_plane (plane-panning-top-left)
[158.708575] Starting subtest: plane-panning-top-left
[158.709498] Starting dynamic subtest: pipe-A
[160.443341] Dynamic subtest pipe-A: SUCCESS (1.734s)
[160.450407] Starting dynamic subtest: pipe-B
[162.849836] Dynamic subtest pipe-B: SUCCESS (2.406s)
[162.850747] Subtest plane-panning-top-left: SUCCESS (4.143s)
[163.712925] [050/133] (857s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[163.763920] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[163.816487] [051/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[163.859695] Starting subtest: multi-wait-for-submit-available-submitted
[163.860563] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[163.943261] [052/133] (857s left) gem_ppgtt (blt-vs-render-ctxn)
[163.995794] Starting subtest: blt-vs-render-ctxN
[197.013111] Subtest blt-vs-render-ctxN: SUCCESS (33.007s)
[197.119301] [053/133] (824s left) prime_vgem (fence-write-hang)
[197.221878] Subtest fence-write-hang: SKIP (0.000s)
[197.313438] [054/133] (823s left) gem_cs_tlb (engines)
[197.361916] Starting subtest: engines
[197.362759] Starting dynamic subtest: rcs0
[199.559840] Dynamic subtest rcs0: SUCCESS (2.152s)
[199.568563] Starting dynamic subtest: bcs0
[201.677369] Dynamic subtest bcs0: SUCCESS (2.153s)
[201.684913] Starting dynamic subtest: vcs0
[203.866626] Dynamic subtest vcs0: SUCCESS (2.151s)
[203.875078] Starting dynamic subtest: vcs1
[205.982672] Dynamic subtest vcs1: SUCCESS (2.152s)
[205.990173] Starting dynamic subtest: vecs0
[208.172994] Dynamic subtest vecs0: SUCCESS (2.152s)
[208.180872] Starting dynamic subtest: ccs0
[210.290534] Dynamic subtest ccs0: SUCCESS (2.154s)
[210.291399] Subtest engines: SUCCESS (12.920s)
[210.397199] [055/133] (810s left) gem_ppgtt (flink-and-close-vma-leak)
[210.463354] Starting subtest: flink-and-close-vma-leak
[210.509811] Subtest flink-and-close-vma-leak: SUCCESS (0.046s)
[210.639305] [056/133] (810s left) prime_mmap (test_correct_cpu_write)
[210.697273] Starting subtest: test_correct_cpu_write
[210.698634] Starting dynamic subtest: test_correct_cpu_write-smem
[210.699714] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[210.700669] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[210.792419] [057/133] (810s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[210.899899] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[210.901708] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[210.985592] [058/133] (810s left) gem_softpin (evict-active)
[211.050701] Starting subtest: evict-active
[211.056371] Subtest evict-active: SUCCESS (0.006s)
[211.174710] [059/133] (810s left) kms_content_protection (uevent)
[211.319935] Starting subtest: uevent
[211.321855] Subtest uevent: SKIP (0.000s)
[211.438742] [060/133] (809s left) i915_pm_rpm (system-suspend-execbuf)
[213.094046] Starting subtest: system-suspend-execbuf
[271.133915] Subtest system-suspend-execbuf: SUCCESS (43.063s)
[271.504437] [061/133] (749s left) gem_sync (basic-store-each)
[271.560478] Starting subtest: basic-store-each
[273.961547] Subtest basic-store-each: SUCCESS (2.402s)
[274.154528] [062/133] (747s left) gem_busy (busy)
[274.219166] Starting subtest: busy
[274.220263] Starting dynamic subtest: all-engines
[274.281942] Dynamic subtest all-engines: SUCCESS (0.062s)
[274.295921] Starting dynamic subtest: rcs0
[275.944880] Dynamic subtest rcs0: SUCCESS (1.659s)
[275.954749] Starting dynamic subtest: bcs0
[275.984034] Dynamic subtest bcs0: SUCCESS (0.041s)
[275.993587] Starting dynamic subtest: vcs0
[276.025788] Dynamic subtest vcs0: SUCCESS (0.039s)
[276.033661] Starting dynamic subtest: vcs1
[277.992263] Dynamic subtest vcs1: SUCCESS (1.956s)
[278.002288] Starting dynamic subtest: vecs0
[279.977901] Dynamic subtest vecs0: SUCCESS (1.986s)
[279.987513] Starting dynamic subtest: ccs0
[281.960374] Dynamic subtest ccs0: SUCCESS (1.982s)
[281.961297] Subtest busy: SUCCESS (7.737s)
[282.323670] [063/133] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[282.422825] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[282.424614] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[282.528401] [064/133] (739s left) kms_pm_rpm (package-g7)
[284.077973] Starting subtest: package-g7
[284.080697] Subtest package-g7: SKIP (0.000s)
[284.833973] [065/133] (736s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[284.924702] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[284.925659] Starting dynamic subtest: pipe-A-eDP-1
[285.809253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[285.817432] Starting dynamic subtest: pipe-B-eDP-1
[287.457637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s)
[287.465638] Starting dynamic subtest: pipe-C-eDP-1
[288.961726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[288.970274] Starting dynamic subtest: pipe-D-eDP-1
[290.559015] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.597s)
[290.560009] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.636s)
[291.746829] [066/133] (729s left) gem_workarounds (basic-read)
[291.823621] Starting subtest: basic-read
[291.834072] Subtest basic-read: SUCCESS (0.011s)
[291.963185] [067/133] (729s left) kms_vblank (ts-continuation-modeset-hang)
[292.066201] Starting subtest: ts-continuation-modeset-hang
[292.068188] Starting dynamic subtest: pipe-A-eDP-1
[318.684726] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.630s)
[318.694267] Starting dynamic subtest: pipe-D-eDP-1
[333.802077] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.114s)
[333.803039] Subtest ts-continuation-modeset-hang: SUCCESS (41.748s)
[334.671992] [068/133] (687s left) kms_cdclk (mode-transition-all-outputs)
[334.757539] Starting subtest: mode-transition-all-outputs
[335.047117] Subtest mode-transition-all-outputs: SKIP (0.288s)
[335.886255] [069/133] (685s left) gem_exec_reloc (basic-cpu-wc-active)
[335.949104] Subtest basic-cpu-wc-active: SKIP (0.000s)
[336.025057] [070/133] (685s left) gem_ctx_param (invalid-param-set)
[336.074021] Starting subtest: invalid-param-set
[336.074976] Subtest invalid-param-set: SUCCESS (0.000s)
[336.147912] [071/133] (685s left) gem_userptr_blits (input-checking)
[336.201023] Starting subtest: input-checking
[336.202029] Subtest input-checking: SUCCESS (0.000s)
[336.332631] [072/133] (685s left) gem_spin_batch (legacy)
[336.396484] Starting subtest: legacy
[336.397888] Starting dynamic subtest: default
[339.650595] Dynamic subtest default: SUCCESS (3.236s)
[339.660120] Starting dynamic subtest: render
[342.922064] Dynamic subtest render: SUCCESS (3.232s)
[342.937149] Starting dynamic subtest: bsd
[346.169635] Dynamic subtest bsd: SUCCESS (3.232s)
[346.182684] Starting dynamic subtest: bsd1
[349.408100] Dynamic subtest bsd1: SUCCESS (3.231s)
[349.426005] Starting dynamic subtest: bsd2
[352.651371] Dynamic subtest bsd2: SUCCESS (3.236s)
[352.661791] Starting dynamic subtest: blt
[355.893599] Dynamic subtest blt: SUCCESS (3.236s)
[355.904386] Starting dynamic subtest: vebox
[359.133712] Dynamic subtest vebox: SUCCESS (3.235s)
[359.135092] Subtest legacy: SUCCESS (22.658s)
[360.996105] [073/133] (660s left) gem_exercise_blt (fast-copy-emit)
[361.051914] Starting subtest: fast-copy-emit
[361.052867] Starting dynamic subtest: linear-smem-smem-emit
[361.081154] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.028s)
[361.091074] Starting dynamic subtest: xmajor-smem-smem-emit
[361.100279] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[361.108403] Starting dynamic subtest: tile4-smem-smem-emit
[361.119280] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[361.127407] Starting dynamic subtest: tile64-smem-smem-emit
[361.138837] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[361.139892] Subtest fast-copy-emit: SUCCESS (0.086s)
[361.263985] [074/133] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[361.377730] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[361.379416] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[361.466288] [075/133] (660s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[361.555481] Starting subtest: psr-rgb101010-draw-blt
[369.007743] Subtest psr-rgb101010-draw-blt: SUCCESS (7.449s)
[369.130745] [076/133] (652s left) kms_cursor_crc (cursor-sliding-32x10)
[369.289414] Starting subtest: cursor-sliding-32x10
[369.336138] Subtest cursor-sliding-32x10: SKIP (0.044s)
[369.600321] [077/133] (652s left) kms_cursor_crc (cursor-random-512x170)
[369.875641] Starting subtest: cursor-random-512x170
[369.877618] Subtest cursor-random-512x170: SKIP (0.001s)
[370.001107] [078/133] (652s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[370.082936] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[370.083804] Starting dynamic subtest: pipe-A-default-mode
[371.249881] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[371.251570] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.167s)
[371.397495] [079/133] (650s left) kms_properties (crtc-properties-legacy)
[371.485663] Starting subtest: crtc-properties-legacy
[371.486574] Starting dynamic subtest: pipe-A-eDP-1
[371.919244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[371.928889] Starting dynamic subtest: pipe-B-eDP-1
[373.076055] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[373.084031] Starting dynamic subtest: pipe-C-eDP-1
[374.186914] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[374.196445] Starting dynamic subtest: pipe-D-eDP-1
[375.325087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[375.325832] Subtest crtc-properties-legacy: SUCCESS (3.839s)
[376.129344] [080/133] (645s left) kms_tv_load_detect (load-detect)
[376.174302] Subtest load-detect: SKIP (0.000s)
[376.229335] [081/133] (645s left) gem_ctx_persistence (engines-hang)
[376.274243] Starting subtest: engines-hang
[376.275374] Starting dynamic subtest: rcs0
[376.389016] Dynamic subtest rcs0: SUCCESS (0.114s)
[376.401440] Starting dynamic subtest: bcs0
[376.481912] Dynamic subtest bcs0: SUCCESS (0.091s)
[376.493599] Starting dynamic subtest: vcs0
[376.577040] Dynamic subtest vcs0: SUCCESS (0.093s)
[376.593332] Starting dynamic subtest: vcs1
[376.669767] Dynamic subtest vcs1: SUCCESS (0.091s)
[376.682421] Starting dynamic subtest: vecs0
[376.756777] Dynamic subtest vecs0: SUCCESS (0.085s)
[376.768596] Starting dynamic subtest: ccs0
[376.849534] Dynamic subtest ccs0: SUCCESS (0.090s)
[376.852831] Subtest engines-hang: SUCCESS (0.576s)
[376.931249] [082/133] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[377.028552] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[384.192470] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.164s)
[384.287495] [083/133] (637s left) gem_exec_fence (syncobj-signal)
[384.730407] Starting subtest: syncobj-signal
[384.734955] Subtest syncobj-signal: SUCCESS (0.005s)
[386.026865] [084/133] (636s left) kms_joiner (invalid-modeset-force-big-joiner)
[386.113145] Starting subtest: invalid-modeset-force-big-joiner
[386.114863] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[386.181590] [085/133] (636s left) kms_getfb (getfb-handle-valid)
[386.273830] Starting subtest: getfb-handle-valid
[386.274744] Subtest getfb-handle-valid: SUCCESS (0.000s)
[386.362949] [086/133] (635s left) kms_busy (extended-modeset-hang-newfb)
[386.457613] Starting subtest: extended-modeset-hang-newfb
[386.458483] Starting dynamic subtest: pipe-A
[421.553127] Dynamic subtest pipe-A: SUCCESS (35.089s)
[421.563118] Starting dynamic subtest: pipe-D
[443.988021] Dynamic subtest pipe-D: SUCCESS (22.429s)
[443.988902] Subtest extended-modeset-hang-newfb: SUCCESS (57.522s)
[444.870092] [087/133] (577s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[444.932902] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[444.934765] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[445.126273] [088/133] (577s left) gem_render_copy_redux (flink-interruptible)
[445.192595] Starting subtest: flink-interruptible
[445.959040] Subtest flink-interruptible: SUCCESS (0.766s)
[446.042059] [089/133] (576s left) gem_exec_schedule (u-submit-early-slice)
[446.113323] Starting subtest: u-submit-early-slice
[446.114312] Starting dynamic subtest: rcs0
[446.157084] Dynamic subtest rcs0: SUCCESS (0.043s)
[446.168005] Starting dynamic subtest: bcs0
[446.191070] Dynamic subtest bcs0: SUCCESS (0.034s)
[446.199230] Starting dynamic subtest: vcs0
[446.229959] Dynamic subtest vcs0: SUCCESS (0.038s)
[446.238397] Starting dynamic subtest: vcs1
[446.267815] Dynamic subtest vcs1: SUCCESS (0.037s)
[446.278079] Starting dynamic subtest: vecs0
[446.302647] Dynamic subtest vecs0: SUCCESS (0.034s)
[446.316109] Starting dynamic subtest: ccs0
[446.340202] Dynamic subtest ccs0: SUCCESS (0.035s)
[446.341136] Subtest u-submit-early-slice: SUCCESS (0.227s)
[448.067918] [090/133] (574s left) kms_sequence (get-busy)
[448.157532] Starting subtest: get-busy
[448.158579] Starting dynamic subtest: pipe-A-eDP-1
[450.094235] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[450.102422] Starting dynamic subtest: pipe-B-eDP-1
[452.671254] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.575s)
[452.679482] Starting dynamic subtest: pipe-C-eDP-1
[455.271439] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[455.279491] Starting dynamic subtest: pipe-D-eDP-1
[457.895713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[457.896480] Subtest get-busy: SUCCESS (9.738s)
[458.684026] [091/133] (563s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[458.773602] Starting subtest: plane-ctm3x4-lut1d
[458.943034] Starting dynamic subtest: pipe-A-plane-0
[459.185500] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[459.193997] Starting dynamic subtest: pipe-A-plane-1
[459.389096] Dynamic subtest pipe-A-plane-1: FAIL (0.180s)
[459.398089] Starting dynamic subtest: pipe-A-plane-2
[459.570706] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[460.708345] Starting dynamic subtest: pipe-B-plane-0
[460.972425] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[460.980950] Starting dynamic subtest: pipe-B-plane-1
[461.156510] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[461.165299] Starting dynamic subtest: pipe-B-plane-2
[461.349650] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[462.424442] Starting dynamic subtest: pipe-C-plane-0
[462.703069] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[462.717083] Starting dynamic subtest: pipe-C-plane-1
[462.883790] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[462.894599] Starting dynamic subtest: pipe-C-plane-2
[463.060701] Dynamic subtest pipe-C-plane-2: FAIL (0.166s)
[464.066320] Starting dynamic subtest: pipe-D-plane-0
[464.394939] Dynamic subtest pipe-D-plane-0: FAIL (0.173s)
[464.403699] Starting dynamic subtest: pipe-D-plane-1
[464.579793] Dynamic subtest pipe-D-plane-1: FAIL (0.166s)
[464.590905] Starting dynamic subtest: pipe-D-plane-2
[464.791029] Dynamic subtest pipe-D-plane-2: FAIL (0.166s)
[464.858763] Subtest plane-ctm3x4-lut1d: FAIL (6.086s)
[465.702728] [092/133] (556s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[465.817474] Starting subtest: cursor-vs-flip-varying-size
[496.877201] Subtest cursor-vs-flip-varying-size: SUCCESS (31.058s)
[497.744887] [093/133] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[497.834723] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[504.592869] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.759s)
[504.745307] [094/133] (517s left) gem_exec_flush (basic-wb-set-default)
[504.799604] Starting subtest: basic-wb-set-default
[510.255892] Subtest basic-wb-set-default: SUCCESS (5.458s)
[510.440362] [095/133] (512s left) kms_hdr (bpc-switch)
[510.539494] Starting subtest: bpc-switch
[511.642345] Starting dynamic subtest: pipe-A-eDP-1
[515.037703] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.396s)
[515.038671] Subtest bpc-switch: SUCCESS (4.500s)
[515.134183] [096/133] (507s left) gem_ctx_persistence (heartbeat-hostile)
[515.182428] Starting subtest: heartbeat-hostile
[515.184272] Subtest heartbeat-hostile: SKIP (0.000s)
[515.272036] [097/133] (507s left) kms_cursor_crc (cursor-onscreen-32x10)
[515.435013] Starting subtest: cursor-onscreen-32x10
[515.484005] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[515.743231] [098/133] (507s left) gem_mmap_wc (close)
[515.789824] Subtest close: SKIP (0.000s)
[515.842782] [099/133] (506s left) gem_mmap_offset (clear)
[515.889894] Starting subtest: clear
[515.890957] Starting dynamic subtest: smem0
[541.169578] Dynamic subtest smem0: SUCCESS (25.267s)
[541.170378] Subtest clear: SUCCESS (25.269s)
[541.304584] [100/133] (481s left) syncobj_wait (reset-signaled)
[541.414586] Starting subtest: reset-signaled
[541.415507] Subtest reset-signaled: SUCCESS (0.000s)
[541.487648] [101/133] (481s left) sysfs_preempt_timeout (timeout)
[541.554195] Starting subtest: timeout
[541.555287] Starting dynamic subtest: vecs0
[550.941671] Dynamic subtest vecs0: SUCCESS (9.376s)
[550.952291] Starting dynamic subtest: ccs0
[552.219494] Dynamic subtest ccs0: SUCCESS (1.286s)
[552.228666] Starting dynamic subtest: vcs0
[561.945022] Dynamic subtest vcs0: SUCCESS (9.713s)
[561.955877] Starting dynamic subtest: bcs0
[563.179609] Dynamic subtest bcs0: SUCCESS (1.242s)
[563.190532] Starting dynamic subtest: rcs0
[564.431392] Dynamic subtest rcs0: SUCCESS (1.252s)
[564.441671] Starting dynamic subtest: vcs1
[573.979971] Dynamic subtest vcs1: SUCCESS (9.536s)
[573.981196] Subtest timeout: SUCCESS (32.415s)
[574.042254] [102/133] (448s left) perf (polling)
[574.174653] Starting subtest: polling
[574.175730] Starting dynamic subtest: 0-rcs0
[584.237934] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[584.248774] Starting dynamic subtest: 1-vcs0
[594.259154] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[594.260657] Subtest polling: SUCCESS (20.040s)
[594.294040] [103/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[594.416576] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[594.418327] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[594.524291] [104/133] (428s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[594.610990] Starting subtest: fbcpsr-rgb565-draw-render
[601.703582] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.093s)
[601.836645] [105/133] (421s left) kms_debugfs (display-on-read-all)
[601.932618] Starting subtest: display-on-read-all
[602.120296] Subtest display-on-read-all: SUCCESS (0.189s)
[602.253464] [106/133] (420s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[602.349914] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[602.351672] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[602.427819] [107/133] (420s left) kms_vrr (seamless-rr-switch-vrr)
[602.518723] Starting subtest: seamless-rr-switch-vrr
[602.521142] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[602.601234] [108/133] (420s left) gem_eio (wait-1us)
[602.813651] Starting subtest: wait-1us
[603.134312] Subtest wait-1us: SUCCESS (0.322s)
[603.267816] [109/133] (419s left) kms_chamelium_hpd (vga-hpd-fast)
[603.661220] Subtest vga-hpd-fast: SKIP (0.000s)
[604.434260] [110/133] (418s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[604.525391] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[604.527119] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[604.626714] [111/133] (418s left) gem_ctx_param (invalid-param-get)
[604.671550] Starting subtest: invalid-param-get
[604.672632] Subtest invalid-param-get: SUCCESS (0.001s)
[604.761222] [112/133] (418s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[604.872955] Starting subtest: short-flip-before-cursor-toggle
[605.789293] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[606.581894] [113/133] (416s left) gem_exec_schedule (preemptive-hang)
[606.750739] Starting subtest: preemptive-hang
[606.752405] Starting dynamic subtest: rcs0
[616.070593] Dynamic subtest rcs0: SUCCESS (9.318s)
[616.081941] Starting dynamic subtest: bcs0
[625.091402] Dynamic subtest bcs0: SUCCESS (9.021s)
[625.101827] Starting dynamic subtest: vcs0
[634.053504] Dynamic subtest vcs0: SUCCESS (8.960s)
[634.065736] Starting dynamic subtest: vcs1
[643.077885] Dynamic subtest vcs1: SUCCESS (9.022s)
[643.086493] Starting dynamic subtest: vecs0
[652.096132] Dynamic subtest vecs0: SUCCESS (9.017s)
[652.106575] Starting dynamic subtest: ccs0
[661.060422] Dynamic subtest ccs0: SUCCESS (8.961s)
[661.061480] Subtest preemptive-hang: SUCCESS (54.308s)
[661.306934] [114/133] (362s left) kms_async_flips (async-flip-dpms)
[661.404267] Starting subtest: async-flip-dpms
[661.781607] Starting dynamic subtest: pipe-A-eDP-1
[665.600327] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.819s)
[665.995057] Starting dynamic subtest: pipe-B-eDP-1
[668.770688] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.784s)
[669.161461] Starting dynamic subtest: pipe-C-eDP-1
[671.943868] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.790s)
[672.334033] Starting dynamic subtest: pipe-D-eDP-1
[675.106905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[675.107770] Subtest async-flip-dpms: SUCCESS (13.703s)
[676.307261] [115/133] (347s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[676.411438] Starting subtest: coverage-vs-premult-vs-constant
[676.694903] Starting dynamic subtest: pipe-A-eDP-1
[677.297891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[677.311240] Starting dynamic subtest: pipe-D-eDP-1
[678.612162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[678.613065] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.202s)
[679.455583] [116/133] (343s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[679.547821] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[679.548750] Starting dynamic subtest: pipe-A-eDP-1
[679.557074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[679.566918] Starting dynamic subtest: pipe-B-eDP-1
[679.574887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[679.584093] Starting dynamic subtest: pipe-C-eDP-1
[679.591945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[679.600121] Starting dynamic subtest: pipe-D-eDP-1
[679.610366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[679.612097] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[681.847772] [117/133] (341s left) kms_chamelium_edid (hdmi-edid-read)
[682.222675] Subtest hdmi-edid-read: SKIP (0.000s)
[683.051799] [118/133] (340s left) api_intel_bb (object-noreloc-keep-cache-simple)
[683.117713] Starting subtest: object-noreloc-keep-cache-simple
[683.128576] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.012s)
[683.248216] [119/133] (340s left) kms_psr (fbc-pr-suspend)
[683.335030] Starting subtest: fbc-pr-suspend
[683.336905] Subtest fbc-pr-suspend: SKIP (0.000s)
[683.402928] [120/133] (340s left) gem_exec_params (invalid-bsd-ring)
[683.446136] Starting subtest: invalid-bsd-ring
[683.447091] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[683.537498] [121/133] (340s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[683.622253] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[683.623725] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[683.690546] [122/133] (339s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[683.781586] Starting subtest: bad-pixel-format-yf-tiled-ccs
[683.782476] Starting dynamic subtest: pipe-A-eDP-1
[683.790697] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[683.799715] Starting dynamic subtest: pipe-B-eDP-1
[683.808061] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[683.816600] Starting dynamic subtest: pipe-C-eDP-1
[683.824831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[683.833532] Starting dynamic subtest: pipe-D-eDP-1
[683.841851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[683.843523] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[686.031140] [123/133] (337s left) gen7_exec_parse (basic-allowed)
[686.096594] Subtest basic-allowed: SKIP (0.000s)
[686.162049] [124/133] (337s left) gem_exec_whisper (basic-fds)
[686.213605] Starting subtest: basic-fds
[693.002526] Subtest basic-fds: SUCCESS (6.787s)
[693.181622] [125/133] (330s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[693.271352] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[700.757290] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.486s)
[700.883637] [126/133] (322s left) kms_flip (flip-vs-expired-vblank)
[700.969628] Starting subtest: flip-vs-expired-vblank
[700.972122] Starting dynamic subtest: A-eDP1
[709.686925] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[709.697920] Starting dynamic subtest: B-eDP1
[718.319082] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[718.330592] Starting dynamic subtest: C-eDP1
[726.944182] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[726.955508] Starting dynamic subtest: D-eDP1
[735.542689] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[735.543989] Subtest flip-vs-expired-vblank: SUCCESS (34.574s)
[736.709985] [127/133] (287s left) kms_lease (setcrtc-implicit-plane)
[736.795356] Starting subtest: setcrtc-implicit-plane
[736.796114] Starting dynamic subtest: pipe-A-eDP-1
[737.264437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[737.274508] Starting dynamic subtest: pipe-B-eDP-1
[738.420026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[738.428913] Starting dynamic subtest: pipe-C-eDP-1
[739.564094] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.144s)
[739.574373] Starting dynamic subtest: pipe-D-eDP-1
[740.695693] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[740.698120] Subtest setcrtc-implicit-plane: SUCCESS (3.902s)
[741.530319] [128/133] (282s left) kms_psr (psr-cursor-plane-onoff)
[741.617066] Starting subtest: psr-cursor-plane-onoff
[741.618115] Starting dynamic subtest: eDP-1
[743.321823] Dynamic subtest eDP-1: SUCCESS (1.705s)
[743.322649] Subtest psr-cursor-plane-onoff: SUCCESS (1.707s)
[744.183805] [129/133] (279s left) gem_mmap_gtt (big-copy)
[744.237295] Subtest big-copy: SKIP (0.000s)
[744.295491] [130/133] (279s left) kms_atomic (plane-primary-legacy)
[744.377695] Starting subtest: plane-primary-legacy
[744.378656] Starting dynamic subtest: pipe-A-eDP-1
[744.845242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[744.847478] Subtest plane-primary-legacy: SUCCESS (0.470s)
[745.717896] [131/133] (278s left) gem_exec_async (forked-writes)
[745.769732] Starting subtest: forked-writes
[745.770669] Starting dynamic subtest: rcs0
[745.800082] Dynamic subtest rcs0: SUCCESS (0.030s)
[745.811052] Starting dynamic subtest: bcs0
[745.822624] Dynamic subtest bcs0: SUCCESS (0.022s)
[745.836293] Starting dynamic subtest: vcs0
[745.845596] Dynamic subtest vcs0: SUCCESS (0.022s)
[745.854930] Starting dynamic subtest: vcs1
[745.869694] Dynamic subtest vcs1: SUCCESS (0.023s)
[745.878801] Starting dynamic subtest: vecs0
[745.892415] Dynamic subtest vecs0: SUCCESS (0.022s)
[745.902502] Starting dynamic subtest: ccs0
[745.915432] Dynamic subtest ccs0: SUCCESS (0.022s)
[745.916249] Subtest forked-writes: SUCCESS (0.146s)
[746.153385] [132/133] (277s left) syncobj_wait (invalid-reset-bad-pad)
[746.198390] Starting subtest: invalid-reset-bad-pad
[746.199384] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[746.289831] [133/133] (277s left) perf_pmu (most-busy-idle-check-all)
[746.321529] Starting subtest: most-busy-idle-check-all
[746.322438] Starting dynamic subtest: rcs0
[747.939362] Dynamic subtest rcs0: SUCCESS (1.610s)
[747.948284] Starting dynamic subtest: bcs0
[749.987782] Dynamic subtest bcs0: SUCCESS (2.047s)
[749.996391] Starting dynamic subtest: vcs0
[751.972517] Dynamic subtest vcs0: SUCCESS (1.981s)
[751.988354] Starting dynamic subtest: vcs1
[753.956380] Dynamic subtest vcs1: SUCCESS (1.981s)
[753.967275] Starting dynamic subtest: vecs0
[755.940613] Dynamic subtest vecs0: SUCCESS (1.980s)
[755.951707] Starting dynamic subtest: ccs0
[757.988598] Dynamic subtest ccs0: SUCCESS (2.045s)
[757.989938] Subtest most-busy-idle-check-all: SUCCESS (11.661s)
[758.061704] 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.