[58.932864] Initializing watchdogs
[58.932914]   /dev/watchdog0
[58.948699] [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.953337] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.955886] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.958132] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[59.070718] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[65.701426] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.592s)
[65.822556] [002/133] (953s left) syncobj_wait (wait-all-complex)
[65.877351] Starting subtest: wait-all-complex
[66.103703] Subtest wait-all-complex: SUCCESS (0.215s)
[66.174936] [003/133] (953s left) kms_cursor_edge_walk (256x256-right-edge)
[66.258679] Starting subtest: 256x256-right-edge
[66.259842] Starting dynamic subtest: pipe-A-eDP-1
[69.706244] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[69.712678] Starting dynamic subtest: pipe-D-eDP-1
[72.842691] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[72.843895] Subtest 256x256-right-edge: SUCCESS (6.570s)
[73.650239] [004/133] (945s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[73.703969] Starting subtest: etime-multi-wait-all-available-unsubmitted
[73.809904] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[73.881712] [005/133] (945s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[73.929616] Starting subtest: y-tiled-ccs-to-y-tiled
[73.931445] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[74.103504] [006/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[74.204119] Starting subtest: fbcpsr-1p-rte
[81.206309] Subtest fbcpsr-1p-rte: SUCCESS (6.999s)
[81.345226] [007/133] (938s left) kms_mmap_write_crc (main)
[81.430779] Starting subtest: main
[81.431845] Starting dynamic subtest: pipe-A-eDP-1
[85.014613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.582s)
[85.015612] Subtest main: SUCCESS (3.582s)
[85.868108] [008/133] (933s left) gen9_exec_parse (unaligned-access)
[85.926334] Subtest unaligned-access: SKIP (0.000s)
[85.964981] [009/133] (933s left) gem_ctx_isolation (preservation-reset)
[86.143809] Starting subtest: preservation-reset
[86.144982] Starting dynamic subtest: rcs0
[86.379576] Dynamic subtest rcs0: SUCCESS (0.247s)
[86.389324] Starting dynamic subtest: bcs0
[86.674506] Dynamic subtest bcs0: SUCCESS (0.294s)
[86.686067] Starting dynamic subtest: vcs0
[86.958207] Dynamic subtest vcs0: SUCCESS (0.283s)
[86.969485] Starting dynamic subtest: vcs1
[88.619520] Dynamic subtest vcs1: SUCCESS (1.660s)
[88.629884] Starting dynamic subtest: vecs0
[90.616650] Dynamic subtest vecs0: SUCCESS (1.996s)
[90.624410] Starting dynamic subtest: ccs0
[92.612301] Dynamic subtest ccs0: SUCCESS (1.994s)
[92.615357] Subtest preservation-reset: SUCCESS (6.480s)
[92.759502] [010/133] (926s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[92.858950] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[92.860910] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[92.926641] [011/133] (926s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[94.448345] Starting subtest: modeset-lpsp-stress-no-wait
[104.861738] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.414s)
[104.948732] [012/133] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[105.038697] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[105.040695] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.119647] [013/133] (914s left) kms_flip (nonblocking-read)
[105.209896] Starting subtest: nonblocking-read
[105.210886] Subtest nonblocking-read: SUCCESS (0.000s)
[105.332691] [014/133] (914s left) sriov_basic (enable-vfs-autoprobe-on)
[105.390046] Starting subtest: enable-vfs-autoprobe-on
[105.391294] Starting dynamic subtest: numvfs-1
[105.433119] Dynamic subtest numvfs-1: FAIL (0.017s)
[105.441841] Starting dynamic subtest: numvfs-2
[105.469521] Dynamic subtest numvfs-2: FAIL (0.004s)
[105.477632] Starting dynamic subtest: numvfs-3
[105.503828] Dynamic subtest numvfs-3: FAIL (0.004s)
[105.510801] Starting dynamic subtest: numvfs-4
[105.536172] Dynamic subtest numvfs-4: FAIL (0.004s)
[105.543117] Starting dynamic subtest: numvfs-5
[105.571380] Dynamic subtest numvfs-5: FAIL (0.004s)
[105.578043] Starting dynamic subtest: numvfs-6
[105.610496] Dynamic subtest numvfs-6: FAIL (0.004s)
[105.617186] Starting dynamic subtest: numvfs-7
[105.642676] Dynamic subtest numvfs-7: FAIL (0.004s)
[105.649216] Starting dynamic subtest: numvfs-random
[105.674646] Dynamic subtest numvfs-random: FAIL (0.004s)
[105.681626] Starting dynamic subtest: numvfs-all
[105.707492] Dynamic subtest numvfs-all: FAIL (0.004s)
[105.708365] Subtest enable-vfs-autoprobe-on: FAIL (0.051s)
[105.735327] [015/133] (914s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[105.836547] Starting subtest: pr-plane-move-sf-dmg-area
[105.838498] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[105.910349] [016/133] (914s left) gem_mmap_wc (bad-size)
[105.956548] Subtest bad-size: SKIP (0.000s)
[106.007851] [017/133] (913s left) gem_exec_reloc (basic-range)
[106.072215] Subtest basic-range: SKIP (0.000s)
[106.151652] [018/133] (913s left) gem_ctx_param (set-priority-range)
[106.195850] Starting subtest: set-priority-range
[106.210129] Subtest set-priority-range: SUCCESS (0.015s)
[106.321082] [019/133] (913s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[106.425479] Starting subtest: flip-vs-cursor-toggle
[115.613065] Subtest flip-vs-cursor-toggle: SUCCESS (9.186s)
[116.451317] [020/133] (903s left) kms_psr (fbc-psr2-dpms)
[116.535164] Starting subtest: fbc-psr2-dpms
[116.536226] Starting dynamic subtest: eDP-1
[116.537884] Dynamic subtest eDP-1: SKIP (0.000s)
[116.539730] Subtest fbc-psr2-dpms: SKIP (0.001s)
[116.607025] [021/133] (903s left) gem_exec_schedule (preempt-other-chain)
[116.665352] Starting subtest: preempt-other-chain
[116.666266] Starting dynamic subtest: rcs0
[116.750370] Dynamic subtest rcs0: SUCCESS (0.085s)
[116.762388] Starting dynamic subtest: bcs0
[116.831784] Dynamic subtest bcs0: SUCCESS (0.081s)
[116.839736] Starting dynamic subtest: vcs0
[116.917425] Dynamic subtest vcs0: SUCCESS (0.085s)
[116.928938] Starting dynamic subtest: vcs1
[117.001046] Dynamic subtest vcs1: SUCCESS (0.083s)
[117.012930] Starting dynamic subtest: vecs0
[117.081104] Dynamic subtest vecs0: SUCCESS (0.079s)
[117.093033] Starting dynamic subtest: ccs0
[117.166703] Dynamic subtest ccs0: SUCCESS (0.085s)
[117.168401] Subtest preempt-other-chain: SUCCESS (0.502s)
[118.376257] [022/133] (901s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[118.471349] Starting subtest: fbc-dirtyfb-ioctl
[118.473455] Starting dynamic subtest: A-eDP-1
[121.133847] Dynamic subtest A-eDP-1: SUCCESS (2.661s)
[121.134698] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.663s)
[121.937667] [023/133] (898s left) perf_pmu (render-node-busy)
[122.004418] Starting subtest: render-node-busy
[122.005505] Starting dynamic subtest: rcs0
[122.593706] Dynamic subtest rcs0: SUCCESS (0.589s)
[122.604858] Starting dynamic subtest: bcs0
[123.152969] Dynamic subtest bcs0: SUCCESS (0.558s)
[123.164028] Starting dynamic subtest: vcs0
[124.326948] Dynamic subtest vcs0: SUCCESS (1.163s)
[124.338764] Starting dynamic subtest: vcs1
[126.309973] Dynamic subtest vcs1: SUCCESS (1.982s)
[126.319783] Starting dynamic subtest: vecs0
[128.358773] Dynamic subtest vecs0: SUCCESS (2.046s)
[128.368245] Starting dynamic subtest: ccs0
[128.913057] Dynamic subtest ccs0: SUCCESS (0.562s)
[128.914361] Subtest render-node-busy: SUCCESS (6.909s)
[129.020640] [024/133] (891s left) kms_invalid_mode (uint-max-clock)
[129.109929] Starting subtest: uint-max-clock
[129.110797] Starting dynamic subtest: pipe-A-eDP-1
[129.394673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[129.403316] Starting dynamic subtest: pipe-B-eDP-1
[129.404197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[129.411716] Starting dynamic subtest: pipe-C-eDP-1
[129.412676] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[129.420529] Starting dynamic subtest: pipe-D-eDP-1
[129.421603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[129.422478] Subtest uint-max-clock: SUCCESS (0.290s)
[130.258518] [025/133] (889s left) gem_exec_capture (userptr)
[130.314635] Starting subtest: userptr
[131.134871] Subtest userptr: SUCCESS (0.819s)
[131.230900] [026/133] (889s left) sysfs_timeslice_duration (duration)
[131.288565] Starting subtest: duration
[131.289915] Starting dynamic subtest: vecs0
[145.284252] Dynamic subtest vecs0: SUCCESS (13.984s)
[145.293292] Starting dynamic subtest: ccs0
[158.435035] Dynamic subtest ccs0: SUCCESS (13.157s)
[158.446351] Starting dynamic subtest: vcs0
[173.253807] Dynamic subtest vcs0: SUCCESS (14.807s)
[173.264403] Starting dynamic subtest: bcs0
[186.395342] Dynamic subtest bcs0: SUCCESS (13.140s)
[186.404959] Starting dynamic subtest: rcs0
[199.537681] Dynamic subtest rcs0: SUCCESS (13.148s)
[199.550265] Starting dynamic subtest: vcs1
[214.275746] Dynamic subtest vcs1: SUCCESS (14.726s)
[214.277194] Subtest duration: SUCCESS (82.974s)
[214.336990] [027/133] (805s left) syncobj_timeline (single-wait-available-signaled)
[214.376830] Starting subtest: single-wait-available-signaled
[214.378229] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[214.475140] [028/133] (805s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[214.573073] Starting subtest: basic-max-pipe-crc-check
[214.574879] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[214.612903] [029/133] (805s left) kms_draw_crc (draw-method-pwrite)
[214.694086] Starting subtest: draw-method-pwrite
[214.694901] Starting dynamic subtest: xrgb8888-untiled
[215.338440] Dynamic subtest xrgb8888-untiled: SUCCESS (0.645s)
[215.348545] Starting dynamic subtest: rgb565-untiled
[215.816345] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[215.825208] Starting dynamic subtest: xrgb2101010-untiled
[216.416496] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.599s)
[216.426602] Starting dynamic subtest: xbgr16161616f-untiled
[217.238774] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.820s)
[217.247374] Starting dynamic subtest: xrgb8888-xtiled
[219.216993] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.977s)
[219.226836] Starting dynamic subtest: rgb565-xtiled
[220.416513] Dynamic subtest rgb565-xtiled: SUCCESS (1.199s)
[220.425525] Starting dynamic subtest: xrgb2101010-xtiled
[222.394384] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.977s)
[222.402444] Starting dynamic subtest: xbgr16161616f-xtiled
[226.028154] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.633s)
[226.036528] Starting dynamic subtest: xrgb8888-4tiled
[227.261332] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.232s)
[227.271490] Starting dynamic subtest: rgb565-4tiled
[227.906198] Dynamic subtest rgb565-4tiled: SUCCESS (0.644s)
[227.916603] Starting dynamic subtest: xrgb2101010-4tiled
[229.116975] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.210s)
[229.125817] Starting dynamic subtest: xbgr16161616f-4tiled
[232.461717] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.344s)
[232.462684] Subtest draw-method-pwrite: SUCCESS (17.768s)
[232.560010] [030/133] (787s left) gem_exec_reloc (basic-cpu-noreloc)
[232.624814] Subtest basic-cpu-noreloc: SKIP (0.000s)
[232.690142] [031/133] (787s left) gem_ctx_exec (basic-nohangcheck)
[232.737611] Starting subtest: basic-nohangcheck
[232.994194] Subtest basic-nohangcheck: SUCCESS (0.258s)
[233.093246] [032/133] (787s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[233.180503] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[233.181468] Starting dynamic subtest: pipe-A-default-mode
[235.897211] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[235.898150] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.718s)
[236.739278] [033/133] (783s left) kms_chamelium_color (degamma)
[236.826289] Subtest degamma: SKIP (0.000s)
[236.864448] [034/133] (783s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[236.949365] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[236.950273] Starting dynamic subtest: pipe-A-eDP-1
[236.959292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.968853] Starting dynamic subtest: pipe-B-eDP-1
[236.977154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.985031] Starting dynamic subtest: pipe-C-eDP-1
[236.992822] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[237.000434] Starting dynamic subtest: pipe-D-eDP-1
[237.015055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[237.016731] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[239.181827] [035/133] (781s left) gem_exec_whisper (basic-forked-all)
[239.244381] Starting subtest: basic-forked-all
[252.438607] Subtest basic-forked-all: SUCCESS (13.192s)
[252.628809] [036/133] (767s left) perf_pmu (busy)
[252.666276] Starting subtest: busy
[252.667170] Starting dynamic subtest: rcs0
[253.257571] Dynamic subtest rcs0: SUCCESS (0.589s)
[253.268494] Starting dynamic subtest: bcs0
[253.824504] Dynamic subtest bcs0: SUCCESS (0.566s)
[253.837219] Starting dynamic subtest: vcs0
[255.334515] Dynamic subtest vcs0: SUCCESS (1.499s)
[255.344670] Starting dynamic subtest: vcs1
[257.317865] Dynamic subtest vcs1: SUCCESS (1.981s)
[257.328488] Starting dynamic subtest: vecs0
[259.366410] Dynamic subtest vecs0: SUCCESS (2.046s)
[259.377234] Starting dynamic subtest: ccs0
[259.933979] Dynamic subtest ccs0: SUCCESS (0.574s)
[259.935150] Subtest busy: SUCCESS (7.268s)
[260.044231] [037/133] (760s left) syncobj_timeline (multi-wait-available-signaled)
[260.099418] Starting subtest: multi-wait-available-signaled
[260.100487] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[260.194068] [038/133] (760s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[260.313361] Starting subtest: flip-vs-cursor-busy-crc-atomic
[261.038552] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.724s)
[261.906611] [039/133] (758s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[261.988836] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[261.990491] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[262.067077] [040/133] (758s left) i915_query (query-regions-garbage-items)
[262.123074] Starting subtest: query-regions-garbage-items
[262.124306] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[262.231725] [041/133] (758s left) gem_flink_basic (double-flink)
[262.287765] Starting subtest: double-flink
[262.288844] Subtest double-flink: SUCCESS (0.000s)
[262.372520] [042/133] (758s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[262.451708] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[262.464370] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[262.533376] [043/133] (758s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[262.615659] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[262.627327] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[262.710307] [044/133] (758s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[262.805487] Starting subtest: async-flip-with-page-flip-events-tiled
[263.198733] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[266.004778] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[266.013297] Starting dynamic subtest: pipe-A-eDP-1-4
[268.179168] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[268.190409] Starting dynamic subtest: pipe-A-eDP-1-4
[270.189877] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[270.200371] Starting dynamic subtest: pipe-A-eDP-1-x
[272.368489] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.176s)
[272.738619] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[275.531167] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[275.539246] Starting dynamic subtest: pipe-B-eDP-1-4
[277.728892] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[277.738516] Starting dynamic subtest: pipe-B-eDP-1-4
[279.738740] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[279.747149] Starting dynamic subtest: pipe-B-eDP-1-x
[281.929052] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[282.286508] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[285.067095] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.779s)
[285.075940] Starting dynamic subtest: pipe-C-eDP-1-4
[287.241446] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[287.252307] Starting dynamic subtest: pipe-C-eDP-1-4
[289.251498] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[289.260464] Starting dynamic subtest: pipe-C-eDP-1-x
[291.430729] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[291.788952] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[294.600916] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[294.609826] Starting dynamic subtest: pipe-D-eDP-1-4
[296.774967] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[296.783556] Starting dynamic subtest: pipe-D-eDP-1-4
[298.785576] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[298.795352] Starting dynamic subtest: pipe-D-eDP-1-x
[300.964498] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[300.965617] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.149s)
[302.190245] [045/133] (718s left) kms_sequence (queue-idle)
[302.291270] Starting subtest: queue-idle
[302.292299] Starting dynamic subtest: pipe-A-eDP-1
[304.094332] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[304.103023] Starting dynamic subtest: pipe-B-eDP-1
[306.557212] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.462s)
[306.567169] Starting dynamic subtest: pipe-C-eDP-1
[308.998283] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.439s)
[309.006581] Starting dynamic subtest: pipe-D-eDP-1
[311.405072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.406s)
[311.405888] Subtest queue-idle: SUCCESS (9.114s)
[312.212329] [046/133] (708s left) gem_ctx_bad_destroy (invalid-ctx)
[312.258189] Starting subtest: invalid-ctx
[312.259048] Subtest invalid-ctx: SUCCESS (0.000s)
[312.324182] [047/133] (708s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[312.416821] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[312.417804] Starting dynamic subtest: pipe-A
[312.437263] Dynamic subtest pipe-A: SKIP (0.019s)
[312.445788] Starting dynamic subtest: pipe-B
[312.473653] Dynamic subtest pipe-B: SKIP (0.035s)
[312.482038] Starting dynamic subtest: pipe-C
[312.507575] Dynamic subtest pipe-C: SKIP (0.034s)
[312.516287] Starting dynamic subtest: pipe-D
[312.545773] Dynamic subtest pipe-D: SKIP (0.035s)
[312.547849] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.126s)
[312.644535] [048/133] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[312.744923] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[312.746781] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[312.816960] [049/133] (708s left) gem_exec_basic (basic)
[312.860613] Starting subtest: basic
[312.861435] Starting dynamic subtest: rcs0-smem
[312.864109] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[312.873725] Starting dynamic subtest: bcs0-smem
[312.874763] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[312.882922] Starting dynamic subtest: vcs0-smem
[312.883844] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[312.891852] Starting dynamic subtest: vcs1-smem
[312.892819] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[312.900736] Starting dynamic subtest: vecs0-smem
[312.901679] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[312.909782] Starting dynamic subtest: ccs0-smem
[312.910735] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[312.911695] Subtest basic: SUCCESS (0.014s)
[314.366231] [050/133] (706s left) api_intel_allocator (two-level-inception)
[314.408821] Starting subtest: two-level-inception
[319.819652] Subtest two-level-inception: SUCCESS (5.400s)
[319.933901] [051/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[320.034976] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[320.036652] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[320.147437] [052/133] (700s left) gen9_exec_parse (basic-rejected-ctx-param)
[320.206776] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[320.279453] [053/133] (700s left) gem_ccs (large-ctrl-surf-copy)
[320.339352] Starting subtest: large-ctrl-surf-copy
[320.341341] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[320.444344] [054/133] (700s left) gem_exec_schedule (submit-golden-slice)
[320.504499] Starting subtest: submit-golden-slice
[320.505628] Starting dynamic subtest: rcs0
[320.544845] Dynamic subtest rcs0: SUCCESS (0.041s)
[320.556925] Starting dynamic subtest: bcs0
[320.585835] Dynamic subtest bcs0: SUCCESS (0.040s)
[320.597212] Starting dynamic subtest: vcs0
[320.635792] Dynamic subtest vcs0: SUCCESS (0.049s)
[320.646592] Starting dynamic subtest: vcs1
[320.673666] Dynamic subtest vcs1: SUCCESS (0.037s)
[320.684614] Starting dynamic subtest: vecs0
[320.712119] Dynamic subtest vecs0: SUCCESS (0.038s)
[320.721168] Starting dynamic subtest: ccs0
[320.752251] Dynamic subtest ccs0: SUCCESS (0.039s)
[320.753064] Subtest submit-golden-slice: SUCCESS (0.250s)
[322.406554] [055/133] (698s left) kms_addfb_basic (bad-pitch-0)
[322.455938] Starting subtest: bad-pitch-0
[322.456943] Subtest bad-pitch-0: SUCCESS (0.000s)
[322.605381] [056/133] (698s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[322.694036] Starting subtest: pipe-fbc-rte
[322.696643] Starting dynamic subtest: pipe-B-eDP-1
[328.185812] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.491s)
[328.189608] Subtest pipe-fbc-rte: SUCCESS (5.494s)
[330.455348] [057/133] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[330.542744] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[330.544629] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[330.637594] [058/133] (690s left) gem_mmap_offset (pf-nonblock)
[330.683343] Starting subtest: pf-nonblock
[330.689591] Subtest pf-nonblock: SUCCESS (0.007s)
[330.819553] [059/133] (690s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[330.900389] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[330.901401] Starting dynamic subtest: pipe-A-eDP-1
[364.934554] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.651s)
[364.945043] Starting dynamic subtest: pipe-B-eDP-1
[399.872584] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.554s)
[399.883531] Starting dynamic subtest: pipe-C-eDP-1
[434.841961] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.435s)
[434.851908] Starting dynamic subtest: pipe-D-eDP-1
[469.846524] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.414s)
[469.847881] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (18.060s)
[476.132000] [060/133] (550s left) kms_psr (psr-dpms)
[476.222017] Starting subtest: psr-dpms
[476.223424] Starting dynamic subtest: eDP-1
[479.295659] Dynamic subtest eDP-1: SUCCESS (3.013s)
[479.296838] Subtest psr-dpms: SUCCESS (3.015s)
[480.177379] [061/133] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[480.269960] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[480.272363] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.349130] [062/133] (546s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[480.450164] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[480.461964] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[480.533786] [063/133] (546s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[480.574612] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[480.619041] [064/133] (545s left) gem_exec_await (wide-contexts)
[480.854785] Starting subtest: wide-contexts
[504.154939] Subtest wide-contexts: SUCCESS (23.197s)
[504.352646] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[504.356902] [065/133] (522s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[504.514721] Starting subtest: y-tiled-8bpp-rotate-270
[504.517122] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[504.612231] [066/133] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[504.713726] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[504.715781] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[504.804019] [067/133] (521s left) i915_pm_rps (min-max-config-idle)
[504.864825] Starting subtest: min-max-config-idle
[504.867130] Subtest min-max-config-idle: SKIP (0.001s)
[504.961098] [068/133] (521s left) gem_lmem_swapping (verify-random)
[505.001038] Subtest verify-random: SKIP (0.000s)
[505.054741] [069/133] (521s left) gem_pxp (protected-raw-src-copy-not-readible)
[505.168316] Starting subtest: protected-raw-src-copy-not-readible
[505.227448] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[505.333497] [070/133] (521s left) kms_psr (psr2-primary-blt)
[505.430891] Starting subtest: psr2-primary-blt
[505.432411] Starting dynamic subtest: eDP-1
[507.183335] Dynamic subtest eDP-1: SUCCESS (1.755s)
[507.184513] Subtest psr2-primary-blt: SUCCESS (1.755s)
[508.055047] [071/133] (518s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[508.154897] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[508.156840] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[508.239401] [072/133] (518s left) kms_psr (fbc-psr-primary-mmap-cpu)
[508.330545] Starting subtest: fbc-psr-primary-mmap-cpu
[508.332011] Starting dynamic subtest: eDP-1
[508.334959] Dynamic subtest eDP-1: SKIP (0.000s)
[508.337711] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[508.400978] [073/133] (518s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[508.495505] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[508.496340] Starting dynamic subtest: pipe-A-eDP-1
[508.577146] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[508.588640] Starting dynamic subtest: pipe-B-eDP-1
[509.729704] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[509.731622] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.235s)
[510.916370] [074/133] (516s left) kms_properties (invalid-properties-atomic)
[511.004339] Starting subtest: invalid-properties-atomic
[511.328776] Subtest invalid-properties-atomic: SUCCESS (0.316s)
[511.405407] [075/133] (515s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[511.500745] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[511.503013] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[511.571780] [076/133] (515s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[511.621752] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[511.674890] [077/133] (515s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[511.764176] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[511.765004] Starting dynamic subtest: pipe-A-eDP-1
[517.622723] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.857s)
[517.633478] Starting dynamic subtest: pipe-B-eDP-1
[524.276317] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[524.277718] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.511s)
[525.149234] [078/133] (501s left) kms_cursor_crc (cursor-size-change)
[525.238103] Starting subtest: cursor-size-change
[525.239653] Starting dynamic subtest: pipe-A-eDP-1
[526.073659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s)
[526.084482] Starting dynamic subtest: pipe-D-eDP-1
[527.542407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.465s)
[527.543620] Subtest cursor-size-change: SUCCESS (2.304s)
[528.411499] [079/133] (498s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[528.533841] Starting subtest: flip-vs-cursor-atomic
[536.151397] Subtest flip-vs-cursor-atomic: SUCCESS (7.614s)
[536.948351] [080/133] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[537.043555] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[543.655160] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.611s)
[543.764511] [081/133] (483s left) gem_ctx_persistence (userptr)
[543.832055] Starting subtest: userptr
[543.985447] Subtest userptr: SUCCESS (0.153s)
[544.097053] [082/133] (483s left) gem_close (many-handles-one-vma)
[544.150763] Starting subtest: many-handles-one-vma
[544.174671] Subtest many-handles-one-vma: SUCCESS (0.025s)
[544.286042] [083/133] (483s left) kms_atomic (atomic-plane-damage)
[544.383456] Starting subtest: atomic-plane-damage
[544.433645] Starting dynamic subtest: pipe-A-eDP-1
[544.970139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[544.971534] Subtest atomic-plane-damage: SUCCESS (0.581s)
[545.820878] [084/133] (481s left) kms_getfb (getfb-handle-not-fb)
[545.906374] Starting subtest: getfb-handle-not-fb
[545.907238] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[546.005402] [085/133] (481s left) kms_color (ctm-max)
[546.097429] Starting subtest: ctm-max
[546.098284] Starting dynamic subtest: pipe-A-eDP-1
[546.819412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[546.831708] Starting dynamic subtest: pipe-B-eDP-1
[548.275763] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[548.287628] Starting dynamic subtest: pipe-C-eDP-1
[549.624641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[549.635433] Starting dynamic subtest: pipe-D-eDP-1
[550.947861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[550.949224] Subtest ctm-max: SUCCESS (4.849s)
[551.744431] [086/133] (475s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[551.835532] Starting subtest: fbc-modesetfrombusy
[555.617615] Subtest fbc-modesetfrombusy: SUCCESS (3.781s)
[556.811338] [087/133] (470s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[556.903645] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[556.905558] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[556.997952] [088/133] (470s left) kms_flip (2x-plain-flip-fb-recreate)
[557.085917] Starting subtest: 2x-plain-flip-fb-recreate
[557.101123] Subtest 2x-plain-flip-fb-recreate: SKIP (0.014s)
[557.176818] [089/133] (470s left) api_intel_bb (lot-of-buffers)
[557.222003] Starting subtest: lot-of-buffers
[558.386430] Subtest lot-of-buffers: SUCCESS (1.157s)
[558.716531] [090/133] (468s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[558.814784] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[563.367806] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.553s)
[564.484661] [091/133] (463s left) kms_plane (pixel-format-y-tiled-modifier)
[564.582082] Starting subtest: pixel-format-y-tiled-modifier
[564.584314] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[564.651645] [092/133] (463s left) kms_hdr (bpc-switch-suspend)
[564.735911] Starting subtest: bpc-switch-suspend
[565.848786] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[585.819029] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.072s)
[586.865207] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[606.805849] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.883s)
[606.806802] Subtest bpc-switch-suspend: SUCCESS (12.102s)
[611.980939] [093/133] (420s left) sw_sync (sync_busy_fork_unixsocket)
[612.020377] Starting subtest: sync_busy_fork_unixsocket
[612.031734] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s)
[612.093432] [094/133] (420s left) gem_render_copy (y-tiled-to-vebox-linear)
[612.159289] Starting subtest: y-tiled-to-vebox-linear
[612.161002] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[612.348567] [095/133] (420s left) kms_vblank (ts-continuation-suspend)
[612.449735] Starting subtest: ts-continuation-suspend
[612.450521] Starting dynamic subtest: pipe-A-eDP-1
[628.961032] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[628.972994] Starting dynamic subtest: pipe-D-eDP-1
[646.969960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[646.971377] Subtest ts-continuation-suspend: SUCCESS (4.470s)
[653.854123] [096/133] (385s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[653.900206] Starting subtest: etime-single-wait-for-submit-unsubmitted
[654.002327] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[654.082536] [097/133] (384s left) dmabuf_sync_file (export-wait-after-attach)
[654.122770] Starting subtest: export-wait-after-attach
[654.124655] Subtest export-wait-after-attach: SUCCESS (0.001s)
[654.195233] [098/133] (384s left) gem_softpin (allocator-evict)
[654.248278] Starting subtest: allocator-evict
[654.249589] Starting dynamic subtest: rcs0
[678.021523] Dynamic subtest rcs0: SUCCESS (23.664s)
[678.032217] Starting dynamic subtest: bcs0
[701.695051] Dynamic subtest bcs0: SUCCESS (23.670s)
[701.707053] Starting dynamic subtest: vcs0
[727.159564] Dynamic subtest vcs0: SUCCESS (25.448s)
[727.174169] Starting dynamic subtest: vcs1
[750.845725] Dynamic subtest vcs1: SUCCESS (23.687s)
[750.857191] Starting dynamic subtest: vecs0
[774.967677] Dynamic subtest vecs0: SUCCESS (24.124s)
[774.979157] Starting dynamic subtest: ccs0
[798.621465] Dynamic subtest ccs0: SUCCESS (23.650s)
[798.623117] Subtest allocator-evict: SUCCESS (144.251s)
[798.705647] [099/133] (240s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[798.862639] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[799.535324] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.671s)
[799.682435] [100/133] (239s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[799.777269] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[800.846665] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[800.975816] [101/133] (238s left) kms_pm_rpm (cursor-dpms)
[802.502112] Starting subtest: cursor-dpms
[802.505614] Subtest cursor-dpms: SKIP (0.000s)
[803.195299] [102/133] (235s left) kms_flip (bo-too-big-interruptible)
[803.293331] Starting subtest: bo-too-big-interruptible
[803.295940] Starting dynamic subtest: A-eDP1
[804.640532] Dynamic subtest A-eDP1: SUCCESS (1.344s)
[804.653960] Starting dynamic subtest: B-eDP1
[805.888524] Dynamic subtest B-eDP1: SUCCESS (1.246s)
[805.901741] Starting dynamic subtest: C-eDP1
[807.146604] Dynamic subtest C-eDP1: SUCCESS (1.257s)
[807.159817] Starting dynamic subtest: D-eDP1
[808.487965] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[808.491103] Subtest bo-too-big-interruptible: SUCCESS (5.196s)
[809.666287] [103/133] (229s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[809.751797] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[809.752807] Starting dynamic subtest: pipe-A-eDP-1
[809.762204] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[809.774313] Starting dynamic subtest: pipe-B-eDP-1
[809.783701] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[809.795286] Starting dynamic subtest: pipe-C-eDP-1
[809.804253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[809.814670] Starting dynamic subtest: pipe-D-eDP-1
[809.824124] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[809.825865] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[811.940497] [104/133] (227s left) gem_mmap_gtt (big-bo-tiledx)
[811.985912] Subtest big-bo-tiledX: SKIP (0.000s)
[812.041894] [105/133] (227s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[812.132319] Starting subtest: bad-aux-stride-yf-tiled-ccs
[812.133401] Starting dynamic subtest: pipe-A-eDP-1
[812.142542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[812.153033] Starting dynamic subtest: pipe-B-eDP-1
[812.160890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[812.171898] Starting dynamic subtest: pipe-C-eDP-1
[812.180695] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[812.190534] Starting dynamic subtest: pipe-D-eDP-1
[812.199500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[812.201073] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[814.431184] [106/133] (224s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[815.028426] Starting subtest: syncobj-timeline-invalid-flags
[815.029946] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[816.228156] [107/133] (223s left) kms_cursor_crc (cursor-onscreen-128x128)
[816.441046] Starting subtest: cursor-onscreen-128x128
[816.445820] Starting dynamic subtest: pipe-A-eDP-1
[818.588294] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.141s)
[818.621177] Starting dynamic subtest: pipe-D-eDP-1
[821.414946] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[821.416193] Subtest cursor-onscreen-128x128: SUCCESS (4.972s)
[822.289410] [108/133] (217s left) vgem_basic (debugfs)
[822.332181] Starting subtest: debugfs
[822.333611] Subtest debugfs: SUCCESS (0.000s)
[822.391070] [109/133] (217s left) kms_atomic_transition (plane-all-transition-fencing)
[822.482404] Starting subtest: plane-all-transition-fencing
[822.483960] Starting dynamic subtest: pipe-A-eDP-1
[824.988943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.508s)
[825.295084] Starting dynamic subtest: pipe-B-eDP-1
[828.524505] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.238s)
[828.830414] Subtest plane-all-transition-fencing: SUCCESS (6.348s)
[829.652783] [110/133] (209s left) gem_exec_params (mmapped)
[829.717555] Starting subtest: mmapped
[829.720974] Subtest mmapped: SUCCESS (0.004s)
[829.829951] [111/133] (209s left) kms_content_protection (lic-type-1)
[829.970695] Starting subtest: lic-type-1
[829.973465] Subtest lic-type-1: SKIP (0.000s)
[830.085405] [112/133] (209s left) sw_sync (alloc_timeline)
[830.118071] Starting subtest: alloc_timeline
[830.119332] Subtest alloc_timeline: SUCCESS (0.000s)
[830.171577] [113/133] (209s left) gem_exec_alignment (forked)
[830.231156] Starting subtest: forked
[870.653342] Subtest forked: SUCCESS (40.364s)
[870.756218] [114/133] (168s left) syncobj_wait (invalid-reset-bad-pad)
[870.862444] Starting subtest: invalid-reset-bad-pad
[870.863394] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[870.941116] [115/133] (168s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[871.046870] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[878.224664] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.177s)
[878.329035] [116/133] (161s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[878.424850] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[878.426578] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[878.514548] [117/133] (161s left) kms_chamelium_color (ctm-0-75)
[878.607330] Subtest ctm-0-75: SKIP (0.000s)
[878.653327] [118/133] (161s left) i915_hangman (gt-error-state-capture)
[878.712515] Starting subtest: gt-error-state-capture
[878.713938] Starting dynamic subtest: rcs0
[889.108737] Dynamic subtest rcs0: SUCCESS (10.391s)
[889.121402] Starting dynamic subtest: bcs0
[901.140502] Dynamic subtest bcs0: SUCCESS (12.030s)
[901.154728] Starting dynamic subtest: vcs0
[911.132742] Dynamic subtest vcs0: SUCCESS (9.982s)
[911.146487] Starting dynamic subtest: vcs1
[923.095708] Dynamic subtest vcs1: SUCCESS (11.968s)
[923.112437] Starting dynamic subtest: vecs0
[933.076670] Dynamic subtest vecs0: SUCCESS (9.978s)
[933.089680] Starting dynamic subtest: ccs0
[944.149452] Dynamic subtest ccs0: SUCCESS (11.069s)
[944.151123] Subtest gt-error-state-capture: SUCCESS (65.436s)
[944.221838] [119/133] ( 95s left) syncobj_timeline (invalid-transfer-bad-pad)
[944.270333] Starting subtest: invalid-transfer-bad-pad
[944.271496] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[944.373795] [120/133] ( 95s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[944.476464] Starting subtest: fbc-rgb565-draw-render
[948.811939] Subtest fbc-rgb565-draw-render: SUCCESS (4.337s)
[949.925514] [121/133] ( 90s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[950.030522] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[951.210541] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.181s)
[951.319915] [122/133] ( 88s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[951.421012] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[951.423726] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[951.491249] [123/133] ( 88s left) gem_userptr_blits (sd-probe)
[951.544030] Starting subtest: sd-probe
[951.544967] Subtest sd-probe: SUCCESS (0.000s)
[951.674304] [124/133] ( 88s left) gem_fenced_exec_thrash (too-many-fences)
[951.733696] Subtest too-many-fences: SKIP (0.000s)
[951.806193] [125/133] ( 88s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[951.904000] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[951.906241] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[952.007290] [126/133] ( 88s left) kms_cursor_crc (cursor-random-64x64)
[952.187739] Starting subtest: cursor-random-64x64
[952.191521] Starting dynamic subtest: pipe-A-eDP-1
[955.579100] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.387s)
[955.612394] Starting dynamic subtest: pipe-D-eDP-1
[959.635587] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.034s)
[959.637119] Subtest cursor-random-64x64: SUCCESS (7.448s)
[960.489424] [127/133] ( 79s left) kms_psr (pr-dpms)
[960.577008] Starting subtest: pr-dpms
[960.579492] Subtest pr-dpms: SKIP (0.000s)
[960.648395] [128/133] ( 79s left) kms_flip (flip-vs-blocking-wf-vblank)
[960.736050] Starting subtest: flip-vs-blocking-wf-vblank
[960.737143] Starting dynamic subtest: A-eDP1
[969.642820] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[969.655405] Starting dynamic subtest: B-eDP1
[978.575494] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[978.588943] Starting dynamic subtest: C-eDP1
[987.531034] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[987.544182] Starting dynamic subtest: D-eDP1
[996.470189] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[996.471619] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.694s)
[997.657848] [129/133] ( 42s left) gem_exec_params (no-blt)
[997.713567] Starting subtest: no-blt
[997.716335] Subtest no-blt: SUCCESS (0.003s)
[997.831121] [130/133] ( 42s left) gem_exec_balancer (bonded-semaphore)
[997.885954] Starting subtest: bonded-semaphore
[997.888235] Subtest bonded-semaphore: SKIP (0.000s)
[998.203474] [131/133] ( 42s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[998.595901] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[999.373165] [132/133] ( 40s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[999.457145] Starting subtest: bad-pixel-format-y-tiled-ccs
[999.458079] Starting dynamic subtest: pipe-A-eDP-1
[999.467303] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[999.477934] Starting dynamic subtest: pipe-B-eDP-1
[999.487147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[999.498183] Starting dynamic subtest: pipe-C-eDP-1
[999.506765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[999.516687] Starting dynamic subtest: pipe-D-eDP-1
[999.524955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[999.526581] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[1001.671665] [133/133] ( 38s left) gem_exec_flush (basic-wb-set-default)
[1001.732099] Starting subtest: basic-wb-set-default
[1007.188668] Subtest basic-wb-set-default: SUCCESS (5.455s)
[1007.373281] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_mmap_write_crc
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_dirtyfb
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_invalid_mode
results: parsing output: 24/ for test: gem_exec_capture
results: parsing output: 25/ for test: sysfs_timeslice_duration
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_multipipe_modeset
results: parsing output: 28/ for test: kms_draw_crc
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: gem_ctx_exec
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_chamelium_color
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_sequence
results: parsing output: 45/ for test: gem_ctx_bad_destroy
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_basic
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: gem_exec_await
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_pm_rps
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_properties
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_pipe_b_c_ivb
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: gem_close
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: kms_getfb
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_hdr
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: sw_sync
results: parsing output: 112/ for test: gem_exec_alignment
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_color
results: parsing output: 117/ for test: i915_hangman
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: gem_fenced_exec_thrash
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_exec_flush
Done.