[57.623942] Initializing watchdogs
[57.623989]   /dev/watchdog0
[57.638382] [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.642685] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.645271] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.648915] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[57.772194] Starting subtest: fbcpsrhdr-rgb565-draw-render
[57.776299] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[57.862832] [002/156] (960s left) i915_suspend (fence-restore-tiled2untiled)
[57.916883] Starting subtest: fence-restore-tiled2untiled
[57.921565] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[58.048179] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[58.145593] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[58.149672] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[58.249354] [004/156] (960s left) gem_lmem_swapping (heavy-verify-random-ccs)
[58.290083] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[58.333505] [005/156] (959s left) gem_eio (in-flight-contexts-immediate)
[58.468189] Starting subtest: in-flight-contexts-immediate
[70.291511] Subtest in-flight-contexts-immediate: SUCCESS (11.821s)
[70.439841] [006/156] (947s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[70.548038] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[77.625803] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.082s)
[77.772872] [007/156] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt)
[77.869205] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt
[77.873560] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[77.961692] [008/156] (940s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[78.062110] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[78.066295] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[78.173636] [009/156] (940s left) prime_mmap (test_aperture_limit)
[78.229754] Starting subtest: test_aperture_limit
[78.232127] Starting dynamic subtest: test_aperture_limit-smem
[78.238750] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[78.242883] Subtest test_aperture_limit: SKIP (0.008s)
[78.338304] [010/156] (940s left) kms_pm_dc (dc3co-vpb-simulation)
[79.436313] Starting subtest: dc3co-vpb-simulation
[88.261283] Subtest dc3co-vpb-simulation: SKIP (8.821s)
[88.373591] [011/156] (930s left) gem_ctx_param (invalid-set-no-zeromap)
[88.417739] Starting subtest: invalid-set-no-zeromap
[88.420064] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[88.492942] [012/156] (930s left) kms_rotation_crc (primary-rotation-270)
[88.586173] Starting subtest: primary-rotation-270
[88.590606] Subtest primary-rotation-270: SKIP (0.001s)
[88.657885] [013/156] (929s left) gem_create (create-valid-nonaligned)
[88.706874] Starting subtest: create-valid-nonaligned
[88.708824] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[88.888044] [014/156] (929s left) core_getversion (basic)
[88.924132] Starting subtest: basic
[88.928033] Subtest basic: SUCCESS (0.000s)
[88.995449] [015/156] (929s left) sw_sync (sync_multi_producer_single_consumer)
[89.028274] Starting subtest: sync_multi_producer_single_consumer
[90.102525] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[90.163444] [016/156] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[90.264068] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[90.268182] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[90.365422] [017/156] (928s left) i915_drm_fdinfo (all-busy-idle-check-all)
[90.406488] Starting subtest: all-busy-idle-check-all
[90.412952] Subtest all-busy-idle-check-all: SKIP (0.004s)
[90.471701] [018/156] (928s left) kms_lease (lease-unleased-connector)
[90.585070] Starting subtest: lease-unleased-connector
[90.587621] Starting dynamic subtest: pipe-A-eDP-1
[90.594923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[90.605815] Starting dynamic subtest: pipe-B-eDP-1
[90.607932] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[90.620270] Starting dynamic subtest: pipe-C-eDP-1
[90.622395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[90.630121] Starting dynamic subtest: pipe-D-eDP-1
[90.631978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[90.633975] Subtest lease-unleased-connector: SUCCESS (0.035s)
[90.721922] [019/156] (928s left) gem_mmap_gtt (cpuset-big-copy-odd)
[90.781372] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[90.846325] [020/156] (928s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[90.899717] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[90.901774] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[90.984891] [021/156] (927s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[91.076716] Starting subtest: psr-rgb565-draw-blt
[98.111045] Subtest psr-rgb565-draw-blt: SUCCESS (7.041s)
[98.257354] [022/156] (920s left) gem_exec_params (dr4-dirt)
[98.319596] Starting subtest: DR4-dirt
[98.321830] Subtest DR4-dirt: SUCCESS (0.000s)
[98.430926] [023/156] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[98.528341] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[98.532741] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[98.628354] [024/156] (920s left) gem_exec_create (forked)
[98.684800] Starting subtest: forked
[98.687210] Starting dynamic subtest: smem
[119.298978] Dynamic subtest smem: SUCCESS (20.613s)
[119.302053] Subtest forked: SUCCESS (20.615s)
[119.495945] [025/156] (899s left) gem_exec_reloc (basic-wc-gtt-active)
[119.555650] Subtest basic-wc-gtt-active: SKIP (0.000s)
[119.631015] [026/156] (899s left) i915_module_load (resize-bar)
[119.661695] Starting subtest: resize-bar
[119.668487] Subtest resize-bar: SKIP (0.006s)
[119.706796] [027/156] (899s left) gem_ccs (ctrl-surf-copy)
[119.769822] Starting subtest: ctrl-surf-copy
[119.774083] Subtest ctrl-surf-copy: SKIP (0.000s)
[119.889517] [028/156] (899s left) kms_big_fb (linear-8bpp-rotate-0)
[119.998955] Starting subtest: linear-8bpp-rotate-0
[121.278887] Subtest linear-8bpp-rotate-0: SUCCESS (1.280s)
[121.405788] [029/156] (897s left) gem_ctx_persistence (idempotent)
[121.454702] Starting subtest: idempotent
[121.456608] Subtest idempotent: SUCCESS (0.000s)
[121.570563] [030/156] (897s left) syncobj_wait (multi-wait-for-submit-signaled)
[121.622503] Starting subtest: multi-wait-for-submit-signaled
[121.624486] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[121.730034] [031/156] (897s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[121.822531] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[121.824355] Starting dynamic subtest: pipe-A-eDP-1
[121.899139] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[121.908115] Starting dynamic subtest: pipe-B-eDP-1
[123.084383] Dynamic subtest pipe-B-eDP-1: SKIP (1.181s)
[123.088763] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.263s)
[124.504242] [032/156] (894s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[124.594656] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[124.599191] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[124.693554] [033/156] (894s left) kms_cursor_crc (cursor-random-32x32)
[124.848629] Starting subtest: cursor-random-32x32
[124.897858] Subtest cursor-random-32x32: SKIP (0.044s)
[125.188208] [034/156] (894s left) gem_userptr_blits (relocations)
[125.246173] Starting subtest: relocations
[125.250879] Subtest relocations: SKIP (0.000s)
[125.364807] [035/156] (894s left) gem_ctx_param (set-priority-invalid-size)
[125.426250] Starting subtest: set-priority-invalid-size
[125.428388] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[125.499404] [036/156] (894s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[125.568448] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[125.570132] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[125.680316] [037/156] (893s left) syncobj_wait (wait-all-snapshot)
[125.739049] Starting subtest: wait-all-snapshot
[125.818361] Subtest wait-all-snapshot: SUCCESS (0.081s)
[125.890159] [038/156] (893s left) kms_psr (psr2-primary-blt)
[125.989116] Starting subtest: psr2-primary-blt
[125.991044] Starting dynamic subtest: eDP-1
[127.707792] Dynamic subtest eDP-1: SUCCESS (1.718s)
[127.710077] Subtest psr2-primary-blt: SUCCESS (1.718s)
[128.592342] [039/156] (891s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[128.639781] Starting subtest: invalid-signal-one-illegal-handle
[128.642175] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[128.750205] [040/156] (890s left) kms_pipe_crc_basic (bad-source)
[128.837142] Starting subtest: bad-source
[128.839422] Subtest bad-source: SUCCESS (0.000s)
[128.915269] [041/156] (890s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[128.964591] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[128.966521] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[129.060951] [042/156] (890s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[129.155127] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[129.157420] Starting dynamic subtest: pipe-A
[129.174888] Dynamic subtest pipe-A: SKIP (0.017s)
[129.186892] Starting dynamic subtest: pipe-B
[129.212415] Dynamic subtest pipe-B: SKIP (0.029s)
[129.221151] Starting dynamic subtest: pipe-C
[129.239202] Dynamic subtest pipe-C: SKIP (0.033s)
[129.249087] Starting dynamic subtest: pipe-D
[129.271964] Dynamic subtest pipe-D: SKIP (0.033s)
[129.275930] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.114s)
[129.392236] [043/156] (890s left) gem_mmap_gtt (basic-small-bo-tiledx)
[129.449432] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[129.514932] [044/156] (890s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[129.604177] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[129.607479] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[129.694388] [045/156] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[129.796824] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[137.184058] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.390s)
[137.317491] [046/156] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[137.427880] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[144.272966] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.853s)
[144.419964] [047/156] (875s left) syncobj_eventfd (binary-wait-before-signal)
[144.472385] Starting subtest: binary-wait-before-signal
[144.501273] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[144.574541] [048/156] (875s left) kms_plane (pixel-format-4-tiled-modifier)
[144.668726] Starting subtest: pixel-format-4-tiled-modifier
[144.695793] Starting dynamic subtest: pipe-A-plane-0
[145.106401] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[145.115730] Starting dynamic subtest: pipe-A-plane-3
[145.428029] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s)
[145.437315] Starting dynamic subtest: pipe-A-plane-5
[145.440876] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[146.552055] Starting dynamic subtest: pipe-B-plane-0
[146.976821] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[146.986776] Starting dynamic subtest: pipe-B-plane-3
[147.299124] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s)
[147.307659] Starting dynamic subtest: pipe-B-plane-5
[147.312290] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[147.612669] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.944s)
[148.443233] [049/156] (871s left) kms_properties (plane-properties-legacy)
[148.549459] Starting subtest: plane-properties-legacy
[148.551760] Starting dynamic subtest: pipe-A-eDP-1
[149.095347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[149.106646] Starting dynamic subtest: pipe-B-eDP-1
[150.406790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[150.416968] Starting dynamic subtest: pipe-C-eDP-1
[151.648090] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[151.659210] Starting dynamic subtest: pipe-D-eDP-1
[152.895330] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[152.897664] Subtest plane-properties-legacy: SUCCESS (4.345s)
[153.695037] [050/156] (866s left) gem_exec_schedule (out-order)
[153.767505] Starting subtest: out-order
[153.769425] Starting dynamic subtest: rcs0
[153.863844] Dynamic subtest rcs0: SUCCESS (0.103s)
[153.875849] Starting dynamic subtest: vcs0
[153.948777] Dynamic subtest vcs0: SUCCESS (0.085s)
[153.966908] Starting dynamic subtest: vcs1
[154.034397] Dynamic subtest vcs1: SUCCESS (0.085s)
[154.047429] Starting dynamic subtest: vecs0
[154.121557] Dynamic subtest vecs0: SUCCESS (0.086s)
[154.132646] Starting dynamic subtest: ccs0
[154.222394] Dynamic subtest ccs0: SUCCESS (0.099s)
[154.225199] Subtest out-order: SUCCESS (0.462s)
[155.349706] [051/156] (864s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[155.450386] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[155.454801] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.550896] [052/156] (864s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[155.652175] Starting subtest: fbc-rgb101010-draw-mmap-wc
[158.216189] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.567s)
[159.415996] [053/156] (860s left) kms_frontbuffer_tracking (psr-1p-rte)
[159.518940] Starting subtest: psr-1p-rte
[164.907274] Subtest psr-1p-rte: SUCCESS (5.395s)
[165.041257] [054/156] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[165.133497] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[165.137823] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[165.228191] [055/156] (855s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[165.324216] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[165.328684] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[165.422753] [056/156] (854s left) kms_content_protection (srm)
[165.557181] Starting subtest: srm
[165.564801] Subtest srm: SKIP (0.003s)
[165.691238] [057/156] (854s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[165.800011] Starting subtest: yf-tiled-32bpp-rotate-0
[165.804197] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[165.903848] [058/156] (854s left) syncobj_wait (invalid-signal-zero-handles)
[165.953604] Starting subtest: invalid-signal-zero-handles
[165.955261] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[166.046992] [059/156] (854s left) gem_pxp (hw-rejects-pxp-context)
[166.159435] Starting subtest: hw-rejects-pxp-context
[166.163538] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[166.275352] [060/156] (854s left) gem_flink_basic (basic)
[166.322155] Starting subtest: basic
[166.323748] Subtest basic: SUCCESS (0.000s)
[166.423948] [061/156] (854s left) perf_pmu (multi-client)
[166.459575] Starting subtest: multi-client
[166.461555] Starting dynamic subtest: rcs0
[167.523814] Dynamic subtest rcs0: SUCCESS (1.061s)
[167.535263] Starting dynamic subtest: bcs0
[168.572354] Dynamic subtest bcs0: SUCCESS (1.046s)
[168.584568] Starting dynamic subtest: vcs0
[169.626586] Dynamic subtest vcs0: SUCCESS (1.051s)
[169.637667] Starting dynamic subtest: vcs1
[171.323823] Dynamic subtest vcs1: SUCCESS (1.695s)
[171.334057] Starting dynamic subtest: vecs0
[173.305531] Dynamic subtest vecs0: SUCCESS (1.979s)
[173.317994] Starting dynamic subtest: ccs0
[175.286358] Dynamic subtest ccs0: SUCCESS (1.978s)
[175.289506] Subtest multi-client: SUCCESS (8.824s)
[175.423120] [062/156] (845s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[177.460800] Starting subtest: dpms-mode-unset-lpsp
[181.550081] Subtest dpms-mode-unset-lpsp: SUCCESS (4.092s)
[181.943792] [063/156] (838s left) kms_flip (2x-flip-vs-panning-interruptible)
[182.040186] Starting subtest: 2x-flip-vs-panning-interruptible
[182.052505] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[182.158856] [064/156] (838s left) perf_pmu (busy-hang)
[182.195083] Starting subtest: busy-hang
[182.197500] Starting dynamic subtest: rcs0
[183.422360] Dynamic subtest rcs0: SUCCESS (1.227s)
[183.431750] Starting dynamic subtest: bcs0
[184.610082] Dynamic subtest bcs0: SUCCESS (1.186s)
[184.619958] Starting dynamic subtest: vcs0
[186.815608] Dynamic subtest vcs0: SUCCESS (2.203s)
[186.824941] Starting dynamic subtest: vcs1
[188.802389] Dynamic subtest vcs1: SUCCESS (1.982s)
[188.812944] Starting dynamic subtest: vecs0
[190.788301] Dynamic subtest vecs0: SUCCESS (1.984s)
[190.797421] Starting dynamic subtest: ccs0
[191.996127] Dynamic subtest ccs0: SUCCESS (1.209s)
[191.998630] Subtest busy-hang: SUCCESS (9.802s)
[192.125876] [065/156] (828s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[192.236772] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[192.241187] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[192.350177] [066/156] (828s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[192.450514] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[192.454666] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[192.555811] [067/156] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[192.658703] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[192.663097] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[192.749578] [068/156] (828s left) kms_color_pipeline (plane-lut1d)
[192.840696] Starting subtest: plane-lut1d
[192.965085] Starting dynamic subtest: pipe-A-plane-0
[193.109555] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[193.118472] Starting dynamic subtest: pipe-A-plane-1
[193.242087] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[193.251205] Starting dynamic subtest: pipe-A-plane-2
[193.375863] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[194.588164] Starting dynamic subtest: pipe-B-plane-0
[194.736078] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[194.745535] Starting dynamic subtest: pipe-B-plane-1
[194.913829] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[194.922897] Starting dynamic subtest: pipe-B-plane-2
[195.047632] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[196.283495] Starting dynamic subtest: pipe-C-plane-0
[196.417933] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[196.430681] Starting dynamic subtest: pipe-C-plane-1
[196.562764] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[196.572295] Starting dynamic subtest: pipe-C-plane-2
[196.706683] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[197.927384] Starting dynamic subtest: pipe-D-plane-0
[198.085573] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[198.094774] Starting dynamic subtest: pipe-D-plane-1
[198.218644] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[198.228279] Starting dynamic subtest: pipe-D-plane-2
[198.363530] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[198.647157] Subtest plane-lut1d: SUCCESS (5.806s)
[199.481109] [069/156] (821s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[199.580589] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[199.584625] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[199.673788] [070/156] (821s left) kms_flip (flip-vs-fences)
[199.774538] Starting subtest: flip-vs-fences
[199.779022] Subtest flip-vs-fences: SKIP (0.000s)
[199.871555] [071/156] (821s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[199.968997] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[199.973453] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[200.062803] [072/156] (820s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[200.162818] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[200.167425] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[200.263531] [073/156] (820s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[200.366687] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[200.370680] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[200.467967] [074/156] (820s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[200.572702] Starting subtest: y-tiled-8bpp-rotate-90
[200.576460] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[200.678314] [075/156] (820s left) kms_psr (fbc-psr-primary-mmap-cpu)
[200.763500] Starting subtest: fbc-psr-primary-mmap-cpu
[200.765432] Starting dynamic subtest: eDP-1
[200.768902] Dynamic subtest eDP-1: SKIP (0.000s)
[200.772466] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[200.851955] [076/156] (820s left) syncobj_basic (bad-create-flags)
[200.907165] Starting subtest: bad-create-flags
[200.909084] Subtest bad-create-flags: SUCCESS (0.000s)
[200.999595] [077/156] (820s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[202.537099] Starting subtest: modeset-non-lpsp-stress-no-wait
[202.597261] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.064s)
[203.327163] [078/156] (817s left) kms_rotation_crc (multiplane-rotation)
[203.420542] Starting subtest: multiplane-rotation
[220.911264] Subtest multiplane-rotation: SUCCESS (17.493s)
[221.014654] [079/156] (800s left) kms_draw_crc (draw-method-render)
[221.117166] Starting subtest: draw-method-render
[221.119079] Starting dynamic subtest: xrgb8888-untiled
[221.350305] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[221.359400] Starting dynamic subtest: rgb565-untiled
[221.582475] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[221.591770] Starting dynamic subtest: xrgb2101010-untiled
[221.793700] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[221.803756] Starting dynamic subtest: xbgr16161616f-untiled
[222.015945] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[222.025413] Starting dynamic subtest: xrgb8888-xtiled
[222.138149] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[222.147041] Starting dynamic subtest: rgb565-xtiled
[222.249698] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[222.259116] Starting dynamic subtest: xrgb2101010-xtiled
[222.371413] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[222.380961] Starting dynamic subtest: xbgr16161616f-xtiled
[222.493710] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[222.502911] Starting dynamic subtest: xrgb8888-4tiled
[222.615851] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[222.624932] Starting dynamic subtest: rgb565-4tiled
[222.727074] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[222.742647] Starting dynamic subtest: xrgb2101010-4tiled
[222.849029] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[222.860078] Starting dynamic subtest: xbgr16161616f-4tiled
[222.982662] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[222.984716] Subtest draw-method-render: SUCCESS (1.867s)
[223.099204] [080/156] (798s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[223.196303] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[223.197985] Starting dynamic subtest: pipe-A-eDP-1
[223.998449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[224.007925] Starting dynamic subtest: pipe-B-eDP-1
[225.533378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s)
[225.543496] Starting dynamic subtest: pipe-C-eDP-1
[227.031870] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[227.042227] Starting dynamic subtest: pipe-D-eDP-1
[228.551071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.518s)
[228.552959] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.348s)
[229.745458] [081/156] (791s left) gem_ctx_sseu (engines)
[229.812310] Subtest engines: SKIP (0.000s)
[229.889875] [082/156] (791s left) sw_sync (sync_merge_invalid)
[229.923170] Starting subtest: sync_merge_invalid
[229.945620] Subtest sync_merge_invalid: SUCCESS (0.026s)
[230.021961] [083/156] (791s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[230.121470] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[230.125455] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[230.225479] [084/156] (791s left) i915_query (query-garbage)
[230.284707] Starting subtest: query-garbage
[230.286731] Subtest query-garbage: SUCCESS (0.000s)
[230.385199] [085/156] (791s left) kms_cursor_legacy (forked-move)
[230.511115] Starting subtest: forked-move
[230.513066] Starting dynamic subtest: pipe-A
[235.968489] Dynamic subtest pipe-A: SUCCESS (5.455s)
[235.987439] Starting dynamic subtest: pipe-B
[241.497287] Dynamic subtest pipe-B: SUCCESS (5.465s)
[241.508204] Starting dynamic subtest: pipe-C
[246.953671] Dynamic subtest pipe-C: SUCCESS (5.464s)
[246.964980] Starting dynamic subtest: pipe-D
[252.422829] Dynamic subtest pipe-D: SUCCESS (5.467s)
[252.440341] Starting dynamic subtest: all-pipes
[257.928929] Dynamic subtest all-pipes: SUCCESS (5.504s)
[257.931367] Subtest forked-move: SUCCESS (27.365s)
[258.027087] [086/156] (763s left) syncobj_timeline (single-wait-available-submitted)
[258.082790] Starting subtest: single-wait-available-submitted
[258.085411] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[258.214461] [087/156] (763s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[258.313932] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[258.318177] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[258.385083] [088/156] (763s left) gem_pxp (hw-rejects-pxp-buffer)
[258.486667] Starting subtest: hw-rejects-pxp-buffer
[258.491033] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[258.590442] [089/156] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[258.683834] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[258.687989] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[258.761169] [090/156] (762s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[259.021503] Starting subtest: parallel-dmabuf-import-out-fence
[260.223294] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.202s)
[260.317598] [091/156] (761s left) syncobj_wait (reset-during-wait-for-submit)
[260.372561] Starting subtest: reset-during-wait-for-submit
[260.476667] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[260.564983] [092/156] (761s left) gem_ringfill (engines-basic)
[266.308746] Starting subtest: engines-basic
[266.311521] Starting dynamic subtest: rcs0
[266.381432] Dynamic subtest rcs0: SUCCESS (0.073s)
[266.394046] Starting dynamic subtest: bcs0
[266.427302] Dynamic subtest bcs0: SUCCESS (0.045s)
[266.437798] Starting dynamic subtest: vcs0
[266.470352] Dynamic subtest vcs0: SUCCESS (0.041s)
[266.482274] Starting dynamic subtest: vcs1
[266.514120] Dynamic subtest vcs1: SUCCESS (0.042s)
[266.528113] Starting dynamic subtest: vecs0
[266.557143] Dynamic subtest vecs0: SUCCESS (0.042s)
[266.568870] Starting dynamic subtest: ccs0
[266.598979] Dynamic subtest ccs0: SUCCESS (0.040s)
[266.601707] Subtest engines-basic: SUCCESS (0.293s)
[266.675663] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[266.679290] [093/156] (755s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[266.776163] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[266.780592] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[266.883557] [094/156] (754s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[266.977753] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[266.982150] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[267.085507] [095/156] (754s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[267.184866] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[267.188842] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[267.283254] [096/156] (754s left) gem_spin_batch (resubmit)
[267.348086] Starting subtest: resubmit
[267.350420] Starting dynamic subtest: rcs0
[267.355302] Dynamic subtest rcs0: SUCCESS (0.006s)
[267.365367] Starting dynamic subtest: bcs0
[267.367517] Dynamic subtest bcs0: SUCCESS (0.002s)
[267.376369] Starting dynamic subtest: vcs0
[267.377941] Dynamic subtest vcs0: SUCCESS (0.003s)
[267.386351] Starting dynamic subtest: vcs1
[267.387954] Dynamic subtest vcs1: SUCCESS (0.003s)
[267.396749] Starting dynamic subtest: vecs0
[267.398367] Dynamic subtest vecs0: SUCCESS (0.003s)
[267.406921] Starting dynamic subtest: ccs0
[267.408602] Dynamic subtest ccs0: SUCCESS (0.004s)
[267.410236] Subtest resubmit: SUCCESS (0.026s)
[267.613672] [097/156] (754s left) sysfs_heartbeat_interval (mixed)
[267.676157] Starting subtest: mixed
[267.678254] Starting dynamic subtest: vecs0
[272.884154] Dynamic subtest vecs0: SUCCESS (5.206s)
[272.896656] Starting dynamic subtest: ccs0
[278.090671] Dynamic subtest ccs0: SUCCESS (5.205s)
[278.103626] Starting dynamic subtest: vcs0
[283.297791] Dynamic subtest vcs0: SUCCESS (5.206s)
[283.307763] Starting dynamic subtest: bcs0
[288.522928] Dynamic subtest bcs0: SUCCESS (5.224s)
[288.534037] Starting dynamic subtest: rcs0
[293.731470] Dynamic subtest rcs0: SUCCESS (5.206s)
[293.744137] Starting dynamic subtest: vcs1
[298.933376] Dynamic subtest vcs1: SUCCESS (5.201s)
[298.936264] Subtest mixed: SUCCESS (31.257s)
[299.011382] [098/156] (722s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[299.107100] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[299.111365] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[299.178740] [099/156] (722s left) gem_exec_flush (basic-uc-prw-default)
[299.253618] Starting subtest: basic-uc-prw-default
[304.742399] Subtest basic-uc-prw-default: SUCCESS (5.462s)
[304.901836] [100/156] (717s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[304.999226] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[305.003627] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[305.081641] [101/156] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[305.193432] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[311.763040] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.577s)
[311.889544] [102/156] (710s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[311.994279] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[311.999117] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[312.102796] [103/156] (710s left) kms_psr (pr-cursor-plane-onoff)
[312.205114] Starting subtest: pr-cursor-plane-onoff
[312.209643] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[312.276444] [104/156] (709s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[312.378055] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[312.382281] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[312.478367] [105/156] (709s left) kms_psr (fbc-pr-cursor-render)
[312.573734] Starting subtest: fbc-pr-cursor-render
[312.578136] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[312.643469] [106/156] (709s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[313.023917] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[313.879847] [107/156] (708s left) kms_chamelium_frames (hdmi-crc-single)
[314.261096] Subtest hdmi-crc-single: SKIP (0.000s)
[315.111883] [108/156] (707s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[315.212736] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[315.217242] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[315.335067] [109/156] (707s left) kms_lease (cursor-implicit-plane)
[315.431950] Starting subtest: cursor-implicit-plane
[315.434263] Starting dynamic subtest: pipe-A-eDP-1
[315.875512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[315.885505] Starting dynamic subtest: pipe-B-eDP-1
[317.041298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[317.055062] Starting dynamic subtest: pipe-C-eDP-1
[318.168243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[318.178269] Starting dynamic subtest: pipe-D-eDP-1
[319.298540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[319.300848] Subtest cursor-implicit-plane: SUCCESS (3.867s)
[320.163619] [110/156] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[320.231781] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[320.340415] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[320.430440] [111/156] (702s left) gen9_exec_parse (bb-oversize)
[320.493298] Subtest bb-oversize: SKIP (0.000s)
[320.548263] [112/156] (702s left) kms_sequence (get-forked)
[320.642789] Starting subtest: get-forked
[320.645081] Starting dynamic subtest: pipe-A-eDP-1
[322.509497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.865s)
[322.519149] Starting dynamic subtest: pipe-B-eDP-1
[325.124655] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.613s)
[325.134631] Starting dynamic subtest: pipe-C-eDP-1
[327.650062] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.523s)
[327.659864] Starting dynamic subtest: pipe-D-eDP-1
[330.181312] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[330.183517] Subtest get-forked: SUCCESS (9.538s)
[330.998802] [113/156] (691s left) gem_exec_params (invalid-batch-start-offset)
[331.062924] Starting subtest: invalid-batch-start-offset
[331.065281] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[331.172261] [114/156] (691s left) gem_exec_reloc (basic-cpu-active)
[331.227072] Subtest basic-cpu-active: SKIP (0.000s)
[331.295121] [115/156] (691s left) gem_exec_params (no-blt)
[331.352320] Starting subtest: no-blt
[331.357339] Subtest no-blt: SUCCESS (0.002s)
[331.477539] [116/156] (691s left) kms_hdr (brightness-with-hdr)
[331.576049] Starting subtest: brightness-with-hdr
[331.578348] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[331.582702] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[331.592419] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[331.596458] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[331.600626] Subtest brightness-with-hdr: SKIP (0.003s)
[331.662331] [117/156] (691s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[331.758106] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[331.784361] Starting dynamic subtest: pipe-A-plane-0
[332.161319] Dynamic subtest pipe-A-plane-0: SUCCESS (0.377s)
[332.170979] Starting dynamic subtest: pipe-A-plane-3
[332.494708] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[333.599128] Starting dynamic subtest: pipe-B-plane-0
[334.001081] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[334.010984] Starting dynamic subtest: pipe-B-plane-3
[334.334607] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[334.658376] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.900s)
[335.482952] [118/156] (687s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[335.582557] Starting subtest: fbc-2p-pri-indfb-multidraw
[335.587079] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[335.681783] [119/156] (687s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[335.768141] Starting subtest: bad-aux-stride-y-tiled-ccs
[335.770482] Starting dynamic subtest: pipe-A-eDP-1
[335.793400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.804960] Starting dynamic subtest: pipe-B-eDP-1
[335.825448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.834842] Starting dynamic subtest: pipe-C-eDP-1
[335.856599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.866423] Starting dynamic subtest: pipe-D-eDP-1
[335.889454] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.894057] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[338.025676] [120/156] (684s left) kms_psr (fbc-psr2-primary-blt)
[338.110754] Starting subtest: fbc-psr2-primary-blt
[338.112987] Starting dynamic subtest: eDP-1
[338.117108] Dynamic subtest eDP-1: SKIP (0.000s)
[338.121174] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[338.201817] [121/156] (684s left) gem_mmap_gtt (ptrace)
[338.259964] Subtest ptrace: SKIP (0.000s)
[338.320549] [122/156] (684s left) api_intel_bb (reset-flags)
[338.374881] Starting subtest: reset-flags
[338.379592] Subtest reset-flags: SUCCESS (0.006s)
[338.515817] [123/156] (684s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[338.623151] Starting subtest: cursor-tearing-framebuffer-change
[338.625391] Starting dynamic subtest: pipe-A-eDP-1
[339.198625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[339.209664] Starting dynamic subtest: pipe-D-eDP-1
[340.449611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[340.451970] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.827s)
[341.286412] [124/156] (681s left) gem_exec_fence (syncobj-channel)
[341.745068] Starting subtest: syncobj-channel
[342.765439] Subtest syncobj-channel: SUCCESS (1.018s)
[343.387788] [125/156] (679s left) gem_exec_balancer (individual)
[343.447897] Starting subtest: individual
[345.272527] Subtest individual: SUCCESS (1.825s)
[345.586577] [126/156] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[345.689260] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[345.693287] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[345.795650] [127/156] (677s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[345.895729] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[345.898078] Starting dynamic subtest: pipe-A-eDP-1
[345.920782] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.932811] Starting dynamic subtest: pipe-B-eDP-1
[345.954703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.964640] Starting dynamic subtest: pipe-C-eDP-1
[345.986668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.996239] Starting dynamic subtest: pipe-D-eDP-1
[346.018423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.022510] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[348.156287] [128/156] (675s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[348.253556] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[352.272683] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.024s)
[353.441567] [129/156] (669s left) api_intel_allocator (two-level-inception)
[353.504795] Starting subtest: two-level-inception
[358.955307] Subtest two-level-inception: SUCCESS (5.400s)
[359.022741] [130/156] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[359.133831] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[359.138267] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[359.245945] [131/156] (664s left) kms_async_flips (async-flip-dpms)
[359.343089] Starting subtest: async-flip-dpms
[359.726463] Starting dynamic subtest: pipe-A-eDP-1
[363.656201] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.928s)
[364.054301] Starting dynamic subtest: pipe-B-eDP-1
[366.907282] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.863s)
[367.282806] Starting dynamic subtest: pipe-C-eDP-1
[370.078306] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.803s)
[370.453686] Starting dynamic subtest: pipe-D-eDP-1
[373.358281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.914s)
[373.360537] Subtest async-flip-dpms: SUCCESS (14.017s)
[374.528960] [132/156] (648s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[374.622813] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[374.626981] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[374.722859] [133/156] (648s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[374.818536] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[374.822738] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[374.906236] [134/156] (648s left) i915_pm_rpm (gem-execbuf-stress)
[376.526296] Starting subtest: gem-execbuf-stress
[376.529049] Starting dynamic subtest: smem0
[389.448501] Dynamic subtest smem0: SUCCESS (12.921s)
[389.460902] Starting dynamic subtest: extra-wait-smem0
[452.464743] Dynamic subtest extra-wait-smem0: SUCCESS (62.960s)
[452.467273] Subtest gem-execbuf-stress: SUCCESS (75.887s)
[452.806169] [135/156] (570s left) kms_vblank (ts-continuation-idle)
[452.902045] Starting subtest: ts-continuation-idle
[452.904371] Starting dynamic subtest: pipe-A-eDP-1
[453.311429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[453.327073] Starting dynamic subtest: pipe-D-eDP-1
[454.380563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.066s)
[454.382879] Subtest ts-continuation-idle: SUCCESS (1.477s)
[455.263896] [136/156] (568s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[455.356370] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[455.360640] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[455.489810] [137/156] (568s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[455.585964] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[456.254588] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[456.429885] [138/156] (567s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[456.522552] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[456.526635] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[456.629447] [139/156] (567s left) gen7_exec_parse (basic-allowed)
[456.689088] Subtest basic-allowed: SKIP (0.000s)
[456.772935] [140/156] (567s left) gem_render_copy_redux (normal)
[456.824726] Starting subtest: normal
[457.102809] Subtest normal: SUCCESS (0.280s)
[457.221935] [141/156] (566s left) gem_exec_whisper (basic-contexts)
[457.276336] Starting subtest: basic-contexts
[465.017212] Subtest basic-contexts: SUCCESS (7.738s)
[465.211115] [142/156] (558s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[465.292993] Starting subtest: primary-x-tiled-reflect-x-180
[472.352810] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.060s)
[473.521874] [143/156] (550s left) kms_cursor_crc (cursor-onscreen-128x128)
[473.741711] Starting subtest: cursor-onscreen-128x128
[473.747112] Starting dynamic subtest: pipe-A-eDP-1
[475.860575] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.113s)
[475.890656] Starting dynamic subtest: pipe-D-eDP-1
[478.677092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[478.679390] Subtest cursor-onscreen-128x128: SUCCESS (4.935s)
[479.576852] [144/156] (544s left) kms_flip (basic-plain-flip)
[479.674499] Starting subtest: basic-plain-flip
[479.676862] Starting dynamic subtest: A-eDP1
[481.382255] Dynamic subtest A-eDP1: SUCCESS (1.707s)
[481.394368] Starting dynamic subtest: B-eDP1
[483.026510] Dynamic subtest B-eDP1: SUCCESS (1.642s)
[483.038670] Starting dynamic subtest: C-eDP1
[484.660257] Dynamic subtest C-eDP1: SUCCESS (1.632s)
[484.673232] Starting dynamic subtest: D-eDP1
[486.297801] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[486.300630] Subtest basic-plain-flip: SUCCESS (6.627s)
[487.472731] [145/156] (536s left) kms_flip (2x-dpms-vs-vblank-race)
[487.563313] Starting subtest: 2x-dpms-vs-vblank-race
[487.577683] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[487.658178] [146/156] (536s left) gem_exec_suspend (basic-s3-devices)
[487.724305] Starting subtest: basic-S3-devices
[487.726718] Starting dynamic subtest: smem
[499.263277] Dynamic subtest smem: SUCCESS (11.536s)
[499.265857] Subtest basic-S3-devices: SUCCESS (11.538s)
[499.455283] [147/156] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[499.557714] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[499.562253] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[499.669483] [148/156] (524s left) gem_exec_suspend (basic-s4-devices)
[499.730604] Starting subtest: basic-S4-devices
[499.732818] Starting dynamic subtest: smem
[511.296284] Dynamic subtest smem: SUCCESS (11.565s)
[511.298976] Subtest basic-S4-devices: SUCCESS (11.568s)
[518.500960] [149/156] (512s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[518.606230] Starting subtest: crc-primary-basic-y-tiled-ccs
[518.608540] Starting dynamic subtest: pipe-A-eDP-1
[518.631573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.645458] Starting dynamic subtest: pipe-B-eDP-1
[518.666684] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.676600] Starting dynamic subtest: pipe-C-eDP-1
[518.697101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.706668] Starting dynamic subtest: pipe-D-eDP-1
[518.727744] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.731953] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[520.902781] [150/156] (510s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[520.993264] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[520.995193] Starting dynamic subtest: pipe-A-eDP-1
[522.203905] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.212s)
[522.214400] Starting dynamic subtest: pipe-B-eDP-1
[524.470912] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[524.488880] Starting dynamic subtest: pipe-C-eDP-1
[526.728066] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.256s)
[526.738734] Starting dynamic subtest: pipe-D-eDP-1
[529.057606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.328s)
[529.060078] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.066s)
[530.220531] [151/156] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[530.311829] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[530.316021] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[530.399492] [152/156] (500s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[530.500314] Starting subtest: 4-tiled-16bpp-rotate-270
[530.519716] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[530.654497] [153/156] (500s left) gem_exec_schedule (u-lateslice)
[530.729253] Starting subtest: u-lateslice
[530.731309] Starting dynamic subtest: rcs0
[530.747262] Dynamic subtest rcs0: SUCCESS (0.026s)
[530.765984] Starting dynamic subtest: bcs0
[530.774810] Dynamic subtest bcs0: SUCCESS (0.022s)
[530.787618] Starting dynamic subtest: vcs0
[530.794241] Dynamic subtest vcs0: SUCCESS (0.020s)
[530.807471] Starting dynamic subtest: vcs1
[530.812309] Dynamic subtest vcs1: SUCCESS (0.020s)
[530.822769] Starting dynamic subtest: vecs0
[530.832431] Dynamic subtest vecs0: SUCCESS (0.019s)
[530.842798] Starting dynamic subtest: ccs0
[530.851828] Dynamic subtest ccs0: SUCCESS (0.019s)
[530.854171] Subtest u-lateslice: SUCCESS (0.131s)
[532.394368] [154/156] (499s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[532.495881] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[532.500220] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[532.586025] [155/156] (498s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[532.681988] Starting subtest: coverage-vs-premult-vs-constant
[532.964560] Starting dynamic subtest: pipe-A-eDP-1
[533.557210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[533.568412] Starting dynamic subtest: pipe-D-eDP-1
[534.921598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.363s)
[534.924161] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.241s)
[535.774493] [156/156] (495s left) gem_create (create-ext-cpu-access-big)
[535.947178] Starting subtest: create-ext-cpu-access-big
[535.952947] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[536.027241] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_suspend
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: kms_pm_dc
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: core_getversion
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_create
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: i915_module_load
results: parsing output: 26/ for test: gem_ccs
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: gem_exec_schedule
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_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: gem_flink_basic
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: perf_pmu
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_color_pipeline
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_draw_crc
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_ctx_sseu
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_ringfill
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_spin_batch
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_sequence
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_hdr
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: i915_pm_rpm
results: parsing output: 134/ for test: kms_vblank
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gen7_exec_parse
results: parsing output: 139/ for test: gem_render_copy_redux
results: parsing output: 140/ for test: gem_exec_whisper
results: parsing output: 141/ for test: kms_rotation_crc
results: parsing output: 142/ for test: kms_cursor_crc
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: gem_exec_suspend
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_suspend
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: gem_exec_schedule
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_plane_alpha_blend
results: parsing output: 155/ for test: gem_create
Done.