[58.540915] Initializing watchdogs
[58.540965]   /dev/watchdog0
[58.555497] [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.560179] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.562383] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.565809] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[58.693406] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[62.406040] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.706s)
[63.582680] [002/133] (955s left) gem_exec_async (concurrent-writes)
[63.645876] Starting subtest: concurrent-writes
[63.648175] Starting dynamic subtest: rcs0
[63.660279] Dynamic subtest rcs0: SUCCESS (0.015s)
[63.669385] Starting dynamic subtest: bcs0
[63.671524] Dynamic subtest bcs0: SUCCESS (0.006s)
[63.679472] Starting dynamic subtest: vcs0
[63.681377] Dynamic subtest vcs0: SUCCESS (0.005s)
[63.688774] Starting dynamic subtest: vcs1
[63.691140] Dynamic subtest vcs1: SUCCESS (0.006s)
[63.698295] Starting dynamic subtest: vecs0
[63.700464] Dynamic subtest vecs0: SUCCESS (0.006s)
[63.707711] Starting dynamic subtest: ccs0
[63.710054] Dynamic subtest ccs0: SUCCESS (0.004s)
[63.712320] Subtest concurrent-writes: SUCCESS (0.045s)
[63.920221] [003/133] (955s left) kms_psr (pr-primary-blt)
[64.012793] Starting subtest: pr-primary-blt
[64.016903] Subtest pr-primary-blt: SKIP (0.000s)
[64.092707] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[64.477632] Subtest dp-crc-fast: SKIP (0.000s)
[65.288953] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[65.469770] Starting subtest: pi-shared-iova
[65.471825] Starting dynamic subtest: rcs0
[65.549507] Dynamic subtest rcs0: SUCCESS (0.083s)
[65.560852] Starting dynamic subtest: vcs0
[65.606862] Dynamic subtest vcs0: SUCCESS (0.057s)
[65.616174] Starting dynamic subtest: vcs1
[65.661309] Dynamic subtest vcs1: SUCCESS (0.054s)
[65.670038] Starting dynamic subtest: vecs0
[65.710812] Dynamic subtest vecs0: SUCCESS (0.049s)
[65.719332] Starting dynamic subtest: ccs0
[65.777588] Dynamic subtest ccs0: SUCCESS (0.066s)
[65.780251] Subtest pi-shared-iova: SUCCESS (0.310s)
[67.194736] [006/133] (952s left) kms_busy (basic-hang)
[67.384390] Starting subtest: basic-hang
[67.386455] Starting dynamic subtest: flip-pipe-A
[68.057510] Dynamic subtest flip-pipe-A: SUCCESS (0.671s)
[68.067452] Starting dynamic subtest: modeset-pipe-A
[71.453095] Dynamic subtest modeset-pipe-A: SUCCESS (3.393s)
[71.463048] Starting dynamic subtest: flip-pipe-D
[72.656271] Dynamic subtest flip-pipe-D: SUCCESS (1.200s)
[72.664245] Starting dynamic subtest: modeset-pipe-D
[76.092831] Dynamic subtest modeset-pipe-D: SUCCESS (3.432s)
[76.095267] Subtest basic-hang: SUCCESS (8.701s)
[76.888347] [007/133] (942s left) kms_flip (basic-flip-vs-dpms)
[76.987417] Starting subtest: basic-flip-vs-dpms
[76.989861] Starting dynamic subtest: A-eDP1
[79.596234] Dynamic subtest A-eDP1: SUCCESS (2.607s)
[79.607412] Starting dynamic subtest: B-eDP1
[81.838485] Dynamic subtest B-eDP1: SUCCESS (2.237s)
[81.850514] Starting dynamic subtest: C-eDP1
[83.920846] Dynamic subtest C-eDP1: SUCCESS (2.080s)
[83.928610] Starting dynamic subtest: D-eDP1
[85.997727] Dynamic subtest D-eDP1: SUCCESS (2.075s)
[86.000079] Subtest basic-flip-vs-dpms: SUCCESS (9.006s)
[86.789616] [008/133] (932s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[86.883472] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[86.885853] Starting dynamic subtest: pipe-A-default-mode
[89.633300] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[89.635452] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.749s)
[90.516069] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[90.575968] Subtest non-threaded: SKIP (0.000s)
[90.627867] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[90.726053] Starting subtest: invalid-plane
[90.728365] Starting dynamic subtest: zero-id
[90.730552] Dynamic subtest zero-id: SUCCESS (0.000s)
[90.738617] Starting dynamic subtest: outrange-id
[90.740492] Dynamic subtest outrange-id: SUCCESS (0.000s)
[90.742386] Subtest invalid-plane: SUCCESS (0.001s)
[90.798415] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[90.848684] Subtest write-wc-read-gtt: SKIP (0.000s)
[90.909076] [012/133] (928s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[90.963247] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[91.044995] [013/133] (928s left) kms_big_fb (linear-32bpp-rotate-0)
[91.182476] Starting subtest: linear-32bpp-rotate-0
[92.714352] Subtest linear-32bpp-rotate-0: SUCCESS (1.531s)
[92.852694] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[92.915544] Subtest bb-start-far: SKIP (0.000s)
[92.978427] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[93.097688] Starting subtest: cursorB-vs-flipA-varying-size
[93.101277] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[93.239325] [016/133] (926s left) gem_lmem_swapping (verify)
[93.277322] Subtest verify: SKIP (0.000s)
[93.321245] [017/133] (926s left) gem_userptr_blits (mmap-offset-banned)
[93.388522] Starting subtest: mmap-offset-banned
[93.390541] Starting dynamic subtest: wb
[93.392590] Dynamic subtest wb: SUCCESS (0.000s)
[93.402217] Starting dynamic subtest: wc
[93.403779] Dynamic subtest wc: SUCCESS (0.000s)
[93.410738] Starting dynamic subtest: uc
[93.412337] Dynamic subtest uc: SUCCESS (0.000s)
[93.413936] Subtest mmap-offset-banned: SUCCESS (0.001s)
[93.510919] [018/133] (926s left) gem_softpin (evict-snoop-interruptible)
[93.567113] Starting subtest: evict-snoop-interruptible
[93.570897] Subtest evict-snoop-interruptible: SKIP (0.000s)
[93.670067] [019/133] (926s left) gem_ctx_persistence (legacy-engines-mixed-process)
[93.738279] Starting subtest: legacy-engines-mixed-process
[93.740288] Starting dynamic subtest: render
[94.852047] Dynamic subtest render: SUCCESS (1.111s)
[94.859700] Starting dynamic subtest: bsd1
[96.900453] Dynamic subtest bsd1: SUCCESS (2.047s)
[96.908915] Starting dynamic subtest: bsd2
[98.914921] Dynamic subtest bsd2: SUCCESS (2.013s)
[98.924448] Starting dynamic subtest: blt
[100.867326] Dynamic subtest blt: SUCCESS (1.949s)
[100.879260] Starting dynamic subtest: vebox
[102.886757] Dynamic subtest vebox: SUCCESS (2.020s)
[102.889183] Subtest legacy-engines-mixed-process: SUCCESS (9.145s)
[102.977333] [020/133] (916s left) gem_eio (hibernate)
[103.210094] Starting subtest: hibernate
[117.900124] Subtest hibernate: SUCCESS (14.685s)
[124.021732] [021/133] (901s left) i915_pm_rps (fence-order)
[124.113337] Starting subtest: fence-order
[127.509031] Subtest fence-order: SUCCESS (3.393s)
[127.626432] [022/133] (898s left) kms_vblank (ts-continuation-idle-hang)
[127.726653] Starting subtest: ts-continuation-idle-hang
[127.728905] Starting dynamic subtest: pipe-A-eDP-1
[154.711082] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.978s)
[154.731492] Starting dynamic subtest: pipe-D-eDP-1
[179.679581] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[179.681579] Subtest ts-continuation-idle-hang: SUCCESS (51.943s)
[180.482126] [023/133] (845s left) perf (unprivileged-single-ctx-counters)
[180.616171] Starting subtest: unprivileged-single-ctx-counters
[180.619834] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[180.664416] [024/133] (845s left) kms_frontbuffer_tracking (fbc-tiling-4)
[180.759681] Starting subtest: fbc-tiling-4
[185.023050] Subtest fbc-tiling-4: SUCCESS (4.267s)
[186.205421] [025/133] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[186.311098] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[193.013742] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.705s)
[193.141981] [026/133] (832s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[193.229603] Starting subtest: crc-primary-suspend-y-tiled-ccs
[193.231838] Starting dynamic subtest: pipe-A-eDP-1
[193.240737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.253887] Starting dynamic subtest: pipe-B-eDP-1
[193.263288] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.273788] Starting dynamic subtest: pipe-C-eDP-1
[193.282221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.291055] Starting dynamic subtest: pipe-D-eDP-1
[193.299405] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.303421] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[195.480101] [027/133] (830s left) gem_spin_batch (engines)
[195.543614] Starting subtest: engines
[195.545909] Starting dynamic subtest: rcs0
[198.784724] Dynamic subtest rcs0: SUCCESS (3.235s)
[198.796594] Starting dynamic subtest: bcs0
[202.020577] Dynamic subtest bcs0: SUCCESS (3.234s)
[202.032167] Starting dynamic subtest: vcs0
[205.257456] Dynamic subtest vcs0: SUCCESS (3.235s)
[205.269471] Starting dynamic subtest: vcs1
[208.493988] Dynamic subtest vcs1: SUCCESS (3.234s)
[208.505768] Starting dynamic subtest: vecs0
[211.733372] Dynamic subtest vecs0: SUCCESS (3.237s)
[211.744873] Starting dynamic subtest: ccs0
[214.973338] Dynamic subtest ccs0: SUCCESS (3.237s)
[214.975825] Subtest engines: SUCCESS (19.424s)
[215.203381] [028/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[215.311524] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[222.449459] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.140s)
[222.563878] [029/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[222.662402] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[222.666696] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[222.784522] [030/133] (803s left) gem_partial_pwrite_pread (reads-snoop)
[222.841646] Subtest reads-snoop: SKIP (0.000s)
[222.910549] [031/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[223.008475] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[224.087395] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.079s)
[224.210347] [032/133] (802s left) kms_getfb (getfb-reject-nv12)
[224.324657] Starting subtest: getfb-reject-nv12
[224.326687] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[224.435996] [033/133] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[224.542349] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[228.764029] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.224s)
[229.925038] [034/133] (796s left) perf_pmu (render-node-busy-idle)
[230.000824] Starting subtest: render-node-busy-idle
[230.003356] Starting dynamic subtest: rcs0
[230.687934] Dynamic subtest rcs0: SUCCESS (0.686s)
[230.700255] Starting dynamic subtest: bcs0
[231.348367] Dynamic subtest bcs0: SUCCESS (0.658s)
[231.363309] Starting dynamic subtest: vcs0
[232.917806] Dynamic subtest vcs0: SUCCESS (1.566s)
[232.930296] Starting dynamic subtest: vcs1
[234.901643] Dynamic subtest vcs1: SUCCESS (1.981s)
[234.914119] Starting dynamic subtest: vecs0
[236.886372] Dynamic subtest vecs0: SUCCESS (1.982s)
[236.898163] Starting dynamic subtest: ccs0
[237.555766] Dynamic subtest ccs0: SUCCESS (0.668s)
[237.558511] Subtest render-node-busy-idle: SUCCESS (7.554s)
[237.631050] [035/133] (788s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[237.731102] Starting subtest: yf-tiled-16bpp-rotate-90
[237.735564] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[237.831175] [036/133] (788s left) kms_content_protection (atomic)
[237.971053] Starting subtest: atomic
[237.975301] Subtest atomic: SKIP (0.000s)
[238.088219] [037/133] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[238.190131] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[238.194154] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[238.282164] [038/133] (788s left) kms_pm_rpm (fences-dpms)
[240.016795] Starting subtest: fences-dpms
[240.021677] Subtest fences-dpms: SKIP (0.000s)
[240.539165] [039/133] (786s left) gem_mmap_gtt (basic-write-read)
[240.605554] Subtest basic-write-read: SKIP (0.000s)
[240.671055] [040/133] (786s left) gem_exec_reloc (basic-write-cpu-active)
[240.735736] Subtest basic-write-cpu-active: SKIP (0.000s)
[240.806541] [041/133] (785s left) gem_eio (unwedge-stress)
[240.995371] Starting subtest: unwedge-stress
[240.997715] Starting dynamic subtest: render
[245.390034] Dynamic subtest render: SUCCESS (4.390s)
[245.407691] Starting dynamic subtest: bsd1
[263.356385] Dynamic subtest bsd1: SUCCESS (17.964s)
[263.372323] Starting dynamic subtest: bsd2
[281.331829] Dynamic subtest bsd2: SUCCESS (17.972s)
[281.352905] Starting dynamic subtest: blt
[281.357787] Dynamic subtest blt: SKIP (0.000s)
[281.376473] Starting dynamic subtest: vebox
[299.338624] Dynamic subtest vebox: SUCCESS (18.003s)
[299.340926] Subtest unwedge-stress: SUCCESS (58.333s)
[300.933476] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[300.937161] [042/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[301.039336] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[301.043885] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[301.129502] [043/133] (725s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[301.226762] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[301.229033] Starting dynamic subtest: pipe-A-default-mode
[303.973699] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[303.975964] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.746s)
[304.842221] [044/133] (722s left) gem_exec_store (pages)
[304.913880] Starting subtest: pages
[304.915907] Starting dynamic subtest: rcs0
[305.015859] Dynamic subtest rcs0: SUCCESS (0.103s)
[305.027800] Starting dynamic subtest: bcs0
[305.088257] Dynamic subtest bcs0: SUCCESS (0.071s)
[305.099864] Starting dynamic subtest: vcs0
[305.165485] Dynamic subtest vcs0: SUCCESS (0.077s)
[305.176794] Starting dynamic subtest: vcs1
[305.242978] Dynamic subtest vcs1: SUCCESS (0.076s)
[305.257507] Starting dynamic subtest: vecs0
[305.323545] Dynamic subtest vecs0: SUCCESS (0.079s)
[305.335161] Starting dynamic subtest: ccs0
[305.399247] Dynamic subtest ccs0: SUCCESS (0.075s)
[305.401411] Subtest pages: SUCCESS (0.488s)
[305.602875] [045/133] (721s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[305.707018] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[305.711320] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[305.782032] [046/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[305.886247] Starting subtest: psr-1p-primscrn-cur-indfb-move
[313.275103] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.390s)
[313.423678] [047/133] (713s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[313.536793] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[313.539027] Starting dynamic subtest: pipe-A-eDP-1
[313.560816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.573127] Starting dynamic subtest: pipe-B-eDP-1
[313.593762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.603201] Starting dynamic subtest: pipe-C-eDP-1
[313.623746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.633287] Starting dynamic subtest: pipe-D-eDP-1
[313.654155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.658059] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[315.810753] [048/133] (711s left) kms_pm_rpm (basic-rte)
[315.857993] Starting subtest: basic-rte
[319.513397] Subtest basic-rte: SUCCESS (3.657s)
[321.011208] [049/133] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[321.107064] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[321.111281] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[321.213421] [050/133] (705s left) gem_exec_schedule (submit-golden-slice)
[321.288931] Starting subtest: submit-golden-slice
[321.291227] Starting dynamic subtest: rcs0
[321.319867] Dynamic subtest rcs0: SUCCESS (0.038s)
[321.331947] Starting dynamic subtest: bcs0
[321.358823] Dynamic subtest bcs0: SUCCESS (0.038s)
[321.369094] Starting dynamic subtest: vcs0
[321.396064] Dynamic subtest vcs0: SUCCESS (0.036s)
[321.405634] Starting dynamic subtest: vcs1
[321.429743] Dynamic subtest vcs1: SUCCESS (0.032s)
[321.441857] Starting dynamic subtest: vecs0
[321.470107] Dynamic subtest vecs0: SUCCESS (0.040s)
[321.481139] Starting dynamic subtest: ccs0
[321.511167] Dynamic subtest ccs0: SUCCESS (0.040s)
[321.513401] Subtest submit-golden-slice: SUCCESS (0.230s)
[322.982549] [051/133] (704s left) kms_async_flips (async-flip-hang)
[323.079051] Starting subtest: async-flip-hang
[323.451811] Starting dynamic subtest: pipe-A-eDP-1
[338.417907] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.962s)
[338.791052] Starting dynamic subtest: pipe-B-eDP-1
[354.419024] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.631s)
[354.803961] Starting dynamic subtest: pipe-C-eDP-1
[370.415031] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.614s)
[370.793613] Starting dynamic subtest: pipe-D-eDP-1
[386.416891] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.625s)
[386.419399] Subtest async-flip-hang: SUCCESS (63.329s)
[387.576749] [052/133] (639s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[387.790453] Starting subtest: cursor-rapid-movement-128x128
[387.795290] Starting dynamic subtest: pipe-A-eDP-1
[388.349359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[388.377742] Starting dynamic subtest: pipe-D-eDP-1
[389.588701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[389.591315] Subtest cursor-rapid-movement-128x128: SUCCESS (1.798s)
[390.451529] [053/133] (636s left) syncobj_timeline (invalid-query-bad-pad)
[390.503780] Starting subtest: invalid-query-bad-pad
[390.505959] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[390.591437] [054/133] (636s left) kms_tiled_display (basic-test-pattern)
[390.692662] Subtest basic-test-pattern: SKIP (0.000s)
[390.738878] [055/133] (636s left) perf (gen12-invalid-class-instance)
[390.831628] Starting subtest: gen12-invalid-class-instance
[390.847588] Subtest gen12-invalid-class-instance: SUCCESS (0.015s)
[390.896513] [056/133] (636s left) kms_invalid_mode (uint-max-clock)
[390.987074] Starting subtest: uint-max-clock
[390.989249] Starting dynamic subtest: pipe-A-eDP-1
[391.277406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[391.288090] Starting dynamic subtest: pipe-B-eDP-1
[391.290355] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[391.299464] Starting dynamic subtest: pipe-C-eDP-1
[391.301755] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[391.311402] Starting dynamic subtest: pipe-D-eDP-1
[391.313743] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[391.315862] Subtest uint-max-clock: SUCCESS (0.296s)
[392.083384] [057/133] (635s left) kms_psr (fbc-psr-cursor-plane-move)
[392.179843] Starting subtest: fbc-psr-cursor-plane-move
[392.182116] Starting dynamic subtest: eDP-1
[392.186232] Dynamic subtest eDP-1: SKIP (0.000s)
[392.190228] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[392.255468] [058/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[392.358436] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[392.362775] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[392.465799] [059/133] (635s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[392.601503] Starting subtest: cursorB-vs-flipB-varying-size
[392.605994] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[392.779784] [060/133] (634s left) gem_exec_reloc (basic-gtt)
[392.840900] Subtest basic-gtt: SKIP (0.000s)
[392.920400] [061/133] (634s left) gem_lmem_swapping (basic)
[392.965197] Subtest basic: SKIP (0.000s)
[393.025651] [062/133] (634s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[393.144977] Starting subtest: basic-flip-before-cursor-varying-size
[394.071429] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[394.910176] [063/133] (632s left) kms_cursor_crc (cursor-onscreen-512x512)
[395.202899] Starting subtest: cursor-onscreen-512x512
[395.207261] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[395.390844] [064/133] (632s left) gem_exec_params (larger-than-life-batch)
[395.447439] Starting subtest: larger-than-life-batch
[397.827612] Subtest larger-than-life-batch: SUCCESS (2.378s)
[397.974235] [065/133] (629s left) gem_close_race (multigpu-basic-process)
[398.099403] Starting subtest: multigpu-basic-process
[398.103754] Subtest multigpu-basic-process: SKIP (0.000s)
[398.319589] [066/133] (629s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[398.486729] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[399.990833] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.503s)
[400.796437] [067/133] (627s left) kms_feature_discovery (display-4x)
[400.890636] Starting subtest: display-4x
[400.894825] Subtest display-4x: SKIP (0.000s)
[400.980614] [068/133] (626s left) prime_mmap (test_refcounting)
[401.035805] Starting subtest: test_refcounting
[401.037669] Starting dynamic subtest: test_refcounting-smem
[401.068074] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[401.070570] Subtest test_refcounting: SUCCESS (0.035s)
[401.171340] [069/133] (626s left) kms_dp_aux_dev (basic)
[401.229166] Starting subtest: basic
[401.450753] Subtest basic: SUCCESS (0.221s)
[401.526440] [070/133] (626s left) syncobj_wait (invalid-reset-one-illegal-handle)
[401.585554] Starting subtest: invalid-reset-one-illegal-handle
[401.587904] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[401.698394] [071/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[401.794073] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[401.798231] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[401.887452] [072/133] (626s left) gem_exec_reloc (basic-cpu)
[401.960521] Subtest basic-cpu: SKIP (0.000s)
[402.027763] [073/133] (626s left) gem_exec_balancer (sliced)
[402.090059] Starting subtest: sliced
[402.094781] Subtest sliced: SKIP (0.000s)
[402.394474] [074/133] (625s left) kms_plane_scaling (2x-scaler-multi-pipe)
[402.485504] Starting subtest: 2x-scaler-multi-pipe
[402.490087] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[402.588899] [075/133] (625s left) gem_ctx_persistence (engines-hang)
[402.647224] Starting subtest: engines-hang
[402.649445] Starting dynamic subtest: rcs0
[402.755265] Dynamic subtest rcs0: SUCCESS (0.111s)
[402.767298] Starting dynamic subtest: bcs0
[402.846939] Dynamic subtest bcs0: SUCCESS (0.089s)
[402.860232] Starting dynamic subtest: vcs0
[402.936761] Dynamic subtest vcs0: SUCCESS (0.088s)
[402.950328] Starting dynamic subtest: vcs1
[403.030757] Dynamic subtest vcs1: SUCCESS (0.092s)
[403.043575] Starting dynamic subtest: vecs0
[403.120843] Dynamic subtest vecs0: SUCCESS (0.088s)
[403.133764] Starting dynamic subtest: ccs0
[403.212866] Dynamic subtest ccs0: SUCCESS (0.090s)
[403.215502] Subtest engines-hang: SUCCESS (0.570s)
[403.294363] [076/133] (624s left) core_setmaster (master-drop-set-root)
[403.365855] Starting subtest: master-drop-set-root
[403.386421] Subtest master-drop-set-root: SUCCESS (0.023s)
[403.437022] [077/133] (624s left) gem_exec_flush (basic-uc-pro-default)
[403.499151] Starting subtest: basic-uc-pro-default
[408.965372] Subtest basic-uc-pro-default: SUCCESS (5.466s)
[409.159132] [078/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[409.265781] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[409.270258] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[409.370136] [079/133] (619s left) gem_userptr_blits (forbidden-operations)
[409.425669] Starting subtest: forbidden-operations
[409.430268] Subtest forbidden-operations: SKIP (0.002s)
[409.549139] [080/133] (618s left) core_getclient (basic)
[409.597905] Starting subtest: basic
[409.600297] Subtest basic: SUCCESS (0.000s)
[409.701189] [081/133] (618s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[409.802242] Starting subtest: fbc-pr-sprite-mmap-gtt
[409.806290] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[409.877071] [082/133] (618s left) kms_flip (2x-plain-flip-fb-recreate)
[409.970275] Starting subtest: 2x-plain-flip-fb-recreate
[409.979912] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[410.061854] [083/133] (618s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[410.151149] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[410.156523] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[411.322061] [084/133] (617s left) syncobj_timeline (wait-all-delayed-signal)
[411.383581] Starting subtest: wait-all-delayed-signal
[411.487604] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[411.565470] [085/133] (617s left) gem_render_copy (linear-to-vebox-yf-tiled)
[411.634318] Starting subtest: linear-to-vebox-yf-tiled
[411.638641] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[411.831932] [086/133] (616s left) kms_cursor_crc (cursor-tearing-position-change)
[411.945302] Starting subtest: cursor-tearing-position-change
[411.947641] Starting dynamic subtest: pipe-A-eDP-1
[412.533441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[412.543890] Starting dynamic subtest: pipe-D-eDP-1
[413.757149] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[413.758999] Subtest cursor-tearing-position-change: SUCCESS (1.810s)
[414.604266] [087/133] (614s left) syncobj_timeline (wait-for-submit-delayed-submit)
[414.667197] Starting subtest: wait-for-submit-delayed-submit
[414.768768] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[414.861370] [088/133] (613s left) gem_exec_params (invalid-ring)
[414.925162] Starting subtest: invalid-ring
[414.927066] Subtest invalid-ring: SUCCESS (0.000s)
[415.027630] [089/133] (613s left) gem_tiled_blits (interruptible)
[415.083272] Subtest interruptible: SKIP (0.000s)
[415.157658] [090/133] (613s left) gem_eio (banned)
[415.399942] Starting subtest: banned
[416.024168] Subtest banned: SUCCESS (0.625s)
[416.206578] [091/133] (612s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[416.300471] Starting subtest: plane-primary-overlay-mutable-zpos
[419.726067] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.424s)
[420.931826] [092/133] (608s left) kms_psr (fbc-pr-dpms)
[421.018791] Starting subtest: fbc-pr-dpms
[421.023147] Subtest fbc-pr-dpms: SKIP (0.000s)
[421.094459] [093/133] (607s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[421.205384] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[421.209646] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[421.280506] [094/133] (607s left) kms_plane_alpha_blend (alpha-transparent-fb)
[421.382033] Starting subtest: alpha-transparent-fb
[421.666555] Starting dynamic subtest: pipe-A-eDP-1
[422.302907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[422.313846] Starting dynamic subtest: pipe-D-eDP-1
[423.657787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[423.660053] Subtest alpha-transparent-fb: SUCCESS (2.276s)
[424.467167] [095/133] (604s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[424.567598] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[424.569755] Starting dynamic subtest: pipe-A
[425.614720] Dynamic subtest pipe-A: SUCCESS (1.050s)
[425.625029] Starting dynamic subtest: pipe-B
[427.769794] Dynamic subtest pipe-B: SUCCESS (2.154s)
[427.780343] Starting dynamic subtest: pipe-C
[428.968875] Dynamic subtest pipe-C: SUCCESS (1.197s)
[428.984923] Starting dynamic subtest: pipe-D
[430.196243] Dynamic subtest pipe-D: SUCCESS (1.226s)
[430.198512] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.632s)
[431.400876] [096/133] (597s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[431.509885] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[431.512208] Starting dynamic subtest: pipe-A-eDP-1
[431.774157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.232s)
[431.787116] Starting dynamic subtest: pipe-B-eDP-1
[433.110664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.336s)
[433.123485] Starting dynamic subtest: pipe-C-eDP-1
[434.393213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[434.404934] Starting dynamic subtest: pipe-D-eDP-1
[435.644190] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[435.646484] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.106s)
[436.859558] [097/133] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[436.958135] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[436.962419] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[437.045736] [098/133] (592s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[437.147754] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[437.152171] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[437.220530] [099/133] (592s left) kms_flip (blocking-absolute-wf_vblank)
[437.304760] Starting subtest: blocking-absolute-wf_vblank
[437.306953] Starting dynamic subtest: A-eDP1
[446.008577] Dynamic subtest A-eDP1: SUCCESS (8.704s)
[446.029745] Starting dynamic subtest: B-eDP1
[454.747696] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[454.767524] Starting dynamic subtest: C-eDP1
[463.469369] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[463.490786] Starting dynamic subtest: D-eDP1
[472.199322] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[472.204880] Subtest blocking-absolute-wf_vblank: SUCCESS (34.904s)
[473.431986] [100/133] (555s left) tools_test (sysfs_l3_parity)
[473.491994] Starting subtest: sysfs_l3_parity
[473.544334] Subtest sysfs_l3_parity: SKIP (0.068s)
[473.605475] [101/133] (555s left) kms_psr (psr-sprite-plane-onoff)
[473.692795] Starting subtest: psr-sprite-plane-onoff
[473.695026] Starting dynamic subtest: eDP-1
[475.478188] Dynamic subtest eDP-1: SUCCESS (1.784s)
[475.480579] Subtest psr-sprite-plane-onoff: SUCCESS (1.787s)
[476.292301] [102/133] (553s left) api_intel_allocator (default-alignment)
[476.348080] Starting subtest: default-alignment
[476.350428] Subtest default-alignment: SUCCESS (0.003s)
[476.466878] [103/133] (552s left) sriov_basic (bind-unbind-vf)
[476.528784] Starting subtest: bind-unbind-vf
[476.530844] Starting dynamic subtest: vf-1
[476.608895] Dynamic subtest vf-1: FAIL (0.030s)
[476.619039] Starting dynamic subtest: vf-2
[476.691225] Dynamic subtest vf-2: FAIL (0.004s)
[476.703101] Starting dynamic subtest: vf-3
[476.774948] Dynamic subtest vf-3: FAIL (0.003s)
[476.786518] Starting dynamic subtest: vf-4
[476.857865] Dynamic subtest vf-4: FAIL (0.004s)
[476.869612] Starting dynamic subtest: vf-5
[476.941802] Dynamic subtest vf-5: FAIL (0.004s)
[476.953665] Starting dynamic subtest: vf-6
[477.025644] Dynamic subtest vf-6: FAIL (0.004s)
[477.037232] Starting dynamic subtest: vf-7
[477.111179] Dynamic subtest vf-7: FAIL (0.004s)
[477.128054] Starting dynamic subtest: vf-random
[477.199644] Dynamic subtest vf-random: FAIL (0.004s)
[477.210980] Starting dynamic subtest: vf-last
[477.267937] Dynamic subtest vf-last: FAIL (0.516s)
[477.269546] Subtest bind-unbind-vf: FAIL (0.578s)
[477.307943] [104/133] (552s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[477.362193] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[477.466145] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[477.542942] [105/133] (552s left) perf_pmu (rc6)
[477.581542] Starting subtest: rc6
[477.583744] Starting dynamic subtest: gt0
[483.954763] Dynamic subtest gt0: SUCCESS (6.372s)
[483.967551] Starting dynamic subtest: runtime-pm-gt0
[491.724243] Dynamic subtest runtime-pm-gt0: SUCCESS (7.769s)
[491.737733] Starting dynamic subtest: runtime-pm-long-gt0
[504.231369] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.504s)
[504.245088] Starting dynamic subtest: other-idle-gt0
[510.576397] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[510.589619] Starting dynamic subtest: gt1
[516.919407] Dynamic subtest gt1: SUCCESS (6.340s)
[516.932622] Starting dynamic subtest: runtime-pm-gt1
[524.366851] Dynamic subtest runtime-pm-gt1: SUCCESS (7.445s)
[524.380296] Starting dynamic subtest: runtime-pm-long-gt1
[536.874390] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.503s)
[536.888059] Starting dynamic subtest: other-idle-gt1
[543.216837] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[543.219573] Subtest rc6: SUCCESS (65.637s)
[544.355491] [106/133] (485s left) gem_exec_fence (syncobj-timeline-repeat)
[544.968676] Starting subtest: syncobj-timeline-repeat
[545.215474] Subtest syncobj-timeline-repeat: SUCCESS (0.247s)
[545.942659] [107/133] (483s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[546.050603] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[550.981945] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.934s)
[552.145588] [108/133] (477s left) kms_color (legacy-gamma-reset)
[552.252833] Starting subtest: legacy-gamma-reset
[552.255017] Starting dynamic subtest: pipe-A-eDP-1
[552.637725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[552.648190] Starting dynamic subtest: pipe-B-eDP-1
[552.652809] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[552.663065] Starting dynamic subtest: pipe-C-eDP-1
[552.665211] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[552.675488] Starting dynamic subtest: pipe-D-eDP-1
[552.677604] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[552.679834] Subtest legacy-gamma-reset: SUCCESS (0.426s)
[553.483906] [109/133] (476s left) gem_exec_balancer (indices)
[553.542609] Starting subtest: indices
[555.891583] Subtest indices: SUCCESS (2.349s)
[556.169471] [110/133] (473s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[556.235719] Starting subtest: yf-tiled-to-vebox-yf-tiled
[556.240202] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[556.401258] [111/133] (473s left) gem_barrier_race (remote-request)
[556.475702] Starting subtest: remote-request
[556.478052] Starting dynamic subtest: rcs0
[561.629948] Dynamic subtest rcs0: SUCCESS (5.154s)
[561.631952] Subtest remote-request: SUCCESS (5.155s)
[561.737902] [112/133] (468s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[561.783405] Starting subtest: etime-multi-wait-for-submit-submitted
[561.890091] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[561.948447] [113/133] (467s left) syncobj_timeline (multi-wait-signaled)
[561.998218] Starting subtest: multi-wait-signaled
[562.000491] Subtest multi-wait-signaled: SUCCESS (0.000s)
[562.071287] [114/133] (467s left) kms_chamelium_hpd (vga-hpd-fast)
[562.447067] Subtest vga-hpd-fast: SKIP (0.000s)
[563.303763] [115/133] (466s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[563.403674] Starting subtest: fbc-modesetfrombusy
[567.183430] Subtest fbc-modesetfrombusy: SUCCESS (3.783s)
[568.338650] [116/133] (461s left) kms_psr (psr-cursor-plane-onoff)
[568.427498] Starting subtest: psr-cursor-plane-onoff
[568.429885] Starting dynamic subtest: eDP-1
[570.143624] Dynamic subtest eDP-1: SUCCESS (1.716s)
[570.145927] Subtest psr-cursor-plane-onoff: SUCCESS (1.717s)
[571.026448] [117/133] (459s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[571.120959] Starting subtest: y-tiled-32bpp-rotate-90
[571.125318] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[571.200112] [118/133] (458s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[571.292681] Starting subtest: psr-rgb565-draw-mmap-gtt
[571.296672] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[571.368649] [119/133] (458s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[571.463806] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[571.468164] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[571.531896] [120/133] (458s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[571.621943] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[571.624370] Starting dynamic subtest: pipe-A-eDP-1
[571.644550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[571.657731] Starting dynamic subtest: pipe-B-eDP-1
[571.677124] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[571.688274] Starting dynamic subtest: pipe-C-eDP-1
[571.707432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[571.718454] Starting dynamic subtest: pipe-D-eDP-1
[571.737389] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[571.739589] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[573.870484] [121/133] (456s left) kms_plane_multiple (2x-tiling-none)
[573.955062] Starting subtest: 2x-tiling-none
[573.959173] Subtest 2x-tiling-none: SKIP (0.000s)
[574.009105] [122/133] (456s left) syncobj_wait (wait-any-interrupted)
[574.065597] Starting subtest: wait-any-interrupted
[574.166050] Subtest wait-any-interrupted: SUCCESS (0.102s)
[574.221550] [123/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[574.306393] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[574.310807] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.382095] [124/133] (455s left) i915_hangman (engine-error-state-capture)
[574.440690] Starting subtest: engine-error-state-capture
[574.442916] Starting dynamic subtest: rcs0
[577.843875] Dynamic subtest rcs0: SUCCESS (3.401s)
[577.857195] Starting dynamic subtest: bcs0
[583.861196] Dynamic subtest bcs0: SUCCESS (6.014s)
[583.875038] Starting dynamic subtest: vcs0
[589.812604] Dynamic subtest vcs0: SUCCESS (5.948s)
[589.826572] Starting dynamic subtest: vcs1
[594.804084] Dynamic subtest vcs1: SUCCESS (4.988s)
[594.818553] Starting dynamic subtest: vecs0
[599.796557] Dynamic subtest vecs0: SUCCESS (4.989s)
[599.810988] Starting dynamic subtest: ccs0
[604.852236] Dynamic subtest ccs0: SUCCESS (5.052s)
[604.855240] Subtest engine-error-state-capture: SUCCESS (30.410s)
[604.957467] [125/133] (425s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[605.057639] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[605.061892] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[605.140425] [126/133] (425s left) i915_drm_fdinfo (virtual-busy)
[605.182698] Starting subtest: virtual-busy
[605.186811] Subtest virtual-busy: SKIP (0.000s)
[605.226302] [127/133] (425s left) gem_ctx_param (invalid-param-set)
[605.277856] Starting subtest: invalid-param-set
[605.280089] Subtest invalid-param-set: SUCCESS (0.000s)
[605.330189] [128/133] (425s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[605.447316] Starting subtest: short-flip-after-cursor-atomic-transitions
[606.395142] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.947s)
[607.225464] [129/133] (423s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[607.295064] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[607.401468] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[607.461428] [130/133] (423s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[607.554697] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[607.556886] Starting dynamic subtest: pipe-A-eDP-1
[607.664595] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[607.676570] Starting dynamic subtest: pipe-B-eDP-1
[608.789636] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[608.794290] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.237s)
[609.968400] [131/133] (420s left) i915_query (query-regions-sanity-check)
[610.020675] Starting subtest: query-regions-sanity-check
[610.030956] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[610.116632] [132/133] (420s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[610.204424] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[616.739960] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.538s)
[616.832263] [133/133] (413s left) gem_mmap_gtt (ptrace)
[616.891282] Subtest ptrace: SKIP (0.000s)
[616.956306] 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.