[43.636298] Initializing watchdogs
[43.636432]   /dev/watchdog0
[43.651456] [001/144] (960s left) prime_mmap (test_forked_cpu_write)
[43.710999] Starting subtest: test_forked_cpu_write
[43.714235] Starting dynamic subtest: test_forked_cpu_write-smem
[43.727064] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.019s)
[43.729597] Subtest test_forked_cpu_write: SUCCESS (0.019s)
[43.812969] [002/144] (960s left) gem_exec_fence (syncobj-invalid-wait)
[44.312673] Starting subtest: syncobj-invalid-wait
[44.315628] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[45.488248] [003/144] (958s left) gem_ctx_persistence (engines-persistence)
[45.549499] Starting subtest: engines-persistence
[45.552186] Starting dynamic subtest: rcs0
[46.311272] Dynamic subtest rcs0: SUCCESS (0.761s)
[46.326250] Starting dynamic subtest: bcs0
[47.056948] Dynamic subtest bcs0: SUCCESS (0.746s)
[47.069567] Starting dynamic subtest: vcs0
[47.848821] Dynamic subtest vcs0: SUCCESS (0.792s)
[47.862663] Starting dynamic subtest: vcs1
[48.595110] Dynamic subtest vcs1: SUCCESS (0.746s)
[48.608052] Starting dynamic subtest: vecs0
[49.365396] Dynamic subtest vecs0: SUCCESS (0.770s)
[49.378146] Starting dynamic subtest: ccs0
[50.129065] Dynamic subtest ccs0: SUCCESS (0.764s)
[50.131704] Subtest engines-persistence: SUCCESS (4.579s)
[50.233169] [004/144] (954s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-mc-ccs)
[50.613316] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs
[50.621882] Subtest pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[51.486291] [005/144] (952s left) gem_ctx_shared (create-shared-gtt)
[51.549505] Starting subtest: create-shared-gtt
[53.705518] Subtest create-shared-gtt: SUCCESS (2.154s)
[54.025324] [006/144] (950s left) kms_flip (flip-vs-suspend-interruptible)
[54.122147] Starting subtest: flip-vs-suspend-interruptible
[54.127658] Starting dynamic subtest: A-eDP1
[104.668675] Dynamic subtest A-eDP1: SUCCESS (4.752s)
[104.679986] Starting dynamic subtest: B-eDP1
[153.678631] Dynamic subtest B-eDP1: SUCCESS (4.595s)
[153.693466] Starting dynamic subtest: C-eDP1
[202.652409] Dynamic subtest C-eDP1: SUCCESS (4.534s)
[202.661469] Starting dynamic subtest: D-eDP1
[251.694837] Dynamic subtest D-eDP1: SUCCESS (4.605s)
[251.700170] Subtest flip-vs-suspend-interruptible: SUCCESS (18.497s)
[252.969883] [007/144] (930s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[253.032840] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[253.035542] Starting dynamic subtest: pipe-A-default-mode
[255.936912] Dynamic subtest pipe-A-default-mode: SUCCESS (2.905s)
[255.939376] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.906s)
[256.817529] [008/144] (926s left) gem_fence_thrash (bo-write-verify-none)
[256.872355] Starting subtest: bo-write-verify-none
[256.879619] Subtest bo-write-verify-none: SKIP (0.001s)
[256.912603] [009/144] (926s left) prime_self_import (basic-with_one_bo)
[256.964288] Starting subtest: basic-with_one_bo
[256.969682] Subtest basic-with_one_bo: SUCCESS (0.001s)
[257.014159] [010/144] (926s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[257.083097] Starting subtest: y-tiled-to-vebox-y-tiled
[257.088118] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[257.263227] [011/144] (926s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[257.357480] Subtest access-purged-bo-mem: SKIP (0.000s)
[257.408004] [012/144] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[257.477386] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[262.003837] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.531s)
[262.124342] [013/144] (921s left) gem_exec_schedule (smoketest-all)
[262.188672] Starting subtest: smoketest-all
[294.590278] Subtest smoketest-all: SUCCESS (32.361s)
[295.598976] [014/144] (887s left) syncobj_timeline (host-signal-ordered)
[295.667858] Starting subtest: host-signal-ordered
[295.670501] Subtest host-signal-ordered: SUCCESS (0.000s)
[295.739192] [015/144] (887s left) gem_lmem_swapping (heavy-verify-multi)
[295.798536] Subtest heavy-verify-multi: SKIP (0.000s)
[295.836182] [016/144] (887s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-mc-ccs)
[296.195750] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-mc-ccs
[296.200559] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[297.073441] [017/144] (886s left) kms_psr (psr2-sprite-mmap-cpu)
[297.139193] Starting subtest: psr2-sprite-mmap-cpu
[297.141686] Starting dynamic subtest: eDP-1
[298.991715] Dynamic subtest eDP-1: SUCCESS (1.855s)
[298.994296] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.855s)
[299.889249] [018/144] (883s left) kms_content_protection (mei-interface)
[299.990643] Starting subtest: mei-interface
[299.995314] Subtest mei-interface: SKIP (0.001s)
[300.085487] [019/144] (883s left) gem_mmap_gtt (cpuset-big-copy)
[300.149714] Subtest cpuset-big-copy: SKIP (0.000s)
[300.186012] [020/144] (883s left) kms_pipe_crc_basic (bad-source)
[300.248978] Starting subtest: bad-source
[300.251348] Subtest bad-source: SUCCESS (0.000s)
[300.299829] [021/144] (883s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[300.695376] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[300.700942] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[301.555432] [022/144] (882s left) perf (polling-parameterized)
[301.688634] Starting subtest: polling-parameterized
[321.712831] Subtest polling-parameterized: SUCCESS (20.026s)
[321.753338] [023/144] (862s left) kms_pm_rpm (i2c)
[323.710220] Starting subtest: i2c
[329.055958] Subtest i2c: SUCCESS (5.348s)
[329.155174] [024/144] (854s left) kms_psr (pr-cursor-plane-onoff)
[329.241691] Starting subtest: pr-cursor-plane-onoff
[329.246750] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[329.355774] [025/144] (854s left) gem_exec_reloc (basic-write-cpu)
[329.425555] Subtest basic-write-cpu: SKIP (0.000s)
[329.487657] [026/144] (854s left) i915_getparams_basic (basic-subslice-total)
[329.554151] Starting subtest: basic-subslice-total
[329.558017] Subtest basic-subslice-total: SUCCESS (0.000s)
[329.610840] [027/144] (854s left) i915_query (query-regions-unallocated)
[329.685095] Starting subtest: query-regions-unallocated
[329.687614] Subtest query-regions-unallocated: SUCCESS (0.000s)
[329.754790] [028/144] (854s left) kms_psr (fbc-pr-primary-render)
[329.848104] Starting subtest: fbc-pr-primary-render
[329.853008] Subtest fbc-pr-primary-render: SKIP (0.000s)
[329.951131] [029/144] (854s left) kms_hdmi_inject (inject-4k)
[330.303568] Starting subtest: inject-4k
[330.580286] Subtest inject-4k: SUCCESS (0.277s)
[331.208033] [030/144] (852s left) kms_ccs (pipe-d-missing-ccs-buffer-yf-tiled-ccs)
[331.638665] Starting subtest: pipe-D-missing-ccs-buffer-yf-tiled-ccs
[331.643972] Subtest pipe-D-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[332.458976] [031/144] (851s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[332.537870] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[332.542295] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[332.621735] [032/144] (851s left) syncobj_timeline (multi-wait-submitted-signaled)
[332.678422] Starting subtest: multi-wait-submitted-signaled
[332.681142] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[332.748766] [033/144] (851s left) kms_vblank (query-idle)
[332.810274] Starting subtest: query-idle
[332.812776] Starting dynamic subtest: pipe-A-eDP-1
[334.558630] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.745s)
[334.578030] Starting dynamic subtest: pipe-D-eDP-1
[337.080246] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s)
[337.082829] Subtest query-idle: SUCCESS (4.270s)
[337.962432] [034/144] (846s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[338.065850] Starting subtest: basic-flip-after-cursor-atomic
[339.021842] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.953s)
[339.952737] [035/144] (844s left) sysfs_heartbeat_interval (nopreempt)
[340.001628] Starting subtest: nopreempt
[340.004034] Starting dynamic subtest: vecs0
[349.490799] Dynamic subtest vecs0: SUCCESS (9.485s)
[349.508726] Starting dynamic subtest: ccs0
[353.381312] Dynamic subtest ccs0: SUCCESS (3.891s)
[353.392272] Starting dynamic subtest: vcs0
[362.538719] Dynamic subtest vcs0: SUCCESS (9.154s)
[362.557377] Starting dynamic subtest: bcs0
[366.516688] Dynamic subtest bcs0: SUCCESS (3.980s)
[366.534684] Starting dynamic subtest: rcs0
[370.318841] Dynamic subtest rcs0: SUCCESS (3.801s)
[370.332389] Starting dynamic subtest: vcs1
[379.503034] Dynamic subtest vcs1: SUCCESS (9.184s)
[379.505598] Subtest nopreempt: SUCCESS (39.501s)
[379.580386] [036/144] (804s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[379.649901] Starting subtest: read-crc-frame-sequence
[379.652376] Starting dynamic subtest: pipe-A-eDP-1
[380.373295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[380.395191] Starting dynamic subtest: pipe-B-eDP-1
[381.887346] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[381.903512] Starting dynamic subtest: pipe-C-eDP-1
[383.278436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[383.296546] Starting dynamic subtest: pipe-D-eDP-1
[384.719418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s)
[384.722475] Subtest read-crc-frame-sequence: SUCCESS (5.071s)
[385.650511] [037/144] (798s left) core_auth (basic-auth)
[385.708081] Starting subtest: basic-auth
[385.710088] Subtest basic-auth: SUCCESS (0.001s)
[385.777991] [038/144] (798s left) vgem_slow (nohang)
[385.844214] Starting subtest: nohang
[396.306541] Subtest nohang: SUCCESS (10.463s)
[396.377838] [039/144] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[396.455365] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[396.460035] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[396.539185] [040/144] (787s left) kms_chamelium_hpd (dp-hpd-storm)
[396.888283] Subtest dp-hpd-storm: SKIP (0.000s)
[397.774808] [041/144] (786s left) kms_ccs (pipe-d-bad-rotation-90-yf-tiled-ccs)
[398.207323] Starting subtest: pipe-D-bad-rotation-90-yf-tiled-ccs
[398.212846] Subtest pipe-D-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[399.091001] [042/144] (785s left) prime_vgem (shrink)
[399.148981] Starting subtest: shrink
[399.151593] Subtest shrink: SUCCESS (0.014s)
[399.249260] [043/144] (785s left) gem_create (create-ext-placement-all)
[399.419718] Starting subtest: create-ext-placement-all
[399.422604] Subtest create-ext-placement-all: SUCCESS (0.000s)
[399.516511] [044/144] (784s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[399.605316] Starting subtest: cursorB-vs-flipB-atomic
[399.610324] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[399.690642] [045/144] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[399.768157] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[404.663244] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.897s)
[404.774168] [046/144] (779s left) kms_sequence (get-busy)
[404.842281] Starting subtest: get-busy
[404.844772] Starting dynamic subtest: pipe-A-eDP-1
[406.802761] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[406.821375] Starting dynamic subtest: pipe-B-eDP-1
[409.510391] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.702s)
[409.524866] Starting dynamic subtest: pipe-C-eDP-1
[412.189800] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.679s)
[412.200421] Starting dynamic subtest: pipe-D-eDP-1
[414.859705] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[414.862373] Subtest get-busy: SUCCESS (10.020s)
[415.794875] [047/144] (768s left) api_intel_bb (simple-bb)
[415.842957] Starting subtest: simple-bb
[415.849210] Subtest simple-bb: SUCCESS (0.009s)
[415.949724] [048/144] (768s left) gem_ctx_param (invalid-ctx-set)
[415.991690] Starting subtest: invalid-ctx-set
[415.993556] Subtest invalid-ctx-set: SUCCESS (0.000s)
[416.030326] [049/144] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[416.085594] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[419.115892] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.035s)
[419.227379] [050/144] (765s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs)
[419.619403] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs
[419.625491] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[420.463179] [051/144] (764s left) gem_ctx_param (invalid-size-get)
[420.512389] Starting subtest: invalid-size-get
[420.515142] Subtest invalid-size-get: SUCCESS (0.000s)
[420.584392] [052/144] (764s left) perf (invalid-oa-format-id)
[420.688431] Starting subtest: invalid-oa-format-id
[420.698889] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[420.727756] [053/144] (763s left) syncobj_timeline (wait-all-for-submit-snapshot)
[420.806383] Starting subtest: wait-all-for-submit-snapshot
[420.888043] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[420.963998] [054/144] (763s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-mc-ccs)
[421.348457] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs
[422.469251] Subtest pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.122s)
[423.665966] [055/144] (761s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[424.070015] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[424.076400] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[424.948416] [056/144] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[425.034148] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[429.878677] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.848s)
[429.976165] [057/144] (754s left) gem_mmap_wc (bad-object)
[430.052464] Subtest bad-object: SKIP (0.000s)
[430.081275] [058/144] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[430.148581] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[430.152986] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[430.249614] [059/144] (754s left) kms_psr (psr2-cursor-plane-move)
[430.313570] Starting subtest: psr2-cursor-plane-move
[430.316223] Starting dynamic subtest: eDP-1
[432.091989] Dynamic subtest eDP-1: SUCCESS (1.776s)
[432.094976] Subtest psr2-cursor-plane-move: SUCCESS (1.777s)
[433.016045] [060/144] (751s left) gem_exec_create (forked)
[433.103731] Starting subtest: forked
[433.106274] Starting dynamic subtest: smem
[454.518443] Dynamic subtest smem: SUCCESS (21.412s)
[454.521205] Subtest forked: SUCCESS (21.414s)
[454.711223] [061/144] (730s left) v3d/v3d_submit_cl (multi-and-single-sync)
[454.824955] Subtest multi-and-single-sync: SKIP (0.000s)
[454.868355] [062/144] (730s left) gem_exec_reloc (basic-active)
[454.941133] Subtest basic-active: SKIP (0.000s)
[455.006355] [063/144] (730s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[455.383930] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[455.390488] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[456.307294] [064/144] (728s left) kms_plane_scaling (intel-max-src-size)
[456.402970] Starting subtest: intel-max-src-size
[456.407597] Subtest intel-max-src-size: SKIP (0.000s)
[456.488532] [065/144] (728s left) gem_exec_schedule (semaphore-codependency)
[456.565960] Starting subtest: semaphore-codependency
[456.575752] Subtest semaphore-codependency: SUCCESS (0.024s)
[456.916793] [066/144] (728s left) gem_exec_params (secure-non-root)
[456.984838] Starting subtest: secure-non-root
[456.990825] Subtest secure-non-root: SKIP (0.000s)
[457.079440] [067/144] (728s left) gem_madvise (dontneed-before-exec)
[457.125196] Starting subtest: dontneed-before-exec
[457.131012] Subtest dontneed-before-exec: SKIP (0.001s)
[457.169837] [068/144] (727s left) perf (gen12-mi-rpc)
[457.257849] Starting subtest: gen12-mi-rpc
[457.260658] Starting dynamic subtest: rcs0
[457.278664] Dynamic subtest rcs0: SUCCESS (0.017s)
[457.281195] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[457.299103] [069/144] (727s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[457.375083] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[457.377712] Starting dynamic subtest: pipe-A-eDP-1
[457.382547] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[457.400673] Starting dynamic subtest: pipe-B-eDP-1
[457.406120] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s)
[457.420313] Starting dynamic subtest: pipe-C-eDP-1
[457.425564] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s)
[457.433208] Starting dynamic subtest: pipe-D-eDP-1
[457.437695] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s)
[457.442240] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.042s)
[457.483195] [070/144] (727s left) gem_exec_whisper (basic-contexts-all)
[457.555181] Starting subtest: basic-contexts-all
[475.639708] Subtest basic-contexts-all: SUCCESS (18.081s)
[475.825468] [071/144] (709s left) gem_exec_balancer (full-pulse)
[475.904799] Starting subtest: full-pulse
[480.145161] Subtest full-pulse: SUCCESS (4.240s)
[480.389899] [072/144] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[480.467615] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[480.472506] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[480.547228] [073/144] (704s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[480.632101] Starting subtest: x-tiled-8bpp-rotate-90
[480.650461] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[480.765346] [074/144] (704s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[480.826824] Starting subtest: fbc-rgb565-draw-blt
[483.911646] Subtest fbc-rgb565-draw-blt: SUCCESS (3.087s)
[484.044525] [075/144] (701s left) vgem_basic (create)
[484.116245] Starting subtest: create
[484.118387] Subtest create: SUCCESS (0.000s)
[484.173543] [076/144] (701s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[484.241542] Starting subtest: plane-upscale-20x20-with-rotation
[484.243578] Starting dynamic subtest: pipe-A-eDP-1
[484.587212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.347s)
[484.600973] Starting dynamic subtest: pipe-B-eDP-1
[486.128952] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s)
[486.140958] Starting dynamic subtest: pipe-C-eDP-1
[487.631848] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.500s)
[487.654250] Starting dynamic subtest: pipe-D-eDP-1
[489.145651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s)
[489.148156] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.907s)
[490.420380] [077/144] (695s left) gem_exec_capture (many-4k-zero)
[490.474844] Starting subtest: many-4K-zero
[490.912972] Subtest many-4K-zero: FAIL (0.376s)
[490.975687] [078/144] (694s left) kms_atomic (plane-immutable-zpos)
[491.104463] Starting subtest: plane-immutable-zpos
[491.107115] Starting dynamic subtest: pipe-A-eDP-1
[491.898963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s)
[491.902553] Subtest plane-immutable-zpos: SUCCESS (0.795s)
[492.817965] [079/144] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[492.907839] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[492.912691] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[493.000143] [080/144] (692s left) kms_ccs (pipe-c-ccs-on-another-bo-yf-tiled-ccs)
[493.413841] Starting subtest: pipe-C-ccs-on-another-bo-yf-tiled-ccs
[493.420482] Subtest pipe-C-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[494.259502] [081/144] (691s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[494.317831] Starting subtest: 4-tiled-8bpp-rotate-90
[494.335105] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.019s)
[494.435693] [082/144] (691s left) drm_fdinfo (isolation)
[494.497149] Starting subtest: isolation
[494.499961] Starting dynamic subtest: rcs0
[494.505536] Dynamic subtest rcs0: SKIP (0.000s)
[494.525802] Starting dynamic subtest: bcs0
[494.531009] Dynamic subtest bcs0: SKIP (0.000s)
[494.544952] Starting dynamic subtest: vcs0
[494.550240] Dynamic subtest vcs0: SKIP (0.000s)
[494.557413] Starting dynamic subtest: vcs1
[494.561593] Dynamic subtest vcs1: SKIP (0.000s)
[494.568747] Starting dynamic subtest: vecs0
[494.572935] Dynamic subtest vecs0: SKIP (0.000s)
[494.580189] Starting dynamic subtest: ccs0
[494.584373] Dynamic subtest ccs0: SKIP (0.000s)
[494.588559] Subtest isolation: SKIP (0.008s)
[494.607833] [083/144] (690s left) kms_psr (fbc-psr2-suspend)
[494.674605] Starting subtest: fbc-psr2-suspend
[494.677021] Starting dynamic subtest: eDP-1
[494.682106] Dynamic subtest eDP-1: SKIP (0.000s)
[494.686551] Subtest fbc-psr2-suspend: SKIP (0.001s)
[494.768566] [084/144] (690s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[495.192339] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[495.200756] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[496.052328] [085/144] (689s left) kms_dsc (dsc-with-bpc)
[496.135636] Subtest dsc-with-bpc: SKIP (0.000s)
[496.153829] [086/144] (689s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[496.191099] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[496.195805] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[496.377928] [087/144] (689s left) kms_chamelium_edid (hdmi-edid-read)
[496.743958] Subtest hdmi-edid-read: SKIP (0.000s)
[497.624678] [088/144] (688s left) vc4/vc4_label_bo (set-label)
[497.717053] Subtest set-label: SKIP (0.000s)
[497.774568] [089/144] (687s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs)
[498.142341] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs
[498.145102] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[499.062114] [090/144] (686s left) syncobj_wait (multi-wait-signaled)
[499.124054] Starting subtest: multi-wait-signaled
[499.126771] Subtest multi-wait-signaled: SUCCESS (0.001s)
[499.201221] [091/144] (686s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[499.291561] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[503.845749] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.555s)
[503.959594] [092/144] (681s left) gem_exec_reloc (basic-gtt-read-noreloc)
[504.007478] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[504.071528] [093/144] (681s left) kms_flip (flip-vs-fences-interruptible)
[504.151447] Starting subtest: flip-vs-fences-interruptible
[504.156230] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[504.238474] [094/144] (681s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[504.327189] Starting subtest: multi-wait-available-unsubmitted-submitted
[504.329291] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[504.401342] [095/144] (681s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[504.491556] Starting subtest: y-tiled-16bpp-rotate-270
[504.496093] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[504.551171] [096/144] (681s left) i915_pm_rpm (gem-pread)
[506.678753] Starting subtest: gem-pread
[508.127719] Subtest gem-pread: SUCCESS (1.453s)
[508.218778] [097/144] (677s left) kms_pm_rpm (pm-caching)
[509.765541] Starting subtest: pm-caching
[509.771228] Subtest pm-caching: SKIP (0.000s)
[510.561813] [098/144] (675s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[510.659837] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[510.664547] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[510.736582] [099/144] (675s left) syncobj_wait (single-wait-all-for-submit-signaled)
[510.810410] Starting subtest: single-wait-all-for-submit-signaled
[510.812917] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[510.884341] [100/144] (675s left) kms_writeback (writeback-check-output)
[510.984975] Subtest writeback-check-output: SKIP (0.000s)
[511.001838] [101/144] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[511.079431] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[511.083798] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[511.174897] [102/144] (674s left) gem_request_retire (retire-vma-not-inactive)
[511.237414] Starting subtest: retire-vma-not-inactive
[511.255114] Subtest retire-vma-not-inactive: SUCCESS (0.019s)
[511.357481] [103/144] (674s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[511.439497] Starting subtest: basic-busy-flip-before-cursor-varying-size
[511.444104] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[511.530784] [104/144] (674s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[511.648545] Starting subtest: cursor-rapid-movement-64x64
[511.653447] Starting dynamic subtest: pipe-A-eDP-1
[512.257584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[512.303562] Starting dynamic subtest: pipe-D-eDP-1
[513.526168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[513.528797] Subtest cursor-rapid-movement-64x64: SUCCESS (1.874s)
[514.414304] [105/144] (671s left) v3d/v3d_submit_csd (single-in-sync)
[514.465899] Subtest single-in-sync: SKIP (0.000s)
[514.519983] [106/144] (671s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[514.575997] Starting subtest: x-tiled-32bpp-rotate-180
[516.084210] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.511s)
[516.259583] [107/144] (670s left) gem_mmap_gtt (basic-write-read)
[516.319814] Subtest basic-write-read: SKIP (0.000s)
[516.349111] [108/144] (669s left) gem_eio (context-create)
[516.597858] Starting subtest: context-create
[516.953585] Subtest context-create: SUCCESS (0.355s)
[517.048477] [109/144] (669s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[522.289626] Starting subtest: overlay-plane-move-continuous-sf
[522.292311] Starting dynamic subtest: pipe-A-eDP-1
[529.055459] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.763s)
[529.076365] Starting dynamic subtest: pipe-B-eDP-1
[535.815362] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.755s)
[535.817881] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.525s)
[536.759143] [110/144] (649s left) api_intel_allocator (two-level-inception)
[536.814748] Starting subtest: two-level-inception
[542.229886] Subtest two-level-inception: SUCCESS (5.416s)
[542.340580] [111/144] (644s left) gem_exec_params (invalid-bsd-ring)
[542.392301] Starting subtest: invalid-bsd-ring
[542.394157] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[542.490934] [112/144] (643s left) intel_hwmon (hwmon-read)
[542.551691] Subtest hwmon-read: SKIP (0.000s)
[542.584951] [113/144] (643s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs)
[542.998911] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs
[543.004840] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[543.848539] [114/144] (642s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[543.905797] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[543.939977] [115/144] (642s left) gem_exec_reloc (basic-concurrent16)
[544.021367] Subtest basic-concurrent16: SKIP (0.000s)
[544.085534] [116/144] (642s left) gem_userptr_blits (set-cache-level)
[544.151628] Starting subtest: set-cache-level
[544.155935] Subtest set-cache-level: SKIP (0.000s)
[544.297763] [117/144] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[544.369330] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[544.373755] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[544.463002] [118/144] (642s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[544.536593] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[545.347397] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[545.505117] [119/144] (641s left) kms_hdr (invalid-metadata-sizes)
[545.600691] Starting subtest: invalid-metadata-sizes
[545.605870] Subtest invalid-metadata-sizes: SKIP (0.000s)
[545.655408] [120/144] (641s left) drm_fdinfo (virtual-busy-hang)
[545.698448] Starting subtest: virtual-busy-hang
[545.703324] Subtest virtual-busy-hang: SKIP (0.000s)
[545.754436] [121/144] (640s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[545.827325] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[549.265134] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.444s)
[549.390095] [122/144] (637s left) kms_ccs (pipe-a-random-ccs-data-yf-tiled-ccs)
[549.749402] Starting subtest: pipe-A-random-ccs-data-yf-tiled-ccs
[549.758149] Subtest pipe-A-random-ccs-data-yf-tiled-ccs: SKIP (0.000s)
[550.640512] [123/144] (636s left) gem_busy (semaphore)
[550.817599] Subtest semaphore: SKIP (0.000s)
[551.033332] [124/144] (635s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[551.127793] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[551.140273] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.014s)
[551.214691] [125/144] (635s left) gem_mmap_gtt (ptrace)
[551.283187] Subtest ptrace: SKIP (0.000s)
[551.308855] [126/144] (635s left) syncobj_timeline (etime-multi-wait-submitted)
[551.353293] Starting subtest: etime-multi-wait-submitted
[551.457710] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[551.535207] [127/144] (635s left) kms_invalid_mode (uint-max-clock)
[551.629045] Starting subtest: uint-max-clock
[551.631642] Starting dynamic subtest: pipe-A-eDP-1
[551.928392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[551.945956] Starting dynamic subtest: pipe-B-eDP-1
[551.948259] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[551.959310] Starting dynamic subtest: pipe-C-eDP-1
[551.961805] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[551.970316] Starting dynamic subtest: pipe-D-eDP-1
[551.972936] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[551.975521] Subtest uint-max-clock: SUCCESS (0.313s)
[552.822605] [128/144] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[552.903893] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[552.907801] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[552.991022] [129/144] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[553.068928] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[553.073359] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[553.149193] [130/144] (633s left) gen9_exec_parse (bb-secure)
[553.226418] Subtest bb-secure: SKIP (0.000s)
[553.268403] [131/144] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[553.322861] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[553.326719] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[553.400746] [132/144] (633s left) gem_spin_batch (spin-each)
[553.440196] Starting subtest: spin-each
[556.810632] Subtest spin-each: SUCCESS (3.373s)
[557.548535] [133/144] (629s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[557.898620] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[558.807083] [134/144] (628s left) kms_rotation_crc (primary-rotation-180)
[558.890727] Starting subtest: primary-rotation-180
[567.910876] Subtest primary-rotation-180: SUCCESS (9.022s)
[569.204363] [135/144] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[569.294666] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[569.299773] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[569.391884] [136/144] (617s left) vgem_basic (busy-fence)
[569.450342] Starting subtest: busy-fence
[569.452423] Subtest busy-fence: SUCCESS (0.000s)
[569.504345] [137/144] (617s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs)
[569.881855] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs
[569.884572] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[570.741626] [138/144] (616s left) gem_userptr_blits (create-destroy-sync)
[570.801720] Starting subtest: create-destroy-sync
[575.821849] Subtest create-destroy-sync: SUCCESS (5.019s)
[575.940940] [139/144] (611s left) gem_exec_reloc (basic-cpu-active)
[575.994138] Subtest basic-cpu-active: SKIP (0.000s)
[576.035965] [140/144] (611s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[576.111239] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[579.048638] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.940s)
[579.186460] [141/144] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[579.255333] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[579.258787] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[579.324637] [142/144] (608s left) kms_cursor_crc (cursor-onscreen-128x128)
[579.468031] Starting subtest: cursor-onscreen-128x128
[579.470636] Starting dynamic subtest: pipe-A-eDP-1
[581.929313] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.458s)
[581.977772] Starting dynamic subtest: pipe-D-eDP-1
[585.113745] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.154s)
[585.116431] Subtest cursor-onscreen-128x128: SUCCESS (5.646s)
[586.006329] [143/144] (601s left) gem_mmap_wc (read-write)
[586.053406] Subtest read-write: SKIP (0.000s)
[586.082206] [144/144] (601s left) prime_mmap (test_reprime)
[586.129302] Starting subtest: test_reprime
[586.131903] Starting dynamic subtest: test_reprime-smem
[586.151591] Dynamic subtest test_reprime-smem: SUCCESS (0.026s)
[586.154249] Subtest test_reprime: SUCCESS (0.026s)
[586.228490] Closing watchdogs
Done.