[57.382393] Initializing watchdogs
[57.382438]   /dev/watchdog0
[57.396789] [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.401009] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.403552] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.407010] [001/154] (960s left) gem_exec_balancer (bonded-true-hang)
[57.697029] Starting subtest: bonded-true-hang
[57.701875] Subtest bonded-true-hang: SKIP (0.000s)
[57.817289] [002/154] (960s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[57.926961] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[57.929359] Starting dynamic subtest: pipe-A
[58.972077] Dynamic subtest pipe-A: SUCCESS (1.061s)
[58.983766] Starting dynamic subtest: pipe-B
[61.349199] Dynamic subtest pipe-B: SUCCESS (2.401s)
[61.357736] Starting dynamic subtest: pipe-C
[62.526737] Dynamic subtest pipe-C: SUCCESS (1.186s)
[62.534972] Starting dynamic subtest: pipe-D
[63.753583] Dynamic subtest pipe-D: SUCCESS (1.235s)
[63.755824] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.884s)
[64.947738] [003/154] (953s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt)
[65.050294] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt
[65.055066] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[65.140730] [004/154] (952s left) api_intel_allocator (default-alignment)
[65.197070] Starting subtest: default-alignment
[65.201850] Subtest default-alignment: SUCCESS (0.003s)
[65.335776] [005/154] (952s left) kms_getfb (getfb-handle-protection)
[65.434754] Starting subtest: getfb-handle-protection
[65.450299] Subtest getfb-handle-protection: SUCCESS (0.016s)
[65.591763] [006/154] (952s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[65.695431] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[65.699699] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[65.789588] [007/154] (952s left) kms_prime (basic-crc-hybrid)
[65.868538] Subtest basic-crc-hybrid: SKIP (0.000s)
[65.987385] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[65.990062] [008/154] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[66.090474] Starting subtest: psr-rgb101010-draw-mmap-gtt
[66.093880] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[66.182241] [009/154] (952s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[66.279198] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[70.729844] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.469s)
[71.920270] [010/154] (946s left) gem_mmap_gtt (big-bo-tiledy)
[71.970412] Subtest big-bo-tiledY: SKIP (0.000s)
[72.028563] [011/154] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[72.129264] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[72.133463] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[72.242820] [012/154] (946s left) perf_pmu (enable-race)
[72.282984] Starting subtest: enable-race
[72.285559] Starting dynamic subtest: rcs0
[85.091218] Dynamic subtest rcs0: SUCCESS (12.801s)
[85.100893] Starting dynamic subtest: bcs0
[97.834865] Dynamic subtest bcs0: SUCCESS (12.743s)
[97.844551] Starting dynamic subtest: vcs0
[113.280965] Dynamic subtest vcs0: SUCCESS (15.462s)
[113.290251] Starting dynamic subtest: vcs1
[129.278936] Dynamic subtest vcs1: SUCCESS (15.998s)
[129.288186] Starting dynamic subtest: vecs0
[145.279921] Dynamic subtest vecs0: SUCCESS (15.999s)
[145.288827] Starting dynamic subtest: ccs0
[158.037328] Dynamic subtest ccs0: SUCCESS (12.738s)
[158.039657] Subtest enable-race: SUCCESS (85.746s)
[158.129625] [013/154] (860s left) kms_psr (psr2-dpms)
[158.219139] Starting subtest: psr2-dpms
[158.221487] Starting dynamic subtest: eDP-1
[161.231859] Dynamic subtest eDP-1: SUCCESS (3.013s)
[161.234201] Subtest psr2-dpms: SUCCESS (3.013s)
[162.091827] [014/154] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[162.200706] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[162.205234] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[162.296280] [015/154] (856s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[162.397324] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[162.401730] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[162.462453] [016/154] (856s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[162.565924] Starting subtest: yf-tiled-64bpp-rotate-90
[162.570083] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[162.662819] [017/154] (855s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[162.747194] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[162.749576] Starting dynamic subtest: pipe-A-default-mode
[163.965827] Dynamic subtest pipe-A-default-mode: SKIP (1.217s)
[163.970063] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.218s)
[164.098325] [018/154] (854s left) gem_exec_whisper (basic-normal)
[164.160834] Starting subtest: basic-normal
[167.944763] Subtest basic-normal: SUCCESS (3.780s)
[168.144179] [019/154] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[168.254565] Starting subtest: psr2-plane-move-sf-dmg-area
[168.256741] Starting dynamic subtest: pipe-A-eDP-1
[172.771108] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.521s)
[172.782845] Starting dynamic subtest: pipe-B-eDP-1
[178.095987] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s)
[178.098485] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.845s)
[178.952095] [020/154] (839s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[179.046373] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[179.050547] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[179.137883] [021/154] (839s left) gem_exec_gttfill (basic)
[179.202638] Starting subtest: basic
[181.717374] Subtest basic: SUCCESS (2.514s)
[181.916140] [022/154] (836s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[182.080286] Starting subtest: addfb25-y-tiled-legacy
[182.082223] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[182.204327] [023/154] (836s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[182.300801] Starting subtest: hdr-2p-pri-indfb-multidraw
[182.305184] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[182.390071] [024/154] (836s left) kms_plane_multiple (2x-tiling-4)
[182.480879] Starting subtest: 2x-tiling-4
[182.484887] Subtest 2x-tiling-4: SKIP (0.000s)
[182.551180] [025/154] (836s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[182.643923] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[182.648347] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[182.730705] [026/154] (836s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[182.780883] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[182.785617] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[182.964074] [027/154] (835s left) kms_psr (psr-sprite-plane-onoff)
[183.056904] Starting subtest: psr-sprite-plane-onoff
[183.059201] Starting dynamic subtest: eDP-1
[185.133357] Dynamic subtest eDP-1: SUCCESS (2.075s)
[185.135532] Subtest psr-sprite-plane-onoff: SUCCESS (2.076s)
[185.968345] [028/154] (833s left) kms_universal_plane (universal-plane-functional)
[186.061587] Starting subtest: universal-plane-functional
[186.063902] Starting dynamic subtest: pipe-A-eDP-1
[189.829492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.767s)
[189.841865] Starting dynamic subtest: pipe-B-eDP-1
[194.184024] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.353s)
[194.193086] Starting dynamic subtest: pipe-C-eDP-1
[198.364588] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.182s)
[198.373364] Starting dynamic subtest: pipe-D-eDP-1
[202.581125] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.214s)
[202.583450] Subtest universal-plane-functional: SUCCESS (16.521s)
[203.389514] [029/154] (815s left) gem_exec_schedule (pi-shared-iova)
[203.581814] Starting subtest: pi-shared-iova
[203.583734] Starting dynamic subtest: rcs0
[203.658093] Dynamic subtest rcs0: SUCCESS (0.078s)
[203.671468] Starting dynamic subtest: vcs0
[203.723751] Dynamic subtest vcs0: SUCCESS (0.066s)
[203.738172] Starting dynamic subtest: vcs1
[203.775474] Dynamic subtest vcs1: SUCCESS (0.051s)
[203.786640] Starting dynamic subtest: vecs0
[203.832317] Dynamic subtest vecs0: SUCCESS (0.054s)
[203.846220] Starting dynamic subtest: ccs0
[203.887499] Dynamic subtest ccs0: SUCCESS (0.055s)
[203.889829] Subtest pi-shared-iova: SUCCESS (0.309s)
[205.406875] [030/154] (813s left) gem_pxp (hw-rejects-pxp-context)
[205.528200] Starting subtest: hw-rejects-pxp-context
[205.532608] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[205.628678] [031/154] (813s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[205.759172] Starting subtest: 2x-cursor-vs-flip-atomic
[205.763877] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[205.907719] [032/154] (813s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[206.002134] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[206.004473] Starting dynamic subtest: pipe-A-default-mode
[208.749532] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[208.751536] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.748s)
[209.570149] [033/154] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[209.675114] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[209.679306] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[209.770625] [034/154] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[209.867092] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[216.658438] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.797s)
[216.781891] [035/154] (802s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[216.876775] Starting subtest: hdr-farfromfence-mmap-gtt
[216.880747] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[216.990079] [036/154] (802s left) gem_ctx_shared (q-smoketest)
[217.050670] Starting subtest: Q-smoketest
[217.053543] Starting dynamic subtest: rcs0
[222.654281] Dynamic subtest rcs0: SUCCESS (5.499s)
[222.664302] Starting dynamic subtest: bcs0
[228.139751] Dynamic subtest bcs0: SUCCESS (5.482s)
[228.153745] Starting dynamic subtest: vcs0
[233.612138] Dynamic subtest vcs0: SUCCESS (5.477s)
[233.624974] Starting dynamic subtest: vcs1
[239.093363] Dynamic subtest vcs1: SUCCESS (5.481s)
[239.105778] Starting dynamic subtest: vecs0
[244.570864] Dynamic subtest vecs0: SUCCESS (5.472s)
[244.581034] Starting dynamic subtest: ccs0
[250.058534] Dynamic subtest ccs0: SUCCESS (5.485s)
[250.060727] Subtest Q-smoketest: SUCCESS (32.903s)
[250.144765] [037/154] (769s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[250.241363] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[250.245694] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[250.337273] [038/154] (769s left) gem_wait (write-busy)
[250.419469] Starting subtest: write-busy
[250.421824] Starting dynamic subtest: all-engines
[251.027826] Dynamic subtest all-engines: SUCCESS (0.603s)
[251.044467] Starting dynamic subtest: rcs0
[251.577604] Dynamic subtest rcs0: SUCCESS (0.553s)
[251.595500] Starting dynamic subtest: bcs0
[252.130799] Dynamic subtest bcs0: SUCCESS (0.552s)
[252.150632] Starting dynamic subtest: vcs0
[253.311607] Dynamic subtest vcs0: SUCCESS (1.178s)
[253.327429] Starting dynamic subtest: vcs1
[255.295402] Dynamic subtest vcs1: SUCCESS (1.982s)
[255.311749] Starting dynamic subtest: vecs0
[257.279467] Dynamic subtest vecs0: SUCCESS (1.981s)
[257.295479] Starting dynamic subtest: ccs0
[257.830919] Dynamic subtest ccs0: SUCCESS (0.550s)
[257.834067] Subtest write-busy: SUCCESS (7.411s)
[258.052787] [039/154] (761s left) kms_flip (wf_vblank-ts-check)
[258.162286] Starting subtest: wf_vblank-ts-check
[258.164432] Starting dynamic subtest: A-eDP1
[267.172736] Dynamic subtest A-eDP1: SUCCESS (8.976s)
[267.183795] Starting dynamic subtest: B-eDP1
[276.063993] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[276.074625] Starting dynamic subtest: C-eDP1
[285.030839] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[285.042936] Starting dynamic subtest: D-eDP1
[293.964026] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[293.966502] Subtest wf_vblank-ts-check: SUCCESS (35.756s)
[295.147186] [040/154] (724s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[295.255713] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[295.260186] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[295.352331] [041/154] (724s left) gem_eio (wait-immediate)
[295.563067] Starting subtest: wait-immediate
[295.887917] Subtest wait-immediate: SUCCESS (0.324s)
[296.000846] [042/154] (723s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[296.091315] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[296.094895] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[296.193033] [043/154] (723s left) kms_dsc (dsc-basic)
[296.279712] Starting subtest: dsc-basic
[296.290778] Subtest dsc-basic: SKIP (0.000s)
[296.353897] [044/154] (723s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[296.452894] Starting subtest: x-tiled-16bpp-rotate-0
[297.745143] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.292s)
[297.875929] [045/154] (721s left) gem_create (create-ext-placement-each)
[298.053035] Starting subtest: create-ext-placement-each
[298.055676] Subtest create-ext-placement-each: SUCCESS (0.000s)
[298.164040] [046/154] (721s left) gem_exec_parallel (fds)
[298.224937] Starting subtest: fds
[298.227314] Starting dynamic subtest: rcs0
[301.498925] Dynamic subtest rcs0: SUCCESS (3.271s)
[301.508480] Starting dynamic subtest: bcs0
[305.793117] Dynamic subtest bcs0: SUCCESS (4.294s)
[305.804097] Starting dynamic subtest: vcs0
[309.673067] Dynamic subtest vcs0: SUCCESS (3.878s)
[309.686057] Starting dynamic subtest: vcs1
[313.577537] Dynamic subtest vcs1: SUCCESS (3.901s)
[313.590690] Starting dynamic subtest: vecs0
[317.571465] Dynamic subtest vecs0: SUCCESS (3.993s)
[317.583435] Starting dynamic subtest: ccs0
[321.631587] Dynamic subtest ccs0: SUCCESS (4.058s)
[321.634242] Subtest fds: SUCCESS (23.404s)
[321.831363] [047/154] (697s left) gem_caching (read-writes)
[321.916079] Subtest read-writes: SKIP (0.000s)
[321.995356] [048/154] (697s left) i915_drm_fdinfo (memory-info-active)
[322.035730] Starting subtest: memory-info-active
[322.037926] Starting dynamic subtest: smem0
[324.750886] Dynamic subtest smem0: SUCCESS (2.715s)
[324.753415] Subtest memory-info-active: SUCCESS (2.715s)
[324.826231] [049/154] (695s left) syncobj_timeline (signal-point-0)
[324.885155] Starting subtest: signal-point-0
[324.887071] Subtest signal-point-0: SUCCESS (0.000s)
[324.982348] [050/154] (694s left) gem_pread (exhaustion)
[325.041672] Subtest exhaustion: SKIP (0.000s)
[325.112120] [051/154] (694s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[325.208676] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[325.212280] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[325.310028] [052/154] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[325.407768] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[325.411284] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[325.525888] [053/154] (694s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[325.621220] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[325.624964] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[325.726853] [054/154] (694s left) kms_cursor_edge_walk (128x128-left-edge)
[325.811133] Starting subtest: 128x128-left-edge
[325.813191] Starting dynamic subtest: pipe-A-eDP-1
[329.305763] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[329.315366] Starting dynamic subtest: pipe-D-eDP-1
[332.427090] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[332.429240] Subtest 128x128-left-edge: SUCCESS (6.616s)
[333.275454] [055/154] (686s left) kms_psr (fbc-psr-cursor-render)
[333.375273] Starting subtest: fbc-psr-cursor-render
[333.377595] Starting dynamic subtest: eDP-1
[333.381651] Dynamic subtest eDP-1: SKIP (0.000s)
[333.385689] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[333.447993] [056/154] (686s left) gem_exec_reloc (basic-write-cpu-active)
[333.510860] Subtest basic-write-cpu-active: SKIP (0.000s)
[333.595148] [057/154] (686s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[333.651279] Starting subtest: multi-wait-all-for-submit-submitted
[333.756476] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[333.831422] [058/154] (686s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[333.921746] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[340.772394] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.857s)
[340.898769] [059/154] (679s left) kms_dp_link_training (non-uhbr-sst)
[340.988080] Starting subtest: non-uhbr-sst
[340.996148] Subtest non-uhbr-sst: SKIP (0.000s)
[341.071828] [060/154] (679s left) kms_content_protection (atomic)
[341.220382] Starting subtest: atomic
[341.224684] Subtest atomic: SKIP (0.000s)
[341.359370] [061/154] (679s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[341.407687] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[341.472878] [062/154] (678s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[341.565568] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[341.567775] Starting dynamic subtest: pipe-A
[341.584767] Dynamic subtest pipe-A: SKIP (0.016s)
[341.594309] Starting dynamic subtest: pipe-B
[341.620834] Dynamic subtest pipe-B: SKIP (0.035s)
[341.632191] Starting dynamic subtest: pipe-C
[341.649995] Dynamic subtest pipe-C: SKIP (0.030s)
[341.659663] Starting dynamic subtest: pipe-D
[341.680315] Dynamic subtest pipe-D: SKIP (0.030s)
[341.684609] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.114s)
[341.775941] [063/154] (678s left) syncobj_timeline (device-submit-unordered)
[341.826012] Starting subtest: device-submit-unordered
[341.827937] Subtest device-submit-unordered: SUCCESS (0.001s)
[341.936800] [064/154] (678s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[342.029823] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[342.033366] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[342.116748] [065/154] (678s left) syncobj_basic (bad-create-flags)
[342.169546] Starting subtest: bad-create-flags
[342.171105] Subtest bad-create-flags: SUCCESS (0.000s)
[342.262614] [066/154] (678s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[342.371179] Starting subtest: pr-cursor-plane-update-sf
[342.374568] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[342.451171] [067/154] (678s left) syncobj_timeline (invalid-query-zero-handles)
[342.498566] Starting subtest: invalid-query-zero-handles
[342.500406] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[342.612243] [068/154] (678s left) syncobj_wait (reset-multiple-signaled)
[342.663939] Starting subtest: reset-multiple-signaled
[342.666090] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[342.786228] [069/154] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[342.880928] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[342.884482] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[342.991370] [070/154] (677s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[343.090638] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[344.050813] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.959s)
[344.170824] [071/154] (676s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[344.262985] Starting subtest: 4-tiled-8bpp-rotate-270
[344.285700] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[344.386379] [072/154] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[344.491690] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[344.495023] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[344.587900] [073/154] (676s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[344.689892] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[344.693271] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[344.783043] [074/154] (676s left) gem_mmap_wc (write)
[344.837676] Subtest write: SKIP (0.000s)
[344.897805] [075/154] (676s left) kms_addfb_basic (unused-handle)
[344.948969] Starting subtest: unused-handle
[344.950955] Subtest unused-handle: SUCCESS (0.000s)
[345.097330] [076/154] (675s left) gem_exec_schedule (semaphore-resolve)
[345.170171] Starting subtest: semaphore-resolve
[345.211032] Subtest semaphore-resolve: SUCCESS (0.045s)
[345.569269] [077/154] (675s left) gem_exec_reloc (basic-wc-cpu)
[345.634505] Subtest basic-wc-cpu: SKIP (0.000s)
[345.710687] [078/154] (675s left) gem_ctx_persistence (legacy-engines-cleanup)
[345.765900] Starting subtest: legacy-engines-cleanup
[345.768262] Starting dynamic subtest: render
[345.850542] Dynamic subtest render: SUCCESS (0.083s)
[345.864045] Starting dynamic subtest: bsd1
[345.908644] Dynamic subtest bsd1: SUCCESS (0.056s)
[345.922244] Starting dynamic subtest: bsd2
[345.947384] Dynamic subtest bsd2: SUCCESS (0.036s)
[345.957394] Starting dynamic subtest: blt
[345.983429] Dynamic subtest blt: SUCCESS (0.034s)
[345.996309] Starting dynamic subtest: vebox
[346.016505] Dynamic subtest vebox: SUCCESS (0.031s)
[346.018863] Subtest legacy-engines-cleanup: SUCCESS (0.251s)
[346.097102] [079/154] (675s left) sw_sync (sync_merge_invalid)
[346.137642] Starting subtest: sync_merge_invalid
[346.162451] Subtest sync_merge_invalid: SUCCESS (0.028s)
[346.242907] [080/154] (674s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[346.350322] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[346.354575] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[346.457277] [081/154] (674s left) kms_psr (psr-basic)
[346.542458] Starting subtest: psr-basic
[346.544524] Starting dynamic subtest: eDP-1
[348.167129] Dynamic subtest eDP-1: SUCCESS (1.624s)
[348.169438] Subtest psr-basic: SUCCESS (1.625s)
[349.039600] [082/154] (672s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[349.156431] Starting subtest: short-flip-before-cursor-toggle
[350.074081] Subtest short-flip-before-cursor-toggle: SUCCESS (0.916s)
[350.897824] [083/154] (670s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[351.004128] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[351.029617] Starting dynamic subtest: pipe-A-plane-0
[351.318701] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[351.328266] Starting dynamic subtest: pipe-A-plane-3
[351.551362] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[352.669283] Starting dynamic subtest: pipe-B-plane-0
[352.957391] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[352.967033] Starting dynamic subtest: pipe-B-plane-3
[353.213146] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[353.542688] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.539s)
[354.351025] [084/154] (666s left) gem_exec_flush (basic-uc-rw-default)
[354.419799] Starting subtest: basic-uc-rw-default
[359.902340] Subtest basic-uc-rw-default: SUCCESS (5.451s)
[360.057964] [085/154] (661s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[360.161021] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[360.163193] Starting dynamic subtest: pipe-A-eDP-1
[360.185649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.198089] Starting dynamic subtest: pipe-B-eDP-1
[360.219727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.228804] Starting dynamic subtest: pipe-C-eDP-1
[360.250591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.260081] Starting dynamic subtest: pipe-D-eDP-1
[360.282782] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.286933] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[362.413256] [086/154] (658s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[362.502122] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[362.506617] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[363.655874] [087/154] (657s left) kms_cursor_crc (cursor-size-hints)
[363.784395] Starting subtest: cursor-size-hints
[363.786899] Starting dynamic subtest: pipe-A-eDP-1
[364.393479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[364.404791] Starting dynamic subtest: pipe-D-eDP-1
[365.642753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[365.645079] Subtest cursor-size-hints: SUCCESS (1.858s)
[366.524544] [088/154] (654s left) gem_mmap_offset (close-race)
[366.582189] Starting subtest: close-race
[386.694641] Subtest close-race: SUCCESS (20.112s)
[386.844172] [089/154] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[386.945743] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[386.950296] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[387.049336] [090/154] (634s left) gem_ctx_persistence (engines-hang)
[387.104062] Starting subtest: engines-hang
[387.106245] Starting dynamic subtest: rcs0
[387.262698] Dynamic subtest rcs0: SUCCESS (0.158s)
[387.274026] Starting dynamic subtest: bcs0
[387.352910] Dynamic subtest bcs0: SUCCESS (0.088s)
[387.364933] Starting dynamic subtest: vcs0
[387.448841] Dynamic subtest vcs0: SUCCESS (0.094s)
[387.461530] Starting dynamic subtest: vcs1
[387.538637] Dynamic subtest vcs1: SUCCESS (0.088s)
[387.550801] Starting dynamic subtest: vecs0
[387.617611] Dynamic subtest vecs0: SUCCESS (0.077s)
[387.629388] Starting dynamic subtest: ccs0
[387.741173] Dynamic subtest ccs0: SUCCESS (0.122s)
[387.743281] Subtest engines-hang: SUCCESS (0.638s)
[387.833993] [091/154] (633s left) kms_panel_fitting (atomic-fastset)
[387.923644] Starting subtest: atomic-fastset
[387.925497] Starting dynamic subtest: pipe-A-eDP-1
[388.059466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[388.071762] Starting dynamic subtest: pipe-B-eDP-1
[389.289678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[389.302188] Starting dynamic subtest: pipe-C-eDP-1
[390.473820] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[390.483540] Starting dynamic subtest: pipe-D-eDP-1
[391.705990] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[391.708294] Subtest atomic-fastset: SUCCESS (3.784s)
[392.963784] [092/154] (628s left) gem_lmem_swapping (heavy-verify-random)
[393.003533] Subtest heavy-verify-random: SKIP (0.000s)
[393.046882] [093/154] (628s left) gem_exec_endless (dispatch)
[393.100544] Starting subtest: dispatch
[393.103091] Starting dynamic subtest: rcs0
[393.111340] Dynamic subtest rcs0: SUCCESS (0.007s)
[393.122642] Starting dynamic subtest: bcs0
[393.127227] Dynamic subtest bcs0: SUCCESS (0.005s)
[393.137458] Starting dynamic subtest: vcs0
[393.142651] Dynamic subtest vcs0: SUCCESS (0.005s)
[393.151932] Starting dynamic subtest: vcs1
[393.156132] Dynamic subtest vcs1: SUCCESS (0.005s)
[393.165186] Starting dynamic subtest: vecs0
[393.169519] Dynamic subtest vecs0: SUCCESS (0.005s)
[393.178793] Starting dynamic subtest: ccs0
[393.183183] Dynamic subtest ccs0: SUCCESS (0.006s)
[393.185397] Subtest dispatch: SUCCESS (0.040s)
[394.354535] [094/154] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[394.456152] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[394.460693] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[394.560183] [095/154] (627s left) kms_chamelium_frames (hdmi-crc-multiple)
[394.934085] Subtest hdmi-crc-multiple: SKIP (0.000s)
[395.777464] [096/154] (626s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[395.868981] Starting subtest: yf-tiled-32bpp-rotate-0
[395.873285] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[395.974540] [097/154] (625s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[396.027628] Subtest tiled-to-untiled: SKIP (0.000s)
[396.097772] [098/154] (625s left) gem_close (many-handles-one-vma)
[396.142574] Starting subtest: many-handles-one-vma
[396.166399] Subtest many-handles-one-vma: SUCCESS (0.024s)
[396.280125] [099/154] (625s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[396.379952] Starting subtest: read-crc-frame-sequence
[396.382892] Starting dynamic subtest: pipe-A-eDP-1
[397.095883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[397.108922] Starting dynamic subtest: pipe-B-eDP-1
[398.477262] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[398.487449] Starting dynamic subtest: pipe-C-eDP-1
[399.859640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[399.870930] Starting dynamic subtest: pipe-D-eDP-1
[401.194965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[401.197458] Subtest read-crc-frame-sequence: SUCCESS (4.816s)
[402.033796] [100/154] (619s left) kms_busy (extended-modeset-hang-newfb)
[402.143257] Starting subtest: extended-modeset-hang-newfb
[402.145567] Starting dynamic subtest: pipe-A
[436.932815] Dynamic subtest pipe-A: SUCCESS (34.788s)
[436.943991] Starting dynamic subtest: pipe-D
[460.166268] Dynamic subtest pipe-D: SUCCESS (23.231s)
[460.168600] Subtest extended-modeset-hang-newfb: SUCCESS (58.024s)
[461.057377] [101/154] (560s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[461.120064] Starting subtest: y-tiled-ccs-to-x-tiled
[461.124550] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[461.314784] [102/154] (560s left) device_reset (cold-reset-bound)
[461.362197] Starting subtest: cold-reset-bound
[461.366363] Subtest cold-reset-bound: SKIP (0.000s)
[461.424010] [103/154] (560s left) gem_basic (create-close)
[461.482116] Starting subtest: create-close
[461.486308] Subtest create-close: SUCCESS (0.000s)
[461.580450] [104/154] (560s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[462.139767] Starting subtest: syncobj-timeline-invalid-flags
[462.142035] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[463.375154] [105/154] (558s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[463.477538] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[463.481669] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[463.582370] [106/154] (558s left) i915_module_load (reload)
[463.614512] Starting subtest: reload
[469.758212] Subtest reload: SUCCESS (6.145s)
[469.801736] [107/154] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[471.318981] Starting subtest: fbcpsrhdr-tiling-4
[471.323411] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[471.412523] [108/154] (550s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[471.505326] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[471.507567] Starting dynamic subtest: pipe-A-eDP-1
[472.725094] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.221s)
[472.733599] Starting dynamic subtest: pipe-B-eDP-1
[474.988504] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.262s)
[474.997174] Starting dynamic subtest: pipe-C-eDP-1
[477.318359] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.329s)
[477.328087] Starting dynamic subtest: pipe-D-eDP-1
[479.645697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.326s)
[479.648253] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.143s)
[480.802650] [109/154] (541s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[480.901509] Starting subtest: bad-pixel-format-yf-tiled-ccs
[480.903736] Starting dynamic subtest: pipe-A-eDP-1
[480.926656] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.936229] Starting dynamic subtest: pipe-B-eDP-1
[480.957760] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.966524] Starting dynamic subtest: pipe-C-eDP-1
[480.987081] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.995610] Starting dynamic subtest: pipe-D-eDP-1
[481.016592] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.020553] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[483.176872] [110/154] (539s left) gem_ccs (ctrl-surf-copy-new-ctx)
[483.238679] Starting subtest: ctrl-surf-copy-new-ctx
[483.242991] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[483.331472] [111/154] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[483.418881] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[483.423022] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[483.524111] [112/154] (538s left) kms_flip (2x-dpms-vs-vblank-race)
[483.619060] Starting subtest: 2x-dpms-vs-vblank-race
[483.627317] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[483.720212] [113/154] (538s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[483.810194] Starting subtest: fbc-psr2-primary-mmap-cpu
[483.812471] Starting dynamic subtest: eDP-1
[483.817062] Dynamic subtest eDP-1: SKIP (0.000s)
[483.821661] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[483.893663] [114/154] (538s left) syncobj_wait (wait-zero-handles)
[483.950065] Starting subtest: wait-zero-handles
[483.952379] Subtest wait-zero-handles: SUCCESS (0.000s)
[484.054238] [115/154] (538s left) gem_exec_parallel (engines)
[484.111579] Starting subtest: engines
[484.113627] Starting dynamic subtest: basic
[486.276904] Dynamic subtest basic: SUCCESS (2.162s)
[486.292197] Starting dynamic subtest: contexts
[490.647216] Dynamic subtest contexts: SUCCESS (4.367s)
[490.658150] Starting dynamic subtest: fds
[494.443895] Dynamic subtest fds: SUCCESS (3.794s)
[494.454923] Starting dynamic subtest: userptr
[496.319217] Dynamic subtest userptr: SUCCESS (1.872s)
[496.321844] Subtest engines: SUCCESS (12.207s)
[496.515009] [116/154] (526s left) kms_cursor_crc (cursor-onscreen-128x128)
[496.721730] Starting subtest: cursor-onscreen-128x128
[496.726623] Starting dynamic subtest: pipe-A-eDP-1
[498.872571] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.144s)
[498.900159] Starting dynamic subtest: pipe-D-eDP-1
[501.689319] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[501.691467] Subtest cursor-onscreen-128x128: SUCCESS (4.966s)
[502.563265] [117/154] (520s left) kms_atomic_transition (plane-all-transition)
[502.660951] Starting subtest: plane-all-transition
[502.663132] Starting dynamic subtest: pipe-A-eDP-1
[505.156351] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[505.462057] Starting dynamic subtest: pipe-B-eDP-1
[508.683719] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[508.986635] Subtest plane-all-transition: SUCCESS (6.324s)
[509.813583] [118/154] (512s left) i915_pm_rpm (gem-idle)
[511.363428] Starting subtest: gem-idle
[517.565352] Subtest gem-idle: SUCCESS (6.192s)
[517.908153] [119/154] (504s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[519.307866] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[519.310141] Starting dynamic subtest: pipe-A-eDP-1
[519.332387] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.342736] Starting dynamic subtest: pipe-B-eDP-1
[519.364205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.373212] Starting dynamic subtest: pipe-C-eDP-1
[519.395091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.404822] Starting dynamic subtest: pipe-D-eDP-1
[519.427691] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.431976] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[521.564623] [120/154] (501s left) api_intel_bb (simple-bb)
[521.624937] Starting subtest: simple-bb
[521.627176] Subtest simple-bb: SUCCESS (0.005s)
[521.749392] [121/154] (501s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[521.843885] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[521.847902] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.949133] [122/154] (500s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[522.045054] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[527.387355] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.347s)
[528.573587] [123/154] (494s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[528.635617] Starting subtest: etime-single-wait-for-submit-unsubmitted
[528.739827] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[528.815523] [124/154] (494s left) syncobj_timeline (wait-all-snapshot)
[528.865542] Starting subtest: wait-all-snapshot
[528.946574] Subtest wait-all-snapshot: SUCCESS (0.082s)
[529.024261] [125/154] (494s left) kms_lease (lease-again)
[529.118369] Starting subtest: lease-again
[529.120828] Starting dynamic subtest: pipe-A-eDP-1
[529.123340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[529.136287] Starting dynamic subtest: pipe-B-eDP-1
[529.138510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[529.147511] Starting dynamic subtest: pipe-C-eDP-1
[529.149803] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[529.158744] Starting dynamic subtest: pipe-D-eDP-1
[529.161060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[529.163301] Subtest lease-again: SUCCESS (0.013s)
[529.233953] [126/154] (493s left) gem_mmap_gtt (basic-wc)
[529.298964] Subtest basic-wc: SKIP (0.000s)
[529.358785] [127/154] (493s left) kms_joiner (basic-force-ultra-joiner)
[529.464560] Starting subtest: basic-force-ultra-joiner
[529.468801] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[529.529620] [128/154] (493s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[529.617458] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[529.621695] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[529.701735] [129/154] (493s left) kms_addfb_basic (bad-pitch-999)
[529.757108] Starting subtest: bad-pitch-999
[529.759019] Subtest bad-pitch-999: SUCCESS (0.000s)
[529.920548] [130/154] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[530.022889] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[536.902312] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.883s)
[537.014462] [131/154] (486s left) gem_userptr_blits (dmabuf-unsync)
[537.074471] Subtest dmabuf-unsync: SKIP (0.000s)
[537.209285] [132/154] (486s left) kms_color (gamma)
[537.318171] Starting subtest: gamma
[537.320780] Starting dynamic subtest: pipe-A-eDP-1
[538.034549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[538.045419] Starting dynamic subtest: pipe-B-eDP-1
[539.503650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s)
[539.514653] Starting dynamic subtest: pipe-C-eDP-1
[540.875607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[540.886992] Starting dynamic subtest: pipe-D-eDP-1
[542.210054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[542.212848] Subtest gamma: SUCCESS (4.893s)
[543.017538] [133/154] (480s left) gen9_exec_parse (batch-invalid-length)
[543.065450] Subtest batch-invalid-length: SKIP (0.000s)
[543.151106] [134/154] (480s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[543.252789] Starting subtest: fbc-rgb101010-draw-pwrite
[546.751979] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.504s)
[547.930384] [135/154] (475s left) gem_eio (in-flight-internal-1us)
[548.149744] Starting subtest: in-flight-internal-1us
[549.383682] Subtest in-flight-internal-1us: SUCCESS (1.233s)
[549.534486] [136/154] (473s left) gem_softpin (reverse)
[549.600832] Starting subtest: reverse
[549.607498] Subtest reverse: SUCCESS (0.007s)
[549.720835] [137/154] (473s left) kms_rotation_crc (exhaust-fences)
[549.809137] Starting subtest: exhaust-fences
[549.813165] Subtest exhaust-fences: SKIP (0.000s)
[549.925575] [138/154] (473s left) kms_atomic_transition (modeset-transition-fencing)
[550.021059] Starting subtest: modeset-transition-fencing
[550.023231] Starting dynamic subtest: 1x-outputs
[561.137286] Dynamic subtest 1x-outputs: SUCCESS (11.116s)
[561.140290] Subtest modeset-transition-fencing: SUCCESS (11.119s)
[562.010175] [139/154] (461s left) kms_flip (nonexisting-fb)
[562.091431] Starting subtest: nonexisting-fb
[562.093885] Starting dynamic subtest: A-eDP1
[563.292399] Dynamic subtest A-eDP1: SUCCESS (1.201s)
[563.303936] Starting dynamic subtest: B-eDP1
[564.441323] Dynamic subtest B-eDP1: SUCCESS (1.147s)
[564.456009] Starting dynamic subtest: C-eDP1
[565.579688] Dynamic subtest C-eDP1: SUCCESS (1.137s)
[565.592226] Starting dynamic subtest: D-eDP1
[566.710942] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[566.713348] Subtest nonexisting-fb: SUCCESS (4.623s)
[567.885437] [140/154] (455s left) sw_sync (sync_merge_same)
[567.923900] Starting subtest: sync_merge_same
[567.926281] Subtest sync_merge_same: SUCCESS (0.000s)
[567.982356] [141/154] (455s left) gem_exec_nop (basic-parallel)
[568.048986] Starting subtest: basic-parallel
[584.258951] Subtest basic-parallel: SUCCESS (16.217s)
[584.497607] [142/154] (439s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[584.607854] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[584.612220] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[584.723147] [143/154] (439s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[584.820103] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[584.824339] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[584.923020] [144/154] (438s left) kms_vblank (ts-continuation-modeset)
[585.027218] Starting subtest: ts-continuation-modeset
[585.029123] Starting dynamic subtest: pipe-A-eDP-1
[586.565156] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.539s)
[586.580037] Starting dynamic subtest: pipe-D-eDP-1
[588.751572] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.182s)
[588.753477] Subtest ts-continuation-modeset: SUCCESS (3.724s)
[589.569565] [145/154] (434s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[589.683366] Starting subtest: flip-vs-cursor-legacy
[597.110960] Subtest flip-vs-cursor-legacy: SUCCESS (7.424s)
[597.998662] [146/154] (425s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[598.103393] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[598.107695] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[598.210372] [147/154] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[598.299212] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[602.745626] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.452s)
[603.877385] [148/154] (420s left) kms_color (ctm-0-25)
[603.965488] Starting subtest: ctm-0-25
[603.967707] Starting dynamic subtest: pipe-A-eDP-1
[607.498571] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.531s)
[607.509460] Starting dynamic subtest: pipe-B-eDP-1
[611.796082] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.297s)
[611.806024] Starting dynamic subtest: pipe-C-eDP-1
[615.828678] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.034s)
[615.840314] Starting dynamic subtest: pipe-D-eDP-1
[619.823983] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[619.826384] Subtest ctm-0-25: SUCCESS (15.859s)
[620.672325] [149/154] (403s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[620.778492] Starting subtest: fbchdr-rgb565-draw-pwrite
[620.782617] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[620.864462] [150/154] (403s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[620.959565] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[620.963733] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[621.068605] [151/154] (403s left) i915_query (engine-info)
[621.123933] Starting subtest: engine-info
[621.126368] Subtest engine-info: SUCCESS (0.005s)
[621.239700] [152/154] (402s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[621.290905] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[621.295302] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.001s)
[621.392217] [153/154] (402s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[621.489750] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[621.494094] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[621.585608] [154/154] (402s left) perf_pmu (busy-accuracy-98)
[621.620352] Starting subtest: busy-accuracy-98
[621.622475] Starting dynamic subtest: rcs0
[624.663759] Dynamic subtest rcs0: SUCCESS (3.038s)
[624.677391] Starting dynamic subtest: bcs0
[627.765467] Dynamic subtest bcs0: SUCCESS (3.050s)
[627.776396] Starting dynamic subtest: vcs0
[630.804589] Dynamic subtest vcs0: SUCCESS (3.039s)
[630.816080] Starting dynamic subtest: vcs1
[633.848073] Dynamic subtest vcs1: SUCCESS (3.041s)
[633.859659] Starting dynamic subtest: vecs0
[636.888607] Dynamic subtest vecs0: SUCCESS (3.041s)
[636.899061] Starting dynamic subtest: ccs0
[639.945502] Dynamic subtest ccs0: SUCCESS (3.051s)
[639.947930] Subtest busy-accuracy-98: SUCCESS (18.274s)
[640.006729] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_getfb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_prime
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_gttfill
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_universal_plane
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_pxp
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_wait
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_dsc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: gem_exec_parallel
results: parsing output: 46/ for test: gem_caching
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_pread
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_cursor_edge_walk
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_dp_link_training
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_panel_fitting
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: gem_exec_endless
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_frames
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_set_tiling_vs_blt
results: parsing output: 97/ for test: gem_close
results: parsing output: 98/ for test: kms_pipe_crc_basic
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: device_reset
results: parsing output: 102/ for test: gem_basic
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_module_load
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gem_exec_parallel
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_atomic_transition
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_joiner
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_color
results: parsing output: 132/ for test: gen9_exec_parse
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: gem_softpin
results: parsing output: 136/ for test: kms_rotation_crc
results: parsing output: 137/ for test: kms_atomic_transition
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: sw_sync
results: parsing output: 140/ for test: gem_exec_nop
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_vblank
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_color
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: i915_query
results: parsing output: 151/ for test: sriov_basic
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: perf_pmu
Done.