[56.812059] Initializing watchdogs
[56.812106]   /dev/watchdog0
[56.827356] [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]
[56.831782] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.834073] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.837588] [001/154] (960s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[56.966764] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[56.969056] Starting dynamic subtest: pipe-A-eDP-1
[56.990346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[56.997954] Starting dynamic subtest: pipe-B-eDP-1
[57.018752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.025629] Starting dynamic subtest: pipe-C-eDP-1
[57.046188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.052911] Starting dynamic subtest: pipe-D-eDP-1
[57.074506] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.078555] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[59.254858] [002/154] (958s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[59.308277] Starting subtest: multi-wait-all-available-submitted-signaled
[59.310577] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[59.407012] [003/154] (958s left) dmabuf_sync_file (export-multiwait)
[59.480611] Starting subtest: export-multiwait
[59.482511] Subtest export-multiwait: SUCCESS (0.001s)
[59.544773] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[59.547882] [004/154] (957s left) prime_busy (hang)
[59.602792] Starting subtest: hang
[59.605177] Starting dynamic subtest: rcs0
[86.808523] Dynamic subtest rcs0: SUCCESS (27.268s)
[86.821250] Starting dynamic subtest: bcs0
[93.973668] Dynamic subtest bcs0: SUCCESS (7.153s)
[93.980934] Starting dynamic subtest: vcs0
[100.937677] Dynamic subtest vcs0: SUCCESS (6.976s)
[100.945062] Starting dynamic subtest: vcs1
[107.979265] Dynamic subtest vcs1: SUCCESS (7.037s)
[107.991034] Starting dynamic subtest: vecs0
[114.952037] Dynamic subtest vecs0: SUCCESS (6.973s)
[114.962085] Starting dynamic subtest: ccs0
[128.793861] Dynamic subtest ccs0: SUCCESS (13.840s)
[128.796777] Subtest hang: SUCCESS (69.252s)
[128.923321] [005/154] (888s left) kms_frontbuffer_tracking (fbc-tiling-y)
[129.027503] Starting subtest: fbc-tiling-y
[129.031617] Subtest fbc-tiling-y: SKIP (0.000s)
[129.140178] [006/154] (888s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[129.198995] Starting subtest: rel-constants-invalid-rel-gen5
[129.201419] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[129.322504] [007/154] (888s left) syncobj_basic (bad-flags-handle-to-fd)
[129.376725] Starting subtest: bad-flags-handle-to-fd
[129.379072] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[129.462673] [008/154] (888s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[129.554208] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[129.558356] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[129.651674] [009/154] (888s left) kms_psr (fbc-psr-sprite-render)
[129.736149] Starting subtest: fbc-psr-sprite-render
[129.738466] Starting dynamic subtest: eDP-1
[129.742589] Dynamic subtest eDP-1: SKIP (0.000s)
[129.746694] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[129.812300] [010/154] (887s left) vgem_basic (busy-fence)
[129.850054] Starting subtest: busy-fence
[129.852067] Subtest busy-fence: SUCCESS (0.000s)
[129.908341] [011/154] (887s left) kms_chamelium_audio (hdmi-audio-edid)
[130.291357] Subtest hdmi-audio-edid: SKIP (0.000s)
[131.090789] [012/154] (886s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw)
[131.202447] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw
[131.206490] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[131.299954] [013/154] (886s left) gem_ctx_persistence (engines-mixed-process)
[131.361082] Starting subtest: engines-mixed-process
[131.363390] Starting dynamic subtest: rcs0
[133.322756] Dynamic subtest rcs0: SUCCESS (1.961s)
[133.332621] Starting dynamic subtest: bcs0
[135.307918] Dynamic subtest bcs0: SUCCESS (1.985s)
[135.316963] Starting dynamic subtest: vcs0
[137.284049] Dynamic subtest vcs0: SUCCESS (1.975s)
[137.294860] Starting dynamic subtest: vcs1
[139.278862] Dynamic subtest vcs1: SUCCESS (1.994s)
[139.289372] Starting dynamic subtest: vecs0
[141.336786] Dynamic subtest vecs0: SUCCESS (2.057s)
[141.347744] Starting dynamic subtest: ccs0
[143.304152] Dynamic subtest ccs0: SUCCESS (1.963s)
[143.306209] Subtest engines-mixed-process: SUCCESS (11.941s)
[143.382668] [014/154] (874s left) i915_drm_fdinfo (busy-idle)
[143.425562] Starting subtest: busy-idle
[143.427464] Starting dynamic subtest: rcs0
[143.449117] Dynamic subtest rcs0: SKIP (0.023s)
[143.459877] Starting dynamic subtest: bcs0
[143.464535] Dynamic subtest bcs0: SKIP (0.000s)
[143.472658] Starting dynamic subtest: vcs0
[143.477273] Dynamic subtest vcs0: SKIP (0.000s)
[143.485795] Starting dynamic subtest: vcs1
[143.489978] Dynamic subtest vcs1: SKIP (0.000s)
[143.497110] Starting dynamic subtest: vecs0
[143.501233] Dynamic subtest vecs0: SKIP (0.000s)
[143.508564] Starting dynamic subtest: ccs0
[143.512855] Dynamic subtest ccs0: SKIP (0.000s)
[143.517071] Subtest busy-idle: SKIP (0.025s)
[143.554484] [015/154] (874s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[143.611666] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[143.678136] [016/154] (874s left) kms_flip (2x-plain-flip-interruptible)
[143.774811] Starting subtest: 2x-plain-flip-interruptible
[143.787780] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[143.863317] [017/154] (874s left) gem_workarounds (basic-read)
[143.918078] Starting subtest: basic-read
[143.928585] Subtest basic-read: SUCCESS (0.010s)
[144.059283] [018/154] (873s left) kms_flip (2x-flip-vs-expired-vblank)
[144.155468] Starting subtest: 2x-flip-vs-expired-vblank
[144.166362] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[144.245386] [019/154] (873s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[144.345724] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[144.349756] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[144.435130] [020/154] (873s left) kms_psr (pr-sprite-render)
[144.519288] Starting subtest: pr-sprite-render
[144.523034] Subtest pr-sprite-render: SKIP (0.000s)
[144.587405] [021/154] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[144.694399] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[145.407967] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.715s)
[145.572831] [022/154] (872s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[145.679759] Starting subtest: fbcpsr-slowdraw
[170.943876] Subtest fbcpsr-slowdraw: SUCCESS (25.268s)
[171.090189] [023/154] (847s left) kms_pipe_stress (stress-xrgb8888-untiled)
[171.193952] Starting subtest: stress-xrgb8888-untiled
[177.153663] Subtest stress-xrgb8888-untiled: SUCCESS (5.960s)
[177.203033] [024/154] (841s left) gem_exec_balancer (bonded-false-hang)
[177.454345] Starting subtest: bonded-false-hang
[177.459522] Subtest bonded-false-hang: SKIP (0.000s)
[177.555800] [025/154] (840s left) i915_query (hwconfig_table)
[177.611891] Starting subtest: hwconfig_table
[177.918540] Subtest hwconfig_table: SUCCESS (0.001s)
[177.957678] [026/154] (840s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[178.052322] Starting subtest: psr-rgb101010-draw-render
[185.608123] Subtest psr-rgb101010-draw-render: SUCCESS (7.561s)
[185.709819] [027/154] (832s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[185.802252] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[185.804500] Starting dynamic subtest: pipe-A
[185.824088] Dynamic subtest pipe-A: SKIP (0.016s)
[185.832688] Starting dynamic subtest: pipe-B
[185.858183] Dynamic subtest pipe-B: SKIP (0.034s)
[185.866757] Starting dynamic subtest: pipe-C
[185.892098] Dynamic subtest pipe-C: SKIP (0.033s)
[185.900401] Starting dynamic subtest: pipe-D
[185.920510] Dynamic subtest pipe-D: SKIP (0.029s)
[185.925508] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.114s)
[186.035914] [028/154] (832s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[186.140881] Starting subtest: fbc-psr2-primary-mmap-cpu
[186.143183] Starting dynamic subtest: eDP-1
[186.147409] Dynamic subtest eDP-1: SKIP (0.000s)
[186.151734] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[186.208729] [029/154] (832s left) gem_partial_pwrite_pread (reads-snoop)
[186.279390] Subtest reads-snoop: SKIP (0.000s)
[186.358314] [030/154] (832s left) api_intel_bb (intel-bb-blit-y)
[186.408236] Starting subtest: intel-bb-blit-y
[190.376119] Subtest intel-bb-blit-y: SUCCESS (3.968s)
[190.495569] [031/154] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[190.590403] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[190.594743] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[190.691992] [032/154] (827s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[190.788309] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[190.792479] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[190.858245] [033/154] (827s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[190.959659] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[190.964183] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.078432] [034/154] (827s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[191.169834] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[191.174176] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[191.269719] [035/154] (827s left) gem_exec_params (invalid-fence-in)
[191.324052] Starting subtest: invalid-fence-in
[191.326638] Subtest invalid-fence-in: SUCCESS (0.000s)
[191.449790] [036/154] (827s left) syncobj_timeline (host-signal-points)
[191.494356] Starting subtest: host-signal-points
[191.498489] Subtest host-signal-points: SUCCESS (0.005s)
[191.594038] [037/154] (827s left) gem_mmap_gtt (basic-small-bo)
[191.653764] Subtest basic-small-bo: SKIP (0.000s)
[191.714296] [038/154] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[191.802882] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[191.806485] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[191.905871] [039/154] (826s left) gem_ctx_persistence (saturated-hostile)
[191.960261] Starting subtest: saturated-hostile
[191.962372] Starting dynamic subtest: rcs0
[192.787750] Dynamic subtest rcs0: SUCCESS (0.826s)
[192.799977] Starting dynamic subtest: bcs0
[193.592708] Dynamic subtest bcs0: SUCCESS (0.803s)
[193.603852] Starting dynamic subtest: vcs0
[194.393323] Dynamic subtest vcs0: SUCCESS (0.800s)
[194.404183] Starting dynamic subtest: vcs1
[195.209463] Dynamic subtest vcs1: SUCCESS (0.814s)
[195.220870] Starting dynamic subtest: vecs0
[196.024757] Dynamic subtest vecs0: SUCCESS (0.814s)
[196.036225] Starting dynamic subtest: ccs0
[196.868054] Dynamic subtest ccs0: SUCCESS (0.841s)
[196.871043] Subtest saturated-hostile: SUCCESS (4.907s)
[196.950258] [040/154] (821s left) gem_eio (in-flight-internal-10ms)
[197.136317] Starting subtest: in-flight-internal-10ms
[198.335402] Subtest in-flight-internal-10ms: SUCCESS (1.199s)
[198.460418] [041/154] (820s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[198.563141] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[198.565491] Starting dynamic subtest: pipe-A-eDP-1
[198.574781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.584627] Starting dynamic subtest: pipe-B-eDP-1
[198.593727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.602062] Starting dynamic subtest: pipe-C-eDP-1
[198.610747] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.619056] Starting dynamic subtest: pipe-D-eDP-1
[198.627693] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.632055] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[200.882189] [042/154] (818s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[200.984197] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[200.988634] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[201.085426] [043/154] (817s left) gem_eio (in-flight-external)
[201.262607] Starting subtest: in-flight-external
[202.352280] Subtest in-flight-external: SUCCESS (1.089s)
[202.519747] [044/154] (816s left) gem_workarounds (basic-read-context)
[202.573471] Starting subtest: basic-read-context
[202.584093] Subtest basic-read-context: SUCCESS (0.009s)
[202.723438] [045/154] (816s left) kms_flip (blocking-wf_vblank)
[202.812607] Starting subtest: blocking-wf_vblank
[202.815126] Starting dynamic subtest: A-eDP1
[211.741221] Dynamic subtest A-eDP1: SUCCESS (8.897s)
[211.750627] Starting dynamic subtest: B-eDP1
[220.662483] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[220.671426] Starting dynamic subtest: C-eDP1
[229.588457] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[229.600312] Starting dynamic subtest: D-eDP1
[238.524768] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[238.527302] Subtest blocking-wf_vblank: SUCCESS (35.671s)
[239.695708] [046/154] (779s left) kms_big_fb (linear-addfb)
[239.797623] Starting subtest: linear-addfb
[239.799526] Subtest linear-addfb: SUCCESS (0.000s)
[239.905400] [047/154] (779s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[240.019623] Starting subtest: 2x-long-cursor-vs-flip-atomic
[240.024059] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[240.160563] [048/154] (779s left) kms_cursor_crc (cursor-offscreen-64x64)
[240.333864] Starting subtest: cursor-offscreen-64x64
[240.336156] Starting dynamic subtest: pipe-A-eDP-1
[242.301721] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.967s)
[242.330775] Starting dynamic subtest: pipe-D-eDP-1
[244.916830] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[244.919063] Subtest cursor-offscreen-64x64: SUCCESS (4.583s)
[245.778354] [049/154] (773s left) kms_plane (pixel-format-linear-modifier)
[245.863772] Starting subtest: pixel-format-linear-modifier
[245.890602] Starting dynamic subtest: pipe-A-plane-0
[246.468880] Dynamic subtest pipe-A-plane-0: SUCCESS (0.578s)
[246.478418] Starting dynamic subtest: pipe-A-plane-3
[246.889890] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[246.899290] Starting dynamic subtest: pipe-A-plane-5
[247.101250] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[248.262401] Starting dynamic subtest: pipe-B-plane-0
[248.877143] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[248.888192] Starting dynamic subtest: pipe-B-plane-3
[249.332089] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[249.343068] Starting dynamic subtest: pipe-B-plane-5
[249.543288] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[249.855520] Subtest pixel-format-linear-modifier: SUCCESS (3.993s)
[250.724926] [050/154] (768s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[250.822303] Starting subtest: psr-shrfb-scaledprimary
[256.592954] Subtest psr-shrfb-scaledprimary: SUCCESS (5.776s)
[256.728594] [051/154] (762s left) fbdev (unaligned-read)
[256.778604] Starting subtest: unaligned-read
[256.793841] Subtest unaligned-read: SUCCESS (0.015s)
[256.847572] [052/154] (762s left) kms_debugfs (display-on-read-all)
[256.932333] Starting subtest: display-on-read-all
[257.097450] Subtest display-on-read-all: SUCCESS (0.166s)
[257.206888] [053/154] (762s left) perf_pmu (semaphore-wait-idle)
[257.242162] Starting subtest: semaphore-wait-idle
[257.244515] Starting dynamic subtest: rcs0
[257.757266] Dynamic subtest rcs0: SUCCESS (0.513s)
[257.773942] Starting dynamic subtest: bcs0
[258.272075] Dynamic subtest bcs0: SUCCESS (0.511s)
[258.284531] Starting dynamic subtest: vcs0
[258.786393] Dynamic subtest vcs0: SUCCESS (0.511s)
[258.797079] Starting dynamic subtest: vcs1
[259.302561] Dynamic subtest vcs1: SUCCESS (0.512s)
[259.312592] Starting dynamic subtest: vecs0
[259.816391] Dynamic subtest vecs0: SUCCESS (0.511s)
[259.827942] Starting dynamic subtest: ccs0
[260.331391] Dynamic subtest ccs0: SUCCESS (0.513s)
[260.334257] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[260.452220] [054/154] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[260.555814] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[260.560036] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[260.663440] [055/154] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[260.769170] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[268.131570] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.366s)
[268.275815] [056/154] (751s left) kms_cursor_crc (cursor-sliding-512x170)
[268.570725] Starting subtest: cursor-sliding-512x170
[268.575250] Subtest cursor-sliding-512x170: SKIP (0.001s)
[268.715319] [057/154] (750s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[268.804403] Starting subtest: 4-tiled-8bpp-rotate-90
[268.831179] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.024s)
[268.929742] [058/154] (750s left) kms_chamelium_frames (vga-frame-dump)
[269.308757] Subtest vga-frame-dump: SKIP (0.000s)
[270.095630] [059/154] (749s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[270.188162] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[270.192322] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[270.294720] [060/154] (749s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[270.388866] Starting subtest: plane-upscale-factor-0-25-with-rotation
[270.391292] Starting dynamic subtest: pipe-A
[270.616925] Dynamic subtest pipe-A: SUCCESS (0.230s)
[270.627244] Starting dynamic subtest: pipe-B
[271.921574] Dynamic subtest pipe-B: SUCCESS (1.303s)
[271.932953] Starting dynamic subtest: pipe-C
[273.235790] Dynamic subtest pipe-C: SUCCESS (1.312s)
[273.245465] Starting dynamic subtest: pipe-D
[274.579612] Dynamic subtest pipe-D: SUCCESS (1.343s)
[274.582046] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.194s)
[275.761307] [061/154] (743s left) kms_color (ctm-red-to-blue)
[275.849702] Starting subtest: ctm-red-to-blue
[275.851602] Starting dynamic subtest: pipe-A-eDP-1
[276.561696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[276.574584] Starting dynamic subtest: pipe-B-eDP-1
[277.970946] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[277.979811] Starting dynamic subtest: pipe-C-eDP-1
[279.349362] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[279.358672] Starting dynamic subtest: pipe-D-eDP-1
[280.676712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[280.679111] Subtest ctm-red-to-blue: SUCCESS (4.829s)
[281.480903] [062/154] (738s left) gem_exec_fence (syncobj-timeline-unused-fence)
[282.054712] Starting subtest: syncobj-timeline-unused-fence
[282.061793] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[283.416309] [063/154] (736s left) gem_exec_whisper (basic-fds-all)
[283.476912] Starting subtest: basic-fds-all
[295.625643] Subtest basic-fds-all: SUCCESS (12.146s)
[295.809325] [064/154] (724s left) kms_addfb_basic (master-rmfb)
[295.868618] Starting subtest: master-rmfb
[295.870948] Subtest master-rmfb: SUCCESS (0.001s)
[296.012481] [065/154] (723s left) kms_atomic (plane-cursor-legacy)
[296.108710] Starting subtest: plane-cursor-legacy
[296.111104] Starting dynamic subtest: pipe-A-eDP-1
[296.472917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[296.475272] Subtest plane-cursor-legacy: SUCCESS (0.365s)
[297.312124] [066/154] (722s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[297.419688] Starting subtest: hdr-rgb565-draw-render
[297.423642] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[297.524729] [067/154] (722s left) i915_pm_rps (reset)
[297.589315] Starting subtest: reset
[306.042592] Subtest reset: SUCCESS (8.454s)
[306.157174] [068/154] (713s left) kms_joiner (basic-ultra-joiner)
[306.252509] Starting subtest: basic-ultra-joiner
[306.256721] Subtest basic-ultra-joiner: SKIP (0.000s)
[306.318039] [069/154] (713s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[306.429316] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[306.433515] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[306.537563] [070/154] (713s left) syncobj_basic (create-signaled)
[306.598089] Starting subtest: create-signaled
[306.600333] Subtest create-signaled: SUCCESS (0.000s)
[306.702404] [071/154] (713s left) kms_content_protection (content-type-change)
[306.849452] Starting subtest: content-type-change
[306.854293] Subtest content-type-change: SKIP (0.000s)
[306.977907] [072/154] (713s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[307.077711] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[307.080995] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.174734] [073/154] (713s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[307.277532] Starting subtest: y-tiled-32bpp-rotate-90
[307.281094] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[307.376287] [074/154] (712s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[307.467845] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[307.471261] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[307.560656] [075/154] (712s left) gem_mmap_gtt (hang-user)
[307.610646] Subtest hang-user: SKIP (0.000s)
[307.666754] [076/154] (712s left) i915_hangman (gt-engine-hang)
[307.732866] Starting subtest: gt-engine-hang
[307.734727] Starting dynamic subtest: rcs0
[309.277049] Dynamic subtest rcs0: SUCCESS (1.543s)
[309.291073] Starting dynamic subtest: bcs0
[311.262728] Dynamic subtest bcs0: SUCCESS (1.982s)
[311.274937] Starting dynamic subtest: vcs0
[313.246415] Dynamic subtest vcs0: SUCCESS (1.981s)
[313.258169] Starting dynamic subtest: vcs1
[315.229709] Dynamic subtest vcs1: SUCCESS (1.980s)
[315.243604] Starting dynamic subtest: vecs0
[317.278478] Dynamic subtest vecs0: SUCCESS (2.045s)
[317.291091] Starting dynamic subtest: ccs0
[319.262854] Dynamic subtest ccs0: SUCCESS (1.981s)
[319.266071] Subtest gt-engine-hang: SUCCESS (11.531s)
[319.356625] [077/154] (701s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[319.464887] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[319.469396] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[319.561172] [078/154] (700s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[319.657248] Starting subtest: fbc-rgb565-draw-pwrite
[324.238605] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.585s)
[325.440223] [079/154] (695s left) gem_ctx_engines (execute-allforone)
[325.500663] Starting subtest: execute-allforone
[325.514610] Subtest execute-allforone: SUCCESS (0.014s)
[327.374704] [080/154] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[327.475442] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[327.479850] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[327.573248] [081/154] (692s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[327.676371] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[327.678330] Starting dynamic subtest: A-eDP1
[331.246676] Dynamic subtest A-eDP1: SUCCESS (3.570s)
[331.256683] Starting dynamic subtest: B-eDP1
[334.450054] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[334.460661] Starting dynamic subtest: C-eDP1
[337.644756] Dynamic subtest C-eDP1: SUCCESS (3.194s)
[337.654368] Starting dynamic subtest: D-eDP1
[340.865760] Dynamic subtest D-eDP1: SUCCESS (3.222s)
[340.868291] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.194s)
[341.683076] [082/154] (678s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[341.741714] Starting subtest: y-tiled-to-vebox-y-tiled
[341.746234] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[341.937622] [083/154] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[342.044300] Starting subtest: psr-1p-primscrn-cur-indfb-move
[349.430019] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.391s)
[349.553615] [084/154] (671s left) prime_self_import (reimport-vs-gem_close-race)
[349.587827] Starting subtest: reimport-vs-gem_close-race
[354.689591] Subtest reimport-vs-gem_close-race: SUCCESS (5.082s)
[354.758850] [085/154] (665s left) kms_psr (psr-sprite-blt)
[354.854076] Starting subtest: psr-sprite-blt
[354.856363] Starting dynamic subtest: eDP-1
[356.588219] Dynamic subtest eDP-1: SUCCESS (1.733s)
[356.590622] Subtest psr-sprite-blt: SUCCESS (1.734s)
[357.437570] [086/154] (663s left) gem_exec_reloc (basic-gtt-read-active)
[357.494575] Subtest basic-gtt-read-active: SKIP (0.000s)
[357.563829] [087/154] (663s left) kms_frontbuffer_tracking (basic)
[357.673102] Starting subtest: basic
[360.900687] Subtest basic: SUCCESS (3.234s)
[361.028198] [088/154] (659s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[361.114451] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[361.116321] Starting dynamic subtest: pipe-A-eDP-1
[361.166304] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[361.175951] Starting dynamic subtest: pipe-B-eDP-1
[361.223203] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[361.232974] Starting dynamic subtest: pipe-C-eDP-1
[361.279843] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[361.292543] Starting dynamic subtest: pipe-D-eDP-1
[361.339359] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[361.343142] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[363.390856] [089/154] (657s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[363.497424] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[363.499802] Starting dynamic subtest: pipe-A-eDP-1
[363.587365] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[363.598701] Starting dynamic subtest: pipe-B-eDP-1
[364.776935] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[364.781866] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.288s)
[365.959971] [090/154] (654s left) prime_vgem (basic-gtt)
[366.025857] Starting subtest: basic-gtt
[366.030610] Subtest basic-gtt: SKIP (0.000s)
[366.124655] [091/154] (654s left) gem_pwrite (basic-self)
[366.176062] Subtest basic-self: SKIP (0.000s)
[366.240045] [092/154] (654s left) kms_psr (psr-primary-mmap-cpu)
[366.332590] Starting subtest: psr-primary-mmap-cpu
[366.334858] Starting dynamic subtest: eDP-1
[368.046604] Dynamic subtest eDP-1: SUCCESS (1.715s)
[368.049108] Subtest psr-primary-mmap-cpu: SUCCESS (1.716s)
[368.932105] [093/154] (652s left) gem_render_copy (linear)
[368.990558] Starting subtest: linear
[368.992617] Starting dynamic subtest: smem
[369.025935] Dynamic subtest smem: SUCCESS (0.038s)
[369.028487] Subtest linear: SUCCESS (0.039s)
[369.254887] [094/154] (651s left) syncobj_wait (reset-unsignaled)
[369.312362] Starting subtest: reset-unsignaled
[369.314275] Subtest reset-unsignaled: SUCCESS (0.000s)
[369.425117] [095/154] (651s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[369.517641] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[369.519850] Starting dynamic subtest: pipe-A-default-mode
[372.268814] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[372.271100] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.752s)
[373.127706] [096/154] (648s left) gem_mmap_gtt (fault-concurrent-x)
[373.179076] Subtest fault-concurrent-X: SKIP (0.000s)
[373.233427] [097/154] (647s left) gem_spin_batch (legacy)
[373.280083] Starting subtest: legacy
[373.282673] Starting dynamic subtest: default
[376.521968] Dynamic subtest default: SUCCESS (3.236s)
[376.531822] Starting dynamic subtest: render
[379.809852] Dynamic subtest render: SUCCESS (3.232s)
[379.821602] Starting dynamic subtest: bsd
[383.047895] Dynamic subtest bsd: SUCCESS (3.235s)
[383.059770] Starting dynamic subtest: bsd1
[386.284341] Dynamic subtest bsd1: SUCCESS (3.234s)
[386.297761] Starting dynamic subtest: bsd2
[389.523747] Dynamic subtest bsd2: SUCCESS (3.236s)
[389.536196] Starting dynamic subtest: blt
[392.764404] Dynamic subtest blt: SUCCESS (3.238s)
[392.776581] Starting dynamic subtest: vebox
[396.003921] Dynamic subtest vebox: SUCCESS (3.236s)
[396.006865] Subtest legacy: SUCCESS (22.669s)
[396.368943] [098/154] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[396.465217] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[403.827360] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.366s)
[403.959679] [099/154] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[404.061341] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[404.065823] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[404.167220] [100/154] (617s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[404.260954] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[404.265476] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[404.361310] [101/154] (617s left) gem_exec_fence (basic-await)
[404.535157] Starting subtest: basic-await
[404.537500] Starting dynamic subtest: rcs0
[404.608243] Dynamic subtest rcs0: SUCCESS (0.075s)
[404.627412] Starting dynamic subtest: bcs0
[404.680564] Dynamic subtest bcs0: SUCCESS (0.071s)
[404.692842] Starting dynamic subtest: vcs0
[404.755097] Dynamic subtest vcs0: SUCCESS (0.071s)
[404.768301] Starting dynamic subtest: vcs1
[404.826258] Dynamic subtest vcs1: SUCCESS (0.072s)
[404.838753] Starting dynamic subtest: vecs0
[404.899057] Dynamic subtest vecs0: SUCCESS (0.071s)
[404.912391] Starting dynamic subtest: ccs0
[404.973075] Dynamic subtest ccs0: SUCCESS (0.072s)
[404.975853] Subtest basic-await: SUCCESS (0.442s)
[406.362871] [102/154] (615s left) api_intel_bb (delta-check)
[406.419660] Starting subtest: delta-check
[406.422855] Subtest delta-check: SUCCESS (0.006s)
[406.518893] [103/154] (614s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[406.644747] Starting subtest: cursorA-vs-flipA-toggle
[417.793420] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.149s)
[418.603637] [104/154] (602s left) gem_exec_fence (syncobj-export)
[419.011673] Starting subtest: syncobj-export
[419.017029] Subtest syncobj-export: SUCCESS (0.005s)
[420.363509] [105/154] (601s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[420.463023] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[420.467644] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[420.535187] [106/154] (601s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[420.647597] Starting subtest: basic-busy-flip-before-cursor-atomic
[420.652234] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[420.792484] [107/154] (600s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[420.891754] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[420.895934] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[420.991305] [108/154] (600s left) kms_vblank (query-idle)
[421.088275] Starting subtest: query-idle
[421.090167] Starting dynamic subtest: pipe-A-eDP-1
[422.829908] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[422.848090] Starting dynamic subtest: pipe-D-eDP-1
[425.232938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[425.235392] Subtest query-idle: SUCCESS (4.147s)
[426.064950] [109/154] (595s left) gem_pipe_control_store_loop (reused-buffer)
[426.124722] Starting subtest: reused-buffer
[428.332769] Subtest reused-buffer: SUCCESS (2.153s)
[428.409951] [110/154] (593s left) kms_addfb_basic (bad-pitch-128)
[428.457449] Starting subtest: bad-pitch-128
[428.459813] Subtest bad-pitch-128: SUCCESS (0.000s)
[428.590441] [111/154] (593s left) tools_test (tools_test)
[428.638409] Starting subtest: tools_test
[428.695411] Subtest tools_test: SUCCESS (0.066s)
[428.755358] [112/154] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[428.843762] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[428.848133] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[428.936808] [113/154] (592s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[429.002265] Starting subtest: wait-all-for-submit-delayed-submit
[429.106942] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[429.183261] [114/154] (592s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[429.230949] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[429.340135] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[429.421653] [115/154] (592s left) gem_exec_schedule (submit-late-slice)
[429.490070] Starting subtest: submit-late-slice
[429.492347] Starting dynamic subtest: rcs0
[429.521784] Dynamic subtest rcs0: SUCCESS (0.037s)
[429.530973] Starting dynamic subtest: bcs0
[429.560633] Dynamic subtest bcs0: SUCCESS (0.038s)
[429.569721] Starting dynamic subtest: vcs0
[429.599605] Dynamic subtest vcs0: SUCCESS (0.038s)
[429.609742] Starting dynamic subtest: vcs1
[429.636129] Dynamic subtest vcs1: SUCCESS (0.036s)
[429.646173] Starting dynamic subtest: vecs0
[429.669581] Dynamic subtest vecs0: SUCCESS (0.033s)
[429.679279] Starting dynamic subtest: ccs0
[429.712685] Dynamic subtest ccs0: SUCCESS (0.042s)
[429.715078] Subtest submit-late-slice: SUCCESS (0.229s)
[431.393924] [116/154] (590s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[431.496078] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[431.500643] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[431.592729] [117/154] (590s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[431.712017] Starting subtest: cursorA-vs-flipB-atomic-transitions
[431.716509] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[431.861654] [118/154] (590s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[432.099242] Starting subtest: cursor-rapid-movement-128x42
[432.144062] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[432.371415] [119/154] (589s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[432.467760] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[432.471242] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[432.572563] [120/154] (589s left) kms_lease (page-flip-implicit-plane)
[432.663271] Starting subtest: page-flip-implicit-plane
[432.665298] Starting dynamic subtest: pipe-A-eDP-1
[433.134096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[433.145760] Starting dynamic subtest: pipe-B-eDP-1
[434.306195] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[434.316125] Starting dynamic subtest: pipe-C-eDP-1
[435.424761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[435.434810] Starting dynamic subtest: pipe-D-eDP-1
[436.555502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[436.557850] Subtest page-flip-implicit-plane: SUCCESS (3.892s)
[437.395444] [121/154] (584s left) kms_chamelium_hpd (dp-hpd)
[437.778540] Subtest dp-hpd: SKIP (0.000s)
[438.597491] [122/154] (583s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[438.696822] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[438.701390] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[438.789599] [123/154] (583s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render)
[438.885368] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render
[438.889470] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[438.986742] [124/154] (583s left) prime_mmap (test_correct_cpu_write)
[439.036090] Starting subtest: test_correct_cpu_write
[439.038417] Starting dynamic subtest: test_correct_cpu_write-smem
[439.040326] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[439.042369] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[439.131498] [125/154] (583s left) gem_exec_flush (basic-wb-set-default)
[439.194408] Starting subtest: basic-wb-set-default
[444.678042] Subtest basic-wb-set-default: SUCCESS (5.460s)
[444.853394] [126/154] (577s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary)
[444.953262] Starting subtest: fbchdr-indfb-scaledprimary
[444.957384] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s)
[445.060367] [127/154] (577s left) gem_lmem_swapping (parallel-random-verify)
[445.105485] Subtest parallel-random-verify: SKIP (0.000s)
[445.147515] [128/154] (577s left) gem_ctx_shared (q-promotion)
[445.206657] Starting subtest: Q-promotion
[445.208976] Starting dynamic subtest: rcs0
[445.327812] Dynamic subtest rcs0: SUCCESS (0.119s)
[445.338025] Starting dynamic subtest: vcs0
[445.423128] Dynamic subtest vcs0: SUCCESS (0.096s)
[445.440074] Starting dynamic subtest: vcs1
[445.511987] Dynamic subtest vcs1: SUCCESS (0.087s)
[445.526985] Starting dynamic subtest: vecs0
[445.597350] Dynamic subtest vecs0: SUCCESS (0.084s)
[445.608074] Starting dynamic subtest: ccs0
[445.695430] Dynamic subtest ccs0: SUCCESS (0.096s)
[445.697803] Subtest Q-promotion: SUCCESS (0.490s)
[447.397461] [129/154] (575s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[447.502405] Starting subtest: x-tiled-64bpp-rotate-180
[449.147134] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.646s)
[449.302736] [130/154] (573s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[449.387368] Starting subtest: bad-rotation-90-y-tiled-ccs
[449.389761] Starting dynamic subtest: pipe-A-eDP-1
[449.412715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.425273] Starting dynamic subtest: pipe-B-eDP-1
[449.443319] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.452088] Starting dynamic subtest: pipe-C-eDP-1
[449.470056] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.479067] Starting dynamic subtest: pipe-D-eDP-1
[449.497222] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.500936] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[451.681164] [131/154] (570s left) syncobj_timeline (multi-wait-signaled)
[451.736449] Starting subtest: multi-wait-signaled
[451.738453] Subtest multi-wait-signaled: SUCCESS (0.000s)
[451.835674] [132/154] (570s left) gen9_exec_parse (bb-large)
[451.885467] Subtest bb-large: SKIP (0.000s)
[451.951226] [133/154] (570s left) gem_exec_reloc (basic-gtt-active)
[452.009729] Subtest basic-gtt-active: SKIP (0.000s)
[452.082961] [134/154] (570s left) kms_psr (fbc-pr-primary-page-flip)
[452.170687] Starting subtest: fbc-pr-primary-page-flip
[452.174980] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[452.244408] [135/154] (570s left) gem_exec_schedule (manyslice)
[452.313792] Starting subtest: manyslice
[452.315945] Starting dynamic subtest: rcs0
[457.480435] Dynamic subtest rcs0: SUCCESS (5.118s)
[457.490359] Starting dynamic subtest: bcs0
[464.112171] Dynamic subtest bcs0: SUCCESS (6.632s)
[464.125189] Starting dynamic subtest: vcs0
[469.700846] Dynamic subtest vcs0: SUCCESS (5.587s)
[469.711140] Starting dynamic subtest: vcs1
[475.776392] Dynamic subtest vcs1: SUCCESS (6.073s)
[475.791549] Starting dynamic subtest: vecs0
[481.848876] Dynamic subtest vecs0: SUCCESS (6.070s)
[481.858960] Starting dynamic subtest: ccs0
[489.046877] Dynamic subtest ccs0: SUCCESS (7.194s)
[489.050031] Subtest manyslice: SUCCESS (36.686s)
[489.296717] [136/154] (533s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[489.396551] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[489.400845] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[489.491964] [137/154] (533s left) syncobj_wait (multi-wait-signaled)
[489.549728] Starting subtest: multi-wait-signaled
[489.552096] Subtest multi-wait-signaled: SUCCESS (0.000s)
[489.659983] [138/154] (533s left) kms_vrr (lobf)
[489.753691] Starting subtest: lobf
[489.758103] Subtest lobf: SKIP (0.000s)
[489.825866] [139/154] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[489.921448] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[489.925876] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[490.014184] [140/154] (532s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[490.102499] Starting subtest: yf-tiled-64bpp-rotate-270
[490.106984] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[490.201150] [141/154] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[490.296164] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[490.299565] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[490.379141] [142/154] (532s left) perf_pmu (busy-idle-no-semaphores)
[490.414891] Starting subtest: busy-idle-no-semaphores
[490.416943] Starting dynamic subtest: rcs0
[491.067066] Dynamic subtest rcs0: SUCCESS (0.651s)
[491.080805] Starting dynamic subtest: bcs0
[491.719508] Dynamic subtest bcs0: SUCCESS (0.650s)
[491.732255] Starting dynamic subtest: vcs0
[492.371641] Dynamic subtest vcs0: SUCCESS (0.649s)
[492.384705] Starting dynamic subtest: vcs1
[493.928656] Dynamic subtest vcs1: SUCCESS (1.553s)
[493.939997] Starting dynamic subtest: vecs0
[495.913097] Dynamic subtest vecs0: SUCCESS (1.983s)
[495.925924] Starting dynamic subtest: ccs0
[497.897371] Dynamic subtest ccs0: SUCCESS (1.981s)
[497.900470] Subtest busy-idle-no-semaphores: SUCCESS (7.483s)
[498.013946] [143/154] (525s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[498.117865] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[498.122172] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[498.213150] [144/154] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[498.317846] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[498.322237] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[498.424625] [145/154] (524s left) kms_hdr (static-toggle-suspend)
[498.517346] Starting subtest: static-toggle-suspend
[498.519651] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[498.524188] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[498.534844] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[498.539085] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[498.543180] Subtest static-toggle-suspend: SKIP (0.003s)
[498.592976] [146/154] (524s left) gem_eio (in-flight-contexts-1us)
[498.794999] Starting subtest: in-flight-contexts-1us
[510.307184] Subtest in-flight-contexts-1us: SUCCESS (11.510s)
[510.427080] [147/154] (512s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[510.516423] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[510.520561] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[510.586840] [148/154] (512s left) kms_frontbuffer_tracking (fbchdr-suspend)
[510.694280] Starting subtest: fbchdr-suspend
[510.698257] Subtest fbchdr-suspend: SKIP (0.000s)
[510.799034] [149/154] (512s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[510.853955] Starting subtest: yf-tiled-ccs-to-y-tiled
[510.858078] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[511.049704] [150/154] (512s left) gem_wait (wait)
[511.117990] Starting subtest: wait
[511.120462] Starting dynamic subtest: all-engines
[512.319552] Dynamic subtest all-engines: SUCCESS (1.200s)
[512.332062] Starting dynamic subtest: rcs0
[513.365262] Dynamic subtest rcs0: SUCCESS (1.044s)
[513.377217] Starting dynamic subtest: bcs0
[514.412331] Dynamic subtest bcs0: SUCCESS (1.045s)
[514.426966] Starting dynamic subtest: vcs0
[515.462120] Dynamic subtest vcs0: SUCCESS (1.046s)
[515.474518] Starting dynamic subtest: vcs1
[516.506991] Dynamic subtest vcs1: SUCCESS (1.042s)
[516.519552] Starting dynamic subtest: vecs0
[517.552264] Dynamic subtest vecs0: SUCCESS (1.043s)
[517.565263] Starting dynamic subtest: ccs0
[518.601280] Dynamic subtest ccs0: SUCCESS (1.047s)
[518.603743] Subtest wait: SUCCESS (7.484s)
[518.803060] [151/154] (504s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[518.918391] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[518.922351] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[519.041802] [152/154] (504s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[519.147310] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[519.151621] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[519.263068] [153/154] (504s left) kms_dsc (dsc-fractional-bpp)
[519.345354] Starting subtest: dsc-fractional-bpp
[519.358330] Subtest dsc-fractional-bpp: SKIP (0.000s)
[519.416220] [154/154] (504s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[519.502769] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[519.505067] Starting dynamic subtest: pipe-A-eDP-1
[519.561703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[519.571810] Starting dynamic subtest: pipe-B-eDP-1
[519.622386] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[519.632651] Starting dynamic subtest: pipe-C-eDP-1
[519.683574] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[519.693325] Starting dynamic subtest: pipe-D-eDP-1
[519.745079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[519.746908] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.245s)
[522.050374] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: prime_busy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: syncobj_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: vgem_basic
results: parsing output: 10/ for test: kms_chamelium_audio
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pipe_stress
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: i915_query
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: gem_workarounds
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: fbdev
results: parsing output: 51/ for test: kms_debugfs
results: parsing output: 52/ for test: perf_pmu
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_cursor_crc
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_pm_rps
results: parsing output: 67/ for test: kms_joiner
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_content_protection
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: i915_hangman
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_ctx_engines
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: prime_self_import
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: gem_pwrite
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_spin_batch
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: gem_pipe_control_store_loop
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: tools_test
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_schedule
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_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: gem_ctx_shared
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gen9_exec_parse
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: gem_exec_schedule
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: syncobj_wait
results: parsing output: 137/ for test: kms_vrr
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_hdr
results: parsing output: 145/ for test: gem_eio
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: gem_wait
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_dsc
results: parsing output: 153/ for test: kms_ccs
Done.