[57.702744] Initializing watchdogs
[57.702789]   /dev/watchdog0
[57.717662] [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]
[57.722146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.724472] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.728194] [001/133] (960s left) gem_workarounds (suspend-resume-context)
[57.832283] Starting subtest: suspend-resume-context
[73.751446] Subtest suspend-resume-context: SUCCESS (1.299s)
[73.912288] [002/133] (944s left) api_intel_bb (crc32)
[73.973452] Starting subtest: crc32
[73.975768] Starting dynamic subtest: rcs0-smem0
[74.266645] Dynamic subtest rcs0-smem0: SUCCESS (0.293s)
[74.277416] Starting dynamic subtest: bcs0-smem0
[74.561084] Dynamic subtest bcs0-smem0: SUCCESS (0.294s)
[74.568608] Starting dynamic subtest: vcs0-smem0
[74.894976] Dynamic subtest vcs0-smem0: SUCCESS (0.332s)
[74.905159] Starting dynamic subtest: vcs1-smem0
[75.239662] Dynamic subtest vcs1-smem0: SUCCESS (0.344s)
[75.250316] Starting dynamic subtest: vecs0-smem0
[75.559480] Dynamic subtest vecs0-smem0: SUCCESS (0.318s)
[75.570046] Starting dynamic subtest: ccs0-smem0
[75.899263] Dynamic subtest ccs0-smem0: SUCCESS (0.339s)
[75.901958] Subtest crc32: SUCCESS (1.926s)
[76.020017] [003/133] (942s left) kms_psr (psr-sprite-plane-move)
[76.111600] Starting subtest: psr-sprite-plane-move
[76.113918] Starting dynamic subtest: eDP-1
[77.854298] Dynamic subtest eDP-1: SUCCESS (1.745s)
[77.856680] Subtest psr-sprite-plane-move: SUCCESS (1.745s)
[78.695582] [004/133] (939s left) kms_display_modes (extended-mode-basic)
[78.795118] Starting subtest: extended-mode-basic
[78.799760] Subtest extended-mode-basic: SKIP (0.000s)
[78.840137] [005/133] (939s left) kms_plane_alpha_blend (constant-alpha-mid)
[78.928188] Starting subtest: constant-alpha-mid
[79.249056] Starting dynamic subtest: pipe-A-eDP-1
[80.105262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[80.114327] Starting dynamic subtest: pipe-D-eDP-1
[81.562226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[81.564756] Subtest constant-alpha-mid: SUCCESS (2.632s)
[82.431818] [006/133] (936s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[82.553348] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[82.555852] Starting dynamic subtest: pipe-A-eDP-1
[93.872743] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.323s)
[93.881433] Starting dynamic subtest: pipe-B-eDP-1
[105.847864] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.975s)
[105.850287] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.301s)
[106.694185] [007/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[106.800767] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[106.805066] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[106.896219] [008/133] (911s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[106.993414] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[106.995873] Starting dynamic subtest: A-eDP1
[110.621896] Dynamic subtest A-eDP1: SUCCESS (3.628s)
[110.630495] Starting dynamic subtest: B-eDP1
[113.838658] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[113.851428] Starting dynamic subtest: C-eDP1
[116.949186] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[116.958140] Starting dynamic subtest: D-eDP1
[120.134499] Dynamic subtest D-eDP1: SUCCESS (3.190s)
[120.136833] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.143s)
[120.934468] [009/133] (897s left) i915_drm_fdinfo (busy-hang)
[120.975336] Starting subtest: busy-hang
[120.977238] Starting dynamic subtest: rcs0
[121.002353] Dynamic subtest rcs0: SKIP (0.027s)
[121.011652] Starting dynamic subtest: bcs0
[121.015642] Dynamic subtest bcs0: SKIP (0.001s)
[121.025949] Starting dynamic subtest: vcs0
[121.030319] Dynamic subtest vcs0: SKIP (0.000s)
[121.037125] Starting dynamic subtest: vcs1
[121.041178] Dynamic subtest vcs1: SKIP (0.000s)
[121.047971] Starting dynamic subtest: vecs0
[121.051893] Dynamic subtest vecs0: SKIP (0.000s)
[121.058845] Starting dynamic subtest: ccs0
[121.062831] Dynamic subtest ccs0: SKIP (0.000s)
[121.066916] Subtest busy-hang: SKIP (0.031s)
[121.100955] [010/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[121.204381] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[121.209563] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[121.301040] [011/133] (897s left) kms_addfb_basic (unused-modifier)
[121.368702] Starting subtest: unused-modifier
[121.370677] Subtest unused-modifier: SUCCESS (0.000s)
[121.505004] [012/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[121.604931] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[121.608933] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[121.692946] [013/133] (897s left) gem_softpin (allocator-fork)
[121.746507] Starting subtest: allocator-fork
[123.956294] Subtest allocator-fork: SUCCESS (2.208s)
[124.091644] [014/133] (894s left) gem_exec_params (invalid-ring)
[124.148476] Starting subtest: invalid-ring
[124.150834] Subtest invalid-ring: SUCCESS (0.000s)
[124.239791] [015/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[124.333906] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[130.932491] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.603s)
[131.064445] [016/133] (887s left) gem_exec_balancer (persistence)
[131.325870] Starting subtest: persistence
[132.205299] Subtest persistence: SUCCESS (0.878s)
[132.317033] [017/133] (886s left) gem_exec_reloc (basic-cpu-wc-active)
[132.386225] Subtest basic-cpu-wc-active: SKIP (0.000s)
[132.463473] [018/133] (886s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[132.560706] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[132.564947] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[132.644606] [019/133] (886s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[132.750429] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[132.754827] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[132.819083] [020/133] (886s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[132.912243] Starting subtest: yf-tiled-8bpp-rotate-90
[132.916364] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[133.015857] [021/133] (885s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[133.062218] Starting subtest: multi-wait-all-for-submit-available-submitted
[133.064431] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[133.148995] [022/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[133.259659] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[133.263360] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[133.361608] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[133.462498] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[133.466223] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[133.563519] [024/133] (885s left) gem_media_vme
[133.674323] [025/133] (885s left) kms_invalid_mode (clock-too-high)
[133.774407] Starting subtest: clock-too-high
[133.776327] Starting dynamic subtest: pipe-A-eDP-1
[133.779819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.787997] Starting dynamic subtest: pipe-B-eDP-1
[133.791497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.798415] Starting dynamic subtest: pipe-C-eDP-1
[133.801985] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.808715] Starting dynamic subtest: pipe-D-eDP-1
[133.812048] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.815350] Subtest clock-too-high: SKIP (0.003s)
[133.848786] [026/133] (885s left) kms_psr (fbc-psr2-primary-blt)
[133.945701] Starting subtest: fbc-psr2-primary-blt
[133.947267] Starting dynamic subtest: eDP-1
[133.950578] Dynamic subtest eDP-1: SKIP (0.000s)
[133.953925] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[134.014411] [027/133] (885s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[134.116492] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[134.118384] Starting dynamic subtest: pipe-A
[134.136713] Dynamic subtest pipe-A: SKIP (0.018s)
[134.144362] Starting dynamic subtest: pipe-B
[134.167297] Dynamic subtest pipe-B: SKIP (0.030s)
[134.174667] Starting dynamic subtest: pipe-C
[134.199400] Dynamic subtest pipe-C: SKIP (0.030s)
[134.206670] Starting dynamic subtest: pipe-D
[134.228364] Dynamic subtest pipe-D: SKIP (0.030s)
[134.231902] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[134.325768] [028/133] (884s left) gem_exec_schedule (out-order)
[134.413934] Starting subtest: out-order
[134.415623] Starting dynamic subtest: rcs0
[134.511117] Dynamic subtest rcs0: SUCCESS (0.102s)
[134.522157] Starting dynamic subtest: vcs0
[134.595381] Dynamic subtest vcs0: SUCCESS (0.083s)
[134.607344] Starting dynamic subtest: vcs1
[134.689236] Dynamic subtest vcs1: SUCCESS (0.093s)
[134.701149] Starting dynamic subtest: vecs0
[134.769316] Dynamic subtest vecs0: SUCCESS (0.079s)
[134.782194] Starting dynamic subtest: ccs0
[134.848800] Dynamic subtest ccs0: SUCCESS (0.079s)
[134.851194] Subtest out-order: SUCCESS (0.440s)
[136.584769] [029/133] (882s left) kms_psr (psr2-no-drrs)
[136.681487] Starting subtest: psr2-no-drrs
[136.684950] Starting dynamic subtest: eDP-1
[138.263228] Dynamic subtest eDP-1: SUCCESS (1.582s)
[138.265425] Subtest psr2-no-drrs: SUCCESS (1.582s)
[139.061652] [030/133] (880s left) gem_exec_balancer (bonded-chain)
[139.115874] Starting subtest: bonded-chain
[146.077360] Subtest bonded-chain: SUCCESS (6.960s)
[146.383940] [031/133] (872s left) kms_chamelium_edid (hdmi-edid-read)
[146.772631] Subtest hdmi-edid-read: SKIP (0.000s)
[147.571399] [032/133] (871s left) kms_content_protection (dp-mst-lic-type-1)
[147.699416] Starting subtest: dp-mst-lic-type-1
[147.704118] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[147.800124] [033/133] (871s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[147.903686] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[147.907889] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[147.969316] [034/133] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[148.062351] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[151.659924] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.602s)
[152.819178] [035/133] (866s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[152.917656] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[152.942437] Starting dynamic subtest: pipe-A-plane-0
[153.364612] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[153.373337] Starting dynamic subtest: pipe-A-plane-3
[153.631205] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[154.701867] Starting dynamic subtest: pipe-B-plane-0
[155.139380] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[155.149624] Starting dynamic subtest: pipe-B-plane-3
[155.394660] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[155.706417] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.791s)
[156.567917] [036/133] (862s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[156.690575] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[156.694902] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[156.786933] [037/133] (862s left) gem_tiled_fence_blits (normal)
[156.844256] Subtest normal: SKIP (0.000s)
[156.906506] [038/133] (862s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[156.998419] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[157.000685] Starting dynamic subtest: pipe-A-eDP-1
[157.022902] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[157.032961] Starting dynamic subtest: pipe-B-eDP-1
[157.051839] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[157.060043] Starting dynamic subtest: pipe-C-eDP-1
[157.080646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[157.089628] Starting dynamic subtest: pipe-D-eDP-1
[157.110369] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[157.114436] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[159.225906] [039/133] (860s left) kms_cursor_crc (cursor-alpha-transparent)
[159.325097] Starting subtest: cursor-alpha-transparent
[159.327261] Starting dynamic subtest: pipe-A-eDP-1
[159.938364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[159.947057] Starting dynamic subtest: pipe-D-eDP-1
[161.252571] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[161.254909] Subtest cursor-alpha-transparent: SUCCESS (1.925s)
[162.095816] [040/133] (857s left) core_auth (basic-auth)
[162.163294] Starting subtest: basic-auth
[162.165554] Subtest basic-auth: SUCCESS (0.001s)
[162.264922] [041/133] (857s left) kms_getfb (getfb-reject-nv12)
[162.352268] Starting subtest: getfb-reject-nv12
[162.354478] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[162.461904] [042/133] (857s left) kms_psr (fbc-psr-cursor-plane-move)
[162.548774] Starting subtest: fbc-psr-cursor-plane-move
[162.550582] Starting dynamic subtest: eDP-1
[162.554576] Dynamic subtest eDP-1: SKIP (0.000s)
[162.558544] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[162.618543] [043/133] (857s left) gem_userptr_blits (sync-overlap)
[162.684402] Starting subtest: sync-overlap
[162.686703] Subtest sync-overlap: SUCCESS (0.000s)
[162.802964] [044/133] (857s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[162.898602] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[163.678502] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[163.827194] [045/133] (856s left) gem_exec_gttfill (multigpu-basic)
[164.004793] Starting subtest: multigpu-basic
[177.631345] Subtest multigpu-basic: SUCCESS (13.625s)
[177.730581] [046/133] (842s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[177.882975] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[177.885395] Starting dynamic subtest: pipe-A-eDP-1
[177.894178] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.903900] Starting dynamic subtest: pipe-B-eDP-1
[177.912397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.920890] Starting dynamic subtest: pipe-C-eDP-1
[177.932197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.939897] Starting dynamic subtest: pipe-D-eDP-1
[177.947683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.951631] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[180.070133] [047/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[180.167437] Starting subtest: 256x256-top-edge
[180.169684] Starting dynamic subtest: pipe-A-eDP-1
[183.647687] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[183.657358] Starting dynamic subtest: pipe-D-eDP-1
[186.785192] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[186.787275] Subtest 256x256-top-edge: SUCCESS (6.618s)
[187.583667] [048/133] (832s left) gem_mmap_wc (write-cpu-read-wc)
[187.659108] Subtest write-cpu-read-wc: SKIP (0.000s)
[187.720154] [049/133] (832s left) gem_ctx_isolation (preservation-s3)
[187.767633] Starting subtest: preservation-S3
[187.769856] Starting dynamic subtest: rcs0
[203.761212] Dynamic subtest rcs0: SUCCESS (1.351s)
[203.770101] Starting dynamic subtest: bcs0
[219.783314] Dynamic subtest bcs0: SUCCESS (1.292s)
[219.792855] Starting dynamic subtest: vcs0
[235.796878] Dynamic subtest vcs0: SUCCESS (3.189s)
[235.812047] Starting dynamic subtest: vcs1
[253.792169] Dynamic subtest vcs1: SUCCESS (5.018s)
[253.802496] Starting dynamic subtest: vecs0
[271.781730] Dynamic subtest vecs0: SUCCESS (4.969s)
[271.791157] Starting dynamic subtest: ccs0
[289.772621] Dynamic subtest ccs0: SUCCESS (3.128s)
[289.775064] Subtest preservation-S3: SUCCESS (18.953s)
[290.007766] [050/133] (730s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[291.746036] Starting subtest: dpms-mode-unset-non-lpsp
[292.911417] Subtest dpms-mode-unset-non-lpsp: SKIP (1.165s)
[293.295259] [051/133] (726s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[293.418358] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[293.551902] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[293.672058] [052/133] (726s left) gem_mmap_gtt (basic-short)
[293.727652] Subtest basic-short: SKIP (0.000s)
[293.785991] [053/133] (726s left) gem_mmap_gtt (basic-write-gtt)
[293.845525] Subtest basic-write-gtt: SKIP (0.000s)
[293.938780] [054/133] (726s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[294.004883] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[294.103945] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[294.184132] [055/133] (726s left) fbdev (eof)
[294.232735] Starting subtest: eof
[294.234636] Subtest eof: SUCCESS (0.000s)
[294.323959] [056/133] (726s left) kms_plane_cursor (primary)
[294.406489] Starting subtest: primary
[294.409939] Starting dynamic subtest: pipe-A-eDP-1-size-64
[296.971914] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.561s)
[296.996068] Starting dynamic subtest: pipe-A-eDP-1-size-128
[299.563295] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[299.591799] Starting dynamic subtest: pipe-A-eDP-1-size-256
[302.133635] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[302.448345] Starting dynamic subtest: pipe-B-eDP-1-size-64
[305.718611] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.279s)
[305.742051] Starting dynamic subtest: pipe-B-eDP-1-size-128
[308.298364] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[308.322824] Starting dynamic subtest: pipe-B-eDP-1-size-256
[310.855788] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[311.172110] Starting dynamic subtest: pipe-C-eDP-1-size-64
[314.013826] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.852s)
[314.040494] Starting dynamic subtest: pipe-C-eDP-1-size-128
[316.192886] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[316.219782] Starting dynamic subtest: pipe-C-eDP-1-size-256
[318.405306] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[318.725041] Starting dynamic subtest: pipe-D-eDP-1-size-64
[321.542800] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.826s)
[321.568870] Starting dynamic subtest: pipe-D-eDP-1-size-128
[323.720733] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[323.748069] Starting dynamic subtest: pipe-D-eDP-1-size-256
[325.911849] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[326.226150] Subtest primary: SUCCESS (31.797s)
[327.044771] [057/133] (693s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[327.142821] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[335.549460] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.405s)
[335.662332] [058/133] (684s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[335.729662] Starting subtest: yf-tiled-to-vebox-y-tiled
[335.733823] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[335.923264] [059/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[336.010989] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[336.015248] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[336.115703] [060/133] (684s left) kms_universal_plane (universal-plane-pageflip-windowed)
[336.204772] Starting subtest: universal-plane-pageflip-windowed
[336.207048] Starting dynamic subtest: pipe-A-eDP-1
[336.792861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[336.802509] Starting dynamic subtest: pipe-B-eDP-1
[337.973505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[337.982087] Starting dynamic subtest: pipe-C-eDP-1
[339.199978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[339.208761] Starting dynamic subtest: pipe-D-eDP-1
[340.422720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[340.424982] Subtest universal-plane-pageflip-windowed: SUCCESS (4.216s)
[341.267393] [061/133] (679s left) syncobj_timeline (wait-for-submit-complex)
[341.321412] Starting subtest: wait-for-submit-complex
[341.382202] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[341.469078] [062/133] (679s left) gem_mmap_gtt (big-copy-xy)
[341.525026] Subtest big-copy-XY: SKIP (0.000s)
[341.589725] [063/133] (679s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[341.659438] Starting subtest: yf-tiled-ccs-to-x-tiled
[341.663847] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[341.854133] [064/133] (678s left) kms_dsc (dsc-basic)
[341.952601] Starting subtest: dsc-basic
[341.966154] Subtest dsc-basic: SKIP (0.000s)
[342.023399] [065/133] (678s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[342.118927] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[342.131129] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[342.206301] [066/133] (678s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[342.310453] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[348.994787] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.683s)
[349.106416] [067/133] (671s left) kms_flip (flip-vs-suspend)
[349.215679] Starting subtest: flip-vs-suspend
[349.218003] Starting dynamic subtest: A-eDP1
[398.759858] Dynamic subtest A-eDP1: SUCCESS (4.575s)
[398.773078] Starting dynamic subtest: B-eDP1
[447.788371] Dynamic subtest B-eDP1: SUCCESS (4.507s)
[447.798339] Starting dynamic subtest: C-eDP1
[496.762913] Dynamic subtest C-eDP1: SUCCESS (4.506s)
[496.772205] Starting dynamic subtest: D-eDP1
[545.776744] Dynamic subtest D-eDP1: SUCCESS (4.556s)
[545.779434] Subtest flip-vs-suspend: SUCCESS (18.153s)
[546.967018] [068/133] (473s left) gem_gpgpu_fill (basic)
[547.043599] Starting subtest: basic
[547.046376] Starting dynamic subtest: smem
[547.052707] Dynamic subtest smem: SUCCESS (0.009s)
[547.055260] Subtest basic: SUCCESS (0.010s)
[547.213169] [069/133] (473s left) gem_exec_params (no-bsd)
[547.271853] Starting subtest: no-bsd
[547.274630] Subtest no-bsd: SUCCESS (0.003s)
[549.016094] [070/133] (471s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[549.118339] Starting subtest: psr-1p-primscrn-spr-indfb-move
[556.580350] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.459s)
[556.703147] [071/133] (464s left) gem_exec_schedule (semaphore-codependency)
[556.780980] Starting subtest: semaphore-codependency
[556.795550] Subtest semaphore-codependency: SUCCESS (0.021s)
[557.131369] [072/133] (463s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[557.220628] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[557.225630] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[557.333634] [073/133] (463s left) kms_flip (2x-flip-vs-fences)
[557.423354] Starting subtest: 2x-flip-vs-fences
[557.428581] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[557.522996] [074/133] (463s left) gem_ctx_persistence (legacy-engines-hostile)
[557.584201] Starting subtest: legacy-engines-hostile
[557.586681] Starting dynamic subtest: render
[557.652785] Dynamic subtest render: SUCCESS (0.067s)
[557.664864] Starting dynamic subtest: bsd1
[557.738828] Dynamic subtest bsd1: SUCCESS (0.084s)
[557.750963] Starting dynamic subtest: bsd2
[557.835282] Dynamic subtest bsd2: SUCCESS (0.093s)
[557.847655] Starting dynamic subtest: blt
[557.926098] Dynamic subtest blt: SUCCESS (0.088s)
[557.937801] Starting dynamic subtest: vebox
[558.021003] Dynamic subtest vebox: SUCCESS (0.092s)
[558.023808] Subtest legacy-engines-hostile: SUCCESS (0.437s)
[558.097505] [075/133] (463s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[558.164842] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[558.230199] [076/133] (462s left) perf (gen12-mi-rpc)
[558.363675] Starting subtest: gen12-mi-rpc
[558.366445] Starting dynamic subtest: rcs0
[558.383842] Dynamic subtest rcs0: SUCCESS (0.020s)
[558.386592] Subtest gen12-mi-rpc: SUCCESS (0.022s)
[558.432358] [077/133] (462s left) perf_pmu (init-sema)
[558.477356] Starting subtest: init-sema
[558.479483] Starting dynamic subtest: rcs0
[558.481652] Dynamic subtest rcs0: SUCCESS (0.004s)
[558.490655] Starting dynamic subtest: bcs0
[558.493272] Dynamic subtest bcs0: SUCCESS (0.001s)
[558.501851] Starting dynamic subtest: vcs0
[558.504294] Dynamic subtest vcs0: SUCCESS (0.001s)
[558.512639] Starting dynamic subtest: vcs1
[558.515135] Dynamic subtest vcs1: SUCCESS (0.001s)
[558.523465] Starting dynamic subtest: vecs0
[558.525622] Dynamic subtest vecs0: SUCCESS (0.001s)
[558.534293] Starting dynamic subtest: ccs0
[558.536650] Dynamic subtest ccs0: SUCCESS (0.001s)
[558.539236] Subtest init-sema: SUCCESS (0.021s)
[558.617150] [078/133] (462s left) syncobj_timeline (multi-wait-signaled)
[558.672145] Starting subtest: multi-wait-signaled
[558.674559] Subtest multi-wait-signaled: SUCCESS (0.001s)
[558.763309] [079/133] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[558.858497] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[558.862659] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[558.957332] [080/133] (462s left) gem_softpin (overlap)
[559.016602] Starting subtest: overlap
[559.878421] Subtest overlap: SUCCESS (0.860s)
[559.988628] [081/133] (461s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[560.055825] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[560.160707] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[560.236334] [082/133] (461s left) gem_exec_reloc (basic-gtt-noreloc)
[560.296610] Subtest basic-gtt-noreloc: SKIP (0.000s)
[560.372101] [083/133] (461s left) gem_wait (await)
[560.444233] Starting subtest: await
[560.446606] Starting dynamic subtest: all-engines
[561.580238] Dynamic subtest all-engines: SUCCESS (1.137s)
[561.597686] Starting dynamic subtest: rcs0
[562.642685] Dynamic subtest rcs0: SUCCESS (1.060s)
[562.658698] Starting dynamic subtest: bcs0
[563.703660] Dynamic subtest bcs0: SUCCESS (1.058s)
[563.719654] Starting dynamic subtest: vcs0
[564.761670] Dynamic subtest vcs0: SUCCESS (1.055s)
[564.778471] Starting dynamic subtest: vcs1
[565.819944] Dynamic subtest vcs1: SUCCESS (1.055s)
[565.836069] Starting dynamic subtest: vecs0
[566.876833] Dynamic subtest vecs0: SUCCESS (1.054s)
[566.894808] Starting dynamic subtest: ccs0
[567.939223] Dynamic subtest ccs0: SUCCESS (1.059s)
[567.942385] Subtest await: SUCCESS (7.494s)
[568.139401] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[568.143204] [084/133] (453s left) drm_mm (drm_mm)
[568.185256] Starting subtest: drm_mm
[568.193185] Starting dynamic subtest: drm_test_mm_init
[568.279679] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s)
[568.292040] Starting dynamic subtest: drm_test_mm_debug
[568.365073] Dynamic subtest drm_test_mm_debug: SUCCESS (0.084s)
[568.376190] Starting dynamic subtest: drm_test_mm_align32
[568.453987] Dynamic subtest drm_test_mm_align32: SUCCESS (0.089s)
[568.465251] Starting dynamic subtest: drm_test_mm_align64
[568.541115] Dynamic subtest drm_test_mm_align64: SUCCESS (0.086s)
[568.552247] Starting dynamic subtest: drm_test_mm_lowest
[568.627553] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.086s)
[568.638582] Starting dynamic subtest: drm_test_mm_highest
[568.718744] Dynamic subtest drm_test_mm_highest: SUCCESS (0.090s)
[568.721410] Subtest drm_mm: SUCCESS (0.534s)
[568.865700] [085/133] (452s left) gem_ctx_param (basic)
[568.917352] Starting subtest: basic
[568.920051] Subtest basic: SUCCESS (0.001s)
[569.019660] [086/133] (452s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[569.118173] Starting subtest: plane-primary-overlay-mutable-zpos
[572.547482] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.426s)
[573.739686] [087/133] (447s left) i915_module_load (resize-bar)
[573.782819] Starting subtest: resize-bar
[573.790629] Subtest resize-bar: SKIP (0.008s)
[573.838070] [088/133] (447s left) gem_exec_suspend (basic-s3)
[573.897605] Starting subtest: basic-S3
[573.899988] Starting dynamic subtest: smem
[594.699301] Dynamic subtest smem: SUCCESS (7.054s)
[594.702323] Subtest basic-S3: SUCCESS (7.057s)
[594.890355] [089/133] (426s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[595.015246] Starting subtest: basic-flip-after-cursor-atomic
[595.928782] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[596.735595] [090/133] (425s left) kms_lease (lease-revoke)
[596.836578] Starting subtest: lease-revoke
[596.839024] Starting dynamic subtest: pipe-A-eDP-1
[596.868565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[596.879303] Starting dynamic subtest: pipe-B-eDP-1
[596.902402] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.032s)
[596.912300] Starting dynamic subtest: pipe-C-eDP-1
[596.929292] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[596.941827] Starting dynamic subtest: pipe-D-eDP-1
[596.958187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[596.960982] Subtest lease-revoke: SUCCESS (0.124s)
[597.072735] [091/133] (424s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[597.163466] Starting subtest: 4-tiled-64bpp-rotate-90
[597.183190] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[597.285820] [092/133] (424s left) gem_exec_async (forked-writes)
[597.340828] Starting subtest: forked-writes
[597.343373] Starting dynamic subtest: rcs0
[597.368210] Dynamic subtest rcs0: SUCCESS (0.027s)
[597.379583] Starting dynamic subtest: bcs0
[597.390552] Dynamic subtest bcs0: SUCCESS (0.021s)
[597.400806] Starting dynamic subtest: vcs0
[597.411409] Dynamic subtest vcs0: SUCCESS (0.020s)
[597.423157] Starting dynamic subtest: vcs1
[597.434010] Dynamic subtest vcs1: SUCCESS (0.022s)
[597.443569] Starting dynamic subtest: vecs0
[597.454749] Dynamic subtest vecs0: SUCCESS (0.020s)
[597.465366] Starting dynamic subtest: ccs0
[597.480303] Dynamic subtest ccs0: SUCCESS (0.024s)
[597.483326] Subtest forked-writes: SUCCESS (0.140s)
[597.705077] [093/133] (424s left) kms_cursor_crc (cursor-random-32x10)
[597.859960] Starting subtest: cursor-random-32x10
[597.907253] Subtest cursor-random-32x10: SKIP (0.041s)
[598.136838] [094/133] (423s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[598.235786] Starting subtest: pr-cursor-plane-update-sf
[598.241006] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[598.307235] [095/133] (423s left) perf_pmu (all-busy-idle-check-all)
[598.344865] Starting subtest: all-busy-idle-check-all
[599.690883] Subtest all-busy-idle-check-all: SUCCESS (1.345s)
[599.785780] [096/133] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[599.875690] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[599.881305] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[599.974256] [097/133] (422s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[600.072300] Starting subtest: fbcpsr-slowdraw
[625.229237] Subtest fbcpsr-slowdraw: SUCCESS (25.145s)
[625.353508] [098/133] (396s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[625.464154] Starting subtest: x-tiled-8bpp-rotate-180
[626.645258] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.180s)
[626.781457] [099/133] (395s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[627.351841] Starting subtest: syncobj-backward-timeline-chain-engines
[627.467593] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.116s)
[628.766511] [100/133] (393s left) gem_eio (in-flight-external)
[628.972479] Starting subtest: in-flight-external
[630.749363] Subtest in-flight-external: SUCCESS (1.774s)
[630.872268] [101/133] (391s left) kms_pm_rpm (pm-caching)
[632.803743] Starting subtest: pm-caching
[632.809461] Subtest pm-caching: SKIP (0.000s)
[633.200472] [102/133] (389s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[633.270183] Starting subtest: invalid-smem-bo-on-discrete
[633.274956] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[633.402660] [103/133] (388s left) gem_eio (in-flight-internal-immediate)
[633.620435] Starting subtest: in-flight-internal-immediate
[634.767545] Subtest in-flight-internal-immediate: SUCCESS (1.145s)
[634.882759] [104/133] (387s left) api_intel_bb (delta-check)
[634.935269] Starting subtest: delta-check
[634.941018] Subtest delta-check: SUCCESS (0.007s)
[635.038785] [105/133] (387s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[635.124372] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[635.127113] Starting dynamic subtest: pipe-A-eDP-1
[635.195799] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[635.208008] Starting dynamic subtest: pipe-B-eDP-1
[635.275987] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[635.286294] Starting dynamic subtest: pipe-C-eDP-1
[635.354038] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[635.364199] Starting dynamic subtest: pipe-D-eDP-1
[635.431580] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[635.437407] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[637.346418] [106/133] (385s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[637.433169] Starting subtest: bad-pixel-format-yf-tiled-ccs
[637.435786] Starting dynamic subtest: pipe-A-eDP-1
[637.461793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.473802] Starting dynamic subtest: pipe-B-eDP-1
[637.499727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.509667] Starting dynamic subtest: pipe-C-eDP-1
[637.535549] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.545381] Starting dynamic subtest: pipe-D-eDP-1
[637.571365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.576240] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[639.638578] [107/133] (382s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[639.747432] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[639.752545] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[639.861677] [108/133] (382s left) gem_exec_fence (basic-wait-all)
[639.923565] Starting subtest: basic-wait-all
[640.015827] Subtest basic-wait-all: SUCCESS (0.093s)
[641.799600] [109/133] (380s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[641.902357] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[642.971956] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.070s)
[643.113417] [110/133] (379s left) syncobj_timeline (wait-all-snapshot)
[643.165308] Starting subtest: wait-all-snapshot
[643.247339] Subtest wait-all-snapshot: SUCCESS (0.084s)
[643.341207] [111/133] (379s left) kms_chamelium_color (ctm-negative)
[643.424899] Subtest ctm-negative: SKIP (0.000s)
[643.476405] [112/133] (379s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[643.591561] Starting subtest: cursorB-vs-flipA-legacy
[643.595973] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[643.740680] [113/133] (379s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[643.855164] Starting subtest: flip-vs-cursor-varying-size
[652.418104] Subtest flip-vs-cursor-varying-size: SUCCESS (8.559s)
[653.266374] [114/133] (369s left) kms_flip (flip-vs-panning)
[653.364200] Starting subtest: flip-vs-panning
[653.366707] Starting dynamic subtest: A-eDP1
[662.084545] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[662.096169] Starting dynamic subtest: B-eDP1
[670.823288] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[670.836715] Starting dynamic subtest: C-eDP1
[679.546145] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[679.555768] Starting dynamic subtest: D-eDP1
[688.270949] Dynamic subtest D-eDP1: SUCCESS (8.719s)
[688.275310] Subtest flip-vs-panning: SUCCESS (34.896s)
[689.431798] [115/133] (333s left) gem_create (create-ext-cpu-access-sanity-check)
[689.613366] Starting subtest: create-ext-cpu-access-sanity-check
[689.618458] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[689.695849] [116/133] (333s left) prime_busy (hang)
[689.757659] Starting subtest: hang
[689.760324] Starting dynamic subtest: rcs0
[716.202017] Dynamic subtest rcs0: SUCCESS (26.427s)
[716.214099] Starting dynamic subtest: bcs0
[723.352572] Dynamic subtest bcs0: SUCCESS (7.144s)
[723.364582] Starting dynamic subtest: vcs0
[730.327577] Dynamic subtest vcs0: SUCCESS (6.971s)
[730.338914] Starting dynamic subtest: vcs1
[737.361368] Dynamic subtest vcs1: SUCCESS (7.033s)
[737.374158] Starting dynamic subtest: vecs0
[744.343127] Dynamic subtest vecs0: SUCCESS (6.974s)
[744.355340] Starting dynamic subtest: ccs0
[758.182418] Dynamic subtest ccs0: SUCCESS (13.832s)
[758.185343] Subtest hang: SUCCESS (68.387s)
[758.294684] [117/133] (264s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[758.394668] Starting subtest: plane-lut1d-pre-ctm3x4
[758.530367] Starting dynamic subtest: pipe-A-plane-0
[758.889625] Dynamic subtest pipe-A-plane-0: FAIL (0.160s)
[758.901316] Starting dynamic subtest: pipe-A-plane-1
[759.138985] Dynamic subtest pipe-A-plane-1: FAIL (0.199s)
[759.149303] Starting dynamic subtest: pipe-A-plane-2
[759.393948] Dynamic subtest pipe-A-plane-2: FAIL (0.238s)
[760.399350] Starting dynamic subtest: pipe-B-plane-0
[760.897260] Dynamic subtest pipe-B-plane-0: FAIL (0.186s)
[760.910773] Starting dynamic subtest: pipe-B-plane-1
[761.255702] Dynamic subtest pipe-B-plane-1: FAIL (0.176s)
[761.265565] Starting dynamic subtest: pipe-B-plane-2
[761.557116] Dynamic subtest pipe-B-plane-2: FAIL (0.659s)
[762.593864] Starting dynamic subtest: pipe-C-plane-0
[763.160559] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[763.172144] Starting dynamic subtest: pipe-C-plane-1
[763.613546] Dynamic subtest pipe-C-plane-1: FAIL (0.706s)
[763.624408] Starting dynamic subtest: pipe-C-plane-2
[764.055239] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[764.822614] Starting dynamic subtest: pipe-D-plane-0
[765.521430] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[765.532394] Starting dynamic subtest: pipe-D-plane-1
[766.044141] Dynamic subtest pipe-D-plane-1: FAIL (0.680s)
[766.055020] Starting dynamic subtest: pipe-D-plane-2
[766.578853] Dynamic subtest pipe-D-plane-2: FAIL (0.615s)
[766.581203] Subtest plane-lut1d-pre-ctm3x4: FAIL (8.163s)
[767.390619] [118/133] (255s left) kms_psr (pr-sprite-mmap-gtt)
[767.485569] Starting subtest: pr-sprite-mmap-gtt
[767.490118] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[767.574292] [119/133] (255s left) i915_query (hwconfig_table)
[767.641565] Starting subtest: hwconfig_table
[768.003114] Subtest hwconfig_table: SUCCESS (0.001s)
[768.057963] [120/133] (255s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[768.165854] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[768.171005] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[768.266054] [121/133] (254s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[768.653693] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[769.498666] [122/133] (253s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[769.601795] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[769.606398] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[769.706819] [123/133] (253s left) gem_workarounds (basic-read)
[769.776881] Starting subtest: basic-read
[769.794185] Subtest basic-read: SUCCESS (0.017s)
[769.902824] [124/133] (253s left) gen9_exec_parse (secure-batches)
[769.966431] Subtest secure-batches: SKIP (0.000s)
[770.029055] [125/133] (253s left) syncobj_wait (multi-wait-for-submit-submitted)
[770.090586] Starting subtest: multi-wait-for-submit-submitted
[770.198259] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[770.280264] [126/133] (253s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[770.372983] Starting subtest: y-tiled-64bpp-rotate-270
[770.378422] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[770.468258] [127/133] (252s left) gem_mmap_gtt (flink-race)
[770.525317] Subtest flink-race: SKIP (0.000s)
[770.583780] [128/133] (252s left) syncobj_wait (wait-all-delayed-signal)
[770.643524] Starting subtest: wait-all-delayed-signal
[770.744694] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[770.826807] [129/133] (252s left) gem_exec_whisper (basic-fds-priority)
[770.891197] Starting subtest: basic-fds-priority
[796.992588] Subtest basic-fds-priority: SUCCESS (26.084s)
[797.177976] [130/133] (226s left) kms_plane (plane-position-hole-dpms)
[797.282241] Starting subtest: plane-position-hole-dpms
[797.806539] Starting dynamic subtest: pipe-A-plane-1
[800.220033] Dynamic subtest pipe-A-plane-1: SUCCESS (2.413s)
[800.232037] Starting dynamic subtest: pipe-A-plane-2
[802.552140] Dynamic subtest pipe-A-plane-2: SUCCESS (2.329s)
[802.564130] Starting dynamic subtest: pipe-A-plane-3
[804.912164] Dynamic subtest pipe-A-plane-3: SUCCESS (2.356s)
[804.923327] Starting dynamic subtest: pipe-A-plane-4
[807.323375] Dynamic subtest pipe-A-plane-4: SUCCESS (2.411s)
[807.334787] Starting dynamic subtest: pipe-A-plane-5
[807.350388] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[808.554319] Starting dynamic subtest: pipe-B-plane-1
[810.969059] Dynamic subtest pipe-B-plane-1: SUCCESS (2.422s)
[810.980528] Starting dynamic subtest: pipe-B-plane-2
[813.239745] Dynamic subtest pipe-B-plane-2: SUCCESS (2.270s)
[813.250113] Starting dynamic subtest: pipe-B-plane-3
[815.627557] Dynamic subtest pipe-B-plane-3: SUCCESS (2.385s)
[815.638631] Starting dynamic subtest: pipe-B-plane-4
[818.022246] Dynamic subtest pipe-B-plane-4: SUCCESS (2.393s)
[818.033633] Starting dynamic subtest: pipe-B-plane-5
[818.048247] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[818.050806] Subtest plane-position-hole-dpms: SUCCESS (20.756s)
[818.900719] [131/133] (204s left) i915_pm_rpm (gem-mmap-type)
[820.836890] Starting subtest: gem-mmap-type
[820.839885] Starting dynamic subtest: wb-smem0
[824.606347] Dynamic subtest wb-smem0: SUCCESS (3.770s)
[824.616850] Starting dynamic subtest: wc-smem0
[827.748932] Dynamic subtest wc-smem0: SUCCESS (3.138s)
[827.759260] Starting dynamic subtest: uc-smem0
[830.605355] Dynamic subtest uc-smem0: SUCCESS (2.855s)
[830.608018] Subtest gem-mmap-type: SUCCESS (9.768s)
[830.692447] [132/133] (192s left) kms_vblank (ts-continuation-idle-hang)
[830.793226] Starting subtest: ts-continuation-idle-hang
[830.795406] Starting dynamic subtest: pipe-A-eDP-1
[857.417444] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.610s)
[857.433862] Starting dynamic subtest: pipe-D-eDP-1
[882.438560] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.008s)
[882.441547] Subtest ts-continuation-idle-hang: SUCCESS (51.621s)
[883.266746] [133/133] (140s left) syncobj_wait (invalid-reset-bad-pad)
[883.329558] Starting subtest: invalid-reset-bad-pad
[883.332397] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[883.407413] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_display_modes
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_media_vme
results: parsing output: 24/ for test: kms_invalid_mode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_tiled_fence_blits
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_universal_plane
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_gpgpu_fill
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_pipe_b_c_ivb
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: drm_mm
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_atomic
results: parsing output: 86/ for test: i915_module_load
results: parsing output: 87/ for test: gem_exec_suspend
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_exec_async
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_chamelium_color
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: kms_color_pipeline
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_workarounds
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: syncobj_wait
Done.