[59.548195] Initializing watchdogs
[59.548323]   /dev/watchdog0
[59.566488] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.571076] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.573253] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.576586] [001/155] (960s left) kms_cursor_crc (cursor-sliding-256x85)
[59.860753] Starting subtest: cursor-sliding-256x85
[59.911881] Subtest cursor-sliding-256x85: SKIP (0.045s)
[60.062986] [002/155] (960s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[60.187217] Starting subtest: basic-busy-flip-before-cursor-atomic
[60.191908] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[60.330383] [003/155] (959s left) perf_pmu (busy)
[60.372131] Starting subtest: busy
[60.374246] Starting dynamic subtest: rcs0
[60.957860] Dynamic subtest rcs0: SUCCESS (0.581s)
[60.969105] Starting dynamic subtest: bcs0
[61.522618] Dynamic subtest bcs0: SUCCESS (0.560s)
[61.536048] Starting dynamic subtest: vcs0
[63.291619] Dynamic subtest vcs0: SUCCESS (1.756s)
[63.303360] Starting dynamic subtest: vcs1
[65.277910] Dynamic subtest vcs1: SUCCESS (1.976s)
[65.288461] Starting dynamic subtest: vecs0
[67.259600] Dynamic subtest vecs0: SUCCESS (1.973s)
[67.270204] Starting dynamic subtest: ccs0
[67.828705] Dynamic subtest ccs0: SUCCESS (0.567s)
[67.831265] Subtest busy: SUCCESS (7.422s)
[67.927176] [004/155] (952s left) kms_setmode (invalid-clone-single-crtc)
[67.975831] Starting subtest: invalid-clone-single-crtc
[67.982606] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[68.101111] [005/155] (952s left) kms_cursor_crc (cursor-onscreen-64x64)
[68.281839] Starting subtest: cursor-onscreen-64x64
[68.297200] Starting dynamic subtest: pipe-A-eDP-1
[70.443097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.143s)
[70.475342] Starting dynamic subtest: pipe-D-eDP-1
[73.367848] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.895s)
[73.370501] Subtest cursor-onscreen-64x64: SUCCESS (5.077s)
[74.218326] [006/155] (946s left) kms_chamelium_edid (hdmi-mode-timings)
[74.608282] Subtest hdmi-mode-timings: SKIP (0.000s)
[75.436251] [007/155] (944s left) kms_addfb_basic (addfb25-4-tiled)
[75.540864] Starting subtest: addfb25-4-tiled
[75.542880] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[75.640328] [008/155] (944s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[75.747119] Starting subtest: 4-tiled-8bpp-rotate-180
[76.928402] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.181s)
[77.062078] [009/155] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[77.161381] Starting subtest: fbcpsr-2p-rte
[77.164869] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[77.286750] [010/155] (943s left) gen9_exec_parse (allowed-all)
[77.335988] Subtest allowed-all: SKIP (0.000s)
[77.392648] [011/155] (943s left) sw_sync (sync_busy_fork)
[77.422270] Starting subtest: sync_busy_fork
[78.435855] Subtest sync_busy_fork: SUCCESS (1.010s)
[78.522296] [012/155] (942s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[78.613088] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[78.617621] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.718508] [013/155] (941s left) syncobj_timeline (invalid-query-zero-handles)
[78.766139] Starting subtest: invalid-query-zero-handles
[78.768499] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[78.875821] [014/155] (941s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[78.978528] Starting subtest: stress-xrgb8888-ytiled
[78.983180] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[79.068885] [015/155] (941s left) gem_exec_params (rel-constants-invalid-ring)
[79.129619] Starting subtest: rel-constants-invalid-ring
[79.132153] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[79.243312] [016/155] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[79.351875] Starting subtest: psr-2p-primscrn-spr-indfb-move
[79.356847] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[79.445046] [017/155] (941s left) gem_ctx_persistence (heartbeat-hostile)
[79.507306] Starting subtest: heartbeat-hostile
[79.511587] Subtest heartbeat-hostile: SKIP (0.000s)
[79.606189] [018/155] (941s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[79.712065] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[79.714091] Starting dynamic subtest: pipe-A-eDP-1
[90.708881] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.994s)
[90.717877] Starting dynamic subtest: pipe-B-eDP-1
[102.491968] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.780s)
[102.494429] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.778s)
[103.337542] [019/155] (917s left) perf_pmu (invalid-init)
[103.384825] Starting subtest: invalid-init
[103.387219] Subtest invalid-init: SUCCESS (0.000s)
[103.480718] [020/155] (917s left) sriov_basic (enable-vfs-autoprobe-on)
[103.538542] Starting subtest: enable-vfs-autoprobe-on
[103.540678] Starting dynamic subtest: numvfs-1
[103.545071] Dynamic subtest numvfs-1: SKIP (0.001s)
[103.553486] Starting dynamic subtest: numvfs-2
[103.557747] Dynamic subtest numvfs-2: SKIP (0.001s)
[103.565776] Starting dynamic subtest: numvfs-3
[103.570139] Dynamic subtest numvfs-3: SKIP (0.001s)
[103.577597] Starting dynamic subtest: numvfs-4
[103.581611] Dynamic subtest numvfs-4: SKIP (0.000s)
[103.589080] Starting dynamic subtest: numvfs-5
[103.593043] Dynamic subtest numvfs-5: SKIP (0.000s)
[103.600460] Starting dynamic subtest: numvfs-6
[103.604446] Dynamic subtest numvfs-6: SKIP (0.001s)
[103.612011] Starting dynamic subtest: numvfs-7
[103.615925] Dynamic subtest numvfs-7: SKIP (0.000s)
[103.623501] Starting dynamic subtest: numvfs-random
[103.627491] Dynamic subtest numvfs-random: SKIP (0.001s)
[103.635044] Starting dynamic subtest: numvfs-all
[103.638986] Dynamic subtest numvfs-all: SKIP (0.000s)
[103.642841] Subtest enable-vfs-autoprobe-on: SKIP (0.008s)
[103.675843] [021/155] (917s left) gem_mmap_offset (open-flood)
[103.731969] Starting subtest: open-flood
[125.221990] Subtest open-flood: SUCCESS (21.490s)
[125.330887] [022/155] (895s left) api_intel_allocator (alloc-simple)
[125.388268] Starting subtest: alloc-simple
[125.392447] Subtest alloc-simple: SUCCESS (0.006s)
[125.526635] [023/155] (895s left) kms_fbcon_fbt (psr-suspend)
[125.581057] Starting subtest: psr-suspend
[174.969103] Subtest psr-suspend: SUCCESS (19.838s)
[175.057441] [024/155] (845s left) kms_frontbuffer_tracking (hdr-1p-rte)
[175.163354] Starting subtest: hdr-1p-rte
[175.167937] Subtest hdr-1p-rte: SKIP (0.000s)
[175.270189] [025/155] (845s left) kms_color (invalid-ctm-matrix-sizes)
[175.368225] Starting subtest: invalid-ctm-matrix-sizes
[175.370465] Starting dynamic subtest: pipe-A
[175.372805] Dynamic subtest pipe-A: SUCCESS (0.003s)
[175.383607] Starting dynamic subtest: pipe-B
[175.385889] Dynamic subtest pipe-B: SUCCESS (0.003s)
[175.395247] Starting dynamic subtest: pipe-C
[175.397618] Dynamic subtest pipe-C: SUCCESS (0.004s)
[175.407025] Starting dynamic subtest: pipe-D
[175.409322] Dynamic subtest pipe-D: SUCCESS (0.004s)
[175.411440] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[175.453946] [026/155] (845s left) gem_mmap (basic-small-bo)
[175.504691] Subtest basic-small-bo: SKIP (0.000s)
[175.557835] [027/155] (845s left) kms_hdr (bpc-switch-dpms)
[175.637477] Starting subtest: bpc-switch-dpms
[175.639852] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[181.167599] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.484s)
[181.178614] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[186.977066] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.784s)
[186.979605] Subtest bpc-switch-dpms: SUCCESS (11.271s)
[187.098279] [028/155] (834s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[187.188607] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[187.190952] Starting dynamic subtest: pipe-A-eDP-1
[187.924317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[187.936217] Starting dynamic subtest: pipe-B-eDP-1
[189.746321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.817s)
[189.755148] Starting dynamic subtest: pipe-C-eDP-1
[191.515299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.761s)
[191.526419] Starting dynamic subtest: pipe-D-eDP-1
[193.336919] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.818s)
[193.338825] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.129s)
[194.497949] [029/155] (826s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[194.603098] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[194.607497] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[194.706455] [030/155] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[194.807215] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[194.811460] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[194.887004] [031/155] (826s left) gem_exec_gttfill (basic)
[194.942724] Starting subtest: basic
[197.656027] Subtest basic: SUCCESS (2.708s)
[197.840677] [032/155] (823s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[198.004390] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[198.008676] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[198.128979] [033/155] (823s left) kms_psr (fbc-pr-primary-mmap-gtt)
[198.229640] Starting subtest: fbc-pr-primary-mmap-gtt
[198.234135] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[198.298842] [034/155] (823s left) i915_hangman (hangcheck-unterminated)
[198.377342] Starting subtest: hangcheck-unterminated
[209.584603] Subtest hangcheck-unterminated: SUCCESS (11.204s)
[209.716598] [035/155] (811s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[209.820261] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[209.822551] Starting dynamic subtest: pipe-A-default-mode
[210.958620] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[210.962473] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.138s)
[211.132027] [036/155] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[211.240069] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[211.243978] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[211.336762] [037/155] (810s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[211.406323] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[211.410647] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[211.583434] [038/155] (809s left) gem_mmap_gtt (close-race)
[211.636763] Subtest close-race: SKIP (0.000s)
[211.698857] [039/155] (809s left) kms_prime (basic-crc-hybrid)
[211.783185] Subtest basic-crc-hybrid: SKIP (0.000s)
[211.933712] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[211.937108] [040/155] (809s left) i915_drm_fdinfo (busy-hang)
[211.980937] Starting subtest: busy-hang
[211.982795] Starting dynamic subtest: rcs0
[212.010907] Dynamic subtest rcs0: SKIP (0.030s)
[212.023182] Starting dynamic subtest: bcs0
[212.027344] Dynamic subtest bcs0: SKIP (0.001s)
[212.036745] Starting dynamic subtest: vcs0
[212.041285] Dynamic subtest vcs0: SKIP (0.000s)
[212.050144] Starting dynamic subtest: vcs1
[212.054258] Dynamic subtest vcs1: SKIP (0.000s)
[212.063215] Starting dynamic subtest: vecs0
[212.067323] Dynamic subtest vecs0: SKIP (0.000s)
[212.076221] Starting dynamic subtest: ccs0
[212.080304] Dynamic subtest ccs0: SKIP (0.000s)
[212.084334] Subtest busy-hang: SKIP (0.036s)
[212.121604] [041/155] (809s left) core_hotunplug (unbind-rebind)
[212.228046] Starting subtest: unbind-rebind
[219.430705] Subtest unbind-rebind: SUCCESS (7.203s)
[219.474217] [042/155] (802s left) kms_psr (fbc-psr2-suspend)
[220.635856] Starting subtest: fbc-psr2-suspend
[220.638194] Starting dynamic subtest: eDP-1
[220.642590] Dynamic subtest eDP-1: SKIP (0.000s)
[220.646901] Subtest fbc-psr2-suspend: SKIP (0.001s)
[220.711792] [043/155] (801s left) gem_exec_balancer (nop)
[220.774822] Starting subtest: nop
[267.439116] Subtest nop: SUCCESS (46.648s)
[267.755681] [044/155] (754s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[267.853052] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[267.857281] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[267.955195] [045/155] (753s left) syncobj_wait (multi-wait-for-submit-submitted)
[268.022760] Starting subtest: multi-wait-for-submit-submitted
[268.124266] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[268.205338] [046/155] (753s left) gem_exec_params (invalid-bsd2-flag-on-render)
[268.275040] Starting subtest: invalid-bsd2-flag-on-render
[268.277405] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[268.385903] [047/155] (753s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[268.480179] Starting subtest: hdr-indfb-scaledprimary
[268.484351] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[268.594186] [048/155] (753s left) gem_exec_gttfill (multigpu-basic)
[268.759439] Starting subtest: multigpu-basic
[281.027055] Subtest multigpu-basic: SUCCESS (12.273s)
[281.108093] [049/155] (740s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[281.247435] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[281.251850] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[281.354884] [050/155] (740s left) kms_atomic (test-only)
[281.453476] Starting subtest: test-only
[281.544907] Starting dynamic subtest: pipe-A-eDP-1
[284.047843] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[284.050094] Subtest test-only: SUCCESS (2.596s)
[284.856579] [051/155] (737s left) kms_content_protection (legacy-hdcp14)
[285.000210] Starting subtest: legacy-hdcp14
[285.004795] Subtest legacy-hdcp14: SKIP (0.000s)
[285.136251] [052/155] (737s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[285.523675] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[286.376444] [053/155] (735s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[286.473516] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[286.475862] Starting dynamic subtest: pipe-A-default-mode
[289.219052] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[289.221378] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.745s)
[290.086850] [054/155] (732s left) gem_exec_reloc (basic-write-cpu-noreloc)
[290.142750] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[290.221093] [055/155] (732s left) kms_dsc (dsc-fractional-bpp)
[290.305363] Starting subtest: dsc-fractional-bpp
[290.318395] Subtest dsc-fractional-bpp: SKIP (0.000s)
[290.388387] [056/155] (731s left) kms_psr (psr2-cursor-blt)
[290.494437] Starting subtest: psr2-cursor-blt
[290.496628] Starting dynamic subtest: eDP-1
[292.165846] Dynamic subtest eDP-1: SUCCESS (1.672s)
[292.168180] Subtest psr2-cursor-blt: SUCCESS (1.673s)
[293.051390] [057/155] (729s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[293.160301] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[293.164393] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[293.252331] [058/155] (729s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[293.346978] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[293.351133] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[293.437984] [059/155] (729s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[293.505011] Starting subtest: y-tiled-ccs-to-y-tiled
[293.509665] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[293.690818] [060/155] (728s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[293.794236] Starting subtest: yf-tiled-64bpp-rotate-180
[293.798805] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[293.887835] [061/155] (728s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[293.949065] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[293.951564] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[294.048734] [062/155] (728s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[294.149326] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[294.151600] Starting dynamic subtest: pipe-A-eDP-1
[294.972089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[294.982514] Starting dynamic subtest: pipe-B-eDP-1
[296.470298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.494s)
[296.481796] Starting dynamic subtest: pipe-C-eDP-1
[297.973411] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[297.984000] Starting dynamic subtest: pipe-D-eDP-1
[299.491286] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s)
[299.493426] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.334s)
[300.671907] [063/155] (721s left) kms_selftest (drm_plane_helper)
[300.716451] Starting subtest: drm_plane_helper
[300.740970] Starting dynamic subtest: drm_test_check_plane_state
[300.848317] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.108s)
[300.858741] Starting dynamic subtest: drm_test_check_invalid_plane_state
[300.948547] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.099s)
[300.950960] Subtest drm_plane_helper: SUCCESS (0.232s)
[301.142203] [064/155] (721s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[301.247443] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[301.251320] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[301.367604] [065/155] (721s left) gem_render_copy (linear-to-vebox-y-tiled)
[301.432985] Starting subtest: linear-to-vebox-y-tiled
[301.437432] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[301.615918] [066/155] (721s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[301.719320] Starting subtest: psr-shrfb-scaledprimary
[307.520427] Subtest psr-shrfb-scaledprimary: SUCCESS (5.805s)
[307.646116] [067/155] (715s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[307.734246] Starting subtest: plane-upscale-20x20-with-modifiers
[307.736566] Starting dynamic subtest: pipe-A
[308.070046] Dynamic subtest pipe-A: SUCCESS (0.338s)
[308.083517] Starting dynamic subtest: pipe-B
[309.475308] Dynamic subtest pipe-B: SUCCESS (1.404s)
[309.485826] Starting dynamic subtest: pipe-C
[311.123342] Dynamic subtest pipe-C: SUCCESS (1.647s)
[311.134138] Starting dynamic subtest: pipe-D
[312.563513] Dynamic subtest pipe-D: SUCCESS (1.439s)
[312.565863] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.832s)
[313.754549] [068/155] (709s left) gem_exec_flush (basic-wb-pro-default)
[313.824091] Starting subtest: basic-wb-pro-default
[319.280549] Subtest basic-wb-pro-default: SUCCESS (5.456s)
[319.467172] [069/155] (703s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[319.566242] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[319.570272] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[319.664808] [070/155] (703s left) gem_pread (self)
[319.725131] Subtest self: SKIP (0.000s)
[319.800185] [071/155] (703s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[319.908462] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[327.212289] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.308s)
[328.374024] [072/155] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[328.477443] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[328.481842] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[328.579032] [073/155] (694s left) kms_psr (psr-primary-page-flip)
[328.669757] Starting subtest: psr-primary-page-flip
[328.672037] Starting dynamic subtest: eDP-1
[330.444469] Dynamic subtest eDP-1: SUCCESS (1.773s)
[330.447087] Subtest psr-primary-page-flip: SUCCESS (1.774s)
[331.329619] [074/155] (691s left) gem_eio (in-flight-10ms)
[331.562023] Starting subtest: in-flight-10ms
[340.535176] Subtest in-flight-10ms: SUCCESS (8.973s)
[340.666812] [075/155] (682s left) kms_plane_multiple (2x-tiling-none)
[340.771207] Starting subtest: 2x-tiling-none
[340.775273] Subtest 2x-tiling-none: SKIP (0.000s)
[340.855682] [076/155] (682s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[340.953275] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[340.959373] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[341.050032] [077/155] (682s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[341.159790] Starting subtest: basic-flip-after-cursor-atomic
[342.084460] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.922s)
[342.951789] [078/155] (680s left) kms_mmap_write_crc (main)
[343.040070] Starting subtest: main
[343.042415] Starting dynamic subtest: pipe-A-eDP-1
[346.470781] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[346.472699] Subtest main: SUCCESS (3.427s)
[347.286940] [079/155] (676s left) gem_mmap_gtt (big-copy-odd)
[347.335614] Subtest big-copy-odd: SKIP (0.000s)
[347.422101] [080/155] (675s left) gem_exec_await (wide-all)
[347.602827] Starting subtest: wide-all
[370.340516] Subtest wide-all: SUCCESS (22.729s)
[370.543961] [081/155] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[370.692825] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[370.697109] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[370.797320] [082/155] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[370.901606] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[370.905571] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[371.011697] [083/155] (652s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[371.145026] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[371.149605] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[371.289840] [084/155] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt)
[371.390872] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt
[371.394944] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[371.496410] [085/155] (652s left) gem_exec_reloc (basic-wc)
[371.563417] Subtest basic-wc: SKIP (0.000s)
[371.642799] [086/155] (652s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[371.730874] Starting subtest: x-tiled-64bpp-rotate-180
[373.223533] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.490s)
[373.406415] [087/155] (650s left) gem_eio (in-flight-internal-1us)
[373.628381] Starting subtest: in-flight-internal-1us
[374.681876] Subtest in-flight-internal-1us: SUCCESS (1.050s)
[374.825093] [088/155] (648s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[374.929003] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[374.933244] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[375.019100] [089/155] (648s left) gem_exec_schedule (u-fairslice)
[375.101702] Starting subtest: u-fairslice
[375.103892] Starting dynamic subtest: rcs0
[377.126475] Dynamic subtest rcs0: SUCCESS (2.028s)
[377.136839] Starting dynamic subtest: bcs0
[379.143967] Dynamic subtest bcs0: SUCCESS (2.018s)
[379.155307] Starting dynamic subtest: vcs0
[381.166146] Dynamic subtest vcs0: SUCCESS (2.020s)
[381.179879] Starting dynamic subtest: vcs1
[383.186852] Dynamic subtest vcs1: SUCCESS (2.017s)
[383.198396] Starting dynamic subtest: vecs0
[385.207535] Dynamic subtest vecs0: SUCCESS (2.019s)
[385.220146] Starting dynamic subtest: ccs0
[387.233737] Dynamic subtest ccs0: SUCCESS (2.026s)
[387.236091] Subtest u-fairslice: SUCCESS (12.135s)
[387.552789] [090/155] (636s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[387.650402] Starting subtest: yf-tiled-16bpp-rotate-90
[387.654344] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[387.755438] [091/155] (636s left) gem_softpin (noreloc-s3)
[387.813212] Starting subtest: noreloc-S3
[408.174876] Subtest noreloc-S3: SUCCESS (5.418s)
[408.369342] [092/155] (615s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[408.475837] Starting subtest: 2x-flip-vs-rmfb-interruptible
[408.486311] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[408.593450] [093/155] (615s left) kms_psr (psr2-sprite-plane-move)
[408.692176] Starting subtest: psr2-sprite-plane-move
[408.694576] Starting dynamic subtest: eDP-1
[410.442636] Dynamic subtest eDP-1: SUCCESS (1.729s)
[410.445598] Subtest psr2-sprite-plane-move: SUCCESS (1.730s)
[411.294773] [094/155] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[411.401388] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[411.406616] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[411.515437] [095/155] (612s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[411.622473] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[411.625447] Starting dynamic subtest: pipe-A
[412.757846] Dynamic subtest pipe-A: SUCCESS (1.128s)
[412.768523] Starting dynamic subtest: pipe-B
[415.052911] Dynamic subtest pipe-B: SUCCESS (2.277s)
[415.064462] Starting dynamic subtest: pipe-C
[416.244664] Dynamic subtest pipe-C: SUCCESS (1.184s)
[416.256958] Starting dynamic subtest: pipe-D
[417.477437] Dynamic subtest pipe-D: SUCCESS (1.226s)
[417.480482] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.818s)
[418.670463] [096/155] (605s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[418.774396] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[418.779632] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[418.872586] [097/155] (605s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[418.969709] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[418.974538] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[419.067817] [098/155] (605s left) gem_wait (write-wait)
[419.123479] Starting subtest: write-wait
[419.126401] Starting dynamic subtest: all-engines
[420.232221] Dynamic subtest all-engines: SUCCESS (1.104s)
[420.250419] Starting dynamic subtest: rcs0
[421.300857] Dynamic subtest rcs0: SUCCESS (1.063s)
[421.320928] Starting dynamic subtest: bcs0
[422.368092] Dynamic subtest bcs0: SUCCESS (1.061s)
[422.387620] Starting dynamic subtest: vcs0
[423.429279] Dynamic subtest vcs0: SUCCESS (1.056s)
[423.448226] Starting dynamic subtest: vcs1
[424.487520] Dynamic subtest vcs1: SUCCESS (1.054s)
[424.506582] Starting dynamic subtest: vecs0
[425.548141] Dynamic subtest vecs0: SUCCESS (1.056s)
[425.565641] Starting dynamic subtest: ccs0
[426.612874] Dynamic subtest ccs0: SUCCESS (1.060s)
[426.615757] Subtest write-wait: SUCCESS (7.471s)
[426.811385] [099/155] (597s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[426.908464] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[426.913859] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[427.012499] [100/155] (597s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[427.121215] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[427.126459] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[427.224960] [101/155] (597s left) api_intel_bb (destroy-bb)
[427.290048] Starting subtest: destroy-bb
[427.297251] Subtest destroy-bb: SUCCESS (0.008s)
[427.418489] [102/155] (596s left) kms_invalid_mode (bad-vtotal)
[427.512121] Starting subtest: bad-vtotal
[427.514439] Starting dynamic subtest: pipe-A-eDP-1
[427.807499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[427.820406] Starting dynamic subtest: pipe-B-eDP-1
[427.823227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[427.834505] Starting dynamic subtest: pipe-C-eDP-1
[427.836885] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[427.850582] Starting dynamic subtest: pipe-D-eDP-1
[427.853031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[427.855524] Subtest bad-vtotal: SUCCESS (0.300s)
[428.634161] [103/155] (595s left) syncobj_timeline (single-wait-available-signaled)
[428.687302] Starting subtest: single-wait-available-signaled
[428.690193] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[428.784847] [104/155] (595s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[428.884283] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[436.244413] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.361s)
[436.367831] [105/155] (588s left) perf_pmu (faulting-read)
[436.406605] Starting subtest: faulting-read
[436.409413] Starting dynamic subtest: wb
[436.411885] Dynamic subtest wb: SUCCESS (0.001s)
[436.423055] Starting dynamic subtest: wc
[436.425053] Dynamic subtest wc: SUCCESS (0.000s)
[436.435385] Starting dynamic subtest: uc
[436.437435] Dynamic subtest uc: SUCCESS (0.000s)
[436.440310] Subtest faulting-read: SUCCESS (0.003s)
[436.523247] [106/155] (588s left) kms_big_fb (linear-16bpp-rotate-180)
[436.629825] Starting subtest: linear-16bpp-rotate-180
[437.986435] Subtest linear-16bpp-rotate-180: SUCCESS (1.356s)
[438.109122] [107/155] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[438.205589] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[444.689930] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.490s)
[444.804397] [108/155] (579s left) gem_exec_schedule (lateslice)
[444.882341] Starting subtest: lateslice
[444.884623] Starting dynamic subtest: rcs0
[444.892264] Dynamic subtest rcs0: SUCCESS (0.021s)
[444.902954] Starting dynamic subtest: bcs0
[444.910147] Dynamic subtest bcs0: SUCCESS (0.017s)
[444.924078] Starting dynamic subtest: vcs0
[444.931368] Dynamic subtest vcs0: SUCCESS (0.020s)
[444.942662] Starting dynamic subtest: vcs1
[444.952397] Dynamic subtest vcs1: SUCCESS (0.021s)
[444.963626] Starting dynamic subtest: vecs0
[444.970448] Dynamic subtest vecs0: SUCCESS (0.017s)
[444.981622] Starting dynamic subtest: ccs0
[444.986286] Dynamic subtest ccs0: SUCCESS (0.016s)
[444.988787] Subtest lateslice: SUCCESS (0.116s)
[446.578458] [109/155] (578s left) gem_lmem_swapping (massive-random)
[446.626433] Subtest massive-random: SKIP (0.000s)
[446.676461] [110/155] (578s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[446.769970] Starting subtest: y-tiled-8bpp-rotate-270
[446.774481] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[446.863954] [111/155] (577s left) prime_mmap_coherency (write)
[446.923452] Starting subtest: write
[452.299674] Subtest write: SUCCESS (5.374s)
[452.464087] [112/155] (572s left) kms_flip (busy-flip)
[452.563098] Starting subtest: busy-flip
[452.565587] Starting dynamic subtest: A-eDP1
[454.228141] Dynamic subtest A-eDP1: SUCCESS (1.664s)
[454.242102] Starting dynamic subtest: B-eDP1
[455.965511] Dynamic subtest B-eDP1: SUCCESS (1.734s)
[455.979846] Starting dynamic subtest: C-eDP1
[457.686590] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[457.698349] Starting dynamic subtest: D-eDP1
[459.341444] Dynamic subtest D-eDP1: SUCCESS (1.652s)
[459.347466] Subtest busy-flip: SUCCESS (6.782s)
[460.500000] [113/155] (564s left) gem_mmap_gtt (basic)
[460.552227] Subtest basic: SKIP (0.000s)
[460.610429] [114/155] (564s left) kms_cursor_crc (cursor-random-32x32)
[460.753529] Starting subtest: cursor-random-32x32
[460.798510] Subtest cursor-random-32x32: SKIP (0.038s)
[461.087310] [115/155] (563s left) gem_softpin (evict-prime)
[461.148168] Starting subtest: evict-prime
[461.151281] Starting dynamic subtest: rcs0
[462.317632] Dynamic subtest rcs0: SUCCESS (1.169s)
[462.329874] Starting dynamic subtest: bcs0
[463.442579] Dynamic subtest bcs0: SUCCESS (1.123s)
[463.454892] Starting dynamic subtest: vcs0
[465.519604] Dynamic subtest vcs0: SUCCESS (2.073s)
[465.538812] Starting dynamic subtest: vcs1
[467.501389] Dynamic subtest vcs1: SUCCESS (1.979s)
[467.515207] Starting dynamic subtest: vecs0
[469.489028] Dynamic subtest vecs0: SUCCESS (1.985s)
[469.502632] Starting dynamic subtest: ccs0
[470.602594] Dynamic subtest ccs0: SUCCESS (1.111s)
[470.615145] Starting dynamic subtest: all
[472.488997] Dynamic subtest all: SUCCESS (1.884s)
[472.491887] Subtest evict-prime: SUCCESS (11.337s)
[472.600457] [116/155] (552s left) gem_eio (in-flight-immediate)
[472.839038] Starting subtest: in-flight-immediate
[481.304767] Subtest in-flight-immediate: SUCCESS (8.461s)
[481.460722] [117/155] (543s left) gem_exec_fence (keep-in-fence)
[481.632417] Starting subtest: keep-in-fence
[481.635468] Starting dynamic subtest: rcs0
[481.697634] Dynamic subtest rcs0: SUCCESS (0.065s)
[481.712657] Starting dynamic subtest: bcs0
[481.757577] Dynamic subtest bcs0: SUCCESS (0.057s)
[481.771630] Starting dynamic subtest: vcs0
[483.496482] Dynamic subtest vcs0: SUCCESS (1.735s)
[483.509339] Starting dynamic subtest: vcs1
[485.481327] Dynamic subtest vcs1: SUCCESS (1.981s)
[485.496607] Starting dynamic subtest: vecs0
[487.529299] Dynamic subtest vecs0: SUCCESS (2.044s)
[487.542610] Starting dynamic subtest: ccs0
[487.763342] Dynamic subtest ccs0: SUCCESS (0.232s)
[487.766491] Subtest keep-in-fence: SUCCESS (6.130s)
[489.607363] [118/155] (535s left) gem_exec_fence (basic-wait)
[489.784280] Starting subtest: basic-wait
[489.787330] Starting dynamic subtest: rcs0
[489.871525] Dynamic subtest rcs0: SUCCESS (0.087s)
[489.886394] Starting dynamic subtest: bcs0
[489.931006] Dynamic subtest bcs0: SUCCESS (0.058s)
[489.944218] Starting dynamic subtest: vcs0
[489.985829] Dynamic subtest vcs0: SUCCESS (0.053s)
[489.999453] Starting dynamic subtest: vcs1
[490.048852] Dynamic subtest vcs1: SUCCESS (0.061s)
[490.061675] Starting dynamic subtest: vecs0
[490.108022] Dynamic subtest vecs0: SUCCESS (0.057s)
[490.119613] Starting dynamic subtest: ccs0
[490.169227] Dynamic subtest ccs0: SUCCESS (0.059s)
[490.172203] Subtest basic-wait: SUCCESS (0.386s)
[491.582660] [119/155] (533s left) gem_exec_whisper (basic-forked-all)
[491.646662] Starting subtest: basic-forked-all
[506.266168] Subtest basic-forked-all: SUCCESS (14.619s)
[506.465862] [120/155] (518s left) kms_psr (fbc-psr-sprite-blt)
[506.568608] Starting subtest: fbc-psr-sprite-blt
[506.571288] Starting dynamic subtest: eDP-1
[506.576239] Dynamic subtest eDP-1: SKIP (0.000s)
[506.581193] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[506.645451] [121/155] (518s left) gem_create (create-clear)
[506.707966] Starting subtest: create-clear
[506.710021] Starting dynamic subtest: smem0
[539.498663] Dynamic subtest smem0: SUCCESS (32.790s)
[539.501169] Subtest create-clear: SUCCESS (32.792s)
[539.693506] [122/155] (485s left) kms_vblank (ts-continuation-dpms-rpm)
[539.795420] Starting subtest: ts-continuation-dpms-rpm
[539.798323] Starting dynamic subtest: pipe-A-eDP-1
[542.295607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[542.314999] Starting dynamic subtest: pipe-D-eDP-1
[544.540912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[544.543597] Subtest ts-continuation-dpms-rpm: SUCCESS (4.746s)
[545.421313] [123/155] (479s left) i915_pm_rpm (gem-idle)
[547.651037] Starting subtest: gem-idle
[553.857936] Subtest gem-idle: SUCCESS (6.204s)
[554.201373] [124/155] (471s left) gem_ctx_param (invalid-get-ringsize)
[555.468609] Starting subtest: invalid-get-ringsize
[555.471222] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[555.596996] [125/155] (469s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[555.698482] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[555.703400] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.807001] [126/155] (469s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[555.905769] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[555.908296] Starting dynamic subtest: pipe-A-eDP-1
[555.934888] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.946629] Starting dynamic subtest: pipe-B-eDP-1
[555.972542] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.983505] Starting dynamic subtest: pipe-C-eDP-1
[556.009062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.019579] Starting dynamic subtest: pipe-D-eDP-1
[556.046407] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.051604] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[558.166492] [127/155] (467s left) syncobj_eventfd (timeline-wait)
[558.214325] Starting subtest: timeline-wait
[558.222936] Subtest timeline-wait: SUCCESS (0.010s)
[558.298883] [128/155] (467s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[558.389338] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[558.391866] Starting dynamic subtest: pipe-A-eDP-1
[558.861763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[558.875062] Starting dynamic subtest: pipe-B-eDP-1
[560.282203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[560.295478] Starting dynamic subtest: pipe-C-eDP-1
[561.663899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[561.676808] Starting dynamic subtest: pipe-D-eDP-1
[562.998115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[563.000353] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.577s)
[564.185284] [129/155] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[564.290165] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[564.295192] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[564.384753] [130/155] (461s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[564.487380] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[564.492418] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[564.582461] [131/155] (461s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[564.685914] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[564.688430] Starting dynamic subtest: pipe-A-eDP-1
[564.780380] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[564.794766] Starting dynamic subtest: pipe-B-eDP-1
[565.956747] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[565.963733] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.276s)
[567.151730] [132/155] (458s left) kms_pm_rpm (fences-dpms)
[568.682086] Starting subtest: fences-dpms
[568.687258] Subtest fences-dpms: SKIP (0.000s)
[569.393527] [133/155] (456s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[569.485306] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[569.488014] Starting dynamic subtest: pipe-A-eDP-1
[569.514614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.527313] Starting dynamic subtest: pipe-B-eDP-1
[569.553026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.564281] Starting dynamic subtest: pipe-C-eDP-1
[569.590155] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.601343] Starting dynamic subtest: pipe-D-eDP-1
[569.623817] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.628225] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[571.741847] [134/155] (454s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[571.842600] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[578.705285] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.866s)
[578.839979] [135/155] (447s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[578.934902] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[586.341215] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.410s)
[586.478613] [136/155] (439s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[586.579101] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[586.584430] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[586.666987] [137/155] (439s left) syncobj_wait (wait-all-delayed-signal)
[586.717437] Starting subtest: wait-all-delayed-signal
[586.818504] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[586.898991] [138/155] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[586.994140] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[586.999197] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[587.097951] [139/155] (438s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[587.202635] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[587.208362] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[587.301817] [140/155] (438s left) syncobj_timeline (etime-multi-wait-submitted)
[587.352159] Starting subtest: etime-multi-wait-submitted
[587.461330] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[587.538956] [141/155] (438s left) gem_workarounds (reset)
[587.606599] Starting subtest: reset
[587.782481] Subtest reset: SUCCESS (0.172s)
[587.905624] [142/155] (438s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[588.000336] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[588.010120] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[588.090503] [143/155] (438s left) kms_addfb_basic (size-max)
[588.179147] Starting subtest: size-max
[588.181458] Subtest size-max: SUCCESS (0.000s)
[588.273698] [144/155] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[588.367179] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[595.360428] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.994s)
[595.483621] [145/155] (430s left) sw_sync (sync_merge)
[595.517080] Starting subtest: sync_merge
[595.519429] Subtest sync_merge: SUCCESS (0.000s)
[595.570976] [146/155] (430s left) syncobj_wait (multi-wait-all-submitted)
[595.615917] Starting subtest: multi-wait-all-submitted
[595.724603] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[595.802746] [147/155] (430s left) sw_sync (sync_multi_consumer)
[595.837898] Starting subtest: sync_multi_consumer
[596.535795] Subtest sync_multi_consumer: SUCCESS (0.703s)
[596.610926] [148/155] (429s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[596.710648] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[596.715814] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[596.815416] [149/155] (429s left) gem_ctx_shared (q-out-order)
[596.876607] Starting subtest: Q-out-order
[596.879379] Starting dynamic subtest: rcs0
[596.988947] Dynamic subtest rcs0: SUCCESS (0.113s)
[597.006910] Starting dynamic subtest: vcs0
[597.077572] Dynamic subtest vcs0: SUCCESS (0.089s)
[597.097800] Starting dynamic subtest: vcs1
[597.162470] Dynamic subtest vcs1: SUCCESS (0.084s)
[597.180239] Starting dynamic subtest: vecs0
[597.242171] Dynamic subtest vecs0: SUCCESS (0.079s)
[597.261602] Starting dynamic subtest: ccs0
[597.338316] Dynamic subtest ccs0: SUCCESS (0.095s)
[597.341625] Subtest Q-out-order: SUCCESS (0.465s)
[598.592634] [150/155] (427s left) kms_plane (pixel-format-yf-tiled-modifier)
[598.686181] Starting subtest: pixel-format-yf-tiled-modifier
[598.691310] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[598.763071] [151/155] (427s left) intel_hwmon (hwmon-read)
[598.828356] Subtest hwmon-read: SKIP (0.000s)
[598.892118] [152/155] (427s left) kms_dp_link_training (uhbr-sst)
[598.985602] Starting subtest: uhbr-sst
[598.995980] Subtest uhbr-sst: SKIP (0.000s)
[599.062400] [153/155] (427s left) kms_addfb_basic (bad-pitch-63)
[599.115206] Starting subtest: bad-pitch-63
[599.117207] Subtest bad-pitch-63: SUCCESS (0.000s)
[599.249997] [154/155] (427s left) prime_mmap (test_map_unmap)
[599.294428] Starting subtest: test_map_unmap
[599.297340] Starting dynamic subtest: test_map_unmap-smem
[599.323894] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[599.326876] Subtest test_map_unmap: SUCCESS (0.031s)
[599.428945] [155/155] (427s left) gem_busy (parallel)
[599.606430] Starting subtest: parallel
[599.609501] Starting dynamic subtest: rcs0
[601.513333] Dynamic subtest rcs0: SUCCESS (1.904s)
[601.526607] Starting dynamic subtest: bcs0
[603.498031] Dynamic subtest bcs0: SUCCESS (1.981s)
[603.513922] Starting dynamic subtest: vcs0
[605.483528] Dynamic subtest vcs0: SUCCESS (1.981s)
[605.497581] Starting dynamic subtest: vcs1
[607.528928] Dynamic subtest vcs1: SUCCESS (2.042s)
[607.543177] Starting dynamic subtest: vecs0
[609.513152] Dynamic subtest vecs0: SUCCESS (1.981s)
[609.530310] Starting dynamic subtest: ccs0
[611.497313] Dynamic subtest ccs0: SUCCESS (1.980s)
[611.500925] Subtest parallel: SUCCESS (11.887s)
[611.702577] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_setmode
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_chamelium_edid
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_pipe_stress
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: sriov_basic
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: kms_fbcon_fbt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: gem_mmap
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_gttfill
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_prime
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: core_hotunplug
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_gttfill
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_atomic
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_dsc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_selftest
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_pread
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_mmap_write_crc
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: gem_exec_await
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_wait
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: prime_mmap_coherency
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: gem_eio
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_create
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: i915_pm_rpm
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_eventfd
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_pm_rpm
results: parsing output: 132/ for test: kms_ccs
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: syncobj_wait
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: gem_workarounds
results: parsing output: 141/ for test: kms_flip
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: sw_sync
results: parsing output: 145/ for test: syncobj_wait
results: parsing output: 146/ for test: sw_sync
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_ctx_shared
results: parsing output: 149/ for test: kms_plane
results: parsing output: 150/ for test: intel_hwmon
results: parsing output: 151/ for test: kms_dp_link_training
results: parsing output: 152/ for test: kms_addfb_basic
results: parsing output: 153/ for test: prime_mmap
results: parsing output: 154/ for test: gem_busy
Done.