[58.256191] Initializing watchdogs
[58.256235]   /dev/watchdog0
[58.270299] [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]
[58.274858] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.276983] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.280400] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[58.402438] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[62.096381] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.697s)
[63.279831] [002/133] (955s left) gem_exec_async (concurrent-writes)
[63.346798] Starting subtest: concurrent-writes
[63.349263] Starting dynamic subtest: rcs0
[63.362519] Dynamic subtest rcs0: SUCCESS (0.016s)
[63.373317] Starting dynamic subtest: bcs0
[63.375791] Dynamic subtest bcs0: SUCCESS (0.006s)
[63.383736] Starting dynamic subtest: vcs0
[63.385611] Dynamic subtest vcs0: SUCCESS (0.006s)
[63.393337] Starting dynamic subtest: vcs1
[63.395751] Dynamic subtest vcs1: SUCCESS (0.006s)
[63.403179] Starting dynamic subtest: vecs0
[63.405082] Dynamic subtest vecs0: SUCCESS (0.006s)
[63.411858] Starting dynamic subtest: ccs0
[63.413821] Dynamic subtest ccs0: SUCCESS (0.007s)
[63.415702] Subtest concurrent-writes: SUCCESS (0.049s)
[63.612486] [003/133] (955s left) kms_psr (pr-primary-blt)
[63.698027] Starting subtest: pr-primary-blt
[63.702403] Subtest pr-primary-blt: SKIP (0.000s)
[63.763388] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[64.161464] Subtest dp-crc-fast: SKIP (0.000s)
[64.979694] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[65.157889] Starting subtest: pi-shared-iova
[65.160351] Starting dynamic subtest: rcs0
[65.228490] Dynamic subtest rcs0: SUCCESS (0.075s)
[65.237280] Starting dynamic subtest: vcs0
[65.290327] Dynamic subtest vcs0: SUCCESS (0.062s)
[65.301146] Starting dynamic subtest: vcs1
[65.342047] Dynamic subtest vcs1: SUCCESS (0.052s)
[65.349455] Starting dynamic subtest: vecs0
[65.401517] Dynamic subtest vecs0: SUCCESS (0.059s)
[65.411266] Starting dynamic subtest: ccs0
[65.461674] Dynamic subtest ccs0: SUCCESS (0.060s)
[65.464155] Subtest pi-shared-iova: SUCCESS (0.308s)
[67.391887] [006/133] (951s left) kms_busy (basic-hang)
[67.562149] Starting subtest: basic-hang
[67.564682] Starting dynamic subtest: flip-pipe-A
[68.212704] Dynamic subtest flip-pipe-A: SUCCESS (0.650s)
[68.222501] Starting dynamic subtest: modeset-pipe-A
[71.641722] Dynamic subtest modeset-pipe-A: SUCCESS (3.427s)
[71.652147] Starting dynamic subtest: flip-pipe-D
[72.914197] Dynamic subtest flip-pipe-D: SUCCESS (1.272s)
[72.924624] Starting dynamic subtest: modeset-pipe-D
[76.373893] Dynamic subtest modeset-pipe-D: SUCCESS (3.459s)
[76.376665] Subtest basic-hang: SUCCESS (8.813s)
[77.176413] [007/133] (941s left) kms_flip (basic-flip-vs-dpms)
[77.270324] Starting subtest: basic-flip-vs-dpms
[77.272787] Starting dynamic subtest: A-eDP1
[79.882660] Dynamic subtest A-eDP1: SUCCESS (2.609s)
[79.891884] Starting dynamic subtest: B-eDP1
[82.084288] Dynamic subtest B-eDP1: SUCCESS (2.201s)
[82.091902] Starting dynamic subtest: C-eDP1
[84.235051] Dynamic subtest C-eDP1: SUCCESS (2.149s)
[84.245113] Starting dynamic subtest: D-eDP1
[86.303524] Dynamic subtest D-eDP1: SUCCESS (2.068s)
[86.305928] Subtest basic-flip-vs-dpms: SUCCESS (9.035s)
[87.096360] [008/133] (931s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[87.190650] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[87.192987] Starting dynamic subtest: pipe-A-default-mode
[89.930435] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[89.932670] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.744s)
[90.800012] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[90.863521] Subtest non-threaded: SKIP (0.000s)
[90.921702] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[91.012839] Starting subtest: invalid-plane
[91.014697] Starting dynamic subtest: zero-id
[91.016606] Dynamic subtest zero-id: SUCCESS (0.000s)
[91.025418] Starting dynamic subtest: outrange-id
[91.027635] Dynamic subtest outrange-id: SUCCESS (0.000s)
[91.029717] Subtest invalid-plane: SUCCESS (0.001s)
[91.079914] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[91.132646] Subtest write-wc-read-gtt: SKIP (0.000s)
[91.197573] [012/133] (928s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[91.246737] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[91.301607] [013/133] (927s left) kms_big_fb (linear-32bpp-rotate-0)
[91.401289] Starting subtest: linear-32bpp-rotate-0
[93.048534] Subtest linear-32bpp-rotate-0: SUCCESS (1.649s)
[93.184559] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[93.254259] Subtest bb-start-far: SKIP (0.000s)
[93.324373] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[93.440074] Starting subtest: cursorB-vs-flipA-varying-size
[93.443926] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[93.579154] [016/133] (925s left) gem_lmem_swapping (verify)
[93.623546] Subtest verify: SKIP (0.000s)
[93.689060] [017/133] (925s left) gem_userptr_blits (mmap-offset-banned)
[93.762165] Starting subtest: mmap-offset-banned
[93.764200] Starting dynamic subtest: wb
[93.766064] Dynamic subtest wb: SUCCESS (0.000s)
[93.782160] Starting dynamic subtest: wc
[93.784150] Dynamic subtest wc: SUCCESS (0.000s)
[93.799045] Starting dynamic subtest: uc
[93.801050] Dynamic subtest uc: SUCCESS (0.000s)
[93.803069] Subtest mmap-offset-banned: SUCCESS (0.001s)
[93.895357] [018/133] (925s left) gem_softpin (evict-snoop-interruptible)
[93.975666] Starting subtest: evict-snoop-interruptible
[93.979525] Subtest evict-snoop-interruptible: SKIP (0.000s)
[94.111232] [019/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process)
[94.162734] Starting subtest: legacy-engines-mixed-process
[94.164842] Starting dynamic subtest: render
[95.901766] Dynamic subtest render: SUCCESS (1.738s)
[95.912027] Starting dynamic subtest: bsd1
[97.924148] Dynamic subtest bsd1: SUCCESS (2.019s)
[97.932950] Starting dynamic subtest: bsd2
[99.908791] Dynamic subtest bsd2: SUCCESS (1.983s)
[99.916541] Starting dynamic subtest: blt
[101.842061] Dynamic subtest blt: SUCCESS (1.934s)
[101.851860] Starting dynamic subtest: vebox
[103.905908] Dynamic subtest vebox: SUCCESS (2.062s)
[103.908431] Subtest legacy-engines-mixed-process: SUCCESS (9.743s)
[103.987622] [020/133] (915s left) gem_eio (hibernate)
[104.224258] Starting subtest: hibernate
[118.788035] Subtest hibernate: SUCCESS (14.562s)
[126.924784] [021/133] (900s left) i915_pm_rps (fence-order)
[127.007982] Starting subtest: fence-order
[130.018275] Subtest fence-order: SUCCESS (3.008s)
[130.157315] [022/133] (897s left) kms_vblank (ts-continuation-idle-hang)
[130.265198] Starting subtest: ts-continuation-idle-hang
[130.267468] Starting dynamic subtest: pipe-A-eDP-1
[156.693076] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.426s)
[156.708413] Starting dynamic subtest: pipe-D-eDP-1
[180.690741] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.994s)
[180.692798] Subtest ts-continuation-idle-hang: SUCCESS (50.423s)
[181.532692] [023/133] (846s left) perf (unprivileged-single-ctx-counters)
[181.682925] Starting subtest: unprivileged-single-ctx-counters
[181.686723] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[181.725639] [024/133] (846s left) kms_frontbuffer_tracking (fbc-tiling-4)
[181.821204] Starting subtest: fbc-tiling-4
[186.031527] Subtest fbc-tiling-4: SUCCESS (4.214s)
[187.242122] [025/133] (840s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[187.336840] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[194.032386] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.700s)
[194.148246] [026/133] (833s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[194.250042] Starting subtest: crc-primary-suspend-y-tiled-ccs
[194.252316] Starting dynamic subtest: pipe-A-eDP-1
[194.261028] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.272213] Starting dynamic subtest: pipe-B-eDP-1
[194.280924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.289727] Starting dynamic subtest: pipe-C-eDP-1
[194.298067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.306632] Starting dynamic subtest: pipe-D-eDP-1
[194.314821] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.318811] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[196.421022] [027/133] (831s left) gem_spin_batch (engines)
[196.484901] Starting subtest: engines
[196.487201] Starting dynamic subtest: rcs0
[199.722108] Dynamic subtest rcs0: SUCCESS (3.234s)
[199.732057] Starting dynamic subtest: bcs0
[202.960736] Dynamic subtest bcs0: SUCCESS (3.238s)
[202.972993] Starting dynamic subtest: vcs0
[206.199845] Dynamic subtest vcs0: SUCCESS (3.237s)
[206.211941] Starting dynamic subtest: vcs1
[209.438077] Dynamic subtest vcs1: SUCCESS (3.235s)
[209.454431] Starting dynamic subtest: vecs0
[212.676992] Dynamic subtest vecs0: SUCCESS (3.237s)
[212.687657] Starting dynamic subtest: ccs0
[215.912807] Dynamic subtest ccs0: SUCCESS (3.234s)
[215.915199] Subtest engines: SUCCESS (19.427s)
[216.145474] [028/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[216.248019] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[223.261326] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.016s)
[223.410706] [029/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[223.505301] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[223.510057] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[223.594016] [030/133] (804s left) gem_partial_pwrite_pread (reads-snoop)
[223.662534] Subtest reads-snoop: SKIP (0.000s)
[223.730378] [031/133] (804s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[223.826862] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[224.894732] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[225.016740] [032/133] (803s left) kms_getfb (getfb-reject-nv12)
[225.104166] Starting subtest: getfb-reject-nv12
[225.106069] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[225.226546] [033/133] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[225.317581] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[229.570215] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.255s)
[230.755118] [034/133] (797s left) perf_pmu (render-node-busy-idle)
[230.816239] Starting subtest: render-node-busy-idle
[230.818896] Starting dynamic subtest: rcs0
[231.503044] Dynamic subtest rcs0: SUCCESS (0.686s)
[231.515359] Starting dynamic subtest: bcs0
[232.172091] Dynamic subtest bcs0: SUCCESS (0.667s)
[232.184487] Starting dynamic subtest: vcs0
[233.942604] Dynamic subtest vcs0: SUCCESS (1.767s)
[233.955191] Starting dynamic subtest: vcs1
[235.926449] Dynamic subtest vcs1: SUCCESS (1.981s)
[235.938057] Starting dynamic subtest: vecs0
[237.910605] Dynamic subtest vecs0: SUCCESS (1.981s)
[237.923349] Starting dynamic subtest: ccs0
[238.576387] Dynamic subtest ccs0: SUCCESS (0.665s)
[238.579031] Subtest render-node-busy-idle: SUCCESS (7.761s)
[238.652766] [035/133] (789s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[238.758567] Starting subtest: yf-tiled-16bpp-rotate-90
[238.762973] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[238.856769] [036/133] (789s left) kms_content_protection (atomic)
[238.996848] Starting subtest: atomic
[239.001276] Subtest atomic: SKIP (0.000s)
[239.118197] [037/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[239.223345] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[239.227772] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[239.323186] [038/133] (789s left) kms_pm_rpm (fences-dpms)
[241.058066] Starting subtest: fences-dpms
[241.063141] Subtest fences-dpms: SKIP (0.000s)
[241.600422] [039/133] (786s left) gem_mmap_gtt (basic-write-read)
[241.657254] Subtest basic-write-read: SKIP (0.000s)
[241.722100] [040/133] (786s left) gem_exec_reloc (basic-write-cpu-active)
[241.780663] Subtest basic-write-cpu-active: SKIP (0.000s)
[241.850060] [041/133] (786s left) gem_eio (unwedge-stress)
[242.042583] Starting subtest: unwedge-stress
[242.044984] Starting dynamic subtest: render
[246.341565] Dynamic subtest render: SUCCESS (4.296s)
[246.356836] Starting dynamic subtest: bsd1
[264.345302] Dynamic subtest bsd1: SUCCESS (18.003s)
[264.359363] Starting dynamic subtest: bsd2
[284.358091] Dynamic subtest bsd2: SUCCESS (20.012s)
[284.373867] Starting dynamic subtest: blt
[284.378260] Dynamic subtest blt: SKIP (0.000s)
[284.387617] Starting dynamic subtest: vebox
[302.326921] Dynamic subtest vebox: SUCCESS (17.967s)
[302.329732] Subtest unwedge-stress: SUCCESS (60.281s)
[303.936265] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[303.939931] [042/133] (724s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[304.036681] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[304.041278] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[304.131262] [043/133] (724s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[304.225425] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[304.227730] Starting dynamic subtest: pipe-A-default-mode
[306.918844] Dynamic subtest pipe-A-default-mode: SUCCESS (2.693s)
[306.921311] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.695s)
[307.806361] [044/133] (720s left) gem_exec_store (pages)
[307.870873] Starting subtest: pages
[307.872997] Starting dynamic subtest: rcs0
[307.946282] Dynamic subtest rcs0: SUCCESS (0.079s)
[307.957796] Starting dynamic subtest: bcs0
[308.008950] Dynamic subtest bcs0: SUCCESS (0.062s)
[308.020944] Starting dynamic subtest: vcs0
[308.080239] Dynamic subtest vcs0: SUCCESS (0.070s)
[308.091829] Starting dynamic subtest: vcs1
[308.156582] Dynamic subtest vcs1: SUCCESS (0.076s)
[308.168710] Starting dynamic subtest: vecs0
[308.235262] Dynamic subtest vecs0: SUCCESS (0.077s)
[308.247203] Starting dynamic subtest: ccs0
[308.308112] Dynamic subtest ccs0: SUCCESS (0.072s)
[308.310540] Subtest pages: SUCCESS (0.442s)
[308.491321] [045/133] (720s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[308.592328] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[308.596760] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[308.666168] [046/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[308.765787] Starting subtest: psr-1p-primscrn-cur-indfb-move
[316.113433] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.351s)
[316.248989] [047/133] (712s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[316.359070] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[316.361434] Starting dynamic subtest: pipe-A-eDP-1
[316.384150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.395035] Starting dynamic subtest: pipe-B-eDP-1
[316.416950] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.426057] Starting dynamic subtest: pipe-C-eDP-1
[316.447247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.456176] Starting dynamic subtest: pipe-D-eDP-1
[316.478639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.483223] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[318.682486] [048/133] (710s left) kms_pm_rpm (basic-rte)
[318.723986] Starting subtest: basic-rte
[321.687227] Subtest basic-rte: SUCCESS (2.965s)
[323.202395] [049/133] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[323.294899] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[323.299211] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[323.396144] [050/133] (705s left) gem_exec_schedule (submit-golden-slice)
[323.463934] Starting subtest: submit-golden-slice
[323.466635] Starting dynamic subtest: rcs0
[323.490481] Dynamic subtest rcs0: SUCCESS (0.035s)
[323.502667] Starting dynamic subtest: bcs0
[323.530518] Dynamic subtest bcs0: SUCCESS (0.039s)
[323.547681] Starting dynamic subtest: vcs0
[323.570033] Dynamic subtest vcs0: SUCCESS (0.039s)
[323.581268] Starting dynamic subtest: vcs1
[323.607025] Dynamic subtest vcs1: SUCCESS (0.036s)
[323.618037] Starting dynamic subtest: vecs0
[323.642277] Dynamic subtest vecs0: SUCCESS (0.034s)
[323.652854] Starting dynamic subtest: ccs0
[323.677510] Dynamic subtest ccs0: SUCCESS (0.035s)
[323.679816] Subtest submit-golden-slice: SUCCESS (0.223s)
[324.964650] [051/133] (703s left) kms_async_flips (async-flip-hang)
[325.059209] Starting subtest: async-flip-hang
[325.437683] Starting dynamic subtest: pipe-A-eDP-1
[340.398420] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.959s)
[340.780886] Starting dynamic subtest: pipe-B-eDP-1
[356.401947] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.628s)
[356.787664] Starting dynamic subtest: pipe-C-eDP-1
[372.396924] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.613s)
[372.771832] Starting dynamic subtest: pipe-D-eDP-1
[388.395228] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s)
[388.397843] Subtest async-flip-hang: SUCCESS (63.337s)
[389.563351] [052/133] (639s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[389.785884] Starting subtest: cursor-rapid-movement-128x128
[389.790521] Starting dynamic subtest: pipe-A-eDP-1
[390.333414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[390.363094] Starting dynamic subtest: pipe-D-eDP-1
[391.564809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[391.567246] Subtest cursor-rapid-movement-128x128: SUCCESS (1.779s)
[392.434962] [053/133] (636s left) syncobj_timeline (invalid-query-bad-pad)
[392.500386] Starting subtest: invalid-query-bad-pad
[392.502621] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[392.605225] [054/133] (636s left) kms_tiled_display (basic-test-pattern)
[392.716598] Subtest basic-test-pattern: SKIP (0.000s)
[392.768272] [055/133] (636s left) perf (gen12-invalid-class-instance)
[392.873510] Starting subtest: gen12-invalid-class-instance
[392.884488] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[392.935567] [056/133] (636s left) kms_invalid_mode (uint-max-clock)
[393.029351] Starting subtest: uint-max-clock
[393.031550] Starting dynamic subtest: pipe-A-eDP-1
[393.314627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[393.325448] Starting dynamic subtest: pipe-B-eDP-1
[393.327622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[393.336665] Starting dynamic subtest: pipe-C-eDP-1
[393.338562] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[393.347256] Starting dynamic subtest: pipe-D-eDP-1
[393.349057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[393.350846] Subtest uint-max-clock: SUCCESS (0.290s)
[394.163275] [057/133] (634s left) kms_psr (fbc-psr-cursor-plane-move)
[394.249544] Starting subtest: fbc-psr-cursor-plane-move
[394.251795] Starting dynamic subtest: eDP-1
[394.256245] Dynamic subtest eDP-1: SKIP (0.000s)
[394.260626] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[394.325688] [058/133] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[394.426195] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[394.434629] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[394.520677] [059/133] (634s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[394.637567] Starting subtest: cursorB-vs-flipB-varying-size
[394.642131] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[394.785101] [060/133] (634s left) gem_exec_reloc (basic-gtt)
[394.849775] Subtest basic-gtt: SKIP (0.000s)
[394.923751] [061/133] (634s left) gem_lmem_swapping (basic)
[394.964302] Subtest basic: SKIP (0.000s)
[395.010557] [062/133] (634s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[395.121615] Starting subtest: basic-flip-before-cursor-varying-size
[396.049372] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[396.882433] [063/133] (632s left) kms_cursor_crc (cursor-onscreen-512x512)
[397.175649] Starting subtest: cursor-onscreen-512x512
[397.179891] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[397.336829] [064/133] (632s left) gem_exec_params (larger-than-life-batch)
[397.393564] Starting subtest: larger-than-life-batch
[399.612281] Subtest larger-than-life-batch: SUCCESS (2.219s)
[400.970499] [065/133] (628s left) gem_close_race (multigpu-basic-process)
[401.076627] Starting subtest: multigpu-basic-process
[401.080922] Subtest multigpu-basic-process: SKIP (0.000s)
[401.295919] [066/133] (628s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[401.427323] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[402.855287] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.425s)
[403.655950] [067/133] (625s left) kms_feature_discovery (display-4x)
[403.744283] Starting subtest: display-4x
[403.749214] Subtest display-4x: SKIP (0.000s)
[403.817912] [068/133] (625s left) prime_mmap (test_refcounting)
[403.868830] Starting subtest: test_refcounting
[403.870629] Starting dynamic subtest: test_refcounting-smem
[403.908239] Dynamic subtest test_refcounting-smem: SUCCESS (0.041s)
[403.910603] Subtest test_refcounting: SUCCESS (0.042s)
[404.005727] [069/133] (625s left) kms_dp_aux_dev (basic)
[404.058995] Starting subtest: basic
[404.279760] Subtest basic: SUCCESS (0.221s)
[404.353481] [070/133] (625s left) syncobj_wait (invalid-reset-one-illegal-handle)
[404.420848] Starting subtest: invalid-reset-one-illegal-handle
[404.423233] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[404.514305] [071/133] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[404.606740] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[404.611115] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[404.700958] [072/133] (625s left) gem_exec_reloc (basic-cpu)
[404.763469] Subtest basic-cpu: SKIP (0.000s)
[404.853462] [073/133] (624s left) gem_exec_balancer (sliced)
[404.906543] Starting subtest: sliced
[404.911078] Subtest sliced: SKIP (0.000s)
[405.207030] [074/133] (624s left) kms_plane_scaling (2x-scaler-multi-pipe)
[405.299766] Starting subtest: 2x-scaler-multi-pipe
[405.304168] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[405.386364] [075/133] (624s left) gem_ctx_persistence (engines-hang)
[405.441247] Starting subtest: engines-hang
[405.443594] Starting dynamic subtest: rcs0
[405.555914] Dynamic subtest rcs0: SUCCESS (0.114s)
[405.570167] Starting dynamic subtest: bcs0
[405.642892] Dynamic subtest bcs0: SUCCESS (0.085s)
[405.655711] Starting dynamic subtest: vcs0
[405.755746] Dynamic subtest vcs0: SUCCESS (0.110s)
[405.772255] Starting dynamic subtest: vcs1
[405.850912] Dynamic subtest vcs1: SUCCESS (0.093s)
[405.864683] Starting dynamic subtest: vecs0
[405.941666] Dynamic subtest vecs0: SUCCESS (0.089s)
[405.954087] Starting dynamic subtest: ccs0
[406.031797] Dynamic subtest ccs0: SUCCESS (0.088s)
[406.034478] Subtest engines-hang: SUCCESS (0.592s)
[406.116769] [076/133] (623s left) core_setmaster (master-drop-set-root)
[406.180918] Starting subtest: master-drop-set-root
[406.205504] Subtest master-drop-set-root: SUCCESS (0.025s)
[406.256477] [077/133] (623s left) gem_exec_flush (basic-uc-pro-default)
[406.319223] Starting subtest: basic-uc-pro-default
[411.783184] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[411.984249] [078/133] (618s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[412.091204] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[412.095675] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[412.197109] [079/133] (617s left) gem_userptr_blits (forbidden-operations)
[412.259821] Starting subtest: forbidden-operations
[412.263984] Subtest forbidden-operations: SKIP (0.000s)
[412.390611] [080/133] (617s left) core_getclient (basic)
[412.444028] Starting subtest: basic
[412.446313] Subtest basic: SUCCESS (0.000s)
[412.561981] [081/133] (617s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[412.653318] Starting subtest: fbc-pr-sprite-mmap-gtt
[412.657592] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[412.725473] [082/133] (617s left) kms_flip (2x-plain-flip-fb-recreate)
[412.824367] Starting subtest: 2x-plain-flip-fb-recreate
[412.832394] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[412.923135] [083/133] (617s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[413.019554] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[413.023128] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[414.183104] [084/133] (616s left) syncobj_timeline (wait-all-delayed-signal)
[414.244086] Starting subtest: wait-all-delayed-signal
[414.348882] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[414.424666] [085/133] (615s left) gem_render_copy (linear-to-vebox-yf-tiled)
[414.475664] Starting subtest: linear-to-vebox-yf-tiled
[414.480595] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[414.656213] [086/133] (615s left) kms_cursor_crc (cursor-tearing-position-change)
[414.779750] Starting subtest: cursor-tearing-position-change
[414.782187] Starting dynamic subtest: pipe-A-eDP-1
[415.350836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[415.360869] Starting dynamic subtest: pipe-D-eDP-1
[416.615494] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[416.617887] Subtest cursor-tearing-position-change: SUCCESS (1.835s)
[417.466616] [087/133] (612s left) syncobj_timeline (wait-for-submit-delayed-submit)
[417.524577] Starting subtest: wait-for-submit-delayed-submit
[417.627665] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[417.703870] [088/133] (612s left) gem_exec_params (invalid-ring)
[417.749495] Starting subtest: invalid-ring
[417.752040] Subtest invalid-ring: SUCCESS (0.000s)
[417.852481] [089/133] (612s left) gem_tiled_blits (interruptible)
[417.903134] Subtest interruptible: SKIP (0.000s)
[417.969608] [090/133] (612s left) gem_eio (banned)
[418.230317] Starting subtest: banned
[418.867949] Subtest banned: SUCCESS (0.635s)
[419.008338] [091/133] (611s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[419.101124] Starting subtest: plane-primary-overlay-mutable-zpos
[422.493225] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.389s)
[423.674845] [092/133] (606s left) kms_psr (fbc-pr-dpms)
[423.766485] Starting subtest: fbc-pr-dpms
[423.770636] Subtest fbc-pr-dpms: SKIP (0.000s)
[423.843358] [093/133] (606s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[423.946720] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[423.951196] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[424.018709] [094/133] (606s left) kms_plane_alpha_blend (alpha-transparent-fb)
[424.111621] Starting subtest: alpha-transparent-fb
[424.397630] Starting dynamic subtest: pipe-A-eDP-1
[425.043519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s)
[425.055095] Starting dynamic subtest: pipe-D-eDP-1
[426.412111] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[426.414393] Subtest alpha-transparent-fb: SUCCESS (2.302s)
[427.225266] [095/133] (603s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[427.323301] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[427.325660] Starting dynamic subtest: pipe-A
[428.393187] Dynamic subtest pipe-A: SUCCESS (1.072s)
[428.407652] Starting dynamic subtest: pipe-B
[430.552588] Dynamic subtest pipe-B: SUCCESS (2.158s)
[430.563032] Starting dynamic subtest: pipe-C
[431.735600] Dynamic subtest pipe-C: SUCCESS (1.182s)
[431.745535] Starting dynamic subtest: pipe-D
[432.875119] Dynamic subtest pipe-D: SUCCESS (1.139s)
[432.877411] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.555s)
[434.073160] [096/133] (596s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[434.176090] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[434.178496] Starting dynamic subtest: pipe-A-eDP-1
[434.428347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.222s)
[434.449732] Starting dynamic subtest: pipe-B-eDP-1
[435.641546] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[435.654877] Starting dynamic subtest: pipe-C-eDP-1
[436.858245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[436.869783] Starting dynamic subtest: pipe-D-eDP-1
[438.082097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[438.084078] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.877s)
[439.204638] [097/133] (591s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[439.311483] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[439.315616] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.410653] [098/133] (591s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[439.509429] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[439.513850] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[439.580076] [099/133] (591s left) kms_flip (blocking-absolute-wf_vblank)
[439.667505] Starting subtest: blocking-absolute-wf_vblank
[439.669783] Starting dynamic subtest: A-eDP1
[448.364449] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[448.377314] Starting dynamic subtest: B-eDP1
[457.100447] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[457.121157] Starting dynamic subtest: C-eDP1
[465.817807] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[465.828100] Starting dynamic subtest: D-eDP1
[474.541279] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[474.547143] Subtest blocking-absolute-wf_vblank: SUCCESS (34.883s)
[475.762985] [100/133] (555s left) tools_test (sysfs_l3_parity)
[475.823114] Starting subtest: sysfs_l3_parity
[475.895469] Subtest sysfs_l3_parity: SKIP (0.082s)
[475.957216] [101/133] (555s left) kms_psr (psr-sprite-plane-onoff)
[476.061190] Starting subtest: psr-sprite-plane-onoff
[476.063484] Starting dynamic subtest: eDP-1
[477.805859] Dynamic subtest eDP-1: SUCCESS (1.746s)
[477.808301] Subtest psr-sprite-plane-onoff: SUCCESS (1.747s)
[478.642569] [102/133] (552s left) api_intel_allocator (default-alignment)
[478.702507] Starting subtest: default-alignment
[478.704909] Subtest default-alignment: SUCCESS (0.003s)
[478.839258] [103/133] (552s left) sriov_basic (bind-unbind-vf)
[478.909568] Starting subtest: bind-unbind-vf
[478.911876] Starting dynamic subtest: vf-1
[478.992413] Dynamic subtest vf-1: FAIL (0.030s)
[479.002794] Starting dynamic subtest: vf-2
[479.073608] Dynamic subtest vf-2: FAIL (0.003s)
[479.089179] Starting dynamic subtest: vf-3
[479.161096] Dynamic subtest vf-3: FAIL (0.003s)
[479.172516] Starting dynamic subtest: vf-4
[479.243415] Dynamic subtest vf-4: FAIL (0.003s)
[479.253889] Starting dynamic subtest: vf-5
[479.324981] Dynamic subtest vf-5: FAIL (0.003s)
[479.337430] Starting dynamic subtest: vf-6
[479.409371] Dynamic subtest vf-6: FAIL (0.004s)
[479.421071] Starting dynamic subtest: vf-7
[479.495451] Dynamic subtest vf-7: FAIL (0.003s)
[479.507300] Starting dynamic subtest: vf-random
[479.577942] Dynamic subtest vf-random: FAIL (0.004s)
[479.588864] Starting dynamic subtest: vf-last
[479.648305] Dynamic subtest vf-last: FAIL (0.516s)
[479.649968] Subtest bind-unbind-vf: FAIL (0.577s)
[479.687394] [104/133] (551s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[479.731864] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[479.832453] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[479.924117] [105/133] (551s left) perf_pmu (rc6)
[479.960927] Starting subtest: rc6
[479.962899] Starting dynamic subtest: gt0
[486.332493] Dynamic subtest gt0: SUCCESS (6.371s)
[486.346063] Starting dynamic subtest: runtime-pm-gt0
[494.059769] Dynamic subtest runtime-pm-gt0: SUCCESS (7.724s)
[494.073211] Starting dynamic subtest: runtime-pm-long-gt0
[506.496486] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.435s)
[506.507503] Starting dynamic subtest: other-idle-gt0
[512.839802] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[512.850908] Starting dynamic subtest: gt1
[519.181446] Dynamic subtest gt1: SUCCESS (6.339s)
[519.194964] Starting dynamic subtest: runtime-pm-gt1
[526.629316] Dynamic subtest runtime-pm-gt1: SUCCESS (7.445s)
[526.640245] Starting dynamic subtest: runtime-pm-long-gt1
[539.135315] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.503s)
[539.148840] Starting dynamic subtest: other-idle-gt1
[545.477923] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[545.480957] Subtest rc6: SUCCESS (65.520s)
[546.620196] [106/133] (484s left) gem_exec_fence (syncobj-timeline-repeat)
[547.214664] Starting subtest: syncobj-timeline-repeat
[547.444326] Subtest syncobj-timeline-repeat: SUCCESS (0.230s)
[548.946376] [107/133] (482s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[549.053062] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[553.875070] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.825s)
[555.032850] [108/133] (476s left) kms_color (legacy-gamma-reset)
[555.130505] Starting subtest: legacy-gamma-reset
[555.132436] Starting dynamic subtest: pipe-A-eDP-1
[555.510368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[555.525817] Starting dynamic subtest: pipe-B-eDP-1
[555.536194] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[555.547213] Starting dynamic subtest: pipe-C-eDP-1
[555.570308] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.031s)
[555.581271] Starting dynamic subtest: pipe-D-eDP-1
[555.604150] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.032s)
[555.606539] Subtest legacy-gamma-reset: SUCCESS (0.474s)
[556.361210] [109/133] (474s left) gem_exec_balancer (indices)
[556.414499] Starting subtest: indices
[558.898604] Subtest indices: SUCCESS (2.483s)
[559.185794] [110/133] (472s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[559.264218] Starting subtest: yf-tiled-to-vebox-yf-tiled
[559.268902] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[559.451471] [111/133] (471s left) gem_barrier_race (remote-request)
[559.517913] Starting subtest: remote-request
[559.520697] Starting dynamic subtest: rcs0
[564.741375] Dynamic subtest rcs0: SUCCESS (5.225s)
[564.743850] Subtest remote-request: SUCCESS (5.227s)
[564.863578] [112/133] (466s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[564.920026] Starting subtest: etime-multi-wait-for-submit-submitted
[565.026059] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[565.085734] [113/133] (466s left) syncobj_timeline (multi-wait-signaled)
[565.146019] Starting subtest: multi-wait-signaled
[565.148354] Subtest multi-wait-signaled: SUCCESS (0.000s)
[565.221460] [114/133] (466s left) kms_chamelium_hpd (vga-hpd-fast)
[565.619172] Subtest vga-hpd-fast: SKIP (0.000s)
[566.396667] [115/133] (465s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[566.497163] Starting subtest: fbc-modesetfrombusy
[570.268966] Subtest fbc-modesetfrombusy: SUCCESS (3.777s)
[571.410344] [116/133] (460s left) kms_psr (psr-cursor-plane-onoff)
[571.503183] Starting subtest: psr-cursor-plane-onoff
[571.505502] Starting dynamic subtest: eDP-1
[573.212838] Dynamic subtest eDP-1: SUCCESS (1.709s)
[573.214873] Subtest psr-cursor-plane-onoff: SUCCESS (1.710s)
[574.062383] [117/133] (457s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[574.160982] Starting subtest: y-tiled-32bpp-rotate-90
[574.165263] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[574.220592] [118/133] (457s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[574.323665] Starting subtest: psr-rgb565-draw-mmap-gtt
[574.327753] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[574.411657] [119/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[574.511892] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[574.515896] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[574.592256] [120/133] (457s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[574.678203] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[574.680427] Starting dynamic subtest: pipe-A-eDP-1
[574.701090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[574.713655] Starting dynamic subtest: pipe-B-eDP-1
[574.732600] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[574.742711] Starting dynamic subtest: pipe-C-eDP-1
[574.761785] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[574.774026] Starting dynamic subtest: pipe-D-eDP-1
[574.793073] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[574.795099] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[576.940577] [121/133] (454s left) kms_plane_multiple (2x-tiling-none)
[577.024830] Starting subtest: 2x-tiling-none
[577.028760] Subtest 2x-tiling-none: SKIP (0.000s)
[577.074698] [122/133] (454s left) syncobj_wait (wait-any-interrupted)
[577.138505] Starting subtest: wait-any-interrupted
[577.243662] Subtest wait-any-interrupted: SUCCESS (0.102s)
[577.304156] [123/133] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[577.402562] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[577.406687] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[577.490574] [124/133] (454s left) i915_hangman (engine-error-state-capture)
[577.562430] Starting subtest: engine-error-state-capture
[577.564249] Starting dynamic subtest: rcs0
[580.852787] Dynamic subtest rcs0: SUCCESS (3.290s)
[580.864531] Starting dynamic subtest: bcs0
[586.867315] Dynamic subtest bcs0: SUCCESS (6.012s)
[586.881213] Starting dynamic subtest: vcs0
[592.821393] Dynamic subtest vcs0: SUCCESS (5.951s)
[592.844628] Starting dynamic subtest: vcs1
[598.836416] Dynamic subtest vcs1: SUCCESS (6.012s)
[598.850677] Starting dynamic subtest: vecs0
[603.828565] Dynamic subtest vecs0: SUCCESS (4.990s)
[603.842867] Starting dynamic subtest: ccs0
[608.885205] Dynamic subtest ccs0: SUCCESS (5.053s)
[608.888087] Subtest engine-error-state-capture: SUCCESS (31.325s)
[609.006055] [125/133] (423s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[609.108935] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[609.113080] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[609.171347] [126/133] (422s left) i915_drm_fdinfo (virtual-busy)
[609.217116] Starting subtest: virtual-busy
[609.221870] Subtest virtual-busy: SKIP (0.000s)
[609.263647] [127/133] (422s left) gem_ctx_param (invalid-param-set)
[609.313827] Starting subtest: invalid-param-set
[609.316097] Subtest invalid-param-set: SUCCESS (0.000s)
[609.368467] [128/133] (422s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[609.485457] Starting subtest: short-flip-after-cursor-atomic-transitions
[610.447874] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[611.278432] [129/133] (420s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[611.337216] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[611.442034] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[611.495624] [130/133] (420s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[611.598837] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[611.601114] Starting dynamic subtest: pipe-A-eDP-1
[611.682365] Dynamic subtest pipe-A-eDP-1: SKIP (0.087s)
[611.693545] Starting dynamic subtest: pipe-B-eDP-1
[612.860808] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[612.865440] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.266s)
[614.036968] [131/133] (418s left) i915_query (query-regions-sanity-check)
[614.087926] Starting subtest: query-regions-sanity-check
[614.096095] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[614.196733] [132/133] (418s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[614.287593] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[620.739166] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.455s)
[620.879457] [133/133] (411s left) gem_mmap_gtt (ptrace)
[620.950783] Subtest ptrace: SKIP (0.000s)
[621.020893] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_async
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_chamelium_frames
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_busy
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_legacy_colorkey
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_partial_pwrite_pread
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_exec_store
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_feature_discovery
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_dp_aux_dev
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: core_setmaster
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: core_getclient
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_tiled_blits
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: tools_test
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: api_intel_allocator
results: parsing output: 102/ for test: sriov_basic
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: gem_barrier_race
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: i915_query
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
Done.