[95.236551] Initializing watchdogs
[95.236600]   /dev/watchdog0
[95.251645] [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]
[95.256253] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[95.258567] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[95.261936] [001/155] (960s left) i915_query (query-regions-garbage-items)
[95.340717] Starting subtest: query-regions-garbage-items
[95.343257] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[95.456617] [002/155] (960s left) prime_vgem (basic-gtt)
[95.582480] Starting subtest: basic-gtt
[95.587324] Subtest basic-gtt: SKIP (0.000s)
[95.702379] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[95.705136] [003/155] (960s left) kms_sequence (queue-idle)
[95.811512] Starting subtest: queue-idle
[95.813488] Starting dynamic subtest: pipe-A-eDP-1
[97.632913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[97.640887] Starting dynamic subtest: pipe-B-eDP-1
[100.092439] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.460s)
[100.101944] Starting dynamic subtest: pipe-C-eDP-1
[102.613874] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[102.622631] Starting dynamic subtest: pipe-D-eDP-1
[105.055292] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[105.057624] Subtest queue-idle: SUCCESS (9.243s)
[105.860862] [004/155] (950s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[105.958439] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[105.962699] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[106.079193] [005/155] (949s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[106.175959] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[106.180316] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[106.266781] [006/155] (949s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[106.370899] Starting subtest: 4-tiled-addfb-size-offset-overflow
[106.373177] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[106.471263] [007/155] (949s left) gem_mmap_gtt (big-bo-tiledy)
[106.534228] Subtest big-bo-tiledY: SKIP (0.000s)
[106.596621] [008/155] (949s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[106.693366] Starting subtest: primary-yf-tiled-reflect-x-0
[106.752726] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[106.853882] [009/155] (949s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[106.950133] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[106.954094] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[107.034347] [010/155] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[107.136423] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[114.372829] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.242s)
[114.509976] [011/155] (941s left) gem_busy (busy)
[114.567054] Starting subtest: busy
[114.569565] Starting dynamic subtest: all-engines
[114.631573] Dynamic subtest all-engines: SUCCESS (0.062s)
[114.640529] Starting dynamic subtest: rcs0
[116.302105] Dynamic subtest rcs0: SUCCESS (1.671s)
[116.310319] Starting dynamic subtest: bcs0
[116.353652] Dynamic subtest bcs0: SUCCESS (0.049s)
[116.363571] Starting dynamic subtest: vcs0
[116.391847] Dynamic subtest vcs0: SUCCESS (0.039s)
[116.400286] Starting dynamic subtest: vcs1
[118.284348] Dynamic subtest vcs1: SUCCESS (1.891s)
[118.294178] Starting dynamic subtest: vecs0
[120.331069] Dynamic subtest vecs0: SUCCESS (2.046s)
[120.340710] Starting dynamic subtest: ccs0
[122.314816] Dynamic subtest ccs0: SUCCESS (1.984s)
[122.317045] Subtest busy: SUCCESS (7.747s)
[122.675082] [012/155] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[122.789409] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[132.451764] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.668s)
[132.612035] [013/155] (923s left) syncobj_timeline (signal)
[132.670965] Starting subtest: signal
[132.673430] Subtest signal: SUCCESS (0.000s)
[132.785753] [014/155] (923s left) i915_pm_freq_api (freq-reset-multiple)
[132.838221] Starting subtest: freq-reset-multiple
[132.840574] Starting dynamic subtest: gt0
[140.957765] Dynamic subtest gt0: SUCCESS (8.117s)
[140.965656] Starting dynamic subtest: gt1
[148.010344] Dynamic subtest gt1: SUCCESS (7.052s)
[148.013102] Subtest freq-reset-multiple: SUCCESS (15.170s)
[148.088568] [015/155] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[148.187703] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[148.192040] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[148.284982] [016/155] (908s left) gem_userptr_blits (userfault)
[148.346829] Starting subtest: userfault
[148.349198] Subtest userfault: SUCCESS (0.007s)
[148.487368] [017/155] (907s left) gem_exec_flush (basic-uc-set-default)
[148.550126] Starting subtest: basic-uc-set-default
[154.005873] Subtest basic-uc-set-default: SUCCESS (5.456s)
[154.203310] [018/155] (902s left) gem_exec_schedule (submit-early-slice)
[154.275041] Starting subtest: submit-early-slice
[154.277252] Starting dynamic subtest: rcs0
[154.341780] Dynamic subtest rcs0: SUCCESS (0.071s)
[154.353889] Starting dynamic subtest: bcs0
[154.397787] Dynamic subtest bcs0: SUCCESS (0.055s)
[154.409179] Starting dynamic subtest: vcs0
[154.455899] Dynamic subtest vcs0: SUCCESS (0.059s)
[154.468134] Starting dynamic subtest: vcs1
[154.512500] Dynamic subtest vcs1: SUCCESS (0.056s)
[154.523066] Starting dynamic subtest: vecs0
[154.559966] Dynamic subtest vecs0: SUCCESS (0.048s)
[154.568294] Starting dynamic subtest: ccs0
[154.607708] Dynamic subtest ccs0: SUCCESS (0.047s)
[154.610149] Subtest submit-early-slice: SUCCESS (0.338s)
[156.373830] [019/155] (900s left) gem_basic (create-fd-close)
[156.423755] Starting subtest: create-fd-close
[156.428268] Subtest create-fd-close: SUCCESS (0.000s)
[156.522501] [020/155] (900s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[156.578342] Starting subtest: invalid-bsd1-flag-on-blt
[156.580822] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[156.689473] [021/155] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[156.749628] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[156.858713] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[156.951498] [022/155] (899s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[157.054349] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[157.058618] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.147959] [023/155] (899s left) gem_partial_pwrite_pread (write-uncached)
[157.209609] Subtest write-uncached: SKIP (0.000s)
[157.281419] [024/155] (899s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[157.348891] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[157.353402] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[157.536143] [025/155] (899s left) kms_getfb (getfb-handle-protection)
[157.642365] Starting subtest: getfb-handle-protection
[157.658447] Subtest getfb-handle-protection: SUCCESS (0.017s)
[157.785873] [026/155] (899s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[157.895315] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[157.899344] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[157.994387] [027/155] (898s left) kms_vblank (wait-forked-hang)
[158.099345] Starting subtest: wait-forked-hang
[158.101489] Starting dynamic subtest: pipe-A-eDP-1
[184.139212] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.037s)
[184.152708] Starting dynamic subtest: pipe-D-eDP-1
[209.039524] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.897s)
[209.041459] Subtest wait-forked-hang: SUCCESS (50.937s)
[209.862377] [028/155] (847s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[209.990149] Starting subtest: basic-flip-after-cursor-atomic
[210.942286] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.952s)
[211.794798] [029/155] (845s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[211.903183] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[211.907282] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[211.999010] [030/155] (844s left) kms_pm_rpm (modeset-pc8-residency-stress)
[213.535902] Starting subtest: modeset-pc8-residency-stress
[213.541125] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[214.253172] [031/155] (842s left) kms_pm_rpm (modeset-lpsp)
[216.481110] Starting subtest: modeset-lpsp
[217.956891] Subtest modeset-lpsp: SUCCESS (1.478s)
[218.055487] [032/155] (838s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[218.160895] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[218.165144] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[218.277386] [033/155] (838s left) gem_softpin (allocator-fork)
[218.339546] Starting subtest: allocator-fork
[220.555475] Subtest allocator-fork: SUCCESS (2.214s)
[220.677192] [034/155] (836s left) syncobj_wait (single-wait-all-for-submit-submitted)
[220.742609] Starting subtest: single-wait-all-for-submit-submitted
[220.849466] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[220.926562] [035/155] (836s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[221.041790] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[221.046185] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[221.113958] [036/155] (836s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[221.203652] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[221.205978] Starting dynamic subtest: pipe-A-eDP-1
[221.226291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[221.236762] Starting dynamic subtest: pipe-B-eDP-1
[221.256300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[221.265053] Starting dynamic subtest: pipe-C-eDP-1
[221.285342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[221.293848] Starting dynamic subtest: pipe-D-eDP-1
[221.314777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[221.317067] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[223.570373] [037/155] (833s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[223.676036] Starting subtest: fbcpsr-modesetfrombusy
[229.862719] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.193s)
[230.001547] [038/155] (827s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[230.109670] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[230.113181] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[230.189155] [039/155] (827s left) perf (create-destroy-userspace-config)
[230.297541] Starting subtest: create-destroy-userspace-config
[230.314597] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[230.353740] [040/155] (827s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[230.440379] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[230.442323] Starting dynamic subtest: pipe-A-eDP-1
[230.462112] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.474665] Starting dynamic subtest: pipe-B-eDP-1
[230.493947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.504528] Starting dynamic subtest: pipe-C-eDP-1
[230.522708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.530574] Starting dynamic subtest: pipe-D-eDP-1
[230.549075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.552415] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[232.699019] [041/155] (824s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[232.803701] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[232.807699] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[232.916427] [042/155] (824s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[233.029430] Starting subtest: 2x-long-cursor-vs-flip-atomic
[233.034107] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[233.176137] [043/155] (824s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[233.279074] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[233.281492] Starting dynamic subtest: pipe-A
[233.341857] Dynamic subtest pipe-A: SUCCESS (0.065s)
[233.352442] Starting dynamic subtest: pipe-B
[234.510706] Dynamic subtest pipe-B: SUCCESS (1.168s)
[234.521642] Starting dynamic subtest: pipe-C
[235.627050] Dynamic subtest pipe-C: SUCCESS (1.116s)
[235.636958] Starting dynamic subtest: pipe-D
[236.755353] Dynamic subtest pipe-D: SUCCESS (1.128s)
[236.757678] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.479s)
[237.913316] [044/155] (819s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[238.015159] Starting subtest: disable-crc-after-crtc
[238.017508] Starting dynamic subtest: pipe-A-eDP-1
[239.668772] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.655s)
[239.679084] Starting dynamic subtest: pipe-B-eDP-1
[242.047497] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.376s)
[242.057346] Starting dynamic subtest: pipe-C-eDP-1
[244.300272] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.252s)
[244.310268] Starting dynamic subtest: pipe-D-eDP-1
[246.542725] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[246.545208] Subtest disable-crc-after-crtc: SUCCESS (8.529s)
[247.381454] [045/155] (810s left) syncobj_basic (bad-flags-handle-to-fd)
[247.438074] Starting subtest: bad-flags-handle-to-fd
[247.440066] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[247.548581] [046/155] (810s left) kms_big_fb (linear-8bpp-rotate-90)
[247.666809] Starting subtest: linear-8bpp-rotate-90
[247.687592] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[247.802438] [047/155] (809s left) vgem_basic (bad-handle)
[247.843048] Starting subtest: bad-handle
[247.844971] Subtest bad-handle: SUCCESS (0.000s)
[247.904617] [048/155] (809s left) i915_pm_rpm (reg-read-ioctl)
[249.420739] Starting subtest: reg-read-ioctl
[251.809983] Subtest reg-read-ioctl: SUCCESS (2.391s)
[252.202266] [049/155] (805s left) gem_ctx_persistence (legacy-engines-hang)
[252.264651] Starting subtest: legacy-engines-hang
[252.266996] Starting dynamic subtest: render
[252.404979] Dynamic subtest render: SUCCESS (0.139s)
[252.418571] Starting dynamic subtest: bsd1
[252.494699] Dynamic subtest bsd1: SUCCESS (0.087s)
[252.507280] Starting dynamic subtest: bsd2
[252.584046] Dynamic subtest bsd2: SUCCESS (0.087s)
[252.595622] Starting dynamic subtest: blt
[252.674557] Dynamic subtest blt: SUCCESS (0.088s)
[252.685152] Starting dynamic subtest: vebox
[252.745600] Dynamic subtest vebox: SUCCESS (0.069s)
[252.747987] Subtest legacy-engines-hang: SUCCESS (0.481s)
[252.864751] [050/155] (804s left) syncobj_wait (invalid-single-wait-unsubmitted)
[252.910991] Starting subtest: invalid-single-wait-unsubmitted
[252.913402] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[253.031809] [051/155] (804s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu)
[253.122731] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu
[253.126212] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[253.221133] [052/155] (804s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary)
[253.316359] Starting subtest: fbchdr-shrfb-scaledprimary
[253.319863] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s)
[253.411887] [053/155] (804s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[253.534124] Starting subtest: cursorB-vs-flipA-legacy
[253.537974] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[253.700147] [054/155] (804s left) kms_chamelium_hpd (dp-hpd-fast)
[254.090145] Subtest dp-hpd-fast: SKIP (0.000s)
[254.891569] [055/155] (803s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[254.996240] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[255.000879] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[255.101433] [056/155] (802s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[255.204314] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[255.208591] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[255.323749] [057/155] (802s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[255.426175] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[255.430181] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[255.531228] [058/155] (802s left) kms_psr (pr-suspend)
[255.632436] Starting subtest: pr-suspend
[255.636941] Subtest pr-suspend: SKIP (0.000s)
[255.709131] [059/155] (802s left) kms_psr (psr-suspend)
[255.804771] Starting subtest: psr-suspend
[255.807110] Starting dynamic subtest: eDP-1
[273.461355] Dynamic subtest eDP-1: SUCCESS (3.032s)
[273.463652] Subtest psr-suspend: SUCCESS (3.033s)
[274.314589] [060/155] (783s left) gem_exec_params (rel-constants-invalid-ring)
[274.383514] Starting subtest: rel-constants-invalid-ring
[274.385881] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[274.479382] [061/155] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[274.581808] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[274.585821] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[274.680725] [062/155] (783s left) prime_busy (hang)
[274.732722] Starting subtest: hang
[274.734814] Starting dynamic subtest: rcs0
[300.409535] Dynamic subtest rcs0: SUCCESS (25.734s)
[300.420211] Starting dynamic subtest: bcs0
[307.573700] Dynamic subtest bcs0: SUCCESS (7.163s)
[307.584929] Starting dynamic subtest: vcs0
[314.608435] Dynamic subtest vcs0: SUCCESS (7.038s)
[314.617491] Starting dynamic subtest: vcs1
[321.586749] Dynamic subtest vcs1: SUCCESS (6.976s)
[321.595938] Starting dynamic subtest: vecs0
[328.561454] Dynamic subtest vecs0: SUCCESS (6.974s)
[328.570682] Starting dynamic subtest: ccs0
[342.461600] Dynamic subtest ccs0: SUCCESS (13.904s)
[342.463581] Subtest hang: SUCCESS (67.799s)
[342.586237] [063/155] (715s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[342.654958] Starting subtest: single-wait-all-for-submit-signaled
[342.657389] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[342.764290] [064/155] (715s left) kms_dsc (dsc-with-bpc-formats)
[342.854957] Starting subtest: dsc-with-bpc-formats
[342.961507] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[343.001965] [065/155] (715s left) gem_exec_params (invalid-fence-in)
[343.066652] Starting subtest: invalid-fence-in
[343.069082] Subtest invalid-fence-in: SUCCESS (0.000s)
[343.199449] [066/155] (715s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[343.298970] Starting subtest: fbcpsrhdr-stridechange
[343.303126] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[343.386764] [067/155] (715s left) kms_async_flips (async-flip-dpms)
[343.484309] Starting subtest: async-flip-dpms
[343.875184] Starting dynamic subtest: pipe-A-eDP-1
[347.748069] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.874s)
[348.130643] Starting dynamic subtest: pipe-B-eDP-1
[351.013092] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.892s)
[351.422422] Starting dynamic subtest: pipe-C-eDP-1
[354.301967] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.892s)
[354.666178] Starting dynamic subtest: pipe-D-eDP-1
[357.552617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.895s)
[357.554927] Subtest async-flip-dpms: SUCCESS (14.076s)
[358.741372] [068/155] (699s left) gem_exec_store (cachelines)
[358.801224] Starting subtest: cachelines
[358.803627] Starting dynamic subtest: rcs0
[358.861518] Dynamic subtest rcs0: SUCCESS (0.062s)
[358.873731] Starting dynamic subtest: bcs0
[358.914563] Dynamic subtest bcs0: SUCCESS (0.051s)
[358.925671] Starting dynamic subtest: vcs0
[358.971367] Dynamic subtest vcs0: SUCCESS (0.055s)
[358.984286] Starting dynamic subtest: vcs1
[359.035217] Dynamic subtest vcs1: SUCCESS (0.062s)
[359.046255] Starting dynamic subtest: vecs0
[359.093288] Dynamic subtest vecs0: SUCCESS (0.056s)
[359.103973] Starting dynamic subtest: ccs0
[359.153784] Dynamic subtest ccs0: SUCCESS (0.058s)
[359.156586] Subtest cachelines: SUCCESS (0.355s)
[359.342564] [069/155] (699s left) gem_ctx_engines (invalid-engines)
[359.418231] Starting subtest: invalid-engines
[359.426109] Subtest invalid-engines: SUCCESS (0.008s)
[359.677201] [070/155] (698s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[359.796724] Starting subtest: cursor-vs-flip-varying-size
[391.177861] Subtest cursor-vs-flip-varying-size: SUCCESS (31.373s)
[392.070743] [071/155] (666s left) kms_psr (fbc-psr-cursor-plane-onoff)
[392.168713] Starting subtest: fbc-psr-cursor-plane-onoff
[392.170998] Starting dynamic subtest: eDP-1
[392.175144] Dynamic subtest eDP-1: SKIP (0.000s)
[392.179439] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[392.243459] [072/155] (666s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[392.295656] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[392.354203] [073/155] (666s left) drm_read (short-buffer-block)
[392.497221] Starting subtest: short-buffer-block
[392.499892] Subtest short-buffer-block: SUCCESS (0.000s)
[392.636138] [074/155] (666s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[392.684864] Starting subtest: invalid-multi-wait-all-unsubmitted
[392.687193] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[392.784341] [075/155] (666s left) kms_properties (connector-properties-atomic)
[392.880078] Starting subtest: connector-properties-atomic
[392.882336] Starting dynamic subtest: pipe-A-eDP-1
[400.979685] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.100s)
[400.990036] Starting dynamic subtest: pipe-None-DP-1
[400.994802] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[401.004044] Starting dynamic subtest: pipe-None-HDMI-A-1
[401.008364] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[401.017540] Starting dynamic subtest: pipe-None-DP-2
[401.021540] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[401.030321] Starting dynamic subtest: pipe-None-HDMI-A-2
[401.034415] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[401.043224] Starting dynamic subtest: pipe-None-DP-3
[401.047332] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[401.056371] Starting dynamic subtest: pipe-None-DP-4
[401.060912] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[401.063150] Subtest connector-properties-atomic: SUCCESS (8.114s)
[401.855425] [076/155] (657s left) kms_plane_alpha_blend (alpha-opaque-fb)
[401.958193] Starting subtest: alpha-opaque-fb
[402.256449] Starting dynamic subtest: pipe-A-eDP-1
[402.899280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[402.909156] Starting dynamic subtest: pipe-D-eDP-1
[404.311445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[404.313792] Subtest alpha-opaque-fb: SUCCESS (2.353s)
[405.115398] [077/155] (653s left) kms_atomic (plane-immutable-zpos)
[405.207843] Starting subtest: plane-immutable-zpos
[405.210183] Starting dynamic subtest: pipe-A-eDP-1
[405.844289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[405.846589] Subtest plane-immutable-zpos: SUCCESS (0.637s)
[406.656650] [078/155] (652s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[406.758688] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[406.762888] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[406.827001] [079/155] (652s left) gen9_exec_parse (basic-rejected)
[406.885302] Subtest basic-rejected: SKIP (0.000s)
[406.954347] [080/155] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[407.062989] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[407.067320] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[407.174321] [081/155] (651s left) syncobj_timeline (invalid-wait-bad-flags)
[407.224122] Starting subtest: invalid-wait-bad-flags
[407.226470] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[407.341996] [082/155] (651s left) perf_pmu (all-busy-check-all)
[407.382226] Starting subtest: all-busy-check-all
[408.935791] Subtest all-busy-check-all: SUCCESS (1.554s)
[409.032777] [083/155] (650s left) kms_psr (psr2-primary-render)
[409.120717] Starting subtest: psr2-primary-render
[409.123027] Starting dynamic subtest: eDP-1
[410.830893] Dynamic subtest eDP-1: SUCCESS (1.710s)
[410.833065] Subtest psr2-primary-render: SUCCESS (1.711s)
[411.705141] [084/155] (647s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[411.802350] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[411.806539] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[411.916361] [085/155] (647s left) kms_chamelium_color (ctm-0-25)
[412.002013] Subtest ctm-0-25: SKIP (0.000s)
[412.052665] [086/155] (647s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[412.147089] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[412.151485] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.235346] [087/155] (647s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[412.297953] Starting subtest: yf-tiled-ccs-to-y-tiled
[412.302589] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[412.511535] [088/155] (646s left) kms_cursor_crc (cursor-offscreen-max-size)
[412.815928] Starting subtest: cursor-offscreen-max-size
[412.822533] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[412.960620] [089/155] (646s left) gem_mmap_gtt (basic-write-read-distinct)
[413.028829] Subtest basic-write-read-distinct: SKIP (0.000s)
[413.097647] [090/155] (646s left) gem_exec_balancer (parallel)
[413.357939] Starting subtest: parallel
[414.337913] Subtest parallel: SUCCESS (0.980s)
[415.004269] [091/155] (644s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[415.097476] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[415.101493] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[415.209553] [092/155] (644s left) gem_exec_parallel (contexts)
[415.267435] Starting subtest: contexts
[415.269864] Starting dynamic subtest: rcs0
[418.441919] Dynamic subtest rcs0: SUCCESS (3.173s)
[418.455756] Starting dynamic subtest: bcs0
[421.834980] Dynamic subtest bcs0: SUCCESS (3.391s)
[421.845943] Starting dynamic subtest: vcs0
[426.296802] Dynamic subtest vcs0: SUCCESS (4.459s)
[426.314579] Starting dynamic subtest: vcs1
[430.372746] Dynamic subtest vcs1: SUCCESS (4.074s)
[430.384458] Starting dynamic subtest: vecs0
[434.413226] Dynamic subtest vecs0: SUCCESS (4.040s)
[434.426722] Starting dynamic subtest: ccs0
[437.924920] Dynamic subtest ccs0: SUCCESS (3.510s)
[437.927541] Subtest contexts: SUCCESS (22.661s)
[438.115234] [093/155] (621s left) kms_psr (fbc-psr2-sprite-render)
[438.222783] Starting subtest: fbc-psr2-sprite-render
[438.225114] Starting dynamic subtest: eDP-1
[438.229463] Dynamic subtest eDP-1: SKIP (0.000s)
[438.233831] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[438.297911] [094/155] (621s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[438.391520] Starting subtest: plane-primary-toggle-with-vblank-wait
[438.393750] Starting dynamic subtest: pipe-A-eDP-1
[438.566907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[438.877512] Starting dynamic subtest: pipe-B-eDP-1
[439.794797] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.928s)
[440.100379] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.710s)
[440.976961] [095/155] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[441.072061] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[441.076083] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[441.162497] [096/155] (618s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[441.253509] Starting subtest: plane-all-transition-nonblocking-fencing
[441.256418] Starting dynamic subtest: pipe-A-eDP-1
[443.750353] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[444.060438] Starting dynamic subtest: pipe-B-eDP-1
[447.292237] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.242s)
[447.591100] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.341s)
[448.423448] [097/155] (611s left) sw_sync (alloc_fence_invalid_timeline)
[448.465759] Starting subtest: alloc_fence_invalid_timeline
[448.467629] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[448.535878] [098/155] (611s left) gem_render_copy_redux (interruptible)
[448.594711] Starting subtest: interruptible
[448.868670] Subtest interruptible: SUCCESS (0.274s)
[448.991506] [099/155] (610s left) gem_mmap_gtt (basic)
[449.049007] Subtest basic: SKIP (0.000s)
[449.140414] [100/155] (610s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[449.248953] Starting subtest: hdr-rgb565-draw-pwrite
[449.253536] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[449.353718] [101/155] (610s left) gem_fence_thrash (bo-write-verify-threaded-none)
[449.387109] Starting subtest: bo-write-verify-threaded-none
[449.414586] Subtest bo-write-verify-threaded-none: SKIP (0.025s)
[449.477360] [102/155] (610s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[449.570171] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[449.573966] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[449.668426] [103/155] (610s left) gem_lmem_swapping (parallel-random-engines)
[449.708224] Subtest parallel-random-engines: SKIP (0.000s)
[449.751447] [104/155] (610s left) perf_pmu (busy-hang)
[449.787637] Starting subtest: busy-hang
[449.789983] Starting dynamic subtest: rcs0
[451.057532] Dynamic subtest rcs0: SUCCESS (1.269s)
[451.068137] Starting dynamic subtest: bcs0
[452.293699] Dynamic subtest bcs0: SUCCESS (1.232s)
[452.305470] Starting dynamic subtest: vcs0
[454.448492] Dynamic subtest vcs0: SUCCESS (2.152s)
[454.461028] Starting dynamic subtest: vcs1
[456.426234] Dynamic subtest vcs1: SUCCESS (1.976s)
[456.440690] Starting dynamic subtest: vecs0
[458.406572] Dynamic subtest vecs0: SUCCESS (1.982s)
[458.419416] Starting dynamic subtest: ccs0
[459.661897] Dynamic subtest ccs0: SUCCESS (1.253s)
[459.664428] Subtest busy-hang: SUCCESS (9.878s)
[459.768595] [105/155] (600s left) i915_drm_fdinfo (busy-check-all)
[459.811349] Starting subtest: busy-check-all
[459.813608] Starting dynamic subtest: rcs0
[459.818308] Dynamic subtest rcs0: SKIP (0.004s)
[459.829833] Starting dynamic subtest: bcs0
[459.834120] Dynamic subtest bcs0: SKIP (0.000s)
[459.843996] Starting dynamic subtest: vcs0
[459.848455] Dynamic subtest vcs0: SKIP (0.001s)
[459.857973] Starting dynamic subtest: vcs1
[459.862045] Dynamic subtest vcs1: SKIP (0.000s)
[459.871472] Starting dynamic subtest: vecs0
[459.875768] Dynamic subtest vecs0: SKIP (0.000s)
[459.886160] Starting dynamic subtest: ccs0
[459.890565] Dynamic subtest ccs0: SKIP (0.000s)
[459.895024] Subtest busy-check-all: SKIP (0.010s)
[459.933600] [106/155] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[460.071490] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[464.240229] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.174s)
[465.447119] [107/155] (594s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[465.827958] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[466.630468] [108/155] (593s left) kms_plane (plane-panning-bottom-right-suspend)
[466.727111] Starting subtest: plane-panning-bottom-right-suspend
[466.729315] Starting dynamic subtest: pipe-A
[485.124711] Dynamic subtest pipe-A: SUCCESS (3.541s)
[485.137122] Starting dynamic subtest: pipe-B
[503.386344] Dynamic subtest pipe-B: SUCCESS (3.036s)
[503.389349] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.584s)
[504.202422] [109/155] (556s left) api_intel_allocator (execbuf-with-allocator)
[504.265359] Starting subtest: execbuf-with-allocator
[504.268426] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[504.384900] [110/155] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[504.489392] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[504.494337] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[504.592916] [111/155] (555s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[504.641315] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[504.643908] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[504.740035] [112/155] (555s left) gem_exec_balancer (parallel-out-fence)
[504.992602] Starting subtest: parallel-out-fence
[506.263565] Subtest parallel-out-fence: SUCCESS (1.276s)
[506.367985] [113/155] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[506.465368] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[506.470386] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[506.554599] [114/155] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[506.655331] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[506.660451] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.751728] [115/155] (553s left) gem_exec_params (mmapped)
[506.810171] Starting subtest: mmapped
[506.815351] Subtest mmapped: SUCCESS (0.004s)
[506.923229] [116/155] (553s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[507.017252] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[507.022280] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[507.114818] [117/155] (553s left) kms_content_protection (lic-type-1)
[507.264330] Starting subtest: lic-type-1
[507.269983] Subtest lic-type-1: SKIP (0.000s)
[507.392014] [118/155] (553s left) perf_pmu (multi-client)
[507.431343] Starting subtest: multi-client
[507.433834] Starting dynamic subtest: rcs0
[508.474691] Dynamic subtest rcs0: SUCCESS (1.047s)
[508.490526] Starting dynamic subtest: bcs0
[509.524535] Dynamic subtest bcs0: SUCCESS (1.051s)
[509.537539] Starting dynamic subtest: vcs0
[510.578018] Dynamic subtest vcs0: SUCCESS (1.054s)
[510.595695] Starting dynamic subtest: vcs1
[512.048869] Dynamic subtest vcs1: SUCCESS (1.472s)
[512.060405] Starting dynamic subtest: vecs0
[514.035141] Dynamic subtest vecs0: SUCCESS (1.987s)
[514.048823] Starting dynamic subtest: ccs0
[516.017829] Dynamic subtest ccs0: SUCCESS (1.984s)
[516.020577] Subtest multi-client: SUCCESS (8.612s)
[516.139633] [119/155] (544s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt)
[516.249029] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt
[516.254280] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[516.336323] [120/155] (544s left) gem_exec_schedule (pi-common)
[516.512901] Starting subtest: pi-common
[516.515292] Starting dynamic subtest: rcs0
[516.558440] Dynamic subtest rcs0: SUCCESS (0.050s)
[516.569283] Starting dynamic subtest: bcs0
[516.619103] Dynamic subtest bcs0: SUCCESS (0.059s)
[516.630921] Starting dynamic subtest: vcs0
[516.665541] Dynamic subtest vcs0: SUCCESS (0.046s)
[516.676315] Starting dynamic subtest: vcs1
[516.702588] Dynamic subtest vcs1: SUCCESS (0.036s)
[516.716249] Starting dynamic subtest: vecs0
[516.735752] Dynamic subtest vecs0: SUCCESS (0.033s)
[516.750561] Starting dynamic subtest: ccs0
[516.766098] Dynamic subtest ccs0: SUCCESS (0.029s)
[516.768521] Subtest pi-common: SUCCESS (0.258s)
[516.998434] [121/155] (543s left) syncobj_wait (reset-unsignaled)
[517.059204] Starting subtest: reset-unsignaled
[517.061282] Subtest reset-unsignaled: SUCCESS (0.000s)
[517.158276] [122/155] (543s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[517.256550] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[517.261448] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[517.362021] [123/155] (543s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[517.458321] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[517.463138] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[517.564665] [124/155] (543s left) dmabuf_sync_file (import-basic)
[517.613910] Starting subtest: import-basic
[517.616399] Subtest import-basic: SUCCESS (0.002s)
[517.668423] [125/155] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[517.770104] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[517.775024] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[517.874109] [126/155] (543s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[517.961821] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[517.964090] Starting dynamic subtest: pipe-A-eDP-1
[517.987618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.000012] Starting dynamic subtest: pipe-B-eDP-1
[518.022030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.031282] Starting dynamic subtest: pipe-C-eDP-1
[518.050166] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.059069] Starting dynamic subtest: pipe-D-eDP-1
[518.077547] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.081463] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[520.225554] [127/155] (540s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[520.319735] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[520.322043] Starting dynamic subtest: pipe-A-default-mode
[521.492403] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[521.497536] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.172s)
[521.652893] [128/155] (539s left) kms_psr (fbc-pr-primary-render)
[521.743287] Starting subtest: fbc-pr-primary-render
[521.748145] Subtest fbc-pr-primary-render: SKIP (0.000s)
[521.817296] [129/155] (539s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[521.910708] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[522.955330] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.045s)
[523.078187] [130/155] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[523.173950] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[530.571189] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.407s)
[530.683041] [131/155] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[530.779677] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[530.784435] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[530.876222] [132/155] (530s left) kms_flip (2x-busy-flip)
[530.969613] Starting subtest: 2x-busy-flip
[530.978890] Subtest 2x-busy-flip: SKIP (0.010s)
[531.058952] [133/155] (530s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[531.153995] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[531.158674] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[531.250501] [134/155] (530s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[531.347423] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[531.352898] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[531.447823] [135/155] (530s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[531.552269] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[531.556530] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[531.650972] [136/155] (529s left) gem_ctx_exec (basic-norecovery)
[531.704245] Starting subtest: basic-norecovery
[531.983925] Subtest basic-norecovery: SUCCESS (0.279s)
[532.113881] [137/155] (529s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[532.204523] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[532.206974] Starting dynamic subtest: pipe-A-default-mode
[534.926443] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[534.929315] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.723s)
[535.761060] [138/155] (525s left) gem_mmap_offset (basic-uaf)
[535.817241] Starting subtest: basic-uaf
[535.820041] Subtest basic-uaf: SUCCESS (0.001s)
[535.916967] [139/155] (525s left) kms_cursor_edge_walk (64x64-top-edge)
[536.010984] Starting subtest: 64x64-top-edge
[536.013323] Starting dynamic subtest: pipe-A-eDP-1
[539.532220] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.521s)
[539.543053] Starting dynamic subtest: pipe-D-eDP-1
[542.669440] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[542.672389] Subtest 64x64-top-edge: SUCCESS (6.661s)
[543.477370] [140/155] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[543.574394] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[543.579266] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[543.665058] [141/155] (518s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[543.764003] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[543.769023] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[543.865074] [142/155] (517s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[543.961282] Starting subtest: plane-lut1d-pre-ctm3x4
[544.096490] Starting dynamic subtest: pipe-A-plane-0
[544.266530] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[544.277471] Starting dynamic subtest: pipe-A-plane-1
[544.451548] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[544.461828] Starting dynamic subtest: pipe-A-plane-2
[544.606727] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[545.775509] Starting dynamic subtest: pipe-B-plane-0
[545.943228] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[545.954402] Starting dynamic subtest: pipe-B-plane-1
[546.132261] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[546.143563] Starting dynamic subtest: pipe-B-plane-2
[546.288893] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[547.512065] Starting dynamic subtest: pipe-C-plane-0
[547.647935] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[547.658666] Starting dynamic subtest: pipe-C-plane-1
[547.815074] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[547.826143] Starting dynamic subtest: pipe-C-plane-2
[547.970370] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[549.138305] Starting dynamic subtest: pipe-D-plane-0
[549.285414] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[549.296594] Starting dynamic subtest: pipe-D-plane-1
[549.451819] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[549.462511] Starting dynamic subtest: pipe-D-plane-2
[549.596419] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[549.882509] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.920s)
[550.700595] [143/155] (511s left) kms_cursor_legacy (forked-move)
[550.822051] Starting subtest: forked-move
[550.824409] Starting dynamic subtest: pipe-A
[556.283118] Dynamic subtest pipe-A: SUCCESS (5.458s)
[556.301460] Starting dynamic subtest: pipe-B
[561.757738] Dynamic subtest pipe-B: SUCCESS (5.472s)
[561.767751] Starting dynamic subtest: pipe-C
[567.233584] Dynamic subtest pipe-C: SUCCESS (5.473s)
[567.252595] Starting dynamic subtest: pipe-D
[572.706222] Dynamic subtest pipe-D: SUCCESS (5.470s)
[572.718565] Starting dynamic subtest: all-pipes
[578.205289] Dynamic subtest all-pipes: SUCCESS (5.497s)
[578.208418] Subtest forked-move: SUCCESS (27.383s)
[578.357572] [144/155] (483s left) gem_mmap (pf-nonblock)
[578.417211] Subtest pf-nonblock: SKIP (0.000s)
[578.480838] [145/155] (483s left) gem_exec_reloc (basic-wc-cpu-active)
[578.541510] Subtest basic-wc-cpu-active: SKIP (0.000s)
[578.619053] [146/155] (483s left) api_intel_bb (intel-bb-blit-none)
[578.677445] Starting subtest: intel-bb-blit-none
[582.938188] Subtest intel-bb-blit-none: SUCCESS (4.264s)
[583.084920] [147/155] (478s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[583.183513] Starting subtest: fbc-pr-cursor-plane-update-sf
[583.188958] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[583.254651] [148/155] (478s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[583.801037] Starting subtest: syncobj-timeline-invalid-flags
[583.803347] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[585.095064] [149/155] (477s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[585.199088] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[585.203947] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[585.297541] [150/155] (476s left) kms_cursor_crc (cursor-random-512x512)
[585.607195] Starting subtest: cursor-random-512x512
[585.612346] Subtest cursor-random-512x512: SKIP (0.001s)
[585.766350] [151/155] (476s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[585.871341] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[585.873940] Starting dynamic subtest: pipe-A-eDP-1
[585.896186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[585.908420] Starting dynamic subtest: pipe-B-eDP-1
[585.931288] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[585.941465] Starting dynamic subtest: pipe-C-eDP-1
[585.964534] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[585.974668] Starting dynamic subtest: pipe-D-eDP-1
[585.997825] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[586.000312] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[588.147913] [152/155] (474s left) syncobj_basic (bad-fd-to-handle)
[588.204357] Starting subtest: bad-fd-to-handle
[588.206828] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[588.303937] [153/155] (473s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[588.352029] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[588.354379] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[588.454816] [154/155] (473s left) kms_flip (plain-flip-fb-recreate-interruptible)
[588.546463] Starting subtest: plain-flip-fb-recreate-interruptible
[588.549158] Starting dynamic subtest: A-eDP1
[597.454149] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[597.464838] Starting dynamic subtest: B-eDP1
[606.284941] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[606.296245] Starting dynamic subtest: C-eDP1
[615.108879] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[615.122051] Starting dynamic subtest: D-eDP1
[623.947957] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[623.953173] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.406s)
[625.153452] [155/155] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[625.262409] Starting subtest: psr-1p-primscrn-cur-indfb-move
[632.640292] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.383s)
[632.762307] Closing watchdogs
results: parsing output: 0/ for test: i915_query
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_sequence
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_busy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_pm_freq_api
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: gem_exec_flush
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_basic
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: kms_pm_rpm
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_joiner
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: prime_busy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: gem_exec_store
results: parsing output: 68/ for test: gem_ctx_engines
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: drm_read
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_plane_alpha_blend
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_parallel
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: gem_render_copy_redux
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_exec_balancer
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: dmabuf_sync_file
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_ctx_exec
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: gem_mmap_offset
results: parsing output: 138/ for test: kms_cursor_edge_walk
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_color_pipeline
results: parsing output: 142/ for test: kms_cursor_legacy
results: parsing output: 143/ for test: gem_mmap
results: parsing output: 144/ for test: gem_exec_reloc
results: parsing output: 145/ for test: api_intel_bb
results: parsing output: 146/ for test: kms_psr2_sf
results: parsing output: 147/ for test: gem_exec_fence
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: syncobj_basic
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.