[63.747501] Initializing watchdogs
[63.747578]   /dev/watchdog0
[63.762407] [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]
[63.767181] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.769574] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.772957] [001/156] (960s left) i915_pm_rpm (gem-pread)
[65.478450] Starting subtest: gem-pread
[67.816622] Subtest gem-pread: SUCCESS (2.334s)
[67.924375] [002/156] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[68.038996] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[68.043197] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.139547] [003/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[68.243587] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[68.248171] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[68.359953] [004/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[68.461722] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[68.465783] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[68.569520] [005/156] (955s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[68.664946] Starting subtest: fbchdr-tiling-y
[68.669180] Subtest fbchdr-tiling-y: SKIP (0.000s)
[68.755620] [006/156] (955s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[68.851882] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[68.855749] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[68.959188] [007/156] (955s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[69.071944] Starting subtest: fbc-farfromfence-mmap-gtt
[69.075628] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[69.154938] [008/156] (955s left) gem_spin_batch (spin-all)
[69.212657] Starting subtest: spin-all
[69.229629] Subtest spin-all: SUCCESS (0.017s)
[71.276390] [009/156] (953s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[71.385296] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[71.389237] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[71.481721] [010/156] (953s left) device_reset (unbind-cold-reset-rebind)
[71.532094] Starting subtest: unbind-cold-reset-rebind
[71.537179] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[71.595185] [011/156] (953s left) kms_pm_dc (dc9-dpms)
[72.706475] Starting subtest: dc9-dpms
[74.148079] Subtest dc9-dpms: SUCCESS (1.440s)
[74.219837] [012/156] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[74.313725] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[74.318184] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.401645] [013/156] (950s left) kms_dp_linktrain_fallback (dp-fallback)
[74.484662] Starting subtest: dp-fallback
[74.490803] Subtest dp-fallback: SKIP (0.000s)
[74.552649] [014/156] (950s left) kms_getfb (getfb2-handle-zero)
[74.640762] Starting subtest: getfb2-handle-zero
[74.643105] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[74.736726] [015/156] (950s left) core_auth (basic-auth)
[74.789391] Starting subtest: basic-auth
[74.791710] Subtest basic-auth: SUCCESS (0.001s)
[74.894326] [016/156] (949s left) gem_busy (semaphore)
[75.082232] Subtest semaphore: SKIP (0.000s)
[75.302159] [017/156] (949s left) prime_mmap (test_forked)
[75.346966] Starting subtest: test_forked
[75.349312] Starting dynamic subtest: test_forked-smem
[75.388435] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[75.390851] Subtest test_forked: SUCCESS (0.043s)
[75.495874] [018/156] (949s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[75.587638] Starting subtest: pr-plane-move-sf-dmg-area
[75.591848] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[75.664237] [019/156] (949s left) i915_drm_fdinfo (all-busy-check-all)
[75.702824] Starting subtest: all-busy-check-all
[75.709582] Subtest all-busy-check-all: SKIP (0.004s)
[75.786209] [020/156] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[75.917073] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[84.852128] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.935s)
[84.975847] [021/156] (940s left) gem_ctx_persistence (heartbeat-hang)
[85.035253] Starting subtest: heartbeat-hang
[85.039678] Subtest heartbeat-hang: SKIP (0.000s)
[85.136026] [022/156] (939s left) kms_pipe_crc_basic (bad-source)
[85.222968] Starting subtest: bad-source
[85.225850] Subtest bad-source: SUCCESS (0.000s)
[85.306539] [023/156] (939s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[85.401781] Starting subtest: psrhdr-rgb101010-draw-pwrite
[85.406295] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[85.501921] [024/156] (939s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[85.592143] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[85.621658] Starting dynamic subtest: pipe-A-plane-0
[85.887702] Dynamic subtest pipe-A-plane-0: SUCCESS (0.267s)
[85.896139] Starting dynamic subtest: pipe-A-plane-3
[86.099068] Dynamic subtest pipe-A-plane-3: SUCCESS (0.211s)
[87.192898] Starting dynamic subtest: pipe-B-plane-0
[87.463608] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[87.473460] Starting dynamic subtest: pipe-B-plane-3
[87.673043] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[87.986739] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.392s)
[88.873048] [025/156] (936s left) gem_ctx_param (invalid-size-set)
[88.920620] Starting subtest: invalid-size-set
[88.923036] Subtest invalid-size-set: SUCCESS (0.001s)
[89.001590] [026/156] (936s left) kms_invalid_mode (bad-vsync-end)
[89.096470] Starting subtest: bad-vsync-end
[89.098976] Starting dynamic subtest: pipe-A-eDP-1
[89.384170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[89.393070] Starting dynamic subtest: pipe-B-eDP-1
[89.394901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[89.402676] Starting dynamic subtest: pipe-C-eDP-1
[89.404820] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[89.412943] Starting dynamic subtest: pipe-D-eDP-1
[89.415340] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.417745] Subtest bad-vsync-end: SUCCESS (0.291s)
[90.197415] [027/156] (935s left) perf_pmu (init-busy)
[90.235050] Starting subtest: init-busy
[90.237618] Starting dynamic subtest: rcs0
[90.240298] Dynamic subtest rcs0: SUCCESS (0.002s)
[90.248381] Starting dynamic subtest: bcs0
[90.250786] Dynamic subtest bcs0: SUCCESS (0.000s)
[90.258311] Starting dynamic subtest: vcs0
[90.260309] Dynamic subtest vcs0: SUCCESS (0.001s)
[90.267889] Starting dynamic subtest: vcs1
[90.270069] Dynamic subtest vcs1: SUCCESS (0.001s)
[90.277546] Starting dynamic subtest: vecs0
[90.279521] Dynamic subtest vecs0: SUCCESS (0.001s)
[90.286998] Starting dynamic subtest: ccs0
[90.288972] Dynamic subtest ccs0: SUCCESS (0.000s)
[90.290973] Subtest init-busy: SUCCESS (0.006s)
[90.359854] [028/156] (934s left) gem_exec_schedule (fairslice-all)
[90.425140] Starting subtest: fairslice-all
[92.527755] Subtest fairslice-all: SUCCESS (2.063s)
[94.361448] [029/156] (931s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[94.454741] Starting subtest: fbc-pr-cursor-mmap-gtt
[94.458785] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[94.525364] [030/156] (930s left) gem_unref_active_buffers
[94.714392] [031/156] (930s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[94.780680] Starting subtest: y-tiled-to-vebox-x-tiled
[94.785533] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[94.959223] [032/156] (930s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[95.056245] Starting subtest: fbc-psr2-sprite-plane-onoff
[95.058347] Starting dynamic subtest: eDP-1
[95.062594] Dynamic subtest eDP-1: SKIP (0.000s)
[95.066799] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[95.137236] [033/156] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[95.231382] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[95.235432] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[95.317901] [034/156] (930s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[95.443721] Starting subtest: 2x-flip-vs-cursor-legacy
[95.447427] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[95.585119] [035/156] (930s left) gem_partial_pwrite_pread (write)
[95.647898] Subtest write: SKIP (0.000s)
[95.749097] [036/156] (929s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[95.801117] Starting subtest: yf-tiled-ccs-to-x-tiled
[95.804929] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[95.983127] [037/156] (929s left) gem_exec_balancer (parallel-keep-in-fence)
[96.233092] Starting subtest: parallel-keep-in-fence
[97.374790] Subtest parallel-keep-in-fence: SUCCESS (1.141s)
[97.477788] [038/156] (928s left) kms_lease (lease-invalid-plane)
[97.575150] Starting subtest: lease-invalid-plane
[97.577512] Starting dynamic subtest: pipe-A-eDP-1
[97.579706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[97.589167] Starting dynamic subtest: pipe-B-eDP-1
[97.591049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[97.598804] Starting dynamic subtest: pipe-C-eDP-1
[97.601241] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[97.611041] Starting dynamic subtest: pipe-D-eDP-1
[97.613196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[97.615348] Subtest lease-invalid-plane: SUCCESS (0.002s)
[97.650126] [039/156] (928s left) gem_exec_flush (basic-uc-rw-default)
[97.718720] Starting subtest: basic-uc-rw-default
[103.205180] Subtest basic-uc-rw-default: SUCCESS (5.455s)
[103.356685] [040/156] (922s left) gem_wait (invalid-buf)
[103.416617] Starting subtest: invalid-buf
[103.419163] Subtest invalid-buf: SUCCESS (0.000s)
[103.621249] [041/156] (922s left) gem_close_race (multigpu-basic-threads)
[103.687095] Starting subtest: multigpu-basic-threads
[103.691748] Subtest multigpu-basic-threads: SKIP (0.000s)
[103.912073] [042/156] (921s left) kms_flip (wf_vblank-ts-check-interruptible)
[104.001080] Starting subtest: wf_vblank-ts-check-interruptible
[104.003361] Starting dynamic subtest: A-eDP1
[112.982730] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[112.995986] Starting dynamic subtest: B-eDP1
[121.920746] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[121.930312] Starting dynamic subtest: C-eDP1
[130.851534] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[130.860741] Starting dynamic subtest: D-eDP1
[139.787934] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[139.790510] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.740s)
[140.979730] [043/156] (884s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[141.075759] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[141.078081] Starting dynamic subtest: pipe-A-eDP-1
[141.102840] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[141.114090] Starting dynamic subtest: pipe-B-eDP-1
[141.136231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[141.144156] Starting dynamic subtest: pipe-C-eDP-1
[141.166251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[141.174150] Starting dynamic subtest: pipe-D-eDP-1
[141.197594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[141.202085] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[143.354737] [044/156] (882s left) gem_mmap_offset (pf-nonblock)
[143.412568] Starting subtest: pf-nonblock
[143.420116] Subtest pf-nonblock: SUCCESS (0.008s)
[143.551523] [045/156] (882s left) syncobj_timeline (host-signal-points)
[143.605515] Starting subtest: host-signal-points
[143.610481] Subtest host-signal-points: SUCCESS (0.004s)
[143.699989] [046/156] (882s left) gem_mmap_gtt (cpuset-basic-small-copy)
[143.756070] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[143.816857] [047/156] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[143.918058] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[152.758984] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.848s)
[152.908755] [048/156] (873s left) drm_read (short-buffer-block)
[153.056664] Starting subtest: short-buffer-block
[153.059161] Subtest short-buffer-block: SUCCESS (0.000s)
[153.206687] [049/156] (872s left) syncobj_timeline (wait-for-submit-complex)
[153.264851] Starting subtest: wait-for-submit-complex
[153.326950] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[153.418783] [050/156] (872s left) gem_exec_schedule (manyslice)
[153.484577] Starting subtest: manyslice
[153.486728] Starting dynamic subtest: rcs0
[158.673163] Dynamic subtest rcs0: SUCCESS (5.142s)
[158.685075] Starting dynamic subtest: bcs0
[165.309579] Dynamic subtest bcs0: SUCCESS (6.636s)
[165.318620] Starting dynamic subtest: vcs0
[170.898471] Dynamic subtest vcs0: SUCCESS (5.588s)
[170.907554] Starting dynamic subtest: vcs1
[176.978149] Dynamic subtest vcs1: SUCCESS (6.077s)
[176.986598] Starting dynamic subtest: vecs0
[183.055324] Dynamic subtest vecs0: SUCCESS (6.078s)
[183.063843] Starting dynamic subtest: ccs0
[189.162629] Dynamic subtest ccs0: SUCCESS (6.158s)
[189.165067] Subtest manyslice: SUCCESS (35.686s)
[189.516183] [051/156] (836s left) kms_flip (2x-flip-vs-suspend-interruptible)
[189.627210] Starting subtest: 2x-flip-vs-suspend-interruptible
[189.631754] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[189.743995] [052/156] (836s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[189.846135] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[189.923467] [053/156] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[190.018159] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[190.022135] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[190.113606] [054/156] (836s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[190.205786] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[190.208157] Starting dynamic subtest: pipe-A-eDP-1
[190.304638] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[190.317402] Starting dynamic subtest: pipe-B-eDP-1
[191.513901] Dynamic subtest pipe-B-eDP-1: SKIP (1.206s)
[191.518777] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.311s)
[192.694622] [055/156] (833s left) kms_psr (psr-primary-blt)
[192.781719] Starting subtest: psr-primary-blt
[192.783977] Starting dynamic subtest: eDP-1
[194.497693] Dynamic subtest eDP-1: SUCCESS (1.716s)
[194.500097] Subtest psr-primary-blt: SUCCESS (1.717s)
[195.363985] [056/156] (831s left) gem_mmap_wc (write-prefaulted)
[195.422057] Subtest write-prefaulted: SKIP (0.000s)
[195.485255] [057/156] (830s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[195.598297] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[195.602475] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[195.691736] [058/156] (830s left) kms_frontbuffer_tracking (fbc-tiling-4)
[195.786600] Starting subtest: fbc-tiling-4
[199.957363] Subtest fbc-tiling-4: SUCCESS (4.178s)
[201.164692] [059/156] (825s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[201.265904] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[207.917464] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.655s)
[208.057989] [060/156] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[208.162388] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[208.167053] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[208.250365] [061/156] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[208.354847] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[208.358981] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[208.449892] [062/156] (818s left) gem_exec_store (cachelines)
[208.509175] Starting subtest: cachelines
[208.511310] Starting dynamic subtest: rcs0
[208.594069] Dynamic subtest rcs0: SUCCESS (0.084s)
[208.607149] Starting dynamic subtest: bcs0
[208.659142] Dynamic subtest bcs0: SUCCESS (0.063s)
[208.668763] Starting dynamic subtest: vcs0
[208.713339] Dynamic subtest vcs0: SUCCESS (0.052s)
[208.723985] Starting dynamic subtest: vcs1
[208.776663] Dynamic subtest vcs1: SUCCESS (0.062s)
[208.786146] Starting dynamic subtest: vecs0
[208.839755] Dynamic subtest vecs0: SUCCESS (0.061s)
[208.850226] Starting dynamic subtest: ccs0
[208.905622] Dynamic subtest ccs0: SUCCESS (0.065s)
[208.908063] Subtest cachelines: SUCCESS (0.397s)
[209.099278] [063/156] (817s left) syncobj_wait (invalid-reset-one-illegal-handle)
[209.153468] Starting subtest: invalid-reset-one-illegal-handle
[209.156043] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[209.242666] [064/156] (817s left) kms_cursor_edge_walk (64x64-left-edge)
[209.342951] Starting subtest: 64x64-left-edge
[209.345242] Starting dynamic subtest: pipe-A-eDP-1
[212.855247] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[212.865223] Starting dynamic subtest: pipe-D-eDP-1
[215.992548] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[215.994453] Subtest 64x64-left-edge: SUCCESS (6.650s)
[216.805268] [065/156] (809s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[216.915718] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[216.919851] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[217.011022] [066/156] (809s left) gem_flink_basic (flink-lifetime)
[217.070752] Starting subtest: flink-lifetime
[217.073492] Subtest flink-lifetime: SUCCESS (0.002s)
[217.167936] [067/156] (809s left) kms_flip (flip-vs-wf_vblank-interruptible)
[217.263579] Starting subtest: flip-vs-wf_vblank-interruptible
[217.265895] Starting dynamic subtest: A-eDP1
[219.144855] Dynamic subtest A-eDP1: SUCCESS (1.880s)
[219.155905] Starting dynamic subtest: B-eDP1
[221.081205] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[221.092428] Starting dynamic subtest: C-eDP1
[223.002633] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[223.012484] Starting dynamic subtest: D-eDP1
[224.935089] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[224.940540] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.676s)
[226.165915] [068/156] (800s left) syncobj_wait (invalid-reset-zero-handles)
[226.211502] Starting subtest: invalid-reset-zero-handles
[226.213814] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[226.302460] [069/156] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[226.405360] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[226.409390] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[226.498616] [070/156] (800s left) kms_psr (psr2-cursor-plane-onoff)
[226.590879] Starting subtest: psr2-cursor-plane-onoff
[226.593102] Starting dynamic subtest: eDP-1
[228.341306] Dynamic subtest eDP-1: SUCCESS (1.750s)
[228.343461] Subtest psr2-cursor-plane-onoff: SUCCESS (1.750s)
[229.216794] [071/156] (797s left) kms_dsc (dsc-with-formats)
[229.307312] Starting subtest: dsc-with-formats
[229.348713] Subtest dsc-with-formats: SKIP (0.001s)
[229.391584] [072/156] (797s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[229.501181] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[229.505172] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[229.593884] [073/156] (797s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[229.687069] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[229.691377] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[229.798120] [074/156] (797s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[229.897280] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[229.899601] Starting dynamic subtest: pipe-A-default-mode
[231.075263] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[231.079306] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.177s)
[231.209321] [075/156] (795s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[231.270189] Starting subtest: map-fixed-invalidate-overlap
[231.274699] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[231.381228] [076/156] (795s left) kms_cursor_crc (cursor-onscreen-256x256)
[231.626772] Starting subtest: cursor-onscreen-256x256
[231.632077] Starting dynamic subtest: pipe-A-eDP-1
[233.751225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[233.780978] Starting dynamic subtest: pipe-D-eDP-1
[236.545726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[236.547851] Subtest cursor-onscreen-256x256: SUCCESS (4.917s)
[237.431324] [077/156] (789s left) kms_big_fb (linear-addfb)
[237.537288] Starting subtest: linear-addfb
[237.539649] Subtest linear-addfb: SUCCESS (0.000s)
[237.632415] [078/156] (789s left) i915_pm_rps (thresholds-park)
[237.698148] Starting subtest: thresholds-park
[237.702549] Subtest thresholds-park: SKIP (0.001s)
[237.811866] [079/156] (789s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[237.914109] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[237.918655] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[238.007468] [080/156] (789s left) gem_exec_schedule (smoketest)
[238.186482] Starting subtest: smoketest
[238.188898] Starting dynamic subtest: rcs0
[243.786592] Dynamic subtest rcs0: SUCCESS (5.495s)
[243.798535] Starting dynamic subtest: bcs0
[249.299316] Dynamic subtest bcs0: SUCCESS (5.511s)
[249.311628] Starting dynamic subtest: vcs0
[254.798227] Dynamic subtest vcs0: SUCCESS (5.500s)
[254.808641] Starting dynamic subtest: vcs1
[260.297794] Dynamic subtest vcs1: SUCCESS (5.494s)
[260.308492] Starting dynamic subtest: vecs0
[265.784413] Dynamic subtest vecs0: SUCCESS (5.494s)
[265.795079] Starting dynamic subtest: ccs0
[271.283311] Dynamic subtest ccs0: SUCCESS (5.488s)
[271.285256] Subtest smoketest: SUCCESS (32.988s)
[271.403553] [081/156] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[271.517525] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[271.521855] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[271.626237] [082/156] (755s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[271.720494] Starting subtest: plane-downscale-factor-0-75-with-rotation
[271.722824] Starting dynamic subtest: pipe-A
[271.948557] Dynamic subtest pipe-A: SUCCESS (0.230s)
[271.957795] Starting dynamic subtest: pipe-B
[273.212148] Dynamic subtest pipe-B: SUCCESS (1.263s)
[273.221667] Starting dynamic subtest: pipe-C
[274.554904] Dynamic subtest pipe-C: SUCCESS (1.342s)
[274.566078] Starting dynamic subtest: pipe-D
[275.874560] Dynamic subtest pipe-D: SUCCESS (1.319s)
[275.877095] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.157s)
[277.048136] [083/156] (750s left) sw_sync (sync_busy_fork)
[277.083061] Starting subtest: sync_busy_fork
[278.097406] Subtest sync_busy_fork: SUCCESS (1.013s)
[278.159289] [084/156] (749s left) kms_psr (fbc-psr-no-drrs)
[278.243085] Starting subtest: fbc-psr-no-drrs
[278.245393] Starting dynamic subtest: eDP-1
[278.249775] Dynamic subtest eDP-1: SKIP (0.000s)
[278.254270] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[278.328579] [085/156] (749s left) vgem_basic (second-client)
[278.446405] Starting subtest: second-client
[278.468596] Subtest second-client: SUCCESS (0.022s)
[278.522095] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[278.525319] [086/156] (749s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[278.627064] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[278.631252] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[278.723448] [087/156] (748s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[278.827571] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[278.832102] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[278.917252] [088/156] (748s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[279.026068] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[279.030648] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[279.107892] [089/156] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[279.214927] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[279.218313] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[279.310261] [090/156] (748s left) syncobj_timeline (invalid-query-one-illegal-handle)
[279.368220] Starting subtest: invalid-query-one-illegal-handle
[279.370120] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[279.478748] [091/156] (748s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[279.584186] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[279.587679] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[279.681268] [092/156] (748s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[279.781610] Starting subtest: 4-tiled-16bpp-rotate-180
[281.128610] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[281.251620] [093/156] (746s left) gem_flink_basic (double-flink)
[281.309149] Starting subtest: double-flink
[281.311051] Subtest double-flink: SUCCESS (0.000s)
[281.415238] [094/156] (746s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[281.507902] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[281.511497] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[281.612033] [095/156] (746s left) gem_exec_balancer (invalid-bonds)
[281.668703] Starting subtest: invalid-bonds
[281.672276] Subtest invalid-bonds: SKIP (0.000s)
[281.987180] [096/156] (746s left) syncobj_timeline (device-submit-unordered)
[282.041466] Starting subtest: device-submit-unordered
[282.043910] Subtest device-submit-unordered: SUCCESS (0.001s)
[282.151166] [097/156] (745s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[282.238415] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[282.250286] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[282.340615] [098/156] (745s left) kms_content_protection (atomic-hdcp14)
[282.480070] Starting subtest: atomic-hdcp14
[282.484310] Subtest atomic-hdcp14: SKIP (0.000s)
[282.621813] [099/156] (745s left) syncobj_eventfd (binary-wait)
[282.684574] Starting subtest: binary-wait
[282.693080] Subtest binary-wait: SUCCESS (0.011s)
[282.766921] [100/156] (745s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[282.872057] Starting subtest: x-tiled-addfb-size-offset-overflow
[282.874052] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[282.964831] [101/156] (745s left) perf (polling)
[283.091771] Starting subtest: polling
[283.093485] Starting dynamic subtest: 0-rcs0
[293.177254] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[293.188042] Starting dynamic subtest: 1-vcs0
[303.197968] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[303.200438] Subtest polling: SUCCESS (20.053s)
[303.242725] [102/156] (725s left) gem_ctx_param (get-priority-new-ctx)
[303.296453] Starting subtest: get-priority-new-ctx
[303.298823] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[303.413493] [103/156] (724s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[303.522157] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[303.526379] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[303.619421] [104/156] (724s left) kms_addfb_basic (bad-pitch-1024)
[303.674534] Starting subtest: bad-pitch-1024
[303.677058] Subtest bad-pitch-1024: SUCCESS (0.000s)
[303.821176] [105/156] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[303.913185] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[308.360598] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.453s)
[309.554113] [106/156] (718s left) kms_flip (dpms-off-confusion)
[309.650530] Starting subtest: dpms-off-confusion
[309.652413] Starting dynamic subtest: A-eDP1
[318.396971] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[318.408121] Starting dynamic subtest: B-eDP1
[327.046612] Dynamic subtest B-eDP1: SUCCESS (8.650s)
[327.057091] Starting dynamic subtest: C-eDP1
[335.684693] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[335.693680] Starting dynamic subtest: D-eDP1
[344.290059] Dynamic subtest D-eDP1: SUCCESS (8.647s)
[344.292803] Subtest dpms-off-confusion: SUCCESS (34.644s)
[345.470492] [107/156] (683s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[345.854941] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[346.685245] [108/156] (681s left) gem_exec_reloc (basic-gtt-noreloc)
[346.752797] Subtest basic-gtt-noreloc: SKIP (0.000s)
[346.819557] [109/156] (681s left) api_intel_bb (intel-bb-blit-x)
[346.868553] Starting subtest: intel-bb-blit-x
[350.607860] Subtest intel-bb-blit-x: SUCCESS (3.740s)
[350.752439] [110/156] (677s left) kms_cdclk (mode-transition)
[350.858221] Starting subtest: mode-transition
[350.860534] Starting dynamic subtest: pipe-A-eDP-1
[351.149861] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[351.159597] Starting dynamic subtest: pipe-B-eDP-1
[351.164945] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[351.176328] Starting dynamic subtest: pipe-C-eDP-1
[351.181122] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[351.189888] Starting dynamic subtest: pipe-D-eDP-1
[351.194375] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[351.198851] Subtest mode-transition: SKIP (0.297s)
[352.019999] [111/156] (676s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[352.075529] Starting subtest: multi-wait-available-submitted-signaled
[352.077813] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[352.167142] [112/156] (676s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[352.262549] Starting subtest: hdr-rgb565-draw-render
[352.266651] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[352.355943] [113/156] (676s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[352.748214] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[353.541720] [114/156] (675s left) api_intel_allocator (alloc-simple)
[353.587584] Starting subtest: alloc-simple
[353.590076] Subtest alloc-simple: SUCCESS (0.003s)
[353.708740] [115/156] (675s left) syncobj_basic (bad-create-flags)
[353.762621] Starting subtest: bad-create-flags
[353.764824] Subtest bad-create-flags: SUCCESS (0.000s)
[353.880116] [116/156] (674s left) perf_pmu (busy-idle)
[353.916567] Starting subtest: busy-idle
[353.918441] Starting dynamic subtest: rcs0
[354.623030] Dynamic subtest rcs0: SUCCESS (0.707s)
[354.634705] Starting dynamic subtest: bcs0
[355.294190] Dynamic subtest bcs0: SUCCESS (0.669s)
[355.305460] Starting dynamic subtest: vcs0
[357.319859] Dynamic subtest vcs0: SUCCESS (2.022s)
[357.332071] Starting dynamic subtest: vcs1
[359.303467] Dynamic subtest vcs1: SUCCESS (1.981s)
[359.314648] Starting dynamic subtest: vecs0
[361.287603] Dynamic subtest vecs0: SUCCESS (1.981s)
[361.300069] Starting dynamic subtest: ccs0
[361.963386] Dynamic subtest ccs0: SUCCESS (0.674s)
[361.966384] Subtest busy-idle: SUCCESS (8.048s)
[362.064905] [117/156] (666s left) kms_color (ctm-negative)
[362.160955] Starting subtest: ctm-negative
[362.163181] Starting dynamic subtest: pipe-A-eDP-1
[362.871684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[362.883602] Starting dynamic subtest: pipe-B-eDP-1
[364.273131] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[364.284769] Starting dynamic subtest: pipe-C-eDP-1
[365.649034] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[365.659097] Starting dynamic subtest: pipe-D-eDP-1
[367.064749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[367.067295] Subtest ctm-negative: SUCCESS (4.906s)
[367.882592] [118/156] (661s left) syncobj_wait (reset-during-wait-for-submit)
[367.929997] Starting subtest: reset-during-wait-for-submit
[368.033535] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[368.125790] [119/156] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[368.232267] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[368.236740] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[368.331568] [120/156] (660s left) i915_hangman (gt-engine-error)
[368.402067] Starting subtest: gt-engine-error
[368.404352] Starting dynamic subtest: rcs0
[370.277958] Dynamic subtest rcs0: SUCCESS (1.874s)
[370.289930] Starting dynamic subtest: bcs0
[372.262056] Dynamic subtest bcs0: SUCCESS (1.981s)
[372.274140] Starting dynamic subtest: vcs0
[374.247729] Dynamic subtest vcs0: SUCCESS (1.982s)
[374.262467] Starting dynamic subtest: vcs1
[376.230084] Dynamic subtest vcs1: SUCCESS (1.980s)
[376.242328] Starting dynamic subtest: vecs0
[378.278931] Dynamic subtest vecs0: SUCCESS (2.046s)
[378.291800] Starting dynamic subtest: ccs0
[380.261552] Dynamic subtest ccs0: SUCCESS (1.979s)
[380.264443] Subtest gt-engine-error: SUCCESS (11.859s)
[380.344295] [121/156] (648s left) kms_plane_alpha_blend (alpha-basic)
[380.445176] Starting subtest: alpha-basic
[380.749408] Starting dynamic subtest: pipe-A-eDP-1
[382.679487] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[382.710657] Starting dynamic subtest: pipe-D-eDP-1
[385.373327] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[385.375759] Subtest alpha-basic: SUCCESS (4.928s)
[386.242064] [122/156] (642s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[386.349216] Starting subtest: yf-tiled-64bpp-rotate-0
[386.353886] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[386.451438] [123/156] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[386.553767] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[386.557709] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[386.652445] [124/156] (642s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[386.751751] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[386.755889] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.844685] [125/156] (642s left) gem_ctx_shared (q-promotion)
[386.908163] Starting subtest: Q-promotion
[386.910469] Starting dynamic subtest: rcs0
[387.006709] Dynamic subtest rcs0: SUCCESS (0.100s)
[387.022932] Starting dynamic subtest: vcs0
[387.092082] Dynamic subtest vcs0: SUCCESS (0.083s)
[387.106298] Starting dynamic subtest: vcs1
[387.175899] Dynamic subtest vcs1: SUCCESS (0.082s)
[387.191623] Starting dynamic subtest: vecs0
[387.253828] Dynamic subtest vecs0: SUCCESS (0.077s)
[387.269593] Starting dynamic subtest: ccs0
[387.335581] Dynamic subtest ccs0: SUCCESS (0.081s)
[387.337681] Subtest Q-promotion: SUCCESS (0.432s)
[388.381167] [126/156] (640s left) gem_exec_fence (syncobj-invalid-wait)
[388.794971] Starting subtest: syncobj-invalid-wait
[388.797633] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[390.370548] [127/156] (638s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[390.478197] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[390.482213] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[390.576326] [128/156] (638s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[390.667058] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[390.669222] Starting dynamic subtest: pipe-A-eDP-1
[390.691084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.700705] Starting dynamic subtest: pipe-B-eDP-1
[390.721736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.730932] Starting dynamic subtest: pipe-C-eDP-1
[390.751609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.760623] Starting dynamic subtest: pipe-D-eDP-1
[390.782590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.786664] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[392.944201] [129/156] (636s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[393.042997] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[393.045225] Starting dynamic subtest: pipe-A-eDP-1
[409.318945] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.267s)
[409.329329] Starting dynamic subtest: pipe-B-eDP-1
[426.296808] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s)
[426.307382] Starting dynamic subtest: pipe-C-eDP-1
[443.289386] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.440s)
[443.300719] Starting dynamic subtest: pipe-D-eDP-1
[460.246147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.302s)
[460.248685] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.457s)
[461.453031] [130/156] (568s left) kms_scaling_modes (scaling-mode-full)
[461.557404] Starting subtest: scaling-mode-full
[461.559823] Starting dynamic subtest: pipe-A-eDP-1
[461.652324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[461.663558] Starting dynamic subtest: pipe-B-eDP-1
[462.905849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[462.917671] Starting dynamic subtest: pipe-C-eDP-1
[464.048473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[464.062023] Starting dynamic subtest: pipe-D-eDP-1
[465.189407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[465.194360] Subtest scaling-mode-full: SUCCESS (3.581s)
[466.357390] [131/156] (563s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[466.667152] Starting subtest: cursor-rapid-movement-512x170
[466.671824] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[466.837325] [132/156] (562s left) prime_udl
[466.932290] [133/156] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[467.031607] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[474.479603] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.407s)
[474.617677] [134/156] (555s left) gem_ctx_isolation (nonpriv-switch)
[474.683412] Starting subtest: nonpriv-switch
[474.685682] Starting dynamic subtest: rcs0
[474.989720] Dynamic subtest rcs0: SUCCESS (0.305s)
[475.002917] Starting dynamic subtest: bcs0
[475.276517] Dynamic subtest bcs0: SUCCESS (0.285s)
[475.288965] Starting dynamic subtest: vcs0
[475.578913] Dynamic subtest vcs0: SUCCESS (0.301s)
[475.590945] Starting dynamic subtest: vcs1
[477.253796] Dynamic subtest vcs1: SUCCESS (1.668s)
[477.264236] Starting dynamic subtest: vecs0
[479.274551] Dynamic subtest vecs0: SUCCESS (2.014s)
[479.287529] Starting dynamic subtest: ccs0
[481.265729] Dynamic subtest ccs0: SUCCESS (1.986s)
[481.268090] Subtest nonpriv-switch: SUCCESS (6.565s)
[481.497560] [135/156] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[481.600892] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[486.081103] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.478s)
[487.287003] [136/156] (542s left) drm_read (empty-block)
[487.442598] Starting subtest: empty-block
[488.444491] Subtest empty-block: SUCCESS (1.000s)
[488.593240] [137/156] (541s left) kms_prime (basic-crc-vgem)
[488.681871] Starting subtest: basic-crc-vgem
[488.684073] Starting dynamic subtest: second-to-first
[489.699399] Dynamic subtest second-to-first: SUCCESS (1.019s)
[489.701424] Subtest basic-crc-vgem: SUCCESS (1.020s)
[489.792901] [138/156] (540s left) kms_sequence (get-busy)
[489.907143] Starting subtest: get-busy
[489.908969] Starting dynamic subtest: pipe-A-eDP-1
[491.848486] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[491.859721] Starting dynamic subtest: pipe-B-eDP-1
[494.480138] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.629s)
[494.491217] Starting dynamic subtest: pipe-C-eDP-1
[497.079763] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[497.090224] Starting dynamic subtest: pipe-D-eDP-1
[499.700617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[499.702867] Subtest get-busy: SUCCESS (9.794s)
[500.588462] [139/156] (529s left) gem_create (create-invalid-size)
[500.642476] Starting subtest: create-invalid-size
[500.644914] Subtest create-invalid-size: SUCCESS (0.000s)
[500.837879] [140/156] (529s left) gem_userptr_blits (set-cache-level)
[500.901656] Starting subtest: set-cache-level
[500.905920] Subtest set-cache-level: SKIP (0.000s)
[501.037563] [141/156] (528s left) gem_softpin (softpin)
[501.094242] Starting subtest: softpin
[533.441822] Subtest softpin: SUCCESS (32.335s)
[533.582171] [142/156] (496s left) kms_vblank (ts-continuation-suspend)
[533.698238] Starting subtest: ts-continuation-suspend
[533.700504] Starting dynamic subtest: pipe-A-eDP-1
[550.387955] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.524s)
[550.405257] Starting dynamic subtest: pipe-D-eDP-1
[567.396948] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.191s)
[567.399867] Subtest ts-continuation-suspend: SUCCESS (3.721s)
[568.228820] [143/156] (461s left) kms_plane_lowres (tiling-y)
[568.325476] Starting subtest: tiling-y
[568.330594] Subtest tiling-y: SKIP (0.000s)
[568.400662] [144/156] (461s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[568.509532] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[568.515129] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[568.628903] [145/156] (461s left) gem_mmap_gtt (basic-short)
[568.681514] Subtest basic-short: SKIP (0.000s)
[568.741639] [146/156] (461s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[568.845016] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[569.706888] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[569.863075] [147/156] (460s left) gem_lmem_swapping (massive-random)
[569.911812] Subtest massive-random: SKIP (0.000s)
[569.967384] [148/156] (460s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[570.097659] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[570.103293] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[570.247333] [149/156] (460s left) syncobj_timeline (wait-zero-handles)
[570.307930] Starting subtest: wait-zero-handles
[570.310925] Subtest wait-zero-handles: SUCCESS (0.000s)
[570.407453] [150/156] (459s left) kms_rotation_crc (sprite-rotation-90)
[570.497949] Starting subtest: sprite-rotation-90
[570.502713] Subtest sprite-rotation-90: SKIP (0.001s)
[570.577181] [151/156] (459s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[570.677520] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[570.682467] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[570.771413] [152/156] (459s left) kms_plane_scaling (planes-upscale-factor-0-25)
[570.858953] Starting subtest: planes-upscale-factor-0-25
[570.861265] Starting dynamic subtest: pipe-A
[570.920484] Dynamic subtest pipe-A: SUCCESS (0.063s)
[570.932330] Starting dynamic subtest: pipe-B
[572.111870] Dynamic subtest pipe-B: SUCCESS (1.174s)
[572.124975] Starting dynamic subtest: pipe-C
[573.240270] Dynamic subtest pipe-C: SUCCESS (1.114s)
[573.251509] Starting dynamic subtest: pipe-D
[574.400371] Dynamic subtest pipe-D: SUCCESS (1.147s)
[574.402948] Subtest planes-upscale-factor-0-25: SUCCESS (3.502s)
[575.570318] [153/156] (454s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[575.672672] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[575.677470] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[575.775724] [154/156] (454s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[575.886857] Starting subtest: 4-tiled-64bpp-rotate-180
[577.409466] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.513s)
[577.580388] [155/156] (453s left) gen7_exec_parse (oacontrol-tracking)
[577.643864] Subtest oacontrol-tracking: SKIP (0.000s)
[577.708807] [156/156] (452s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[577.798583] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[577.803160] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[578.901379] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_spin_batch
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: device_reset
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_dp_linktrain_fallback
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: core_auth
results: parsing output: 15/ for test: gem_busy
results: parsing output: 16/ for test: prime_mmap
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_pipe_crc_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_unref_active_buffers
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: gem_wait
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_store
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_cursor_edge_walk
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_flink_basic
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_dsc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: i915_pm_rps
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_flink_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: syncobj_eventfd
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: api_intel_allocator
results: parsing output: 114/ for test: syncobj_basic
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_hangman
results: parsing output: 120/ for test: kms_plane_alpha_blend
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_scaling_modes
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: prime_udl
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_ctx_isolation
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: drm_read
results: parsing output: 136/ for test: kms_prime
results: parsing output: 137/ for test: kms_sequence
results: parsing output: 138/ for test: gem_create
results: parsing output: 139/ for test: gem_userptr_blits
results: parsing output: 140/ for test: gem_softpin
results: parsing output: 141/ for test: kms_vblank
results: parsing output: 142/ for test: kms_plane_lowres
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: gem_lmem_swapping
results: parsing output: 147/ for test: kms_cursor_legacy
results: parsing output: 148/ for test: syncobj_timeline
results: parsing output: 149/ for test: kms_rotation_crc
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_plane_scaling
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: gen7_exec_parse
results: parsing output: 155/ for test: kms_ccs
Done.