[57.433368] Initializing watchdogs
[57.433427]   /dev/watchdog0
[57.448652] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.453426] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.455672] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.459015] [001/154] (960s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[57.585541] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[57.589735] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[57.674130] [002/154] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[57.740262] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[57.801400] [003/154] (960s left) gem_exec_params (invalid-ring)
[57.855854] Starting subtest: invalid-ring
[57.858180] Subtest invalid-ring: SUCCESS (0.000s)
[57.952246] [004/154] (960s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[58.041504] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[58.045938] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[58.124246] [005/154] (959s left) kms_flip (blocking-wf_vblank)
[58.222323] Starting subtest: blocking-wf_vblank
[58.224752] Starting dynamic subtest: A-eDP1
[67.215778] Dynamic subtest A-eDP1: SUCCESS (8.976s)
[67.227797] Starting dynamic subtest: B-eDP1
[76.145972] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[76.154453] Starting dynamic subtest: C-eDP1
[85.068173] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[85.076394] Starting dynamic subtest: D-eDP1
[94.002860] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[94.008604] Subtest blocking-wf_vblank: SUCCESS (35.760s)
[95.231900] [006/154] (922s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[95.347685] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[95.352068] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[95.443557] [007/154] (922s left) gem_close_race (multigpu-basic-threads)
[95.513369] Starting subtest: multigpu-basic-threads
[95.517878] Subtest multigpu-basic-threads: SKIP (0.000s)
[95.744015] [008/154] (922s left) gen7_exec_parse (basic-offset)
[95.806462] Subtest basic-offset: SKIP (0.000s)
[95.874162] [009/154] (922s left) gem_exec_schedule (lateslice)
[95.938765] Starting subtest: lateslice
[95.940994] Starting dynamic subtest: rcs0
[95.947959] Dynamic subtest rcs0: SUCCESS (0.019s)
[95.955796] Starting dynamic subtest: bcs0
[95.965049] Dynamic subtest bcs0: SUCCESS (0.016s)
[95.972910] Starting dynamic subtest: vcs0
[95.983448] Dynamic subtest vcs0: SUCCESS (0.018s)
[95.991206] Starting dynamic subtest: vcs1
[95.999362] Dynamic subtest vcs1: SUCCESS (0.016s)
[96.007232] Starting dynamic subtest: vecs0
[96.017446] Dynamic subtest vecs0: SUCCESS (0.018s)
[96.025361] Starting dynamic subtest: ccs0
[96.036841] Dynamic subtest ccs0: SUCCESS (0.019s)
[96.039134] Subtest lateslice: SUCCESS (0.108s)
[97.385353] [010/154] (920s left) gem_exec_fence (concurrent)
[97.561742] Starting subtest: concurrent
[97.566702] Subtest concurrent: SKIP (0.000s)
[99.451444] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[99.456706] [011/154] (918s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[99.562661] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[99.567198] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[99.655865] [012/154] (918s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[99.706686] Starting subtest: wait-all-for-submit-delayed-submit
[99.811564] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[99.903071] [013/154] (918s left) api_intel_bb (purge-bb)
[99.950252] Starting subtest: purge-bb
[99.952700] Subtest purge-bb: SUCCESS (0.004s)
[100.064243] [014/154] (918s left) kms_psr (pr-suspend)
[100.144598] Starting subtest: pr-suspend
[100.149030] Subtest pr-suspend: SKIP (0.000s)
[100.219954] [015/154] (918s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[100.325258] Starting subtest: fbc-rgb565-draw-blt
[104.530844] Subtest fbc-rgb565-draw-blt: SUCCESS (4.211s)
[105.756277] [016/154] (912s left) kms_psr (psr-sprite-blt)
[105.854487] Starting subtest: psr-sprite-blt
[105.856712] Starting dynamic subtest: eDP-1
[107.569282] Dynamic subtest eDP-1: SUCCESS (1.712s)
[107.571568] Subtest psr-sprite-blt: SUCCESS (1.713s)
[108.442770] [017/154] (910s left) kms_universal_plane (universal-plane-functional)
[108.543919] Starting subtest: universal-plane-functional
[108.546434] Starting dynamic subtest: pipe-A-eDP-1
[112.567786] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.022s)
[112.577093] Starting dynamic subtest: pipe-B-eDP-1
[117.059024] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.491s)
[117.069043] Starting dynamic subtest: pipe-C-eDP-1
[121.342048] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.280s)
[121.350819] Starting dynamic subtest: pipe-D-eDP-1
[125.652709] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.310s)
[125.655090] Subtest universal-plane-functional: SUCCESS (17.108s)
[126.551132] [018/154] (892s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[126.660919] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[126.665158] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[126.760653] [019/154] (891s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[126.862043] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[126.866300] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[126.967838] [020/154] (891s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[127.067707] Starting subtest: x-tiled-16bpp-rotate-180
[128.368683] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[128.489449] [021/154] (890s left) gem_userptr_blits (map-fixed-invalidate)
[128.555482] Starting subtest: map-fixed-invalidate
[128.559317] Subtest map-fixed-invalidate: SKIP (0.000s)
[128.679918] [022/154] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[128.771876] Starting subtest: addfb25-y-tiled-small-legacy
[128.775436] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[128.872647] [023/154] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[128.965813] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[136.056021] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.094s)
[136.182155] [024/154] (882s left) kms_flip (basic-flip-vs-dpms)
[136.280353] Starting subtest: basic-flip-vs-dpms
[136.282633] Starting dynamic subtest: A-eDP1
[138.896800] Dynamic subtest A-eDP1: SUCCESS (2.617s)
[138.905742] Starting dynamic subtest: B-eDP1
[141.140210] Dynamic subtest B-eDP1: SUCCESS (2.241s)
[141.149796] Starting dynamic subtest: C-eDP1
[143.400536] Dynamic subtest C-eDP1: SUCCESS (2.260s)
[143.410854] Starting dynamic subtest: D-eDP1
[145.667721] Dynamic subtest D-eDP1: SUCCESS (2.264s)
[145.670064] Subtest basic-flip-vs-dpms: SUCCESS (9.393s)
[146.466759] [025/154] (872s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[146.519967] Starting subtest: invalid-single-wait-all-unsubmitted
[146.522301] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[146.628386] [026/154] (872s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[146.754471] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[146.759164] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[146.901643] [027/154] (872s left) core_setmaster_vs_auth
[147.045155] [028/154] (872s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[147.100718] Subtest writes-after-reads-uncached: SKIP (0.000s)
[147.157348] [029/154] (871s left) kms_draw_crc (draw-method-mmap-cpu)
[147.256543] Starting subtest: draw-method-mmap-cpu
[147.258869] Starting dynamic subtest: xrgb8888-untiled
[147.521113] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[147.531398] Starting dynamic subtest: rgb565-untiled
[147.765537] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[147.773239] Starting dynamic subtest: xrgb2101010-untiled
[147.987849] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[147.996068] Starting dynamic subtest: xbgr16161616f-untiled
[148.221179] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[148.229462] Starting dynamic subtest: xrgb8888-xtiled
[148.365763] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[148.374595] Starting dynamic subtest: rgb565-xtiled
[148.499082] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[148.508719] Starting dynamic subtest: xrgb2101010-xtiled
[148.621043] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[148.629175] Starting dynamic subtest: xbgr16161616f-xtiled
[148.754685] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[148.763396] Starting dynamic subtest: xrgb8888-4tiled
[148.899262] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[148.909329] Starting dynamic subtest: rgb565-4tiled
[149.043300] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[149.051984] Starting dynamic subtest: xrgb2101010-4tiled
[149.187943] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[149.196033] Starting dynamic subtest: xbgr16161616f-4tiled
[149.332597] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[149.334584] Subtest draw-method-mmap-cpu: SUCCESS (2.078s)
[149.426719] [030/154] (869s left) gem_fence_thrash (bo-write-verify-threaded-none)
[149.461582] Starting subtest: bo-write-verify-threaded-none
[149.476117] Subtest bo-write-verify-threaded-none: SKIP (0.012s)
[149.534026] [031/154] (869s left) perf (i915-ref-count)
[149.611763] Starting subtest: i915-ref-count
[149.680437] Subtest i915-ref-count: SUCCESS (0.068s)
[149.746597] [032/154] (869s left) gem_ccs (block-multicopy-compressed)
[149.796152] Starting subtest: block-multicopy-compressed
[149.800268] Subtest block-multicopy-compressed: SKIP (0.000s)
[149.893289] [033/154] (869s left) gem_exec_balancer (parallel-bb-first)
[150.139994] Starting subtest: parallel-bb-first
[151.105892] Subtest parallel-bb-first: SUCCESS (0.966s)
[151.372014] [034/154] (867s left) kms_addfb_basic (too-high)
[151.473972] Starting subtest: too-high
[151.476282] Subtest too-high: SUCCESS (0.001s)
[151.574822] [035/154] (867s left) kms_rotation_crc (primary-rotation-270)
[151.665758] Starting subtest: primary-rotation-270
[151.670217] Subtest primary-rotation-270: SKIP (0.001s)
[151.739876] [036/154] (867s left) kms_big_fb (linear-32bpp-rotate-270)
[151.832407] Starting subtest: linear-32bpp-rotate-270
[151.851650] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[151.964380] [037/154] (867s left) gem_pwrite (basic-random)
[152.017881] Subtest basic-random: SKIP (0.000s)
[152.075531] [038/154] (867s left) gem_spin_batch (resubmit-all)
[152.128796] Starting subtest: resubmit-all
[152.131147] Starting dynamic subtest: rcs0
[152.142187] Dynamic subtest rcs0: SUCCESS (0.013s)
[152.151922] Starting dynamic subtest: bcs0
[152.154073] Dynamic subtest bcs0: SUCCESS (0.001s)
[152.165546] Starting dynamic subtest: vcs0
[152.167728] Dynamic subtest vcs0: SUCCESS (0.002s)
[152.175908] Starting dynamic subtest: vcs1
[152.178129] Dynamic subtest vcs1: SUCCESS (0.003s)
[152.186056] Starting dynamic subtest: vecs0
[152.188313] Dynamic subtest vecs0: SUCCESS (0.002s)
[152.196085] Starting dynamic subtest: ccs0
[152.198268] Dynamic subtest ccs0: SUCCESS (0.003s)
[152.200454] Subtest resubmit-all: SUCCESS (0.030s)
[153.354039] [039/154] (866s left) syncobj_timeline (invalid-transfer-illegal-handle)
[153.405637] Starting subtest: invalid-transfer-illegal-handle
[153.408092] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[153.495100] [040/154] (866s left) kms_psr (fbc-psr-cursor-blt)
[153.591577] Starting subtest: fbc-psr-cursor-blt
[153.593787] Starting dynamic subtest: eDP-1
[153.597721] Dynamic subtest eDP-1: SKIP (0.000s)
[153.601665] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[153.669539] [041/154] (865s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[153.765153] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[153.769188] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[153.847731] [042/154] (865s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[153.944424] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[153.946799] Starting dynamic subtest: pipe-A-eDP-1
[154.004190] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[154.012514] Starting dynamic subtest: pipe-B-eDP-1
[154.069409] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[154.078097] Starting dynamic subtest: pipe-C-eDP-1
[154.131951] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[154.140041] Starting dynamic subtest: pipe-D-eDP-1
[154.193895] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[154.197994] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[156.236294] [043/154] (863s left) kms_psr (fbc-pr-suspend)
[156.338646] Starting subtest: fbc-pr-suspend
[156.342878] Subtest fbc-pr-suspend: SKIP (0.000s)
[156.411586] [044/154] (863s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[156.520536] Starting subtest: fbc-rgb101010-draw-render
[159.064719] Subtest fbc-rgb101010-draw-render: SUCCESS (2.549s)
[160.236152] [045/154] (859s left) kms_chamelium_frames (hdmi-aspect-ratio)
[160.627998] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[161.421457] [046/154] (858s left) api_intel_allocator (simple-allocator)
[161.481500] Starting subtest: simple-allocator
[161.483909] Starting dynamic subtest: basic
[161.486332] Dynamic subtest basic: SUCCESS (0.004s)
[161.499645] Starting dynamic subtest: parallel-one
[161.676580] Dynamic subtest parallel-one: SUCCESS (0.191s)
[161.686174] Starting dynamic subtest: print
[161.688447] Dynamic subtest print: SUCCESS (0.000s)
[161.696576] Starting dynamic subtest: reuse
[161.698600] Dynamic subtest reuse: SUCCESS (0.000s)
[161.706450] Starting dynamic subtest: reserve
[161.708415] Dynamic subtest reserve: SUCCESS (0.000s)
[161.716214] Starting dynamic subtest: fork-reopen-allocator
[161.718158] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[161.720088] Subtest simple-allocator: SUCCESS (0.212s)
[161.810452] [047/154] (858s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[161.904250] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[161.908453] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[161.997087] [048/154] (857s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[162.081328] Starting subtest: stress-xrgb8888-ytiled
[162.085668] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[162.146799] [049/154] (857s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[162.239219] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[162.241099] Starting dynamic subtest: pipe-A-eDP-1
[164.519913] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.282s)
[164.528455] Starting dynamic subtest: pipe-B-eDP-1
[167.046045] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.524s)
[167.055474] Starting dynamic subtest: pipe-C-eDP-1
[169.280557] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[169.290898] Starting dynamic subtest: pipe-D-eDP-1
[171.485738] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.204s)
[171.487891] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.249s)
[172.672732] [050/154] (847s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[172.779363] Starting subtest: psr2-overlay-plane-move-continuous-sf
[172.781616] Starting dynamic subtest: pipe-A-eDP-1
[178.780344] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.003s)
[178.789959] Starting dynamic subtest: pipe-B-eDP-1
[185.476581] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.694s)
[185.479088] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.700s)
[186.330976] [051/154] (833s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[186.377665] Starting subtest: etime-multi-wait-all-available-unsubmitted
[186.480043] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[186.555582] [052/154] (833s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[186.639854] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[186.642140] Starting dynamic subtest: pipe-A-eDP-1
[186.665648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[186.676437] Starting dynamic subtest: pipe-B-eDP-1
[186.699472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[186.707057] Starting dynamic subtest: pipe-C-eDP-1
[186.729824] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[186.737847] Starting dynamic subtest: pipe-D-eDP-1
[186.763498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[186.768044] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[188.908463] [053/154] (831s left) kms_lease (invalid-create-leases)
[189.007132] Starting subtest: invalid-create-leases
[189.011663] Subtest invalid-create-leases: SUCCESS (0.007s)
[189.110573] [054/154] (831s left) i915_hangman (gt-error-state-capture)
[189.177204] Starting subtest: gt-error-state-capture
[189.179532] Starting dynamic subtest: rcs0
[200.323567] Dynamic subtest rcs0: SUCCESS (11.145s)
[200.335510] Starting dynamic subtest: bcs0
[212.292418] Dynamic subtest bcs0: SUCCESS (11.966s)
[212.304428] Starting dynamic subtest: vcs0
[224.258607] Dynamic subtest vcs0: SUCCESS (11.964s)
[224.269414] Starting dynamic subtest: vcs1
[233.218583] Dynamic subtest vcs1: SUCCESS (8.957s)
[233.230463] Starting dynamic subtest: vecs0
[244.228290] Dynamic subtest vecs0: SUCCESS (11.006s)
[244.239882] Starting dynamic subtest: ccs0
[254.274907] Dynamic subtest ccs0: SUCCESS (10.044s)
[254.277907] Subtest gt-error-state-capture: SUCCESS (65.096s)
[254.400478] [055/154] (765s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[254.505112] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[255.439871] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.937s)
[255.602350] [056/154] (764s left) kms_cursor_crc (cursor-random-256x256)
[255.846429] Starting subtest: cursor-random-256x256
[255.851640] Starting dynamic subtest: pipe-A-eDP-1
[259.205897] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s)
[259.234952] Starting dynamic subtest: pipe-D-eDP-1
[263.213748] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s)
[263.216652] Subtest cursor-random-256x256: SUCCESS (7.365s)
[264.060867] [057/154] (756s left) kms_cursor_crc (cursor-dpms)
[264.182799] Starting subtest: cursor-dpms
[264.184953] Starting dynamic subtest: pipe-A-eDP-1
[267.246650] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.064s)
[267.256485] Starting dynamic subtest: pipe-D-eDP-1
[270.924670] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.675s)
[270.926651] Subtest cursor-dpms: SUCCESS (6.741s)
[271.769169] [058/154] (748s left) kms_cursor_crc (cursor-sliding-32x32)
[271.912682] Starting subtest: cursor-sliding-32x32
[271.960324] Subtest cursor-sliding-32x32: SKIP (0.044s)
[272.277475] [059/154] (748s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[272.381219] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[272.385631] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.478248] [060/154] (747s left) gem_exec_params (batch-first)
[272.536634] Starting subtest: batch-first
[272.542588] Subtest batch-first: SUCCESS (0.006s)
[272.676718] [061/154] (747s left) kms_psr (fbc-pr-primary-page-flip)
[272.763086] Starting subtest: fbc-pr-primary-page-flip
[272.766739] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[272.853040] [062/154] (747s left) gem_set_tiling_vs_pwrite
[272.973889] [063/154] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[273.061794] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[273.065533] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[273.170762] [064/154] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[273.271795] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[273.275445] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[273.355757] [065/154] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[273.455438] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[273.458895] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[273.560687] [066/154] (747s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[273.661325] Starting subtest: psr-rgb101010-draw-mmap-gtt
[273.664784] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[273.767156] [067/154] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[273.854188] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[273.857654] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[273.944118] [068/154] (746s left) kms_vblank (ts-continuation-dpms-suspend)
[274.032350] Starting subtest: ts-continuation-dpms-suspend
[274.033950] Starting dynamic subtest: pipe-A-eDP-1
[291.658244] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.400s)
[291.673180] Starting dynamic subtest: pipe-D-eDP-1
[309.659204] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.912s)
[309.661513] Subtest ts-continuation-dpms-suspend: SUCCESS (5.315s)
[316.488104] [069/154] (710s left) gem_set_tiling_vs_gtt
[316.610218] [070/154] (710s left) kms_color (deep-color)
[316.705844] Starting subtest: deep-color
[317.748488] Starting dynamic subtest: pipe-A-eDP-1-gamma
[318.480191] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.722s)
[318.491481] Starting dynamic subtest: pipe-A-eDP-1-degamma
[319.972304] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.485s)
[319.983466] Starting dynamic subtest: pipe-A-eDP-1-ctm
[321.397371] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.416s)
[322.178503] Starting dynamic subtest: pipe-B-eDP-1-gamma
[322.897100] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.726s)
[322.907873] Starting dynamic subtest: pipe-B-eDP-1-degamma
[324.391818] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.485s)
[324.402795] Starting dynamic subtest: pipe-B-eDP-1-ctm
[325.850253] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.453s)
[326.701456] Starting dynamic subtest: pipe-C-eDP-1-gamma
[327.389724] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s)
[327.399891] Starting dynamic subtest: pipe-C-eDP-1-degamma
[328.779814] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.388s)
[328.789855] Starting dynamic subtest: pipe-C-eDP-1-ctm
[330.211700] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.426s)
[331.017199] Starting dynamic subtest: pipe-D-eDP-1-gamma
[331.712389] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s)
[331.722176] Starting dynamic subtest: pipe-D-eDP-1-degamma
[333.183560] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.465s)
[333.194067] Starting dynamic subtest: pipe-D-eDP-1-ctm
[334.602070] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.418s)
[334.604472] Subtest deep-color: SUCCESS (17.832s)
[335.479602] [071/154] (691s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[335.583458] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[335.587522] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[335.666999] [072/154] (691s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[335.755279] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[335.757765] Starting dynamic subtest: pipe-A-default-mode
[338.528959] Dynamic subtest pipe-A-default-mode: SUCCESS (2.770s)
[338.531245] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.772s)
[339.383581] [073/154] (687s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[339.443442] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[339.550214] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[339.627211] [074/154] (687s left) kms_prime (basic-crc-hybrid)
[339.711352] Subtest basic-crc-hybrid: SKIP (0.000s)
[339.818650] [075/154] (687s left) gem_ctx_param (set-priority-range)
[339.876982] Starting subtest: set-priority-range
[339.891558] Subtest set-priority-range: SUCCESS (0.015s)
[340.028985] [076/154] (687s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[340.094733] Starting subtest: yf-tiled-ccs-to-x-tiled
[340.099318] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[340.278602] [077/154] (686s left) gem_exec_gttfill (all-engines)
[340.348945] Starting subtest: all-engines
[363.474756] Subtest all-engines: SUCCESS (23.118s)
[363.667373] [078/154] (663s left) syncobj_wait (multi-wait-all-signaled)
[363.764014] Starting subtest: multi-wait-all-signaled
[363.766449] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[363.845298] [079/154] (663s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary)
[363.974323] Starting subtest: fbchdr-shrfb-scaledprimary
[363.978665] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s)
[364.068100] [080/154] (663s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[364.223133] Starting subtest: dp-mst-type-1-suspend-resume
[364.227759] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[364.353494] [081/154] (662s left) kms_atomic (plane-invalid-params-fence)
[364.447192] Starting subtest: plane-invalid-params-fence
[364.449478] Starting dynamic subtest: pipe-A-eDP-1
[364.842705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[364.845016] Subtest plane-invalid-params-fence: SUCCESS (0.395s)
[365.720631] [082/154] (661s left) syncobj_timeline (wait-all-for-submit-complex)
[365.775230] Starting subtest: wait-all-for-submit-complex
[365.989400] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[366.066224] [083/154] (661s left) kms_big_fb (yf-tiled-addfb)
[366.183110] Starting subtest: yf-tiled-addfb
[366.187723] Subtest yf-tiled-addfb: SKIP (0.000s)
[366.283937] [084/154] (661s left) kms_plane_scaling (planes-upscale-factor-0-25)
[366.384626] Starting subtest: planes-upscale-factor-0-25
[366.386999] Starting dynamic subtest: pipe-A
[366.445129] Dynamic subtest pipe-A: SUCCESS (0.062s)
[366.455627] Starting dynamic subtest: pipe-B
[367.643295] Dynamic subtest pipe-B: SUCCESS (1.196s)
[367.653567] Starting dynamic subtest: pipe-C
[368.751843] Dynamic subtest pipe-C: SUCCESS (1.107s)
[368.764534] Starting dynamic subtest: pipe-D
[369.886464] Dynamic subtest pipe-D: SUCCESS (1.133s)
[369.888856] Subtest planes-upscale-factor-0-25: SUCCESS (3.503s)
[371.041217] [085/154] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[371.138056] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[374.828555] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.694s)
[376.069079] [086/154] (651s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[376.168685] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[376.171026] Starting dynamic subtest: pipe-A-eDP-1
[376.243179] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[376.254044] Starting dynamic subtest: pipe-B-eDP-1
[377.413439] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s)
[377.418160] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.248s)
[378.614029] [087/154] (648s left) perf (gen12-unprivileged-single-ctx-counters)
[378.742644] Starting subtest: gen12-unprivileged-single-ctx-counters
[378.745200] Starting dynamic subtest: rcs0
[378.813013] Dynamic subtest rcs0: SUCCESS (0.070s)
[378.815377] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.071s)
[378.865134] [088/154] (648s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[378.953963] Subtest tiled-to-tiled: SKIP (0.000s)
[379.038344] [089/154] (648s left) i915_pm_rps (min-max-config-loaded)
[379.095762] Starting subtest: min-max-config-loaded
[379.100315] Subtest min-max-config-loaded: SKIP (0.000s)
[379.200114] [090/154] (648s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[379.306373] Starting subtest: 4-tiled-64bpp-rotate-180
[380.818962] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.512s)
[380.997684] [091/154] (646s left) i915_drm_fdinfo (all-busy-idle-check-all)
[381.045095] Starting subtest: all-busy-idle-check-all
[381.053077] Subtest all-busy-idle-check-all: SKIP (0.003s)
[381.125400] [092/154] (646s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[381.263639] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[381.267069] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[381.353310] [093/154] (646s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[381.446911] Starting subtest: psrhdr-rgb101010-draw-pwrite
[381.450365] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[381.537893] [094/154] (646s left) gem_sync (basic-all)
[381.611029] Starting subtest: basic-all
[384.763997] Subtest basic-all: SUCCESS (3.159s)
[384.952874] [095/154] (642s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[385.070484] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[385.074704] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[385.176179] [096/154] (642s left) kms_lease (cursor-implicit-plane)
[385.278759] Starting subtest: cursor-implicit-plane
[385.280985] Starting dynamic subtest: pipe-A-eDP-1
[385.739864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[385.750804] Starting dynamic subtest: pipe-B-eDP-1
[386.843075] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.105s)
[386.854690] Starting dynamic subtest: pipe-C-eDP-1
[387.960512] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[387.971513] Starting dynamic subtest: pipe-D-eDP-1
[389.107310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[389.109568] Subtest cursor-implicit-plane: SUCCESS (3.830s)
[389.955881] [097/154] (638s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[390.049991] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[390.052282] Starting dynamic subtest: pipe-A-default-mode
[392.837843] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[392.840072] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.788s)
[393.681007] [098/154] (634s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[393.773627] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[393.778038] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[393.874864] [099/154] (634s left) gem_ctx_shared (single-timeline)
[393.934340] Starting subtest: single-timeline
[393.957040] Subtest single-timeline: SUCCESS (0.016s)
[394.189334] [100/154] (633s left) kms_plane_multiple (2x-tiling-4)
[394.281104] Starting subtest: 2x-tiling-4
[394.285185] Subtest 2x-tiling-4: SKIP (0.000s)
[394.358110] [101/154] (633s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[394.416599] Starting subtest: y-tiled-to-vebox-y-tiled
[394.420524] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[394.601791] [102/154] (633s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[394.705141] Starting subtest: fbcpsr-tiling-linear
[401.332706] Subtest fbcpsr-tiling-linear: SUCCESS (6.629s)
[401.458543] [103/154] (626s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[401.565766] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[401.570050] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.688127] [104/154] (626s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[402.068680] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[402.922841] [105/154] (625s left) gem_exec_whisper (basic-sync-all)
[402.989891] Starting subtest: basic-sync-all
[408.678731] Subtest basic-sync-all: SUCCESS (5.686s)
[408.890331] [106/154] (619s left) syncobj_wait (invalid-reset-bad-pad)
[408.952940] Starting subtest: invalid-reset-bad-pad
[408.955313] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[409.064530] [107/154] (619s left) sysfs_preempt_timeout (invalid)
[409.112619] Starting subtest: invalid
[409.115080] Starting dynamic subtest: vecs0
[409.117486] Dynamic subtest vecs0: SUCCESS (0.000s)
[409.130501] Starting dynamic subtest: ccs0
[409.132807] Dynamic subtest ccs0: SUCCESS (0.000s)
[409.143020] Starting dynamic subtest: vcs0
[409.145174] Dynamic subtest vcs0: SUCCESS (0.000s)
[409.155214] Starting dynamic subtest: bcs0
[409.157531] Dynamic subtest bcs0: SUCCESS (0.000s)
[409.167636] Starting dynamic subtest: rcs0
[409.170152] Dynamic subtest rcs0: SUCCESS (0.000s)
[409.180795] Starting dynamic subtest: vcs1
[409.183273] Dynamic subtest vcs1: SUCCESS (0.000s)
[409.185633] Subtest invalid: SUCCESS (0.006s)
[409.228114] [108/154] (619s left) kms_cursor_legacy (torture-bo)
[409.352314] Starting subtest: torture-bo
[409.354584] Starting dynamic subtest: pipe-A
[415.033852] Dynamic subtest pipe-A: SUCCESS (5.681s)
[415.063327] Starting dynamic subtest: pipe-B
[421.483614] Dynamic subtest pipe-B: SUCCESS (6.450s)
[421.494319] Starting dynamic subtest: pipe-C
[427.515717] Dynamic subtest pipe-C: SUCCESS (6.031s)
[427.527706] Starting dynamic subtest: pipe-D
[434.041298] Dynamic subtest pipe-D: SUCCESS (6.524s)
[434.054834] Starting dynamic subtest: all-pipes
[439.994740] Dynamic subtest all-pipes: SUCCESS (5.952s)
[439.997591] Subtest torture-bo: SUCCESS (30.647s)
[440.166612] [109/154] (588s left) gem_ctx_persistence (engines-hostile)
[440.221482] Starting subtest: engines-hostile
[440.223805] Starting dynamic subtest: rcs0
[440.291520] Dynamic subtest rcs0: SUCCESS (0.070s)
[440.303012] Starting dynamic subtest: bcs0
[440.380769] Dynamic subtest bcs0: SUCCESS (0.087s)
[440.393819] Starting dynamic subtest: vcs0
[440.468744] Dynamic subtest vcs0: SUCCESS (0.086s)
[440.482398] Starting dynamic subtest: vcs1
[440.575551] Dynamic subtest vcs1: SUCCESS (0.105s)
[440.588689] Starting dynamic subtest: vecs0
[440.646023] Dynamic subtest vecs0: SUCCESS (0.068s)
[440.660230] Starting dynamic subtest: ccs0
[440.766535] Dynamic subtest ccs0: SUCCESS (0.119s)
[440.769141] Subtest engines-hostile: SUCCESS (0.546s)
[440.850195] [110/154] (587s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[440.960687] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[440.965088] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[441.044605] [111/154] (587s left) perf_pmu (event-wait)
[441.087473] Starting subtest: event-wait
[441.089333] Starting dynamic subtest: rcs0
[441.092936] Dynamic subtest rcs0: SKIP (0.000s)
[441.096369] Subtest event-wait: SKIP (0.001s)
[441.214647] [112/154] (587s left) syncobj_eventfd (binary-wait-signaled)
[441.262889] Starting subtest: binary-wait-signaled
[441.264932] Subtest binary-wait-signaled: SUCCESS (0.000s)
[441.374853] [113/154] (587s left) i915_query (engine-info-invalid)
[441.429749] Starting subtest: engine-info-invalid
[441.431624] Subtest engine-info-invalid: SUCCESS (0.000s)
[441.539327] [114/154] (587s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[441.630447] Starting subtest: fbc-indfb-scaledprimary
[444.481099] Subtest fbc-indfb-scaledprimary: SUCCESS (2.853s)
[445.642528] [115/154] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[445.741767] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[445.745846] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[445.833698] [116/154] (582s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[445.928429] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[445.932579] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.022522] [117/154] (582s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[446.145516] Starting subtest: cursorB-vs-flipB-atomic
[446.149974] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[446.293255] [118/154] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[446.401630] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[446.405644] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[446.500601] [119/154] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[446.603965] Starting subtest: fbcpsr-1p-rte
[453.665294] Subtest fbcpsr-1p-rte: SUCCESS (7.064s)
[453.824821] [120/154] (575s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[453.923754] Starting subtest: primary-y-tiled-reflect-x-180
[453.994832] Subtest primary-y-tiled-reflect-x-180: SKIP (0.070s)
[454.099110] [121/154] (574s left) gem_exec_schedule (semaphore-user)
[454.177054] Starting subtest: semaphore-user
[454.228967] Subtest semaphore-user: SUCCESS (0.058s)
[455.667529] [122/154] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[455.762787] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[455.767205] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[455.857534] [123/154] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[455.953581] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[463.032280] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.082s)
[463.173862] [124/154] (565s left) kms_addfb_basic (bad-pitch-0)
[463.234269] Starting subtest: bad-pitch-0
[463.236681] Subtest bad-pitch-0: SUCCESS (0.000s)
[463.381119] [125/154] (565s left) dumb_buffer (map-uaf)
[463.441639] Starting subtest: map-uaf
[463.443996] Subtest map-uaf: SUCCESS (0.005s)
[463.541743] [126/154] (565s left) gen9_exec_parse (batch-zero-length)
[463.612526] Subtest batch-zero-length: SKIP (0.000s)
[463.686118] [127/154] (565s left) syncobj_wait (single-wait-for-submit-signaled)
[463.740627] Starting subtest: single-wait-for-submit-signaled
[463.742627] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[463.846782] [128/154] (565s left) gem_exec_store (cachelines)
[463.914999] Starting subtest: cachelines
[463.917311] Starting dynamic subtest: rcs0
[463.994227] Dynamic subtest rcs0: SUCCESS (0.078s)
[464.007113] Starting dynamic subtest: bcs0
[464.056436] Dynamic subtest bcs0: SUCCESS (0.061s)
[464.069108] Starting dynamic subtest: vcs0
[464.115891] Dynamic subtest vcs0: SUCCESS (0.058s)
[464.127938] Starting dynamic subtest: vcs1
[464.178978] Dynamic subtest vcs1: SUCCESS (0.061s)
[464.191559] Starting dynamic subtest: vecs0
[464.231883] Dynamic subtest vecs0: SUCCESS (0.051s)
[464.243438] Starting dynamic subtest: ccs0
[464.289005] Dynamic subtest ccs0: SUCCESS (0.055s)
[464.291503] Subtest cachelines: SUCCESS (0.376s)
[464.474557] [129/154] (564s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[464.578044] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[464.582162] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[464.670236] [130/154] (564s left) core_auth (basic-auth)
[464.719250] Starting subtest: basic-auth
[464.721741] Subtest basic-auth: SUCCESS (0.001s)
[464.820931] [131/154] (564s left) gem_ctx_persistence (legacy-engines-cleanup)
[464.876257] Starting subtest: legacy-engines-cleanup
[464.878743] Starting dynamic subtest: render
[464.946334] Dynamic subtest render: SUCCESS (0.070s)
[464.962480] Starting dynamic subtest: bsd1
[465.000486] Dynamic subtest bsd1: SUCCESS (0.051s)
[465.015420] Starting dynamic subtest: bsd2
[465.035511] Dynamic subtest bsd2: SUCCESS (0.032s)
[465.045681] Starting dynamic subtest: blt
[465.072302] Dynamic subtest blt: SUCCESS (0.034s)
[465.083069] Starting dynamic subtest: vebox
[465.112765] Dynamic subtest vebox: SUCCESS (0.037s)
[465.115156] Subtest legacy-engines-cleanup: SUCCESS (0.236s)
[465.206089] [132/154] (564s left) sw_sync (sync_multi_consumer_producer)
[465.241737] Starting subtest: sync_multi_consumer_producer
[465.538773] Subtest sync_multi_consumer_producer: SUCCESS (0.298s)
[465.610668] [133/154] (563s left) gem_exec_await (wide-all)
[465.815830] Starting subtest: wide-all
[489.383056] Subtest wide-all: SUCCESS (23.562s)
[489.576341] [134/154] (539s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[489.712796] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[489.714645] Starting dynamic subtest: pipe-A-eDP-1
[489.867988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[489.881832] Starting dynamic subtest: pipe-B-eDP-1
[489.901496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[489.914609] Starting dynamic subtest: pipe-C-eDP-1
[489.933313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[489.943978] Starting dynamic subtest: pipe-D-eDP-1
[489.962906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[489.965055] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[492.176471] [135/154] (537s left) kms_psr (psr-cursor-blt)
[492.279169] Starting subtest: psr-cursor-blt
[492.281515] Starting dynamic subtest: eDP-1
[493.970174] Dynamic subtest eDP-1: SUCCESS (1.691s)
[493.972565] Subtest psr-cursor-blt: SUCCESS (1.692s)
[494.860664] [136/154] (534s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[494.965861] Starting subtest: hdr-rgb565-draw-blt
[494.970130] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[495.060728] [137/154] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[495.155079] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[495.158974] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[495.252562] [138/154] (534s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[495.348333] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[495.352760] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[495.457420] [139/154] (534s left) perf_pmu (interrupts)
[495.499180] Starting subtest: interrupts
[496.558951] Subtest interrupts: SUCCESS (1.059s)
[496.688136] [140/154] (533s left) kms_frontbuffer_tracking (psrhdr-suspend)
[496.792341] Starting subtest: psrhdr-suspend
[496.796549] Subtest psrhdr-suspend: SKIP (0.000s)
[496.895419] [141/154] (532s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[496.987831] Starting subtest: fbcpsr-slowdraw
[522.200491] Subtest fbcpsr-slowdraw: SUCCESS (25.208s)
[522.333025] [142/154] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[522.436081] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[522.440601] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[522.537116] [143/154] (507s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[522.633572] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[522.637726] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.726506] [144/154] (507s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[522.792306] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[522.794866] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[522.902301] [145/154] (507s left) gem_mmap_gtt (zero-extend)
[522.968782] Subtest zero-extend: SKIP (0.000s)
[523.026701] [146/154] (507s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[523.129900] Starting subtest: y-tiled-16bpp-rotate-0
[523.133695] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[523.231945] [147/154] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[523.331490] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[530.715450] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.385s)
[530.878171] [148/154] (499s left) gem_exec_fence (syncobj-timeline-repeat)
[531.406958] Starting subtest: syncobj-timeline-repeat
[531.655801] Subtest syncobj-timeline-repeat: SUCCESS (0.249s)
[532.693992] [149/154] (497s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[532.786596] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[532.790723] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[532.885603] [150/154] (497s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[532.976710] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[532.979541] Starting dynamic subtest: pipe-A
[532.999027] Dynamic subtest pipe-A: SKIP (0.017s)
[533.010203] Starting dynamic subtest: pipe-B
[533.030501] Dynamic subtest pipe-B: SKIP (0.032s)
[533.041434] Starting dynamic subtest: pipe-C
[533.064102] Dynamic subtest pipe-C: SKIP (0.032s)
[533.074823] Starting dynamic subtest: pipe-D
[533.095514] Dynamic subtest pipe-D: SKIP (0.032s)
[533.099849] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.116s)
[533.194112] [151/154] (497s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[533.282591] Starting subtest: crc-primary-basic-yf-tiled-ccs
[533.284905] Starting dynamic subtest: pipe-A-eDP-1
[533.307980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[533.321714] Starting dynamic subtest: pipe-B-eDP-1
[533.343553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.354426] Starting dynamic subtest: pipe-C-eDP-1
[533.376074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.386480] Starting dynamic subtest: pipe-D-eDP-1
[533.409187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.413188] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[535.592648] [152/154] (494s left) kms_fbcon_fbt (psr-suspend)
[535.650304] Starting subtest: psr-suspend
[586.107552] Subtest psr-suspend: SUCCESS (21.248s)
[587.192769] [153/154] (444s left) prime_mmap (test_dup)
[587.254748] Starting subtest: test_dup
[587.256896] Starting dynamic subtest: test_dup-smem
[587.284443] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[587.286805] Subtest test_dup: SUCCESS (0.032s)
[587.377338] [154/154] (444s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[587.486605] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[587.490508] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[587.565447] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_universal_plane
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: core_setmaster_vs_auth
results: parsing output: 27/ for test: gem_partial_pwrite_pread
results: parsing output: 28/ for test: kms_draw_crc
results: parsing output: 29/ for test: gem_fence_thrash
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_ccs
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_pwrite
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_chamelium_frames
results: parsing output: 45/ for test: api_intel_allocator
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_stress
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_set_tiling_vs_gtt
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_prime
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: gem_exec_gttfill
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: kms_atomic
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: gem_set_tiling_vs_blt
results: parsing output: 88/ for test: i915_pm_rps
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_plane_multiple
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_chamelium_hpd
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: sysfs_preempt_timeout
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: syncobj_eventfd
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: dumb_buffer
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_store
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: core_auth
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: sw_sync
results: parsing output: 132/ for test: gem_exec_await
results: parsing output: 133/ for test: kms_ccs
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: perf_pmu
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_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: syncobj_timeline
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_fence
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_plane_scaling
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: kms_fbcon_fbt
results: parsing output: 152/ for test: prime_mmap
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.