[59.125873] Initializing watchdogs
[59.125921]   /dev/watchdog0
[59.145882] [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.150388] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.152854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.154738] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[59.244832] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[59.246503] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[59.335149] [002/133] (960s left) kms_psr (pr-sprite-blt)
[59.427822] Starting subtest: pr-sprite-blt
[59.429714] Subtest pr-sprite-blt: SKIP (0.000s)
[59.501905] [003/133] (960s left) kms_feature_discovery (psr2)
[59.596234] Starting subtest: psr2
[59.597201] Subtest psr2: SUCCESS (0.000s)
[59.674133] [004/133] (960s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[59.758898] Starting subtest: pr-cursor-plane-update-sf
[59.760664] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[59.825735] [005/133] (959s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[59.908618] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[59.909678] Starting dynamic subtest: pipe-A-eDP-1
[71.279441] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.362s)
[71.285716] Starting dynamic subtest: pipe-B-eDP-1
[83.302089] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.017s)
[83.303068] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.381s)
[84.136953] [006/133] (935s left) i915_query (hwconfig_table)
[84.181088] Starting subtest: hwconfig_table
[84.289179] Subtest hwconfig_table: SUCCESS (0.001s)
[84.316963] [007/133] (935s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[84.413195] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[84.443361] Starting dynamic subtest: pipe-A-plane-0
[84.874774] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[84.881426] Starting dynamic subtest: pipe-A-plane-3
[85.141035] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[86.220693] Starting dynamic subtest: pipe-B-plane-0
[86.669868] Dynamic subtest pipe-B-plane-0: SUCCESS (0.456s)
[86.678119] Starting dynamic subtest: pipe-B-plane-3
[86.925777] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[87.234732] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.820s)
[88.097291] [008/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[88.189285] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[88.191052] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[88.286478] [009/133] (931s left) gen7_exec_parse (batch-without-end)
[88.343672] Subtest batch-without-end: SKIP (0.000s)
[88.391407] [010/133] (931s left) kms_flip (basic-plain-flip)
[88.475855] Starting subtest: basic-plain-flip
[88.477903] Starting dynamic subtest: A-eDP1
[90.216446] Dynamic subtest A-eDP1: SUCCESS (1.739s)
[90.224642] Starting dynamic subtest: B-eDP1
[91.849677] Dynamic subtest B-eDP1: SUCCESS (1.632s)
[91.862053] Starting dynamic subtest: C-eDP1
[93.567832] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[93.576059] Starting dynamic subtest: D-eDP1
[95.201047] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[95.201973] Subtest basic-plain-flip: SUCCESS (6.725s)
[96.364859] [011/133] (923s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[96.487418] Starting subtest: cursorB-vs-flipB-varying-size
[96.489223] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[96.625979] [012/133] (923s left) kms_plane_multiple (tiling-y)
[96.712387] Starting subtest: tiling-y
[96.714319] Subtest tiling-y: SKIP (0.000s)
[96.789401] [013/133] (923s left) gem_caching (read-writes)
[96.840137] Subtest read-writes: SKIP (0.000s)
[96.903869] [014/133] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[96.993876] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[103.708690] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.713s)
[103.851537] [015/133] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[103.947722] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[103.949530] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[104.055676] [016/133] (916s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[104.169692] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[104.171415] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[104.263161] [017/133] (915s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.352203] Starting subtest: primary-4-tiled-reflect-x-180
[111.446056] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.094s)
[112.663135] [018/133] (907s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[112.755151] Starting subtest: fbc-psr-cursor-mmap-cpu
[112.756029] Starting dynamic subtest: eDP-1
[112.757677] Dynamic subtest eDP-1: SKIP (0.000s)
[112.759426] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[112.821817] [019/133] (907s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[112.874162] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[112.875251] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[112.978921] [020/133] (907s left) kms_pm_rpm (dpms-non-lpsp)
[115.017716] Starting subtest: dpms-non-lpsp
[115.019765] Subtest dpms-non-lpsp: SKIP (0.001s)
[115.382625] [021/133] (904s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[115.480729] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[122.885624] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.404s)
[124.083541] [022/133] (896s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[124.173069] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[124.173888] Starting dynamic subtest: pipe-A-eDP-1
[124.196318] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[124.203587] Starting dynamic subtest: pipe-B-eDP-1
[124.224700] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[124.231160] Starting dynamic subtest: pipe-C-eDP-1
[124.250959] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[124.256555] Starting dynamic subtest: pipe-D-eDP-1
[124.277341] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[124.278892] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[126.458230] [023/133] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[126.551688] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[126.553489] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[126.627663] [024/133] (893s left) sriov_basic (bind-unbind-vf)
[126.685582] Starting subtest: bind-unbind-vf
[126.686603] Starting dynamic subtest: vf-1
[126.722731] Dynamic subtest vf-1: FAIL (0.018s)
[126.728956] Starting dynamic subtest: vf-2
[126.759926] Dynamic subtest vf-2: FAIL (0.010s)
[126.765986] Starting dynamic subtest: vf-3
[126.794432] Dynamic subtest vf-3: FAIL (0.010s)
[126.800080] Starting dynamic subtest: vf-4
[126.827700] Dynamic subtest vf-4: FAIL (0.010s)
[126.833394] Starting dynamic subtest: vf-5
[126.860474] Dynamic subtest vf-5: FAIL (0.010s)
[126.866101] Starting dynamic subtest: vf-6
[126.893173] Dynamic subtest vf-6: FAIL (0.010s)
[126.898811] Starting dynamic subtest: vf-7
[126.932213] Dynamic subtest vf-7: FAIL (0.011s)
[126.938104] Starting dynamic subtest: vf-random
[126.969997] Dynamic subtest vf-random: FAIL (0.007s)
[126.977138] Starting dynamic subtest: vf-last
[127.003646] Dynamic subtest vf-last: FAIL (0.004s)
[127.004468] Subtest bind-unbind-vf: FAIL (0.101s)
[127.031645] [025/133] (893s left) kms_properties (connector-properties-atomic)
[127.110911] Starting subtest: connector-properties-atomic
[127.111762] Starting dynamic subtest: pipe-A-eDP-1
[135.053058] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.940s)
[135.059392] Starting dynamic subtest: pipe-None-DP-1
[135.061280] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[135.067256] Starting dynamic subtest: pipe-None-HDMI-A-1
[135.069130] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[135.074581] Starting dynamic subtest: pipe-None-DP-2
[135.076405] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[135.082107] Starting dynamic subtest: pipe-None-HDMI-A-2
[135.083942] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[135.089491] Starting dynamic subtest: pipe-None-DP-3
[135.091504] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[135.097071] Starting dynamic subtest: pipe-None-DP-4
[135.098893] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[135.099859] Subtest connector-properties-atomic: SUCCESS (7.949s)
[135.906643] [026/133] (884s left) syncobj_eventfd (invalid-bad-pad)
[135.951427] Starting subtest: invalid-bad-pad
[135.952433] Subtest invalid-bad-pad: SUCCESS (0.000s)
[136.015983] [027/133] (884s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[136.066525] Starting subtest: single-wait-all-for-submit-available-signaled
[136.067551] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[136.155321] [028/133] (884s left) gem_exec_fence (syncobj-timeline-wait)
[136.751106] Starting subtest: syncobj-timeline-wait
[137.911429] Subtest syncobj-timeline-wait: SUCCESS (1.160s)
[138.128892] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[138.130960] [029/133] (882s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[138.224218] Starting subtest: plane-upscale-factor-0-25-with-rotation
[138.225029] Starting dynamic subtest: pipe-A
[138.452226] Dynamic subtest pipe-A: SUCCESS (0.228s)
[138.458631] Starting dynamic subtest: pipe-B
[139.707151] Dynamic subtest pipe-B: SUCCESS (1.254s)
[139.714306] Starting dynamic subtest: pipe-C
[141.048703] Dynamic subtest pipe-C: SUCCESS (1.340s)
[141.055097] Starting dynamic subtest: pipe-D
[142.375054] Dynamic subtest pipe-D: SUCCESS (1.326s)
[142.375926] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.152s)
[143.552095] [030/133] (876s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[143.655244] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[144.669995] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.015s)
[144.791229] [031/133] (875s left) i915_fb_tiling (basic-x-tiling)
[144.845571] Subtest basic-x-tiling: SKIP (0.000s)
[144.896204] [032/133] (875s left) gem_exec_endless (dispatch)
[144.963865] Starting subtest: dispatch
[144.964983] Starting dynamic subtest: rcs0
[144.969192] Dynamic subtest rcs0: SUCCESS (0.005s)
[144.978440] Starting dynamic subtest: bcs0
[144.980015] Dynamic subtest bcs0: SUCCESS (0.004s)
[144.987188] Starting dynamic subtest: vcs0
[144.989388] Dynamic subtest vcs0: SUCCESS (0.005s)
[144.996259] Starting dynamic subtest: vcs1
[144.997979] Dynamic subtest vcs1: SUCCESS (0.005s)
[145.004033] Starting dynamic subtest: vecs0
[145.005677] Dynamic subtest vecs0: SUCCESS (0.005s)
[145.011825] Starting dynamic subtest: ccs0
[145.013680] Dynamic subtest ccs0: SUCCESS (0.005s)
[145.014490] Subtest dispatch: SUCCESS (0.031s)
[146.936051] [033/133] (873s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[147.035941] Starting subtest: yf-tiled-16bpp-rotate-90
[147.037767] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[147.113342] [034/133] (873s left) gem_mmap_gtt (basic-short)
[147.175846] Subtest basic-short: SKIP (0.000s)
[147.233762] [035/133] (873s left) i915_drm_fdinfo (busy-hang)
[147.280811] Starting subtest: busy-hang
[147.281910] Starting dynamic subtest: rcs0
[147.309239] Dynamic subtest rcs0: SKIP (0.027s)
[147.319419] Starting dynamic subtest: bcs0
[147.321180] Dynamic subtest bcs0: SKIP (0.001s)
[147.330360] Starting dynamic subtest: vcs0
[147.332053] Dynamic subtest vcs0: SKIP (0.001s)
[147.338276] Starting dynamic subtest: vcs1
[147.339857] Dynamic subtest vcs1: SKIP (0.000s)
[147.346127] Starting dynamic subtest: vecs0
[147.347871] Dynamic subtest vecs0: SKIP (0.001s)
[147.354309] Starting dynamic subtest: ccs0
[147.355978] Dynamic subtest ccs0: SKIP (0.000s)
[147.357747] Subtest busy-hang: SKIP (0.035s)
[147.387663] [036/133] (873s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[147.463889] Starting subtest: x-tiled-to-vebox-y-tiled
[147.465857] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[147.665441] [037/133] (873s left) device_reset (unbind-cold-reset-rebind)
[147.714647] Starting subtest: unbind-cold-reset-rebind
[147.716749] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[147.779596] [038/133] (873s left) kms_big_fb (linear-32bpp-rotate-0)
[147.866618] Starting subtest: linear-32bpp-rotate-0
[149.322593] Subtest linear-32bpp-rotate-0: SUCCESS (1.456s)
[149.459129] [039/133] (871s left) gem_pxp (fail-invalid-protected-context)
[149.590802] Starting subtest: fail-invalid-protected-context
[149.592269] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[149.689862] [040/133] (871s left) gem_exec_suspend (basic)
[149.756542] Starting subtest: basic
[149.757553] Starting dynamic subtest: smem
[150.944880] Dynamic subtest smem: SUCCESS (1.178s)
[150.946311] Subtest basic: SUCCESS (1.180s)
[151.131902] [041/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[151.237371] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[151.239020] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.322884] [042/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[151.424889] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[151.426720] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[151.520676] [043/133] (869s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[151.636598] Starting subtest: flip-vs-cursor-crc-legacy
[152.337384] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.700s)
[153.193134] [044/133] (867s left) syncobj_timeline (invalid-query-bad-pad)
[153.242456] Starting subtest: invalid-query-bad-pad
[153.243418] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[153.325206] [045/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[153.415749] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[153.417500] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[153.506116] [046/133] (867s left) gem_exec_balancer (individual)
[153.572532] Starting subtest: individual
[154.918354] Subtest individual: SUCCESS (1.336s)
[155.229692] [047/133] (865s left) kms_cursor_crc (cursor-size-change)
[155.325135] Starting subtest: cursor-size-change
[155.325962] Starting dynamic subtest: pipe-A-eDP-1
[156.123871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[156.130703] Starting dynamic subtest: pipe-D-eDP-1
[157.565147] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[157.566169] Subtest cursor-size-change: SUCCESS (2.240s)
[158.351533] [048/133] (862s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[158.454975] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[158.456702] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[158.522799] [049/133] (862s left) kms_plane (plane-panning-top-left)
[158.610430] Starting subtest: plane-panning-top-left
[158.611364] Starting dynamic subtest: pipe-A
[160.308810] Dynamic subtest pipe-A: SUCCESS (1.699s)
[160.316448] Starting dynamic subtest: pipe-B
[162.717664] Dynamic subtest pipe-B: SUCCESS (2.406s)
[162.718529] Subtest plane-panning-top-left: SUCCESS (4.107s)
[163.576695] [050/133] (857s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[163.635655] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[163.707229] [051/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[163.750033] Starting subtest: multi-wait-for-submit-available-submitted
[163.751243] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[163.839339] [052/133] (857s left) gem_ppgtt (blt-vs-render-ctxn)
[163.897544] Starting subtest: blt-vs-render-ctxN
[196.808352] Subtest blt-vs-render-ctxN: SUCCESS (32.901s)
[196.928030] [053/133] (824s left) prime_vgem (fence-write-hang)
[197.059029] Subtest fence-write-hang: SKIP (0.000s)
[197.147927] [054/133] (824s left) gem_cs_tlb (engines)
[197.196678] Starting subtest: engines
[197.197607] Starting dynamic subtest: rcs0
[199.395279] Dynamic subtest rcs0: SUCCESS (2.152s)
[199.404612] Starting dynamic subtest: bcs0
[201.513059] Dynamic subtest bcs0: SUCCESS (2.152s)
[201.522706] Starting dynamic subtest: vcs0
[203.658188] Dynamic subtest vcs0: SUCCESS (2.152s)
[203.673759] Starting dynamic subtest: vcs1
[205.854451] Dynamic subtest vcs1: SUCCESS (2.151s)
[205.864218] Starting dynamic subtest: vecs0
[207.970684] Dynamic subtest vecs0: SUCCESS (2.151s)
[207.980879] Starting dynamic subtest: ccs0
[210.159602] Dynamic subtest ccs0: SUCCESS (2.153s)
[210.160485] Subtest engines: SUCCESS (12.918s)
[210.218917] [055/133] (811s left) gem_ppgtt (flink-and-close-vma-leak)
[210.270610] Starting subtest: flink-and-close-vma-leak
[210.313818] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[210.437302] [056/133] (810s left) prime_mmap (test_correct_cpu_write)
[210.486066] Starting subtest: test_correct_cpu_write
[210.486862] Starting dynamic subtest: test_correct_cpu_write-smem
[210.487676] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[210.488619] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[210.580632] [057/133] (810s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[210.681698] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[210.683409] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[210.784075] [058/133] (810s left) gem_softpin (evict-active)
[210.838560] Starting subtest: evict-active
[210.845731] Subtest evict-active: SUCCESS (0.007s)
[210.931840] [059/133] (810s left) kms_content_protection (uevent)
[211.079892] Starting subtest: uevent
[211.081609] Subtest uevent: SKIP (0.000s)
[211.178016] [060/133] (810s left) i915_pm_rpm (system-suspend-execbuf)
[213.039863] Starting subtest: system-suspend-execbuf
[271.174063] Subtest system-suspend-execbuf: SUCCESS (43.022s)
[271.567016] [061/133] (750s left) gem_sync (basic-store-each)
[271.625597] Starting subtest: basic-store-each
[274.018390] Subtest basic-store-each: SUCCESS (2.395s)
[274.210937] [062/133] (747s left) gem_busy (busy)
[274.274613] Starting subtest: busy
[274.275816] Starting dynamic subtest: all-engines
[274.332363] Dynamic subtest all-engines: SUCCESS (0.058s)
[274.342919] Starting dynamic subtest: rcs0
[275.962174] Dynamic subtest rcs0: SUCCESS (1.624s)
[275.972213] Starting dynamic subtest: bcs0
[275.996721] Dynamic subtest bcs0: SUCCESS (0.039s)
[276.004471] Starting dynamic subtest: vcs0
[276.037536] Dynamic subtest vcs0: SUCCESS (0.039s)
[276.045486] Starting dynamic subtest: vcs1
[278.010199] Dynamic subtest vcs1: SUCCESS (1.961s)
[278.022562] Starting dynamic subtest: vecs0
[279.994338] Dynamic subtest vecs0: SUCCESS (1.982s)
[280.004000] Starting dynamic subtest: ccs0
[281.981497] Dynamic subtest ccs0: SUCCESS (1.987s)
[281.982739] Subtest busy: SUCCESS (7.698s)
[282.330270] [063/133] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[282.424996] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[282.426727] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[282.538759] [064/133] (739s left) kms_pm_rpm (package-g7)
[284.069780] Starting subtest: package-g7
[284.072052] Subtest package-g7: SKIP (0.000s)
[284.786313] [065/133] (736s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[284.875751] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[284.876659] Starting dynamic subtest: pipe-A-eDP-1
[285.705130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[285.713179] Starting dynamic subtest: pipe-B-eDP-1
[287.353260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.647s)
[287.361408] Starting dynamic subtest: pipe-C-eDP-1
[288.829810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.475s)
[288.837929] Starting dynamic subtest: pipe-D-eDP-1
[290.409076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.578s)
[290.409898] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.531s)
[291.639088] [066/133] (730s left) gem_workarounds (basic-read)
[291.697923] Starting subtest: basic-read
[291.708409] Subtest basic-read: SUCCESS (0.011s)
[291.824061] [067/133] (729s left) kms_vblank (ts-continuation-modeset-hang)
[291.910867] Starting subtest: ts-continuation-modeset-hang
[291.911809] Starting dynamic subtest: pipe-A-eDP-1
[318.709574] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.790s)
[318.720359] Starting dynamic subtest: pipe-D-eDP-1
[342.701851] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.989s)
[342.702735] Subtest ts-continuation-modeset-hang: SUCCESS (50.784s)
[343.563560] [068/133] (678s left) kms_cdclk (mode-transition-all-outputs)
[343.665091] Starting subtest: mode-transition-all-outputs
[343.960956] Subtest mode-transition-all-outputs: SKIP (0.296s)
[344.790528] [069/133] (677s left) gem_exec_reloc (basic-cpu-wc-active)
[344.849072] Subtest basic-cpu-wc-active: SKIP (0.000s)
[344.922227] [070/133] (676s left) gem_ctx_param (invalid-param-set)
[344.977793] Starting subtest: invalid-param-set
[344.978738] Subtest invalid-param-set: SUCCESS (0.000s)
[345.059202] [071/133] (676s left) gem_userptr_blits (input-checking)
[345.121943] Starting subtest: input-checking
[345.122968] Subtest input-checking: SUCCESS (0.000s)
[345.262460] [072/133] (676s left) gem_spin_batch (legacy)
[345.313571] Starting subtest: legacy
[345.314672] Starting dynamic subtest: default
[348.563959] Dynamic subtest default: SUCCESS (3.238s)
[348.574331] Starting dynamic subtest: render
[351.838909] Dynamic subtest render: SUCCESS (3.235s)
[351.849435] Starting dynamic subtest: bsd
[355.077241] Dynamic subtest bsd: SUCCESS (3.235s)
[355.087855] Starting dynamic subtest: bsd1
[358.315548] Dynamic subtest bsd1: SUCCESS (3.235s)
[358.325871] Starting dynamic subtest: bsd2
[361.554588] Dynamic subtest bsd2: SUCCESS (3.236s)
[361.564890] Starting dynamic subtest: blt
[364.793913] Dynamic subtest blt: SUCCESS (3.236s)
[364.804201] Starting dynamic subtest: vebox
[368.031313] Dynamic subtest vebox: SUCCESS (3.234s)
[368.032540] Subtest legacy: SUCCESS (22.670s)
[370.055467] [073/133] (651s left) gem_exercise_blt (fast-copy-emit)
[370.118222] Starting subtest: fast-copy-emit
[370.119177] Starting dynamic subtest: linear-smem-smem-emit
[370.151661] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.032s)
[370.161076] Starting dynamic subtest: xmajor-smem-smem-emit
[370.170314] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[370.187311] Starting dynamic subtest: tile4-smem-smem-emit
[370.190402] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[370.207776] Starting dynamic subtest: tile64-smem-smem-emit
[370.209127] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[370.210484] Subtest fast-copy-emit: SUCCESS (0.089s)
[370.332957] [074/133] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[370.434047] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[370.435771] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[370.532561] [075/133] (651s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[370.626868] Starting subtest: psr-rgb101010-draw-blt
[378.040386] Subtest psr-rgb101010-draw-blt: SUCCESS (7.413s)
[378.173657] [076/133] (643s left) kms_cursor_crc (cursor-sliding-32x10)
[378.334964] Starting subtest: cursor-sliding-32x10
[378.387028] Subtest cursor-sliding-32x10: SKIP (0.049s)
[378.634512] [077/133] (643s left) kms_cursor_crc (cursor-random-512x170)
[378.905168] Starting subtest: cursor-random-512x170
[378.907222] Subtest cursor-random-512x170: SKIP (0.001s)
[379.053464] [078/133] (643s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[379.148085] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[379.149501] Starting dynamic subtest: pipe-A-default-mode
[380.287384] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[380.289119] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.139s)
[380.438598] [079/133] (641s left) kms_properties (crtc-properties-legacy)
[380.524621] Starting subtest: crtc-properties-legacy
[380.525497] Starting dynamic subtest: pipe-A-eDP-1
[380.970989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[380.979586] Starting dynamic subtest: pipe-B-eDP-1
[382.115981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[382.125516] Starting dynamic subtest: pipe-C-eDP-1
[383.241443] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[383.250122] Starting dynamic subtest: pipe-D-eDP-1
[384.372398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[384.373630] Subtest crtc-properties-legacy: SUCCESS (3.848s)
[385.187687] [080/133] (637s left) kms_tv_load_detect (load-detect)
[385.247565] Subtest load-detect: SKIP (0.000s)
[385.313952] [081/133] (636s left) gem_ctx_persistence (engines-hang)
[385.367892] Starting subtest: engines-hang
[385.368825] Starting dynamic subtest: rcs0
[385.502985] Dynamic subtest rcs0: SUCCESS (0.134s)
[385.515563] Starting dynamic subtest: bcs0
[385.573878] Dynamic subtest bcs0: SUCCESS (0.069s)
[385.585600] Starting dynamic subtest: vcs0
[385.696898] Dynamic subtest vcs0: SUCCESS (0.121s)
[385.708862] Starting dynamic subtest: vcs1
[385.787890] Dynamic subtest vcs1: SUCCESS (0.089s)
[385.799327] Starting dynamic subtest: vecs0
[385.878944] Dynamic subtest vecs0: SUCCESS (0.089s)
[385.890921] Starting dynamic subtest: ccs0
[385.968881] Dynamic subtest ccs0: SUCCESS (0.088s)
[385.971199] Subtest engines-hang: SUCCESS (0.602s)
[386.059724] [082/133] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[386.142045] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[393.355872] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.213s)
[393.474797] [083/133] (628s left) gem_exec_fence (syncobj-signal)
[393.929636] Starting subtest: syncobj-signal
[393.933941] Subtest syncobj-signal: SUCCESS (0.005s)
[395.050273] [084/133] (627s left) kms_joiner (invalid-modeset-force-big-joiner)
[395.143116] Starting subtest: invalid-modeset-force-big-joiner
[395.144899] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[395.213561] [085/133] (627s left) kms_getfb (getfb-handle-valid)
[395.303866] Starting subtest: getfb-handle-valid
[395.304753] Subtest getfb-handle-valid: SUCCESS (0.000s)
[395.403326] [086/133] (627s left) kms_busy (extended-modeset-hang-newfb)
[395.498686] Starting subtest: extended-modeset-hang-newfb
[395.499659] Starting dynamic subtest: pipe-A
[430.714607] Dynamic subtest pipe-A: SUCCESS (35.204s)
[430.724395] Starting dynamic subtest: pipe-D
[453.907352] Dynamic subtest pipe-D: SUCCESS (23.183s)
[453.908358] Subtest extended-modeset-hang-newfb: SUCCESS (58.393s)
[454.707516] [087/133] (567s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[454.774700] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[454.776614] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[454.964669] [088/133] (567s left) gem_render_copy_redux (flink-interruptible)
[455.017689] Starting subtest: flink-interruptible
[455.777082] Subtest flink-interruptible: SUCCESS (0.759s)
[455.915940] [089/133] (566s left) gem_exec_schedule (u-submit-early-slice)
[455.987703] Starting subtest: u-submit-early-slice
[455.988676] Starting dynamic subtest: rcs0
[456.029733] Dynamic subtest rcs0: SUCCESS (0.041s)
[456.040797] Starting dynamic subtest: bcs0
[456.062675] Dynamic subtest bcs0: SUCCESS (0.033s)
[456.071323] Starting dynamic subtest: vcs0
[456.104711] Dynamic subtest vcs0: SUCCESS (0.041s)
[456.112957] Starting dynamic subtest: vcs1
[456.140656] Dynamic subtest vcs1: SUCCESS (0.035s)
[456.149399] Starting dynamic subtest: vecs0
[456.179864] Dynamic subtest vecs0: SUCCESS (0.038s)
[456.188340] Starting dynamic subtest: ccs0
[456.216617] Dynamic subtest ccs0: SUCCESS (0.036s)
[456.217846] Subtest u-submit-early-slice: SUCCESS (0.229s)
[458.042907] [090/133] (564s left) kms_sequence (get-busy)
[458.148454] Starting subtest: get-busy
[458.149364] Starting dynamic subtest: pipe-A-eDP-1
[460.083679] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[460.092336] Starting dynamic subtest: pipe-B-eDP-1
[462.702754] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.619s)
[462.710805] Starting dynamic subtest: pipe-C-eDP-1
[465.311778] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[465.321471] Starting dynamic subtest: pipe-D-eDP-1
[467.963928] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.650s)
[467.964805] Subtest get-busy: SUCCESS (9.819s)
[468.830381] [091/133] (553s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[468.927548] Starting subtest: plane-ctm3x4-lut1d
[469.075863] Starting dynamic subtest: pipe-A-plane-0
[469.323491] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[469.332476] Starting dynamic subtest: pipe-A-plane-1
[469.512450] Dynamic subtest pipe-A-plane-1: FAIL (0.179s)
[469.521157] Starting dynamic subtest: pipe-A-plane-2
[469.729516] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[470.838777] Starting dynamic subtest: pipe-B-plane-0
[471.088763] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[471.097308] Starting dynamic subtest: pipe-B-plane-1
[471.266141] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[471.274834] Starting dynamic subtest: pipe-B-plane-2
[471.453446] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[472.566957] Starting dynamic subtest: pipe-C-plane-0
[472.824827] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[472.833813] Starting dynamic subtest: pipe-C-plane-1
[472.999325] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[473.008679] Starting dynamic subtest: pipe-C-plane-2
[473.162767] Dynamic subtest pipe-C-plane-2: FAIL (0.155s)
[474.224669] Starting dynamic subtest: pipe-D-plane-0
[474.540935] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[474.549186] Starting dynamic subtest: pipe-D-plane-1
[474.734594] Dynamic subtest pipe-D-plane-1: FAIL (0.154s)
[474.743182] Starting dynamic subtest: pipe-D-plane-2
[474.933864] Dynamic subtest pipe-D-plane-2: FAIL (0.340s)
[475.182673] Subtest plane-ctm3x4-lut1d: FAIL (6.256s)
[476.067661] [092/133] (546s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[476.196451] Starting subtest: cursor-vs-flip-varying-size
[507.303843] Subtest cursor-vs-flip-varying-size: SUCCESS (31.109s)
[508.178194] [093/133] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[508.279579] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[514.999213] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.720s)
[515.119047] [094/133] (507s left) gem_exec_flush (basic-wb-set-default)
[515.175538] Starting subtest: basic-wb-set-default
[520.645341] Subtest basic-wb-set-default: SUCCESS (5.469s)
[520.829782] [095/133] (501s left) kms_hdr (bpc-switch)
[520.931107] Starting subtest: bpc-switch
[522.006410] Starting dynamic subtest: pipe-A-eDP-1
[525.505826] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[525.506764] Subtest bpc-switch: SUCCESS (4.576s)
[525.613935] [096/133] (497s left) gem_ctx_persistence (heartbeat-hostile)
[525.677029] Starting subtest: heartbeat-hostile
[525.678818] Subtest heartbeat-hostile: SKIP (0.000s)
[525.775180] [097/133] (497s left) kms_cursor_crc (cursor-onscreen-32x10)
[525.923294] Starting subtest: cursor-onscreen-32x10
[525.971710] Subtest cursor-onscreen-32x10: SKIP (0.047s)
[526.234621] [098/133] (496s left) gem_mmap_wc (close)
[526.291164] Subtest close: SKIP (0.000s)
[526.348002] [099/133] (496s left) gem_mmap_offset (clear)
[526.406326] Starting subtest: clear
[526.407333] Starting dynamic subtest: smem0
[551.542326] Dynamic subtest smem0: SUCCESS (25.132s)
[551.543497] Subtest clear: SUCCESS (25.134s)
[551.644419] [100/133] (471s left) syncobj_wait (reset-signaled)
[551.742883] Starting subtest: reset-signaled
[551.743743] Subtest reset-signaled: SUCCESS (0.000s)
[551.829657] [101/133] (471s left) sysfs_preempt_timeout (timeout)
[551.881604] Starting subtest: timeout
[551.882609] Starting dynamic subtest: vecs0
[561.994992] Dynamic subtest vecs0: SUCCESS (10.110s)
[562.005740] Starting dynamic subtest: ccs0
[563.316605] Dynamic subtest ccs0: SUCCESS (1.319s)
[563.328924] Starting dynamic subtest: vcs0
[572.975636] Dynamic subtest vcs0: SUCCESS (9.649s)
[572.986375] Starting dynamic subtest: bcs0
[574.216943] Dynamic subtest bcs0: SUCCESS (1.246s)
[574.225556] Starting dynamic subtest: rcs0
[575.478737] Dynamic subtest rcs0: SUCCESS (1.261s)
[575.488890] Starting dynamic subtest: vcs1
[584.940230] Dynamic subtest vcs1: SUCCESS (9.450s)
[584.941425] Subtest timeout: SUCCESS (33.046s)
[585.020029] [102/133] (438s left) perf (polling)
[585.169171] Starting subtest: polling
[585.170183] Starting dynamic subtest: 0-rcs0
[595.230958] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[595.241612] Starting dynamic subtest: 1-vcs1
[605.257511] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[605.258893] Subtest polling: SUCCESS (20.039s)
[605.291771] [103/133] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[605.389588] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[605.391344] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[605.482194] [104/133] (417s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[605.571626] Starting subtest: fbcpsr-rgb565-draw-render
[612.679877] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.108s)
[612.798978] [105/133] (410s left) kms_debugfs (display-on-read-all)
[612.898515] Starting subtest: display-on-read-all
[613.100472] Subtest display-on-read-all: SUCCESS (0.203s)
[613.221309] [106/133] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[613.303580] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[613.305155] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[613.402089] [107/133] (409s left) kms_vrr (seamless-rr-switch-vrr)
[613.490882] Starting subtest: seamless-rr-switch-vrr
[613.493260] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[613.558935] [108/133] (409s left) gem_eio (wait-1us)
[613.771327] Starting subtest: wait-1us
[614.091198] Subtest wait-1us: SUCCESS (0.320s)
[614.204271] [109/133] (409s left) kms_chamelium_hpd (vga-hpd-fast)
[614.598026] Subtest vga-hpd-fast: SKIP (0.000s)
[615.392141] [110/133] (407s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[615.495700] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[615.497685] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[615.597490] [111/133] (407s left) gem_ctx_param (invalid-param-get)
[615.641759] Starting subtest: invalid-param-get
[615.642807] Subtest invalid-param-get: SUCCESS (0.001s)
[615.747054] [112/133] (407s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[615.860612] Starting subtest: short-flip-before-cursor-toggle
[616.782000] Subtest short-flip-before-cursor-toggle: SUCCESS (0.919s)
[617.657137] [113/133] (405s left) gem_exec_schedule (preemptive-hang)
[617.838624] Starting subtest: preemptive-hang
[617.839586] Starting dynamic subtest: rcs0
[627.095437] Dynamic subtest rcs0: SUCCESS (9.264s)
[627.104915] Starting dynamic subtest: bcs0
[636.167638] Dynamic subtest bcs0: SUCCESS (9.068s)
[636.178205] Starting dynamic subtest: vcs0
[645.079063] Dynamic subtest vcs0: SUCCESS (8.906s)
[645.088790] Starting dynamic subtest: vcs1
[654.100927] Dynamic subtest vcs1: SUCCESS (9.019s)
[654.113774] Starting dynamic subtest: vecs0
[663.060477] Dynamic subtest vecs0: SUCCESS (8.958s)
[663.073714] Starting dynamic subtest: ccs0
[672.087478] Dynamic subtest ccs0: SUCCESS (9.022s)
[672.088326] Subtest preemptive-hang: SUCCESS (54.247s)
[672.334205] [114/133] (351s left) kms_async_flips (async-flip-dpms)
[672.432201] Starting subtest: async-flip-dpms
[672.813429] Starting dynamic subtest: pipe-A-eDP-1
[676.594584] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.780s)
[676.989379] Starting dynamic subtest: pipe-B-eDP-1
[679.751440] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[680.130692] Starting dynamic subtest: pipe-C-eDP-1
[682.914644] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.791s)
[683.294522] Starting dynamic subtest: pipe-D-eDP-1
[686.098439] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.811s)
[686.099427] Subtest async-flip-dpms: SUCCESS (13.664s)
[687.286496] [115/133] (336s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[687.379607] Starting subtest: coverage-vs-premult-vs-constant
[687.662831] Starting dynamic subtest: pipe-A-eDP-1
[688.227870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[688.236710] Starting dynamic subtest: pipe-D-eDP-1
[689.522131] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[689.523072] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.142s)
[690.351391] [116/133] (333s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[690.443092] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[690.444194] Starting dynamic subtest: pipe-A-eDP-1
[690.452797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[690.462525] Starting dynamic subtest: pipe-B-eDP-1
[690.470053] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[690.479200] Starting dynamic subtest: pipe-C-eDP-1
[690.486831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[690.495038] Starting dynamic subtest: pipe-D-eDP-1
[690.503098] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[690.504772] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[692.715890] [117/133] (330s left) kms_chamelium_edid (hdmi-edid-read)
[693.106561] Subtest hdmi-edid-read: SKIP (0.000s)
[693.922799] [118/133] (329s left) api_intel_bb (object-noreloc-keep-cache-simple)
[693.984118] Starting subtest: object-noreloc-keep-cache-simple
[693.989178] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[694.106456] [119/133] (329s left) kms_psr (fbc-pr-suspend)
[694.190486] Starting subtest: fbc-pr-suspend
[694.192094] Subtest fbc-pr-suspend: SKIP (0.000s)
[694.263043] [120/133] (329s left) gem_exec_params (invalid-bsd-ring)
[694.324074] Starting subtest: invalid-bsd-ring
[694.325300] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[694.437745] [121/133] (329s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[694.517903] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[694.519782] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[694.586829] [122/133] (329s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[694.676583] Starting subtest: bad-pixel-format-yf-tiled-ccs
[694.677556] Starting dynamic subtest: pipe-A-eDP-1
[694.686635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[694.696191] Starting dynamic subtest: pipe-B-eDP-1
[694.705046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[694.713430] Starting dynamic subtest: pipe-C-eDP-1
[694.721795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[694.730074] Starting dynamic subtest: pipe-D-eDP-1
[694.738766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[694.740491] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[696.903100] [123/133] (326s left) gen7_exec_parse (basic-allowed)
[696.973951] Subtest basic-allowed: SKIP (0.000s)
[697.041658] [124/133] (326s left) gem_exec_whisper (basic-fds)
[697.098721] Starting subtest: basic-fds
[703.688621] Subtest basic-fds: SUCCESS (6.587s)
[703.870332] [125/133] (319s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[703.965087] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[711.521509] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.555s)
[711.629075] [126/133] (312s left) kms_flip (flip-vs-expired-vblank)
[711.724469] Starting subtest: flip-vs-expired-vblank
[711.725333] Starting dynamic subtest: A-eDP1
[720.474322] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[720.485628] Starting dynamic subtest: B-eDP1
[729.109089] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[729.119936] Starting dynamic subtest: C-eDP1
[737.743238] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[737.755877] Starting dynamic subtest: D-eDP1
[746.374645] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[746.375839] Subtest flip-vs-expired-vblank: SUCCESS (34.635s)
[747.499622] [127/133] (276s left) kms_lease (setcrtc-implicit-plane)
[747.588614] Starting subtest: setcrtc-implicit-plane
[747.589504] Starting dynamic subtest: pipe-A-eDP-1
[748.067569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[748.077189] Starting dynamic subtest: pipe-B-eDP-1
[749.247953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[749.259724] Starting dynamic subtest: pipe-C-eDP-1
[750.354618] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[750.363418] Starting dynamic subtest: pipe-D-eDP-1
[751.482485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[751.483325] Subtest setcrtc-implicit-plane: SUCCESS (3.896s)
[752.331130] [128/133] (271s left) kms_psr (psr-cursor-plane-onoff)
[752.435608] Starting subtest: psr-cursor-plane-onoff
[752.436540] Starting dynamic subtest: eDP-1
[754.127700] Dynamic subtest eDP-1: SUCCESS (1.692s)
[754.128579] Subtest psr-cursor-plane-onoff: SUCCESS (1.693s)
[754.983994] [129/133] (268s left) gem_mmap_gtt (big-copy)
[755.038525] Subtest big-copy: SKIP (0.000s)
[755.089412] [130/133] (268s left) kms_atomic (plane-primary-legacy)
[755.190649] Starting subtest: plane-primary-legacy
[755.191543] Starting dynamic subtest: pipe-A-eDP-1
[755.634169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[755.635463] Subtest plane-primary-legacy: SUCCESS (0.445s)
[756.506071] [131/133] (267s left) gem_exec_async (forked-writes)
[756.575541] Starting subtest: forked-writes
[756.576406] Starting dynamic subtest: rcs0
[756.610117] Dynamic subtest rcs0: SUCCESS (0.035s)
[756.621923] Starting dynamic subtest: bcs0
[756.632844] Dynamic subtest bcs0: SUCCESS (0.022s)
[756.642309] Starting dynamic subtest: vcs0
[756.654989] Dynamic subtest vcs0: SUCCESS (0.021s)
[756.664081] Starting dynamic subtest: vcs1
[756.678338] Dynamic subtest vcs1: SUCCESS (0.023s)
[756.688246] Starting dynamic subtest: vecs0
[756.701507] Dynamic subtest vecs0: SUCCESS (0.022s)
[756.713353] Starting dynamic subtest: ccs0
[756.725242] Dynamic subtest ccs0: SUCCESS (0.023s)
[756.726175] Subtest forked-writes: SUCCESS (0.152s)
[756.945761] [132/133] (267s left) syncobj_wait (invalid-reset-bad-pad)
[757.005778] Starting subtest: invalid-reset-bad-pad
[757.006641] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[757.129604] [133/133] (266s left) perf_pmu (most-busy-idle-check-all)
[757.179704] Starting subtest: most-busy-idle-check-all
[757.180813] Starting dynamic subtest: rcs0
[758.966903] Dynamic subtest rcs0: SUCCESS (1.779s)
[758.978128] Starting dynamic subtest: bcs0
[760.950921] Dynamic subtest bcs0: SUCCESS (1.982s)
[760.964397] Starting dynamic subtest: vcs0
[762.998271] Dynamic subtest vcs0: SUCCESS (2.046s)
[763.008192] Starting dynamic subtest: vcs1
[764.982903] Dynamic subtest vcs1: SUCCESS (1.982s)
[764.993058] Starting dynamic subtest: vecs0
[766.966692] Dynamic subtest vecs0: SUCCESS (1.981s)
[766.977331] Starting dynamic subtest: ccs0
[768.951867] Dynamic subtest ccs0: SUCCESS (1.982s)
[768.952963] Subtest most-busy-idle-check-all: SUCCESS (11.768s)
[769.034747] 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.