[59.282289] Initializing watchdogs
[59.282334]   /dev/watchdog0
[59.296500] [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]
[59.300725] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.303046] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.306407] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[59.423239] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[63.128543] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.697s)
[64.321733] [002/133] (955s left) gem_exec_async (concurrent-writes)
[64.376964] Starting subtest: concurrent-writes
[64.379526] Starting dynamic subtest: rcs0
[64.394547] Dynamic subtest rcs0: SUCCESS (0.018s)
[64.406395] Starting dynamic subtest: bcs0
[64.408666] Dynamic subtest bcs0: SUCCESS (0.007s)
[64.416734] Starting dynamic subtest: vcs0
[64.419413] Dynamic subtest vcs0: SUCCESS (0.005s)
[64.434296] Starting dynamic subtest: vcs1
[64.436629] Dynamic subtest vcs1: SUCCESS (0.007s)
[64.443854] Starting dynamic subtest: vecs0
[64.446244] Dynamic subtest vecs0: SUCCESS (0.009s)
[64.453351] Starting dynamic subtest: ccs0
[64.455706] Dynamic subtest ccs0: SUCCESS (0.006s)
[64.458077] Subtest concurrent-writes: SUCCESS (0.052s)
[64.644863] [003/133] (955s left) kms_psr (pr-primary-blt)
[64.750220] Starting subtest: pr-primary-blt
[64.754757] Subtest pr-primary-blt: SKIP (0.000s)
[64.818056] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[65.186393] Subtest dp-crc-fast: SKIP (0.000s)
[66.015638] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[66.199051] Starting subtest: pi-shared-iova
[66.201432] Starting dynamic subtest: rcs0
[66.280051] Dynamic subtest rcs0: SUCCESS (0.083s)
[66.290322] Starting dynamic subtest: vcs0
[66.336749] Dynamic subtest vcs0: SUCCESS (0.057s)
[66.346965] Starting dynamic subtest: vcs1
[66.392712] Dynamic subtest vcs1: SUCCESS (0.056s)
[66.400525] Starting dynamic subtest: vecs0
[66.450573] Dynamic subtest vecs0: SUCCESS (0.055s)
[66.462831] Starting dynamic subtest: ccs0
[66.507483] Dynamic subtest ccs0: SUCCESS (0.059s)
[66.509935] Subtest pi-shared-iova: SUCCESS (0.310s)
[68.138475] [006/133] (951s left) kms_busy (basic-hang)
[68.245360] Starting subtest: basic-hang
[68.247877] Starting dynamic subtest: flip-pipe-A
[68.858583] Dynamic subtest flip-pipe-A: SUCCESS (0.612s)
[68.867726] Starting dynamic subtest: modeset-pipe-A
[72.258776] Dynamic subtest modeset-pipe-A: SUCCESS (3.399s)
[72.266663] Starting dynamic subtest: flip-pipe-D
[73.446670] Dynamic subtest flip-pipe-D: SUCCESS (1.185s)
[73.456188] Starting dynamic subtest: modeset-pipe-D
[76.890754] Dynamic subtest modeset-pipe-D: SUCCESS (3.440s)
[76.893605] Subtest basic-hang: SUCCESS (8.640s)
[77.735906] [007/133] (942s left) kms_flip (basic-flip-vs-dpms)
[77.822764] Starting subtest: basic-flip-vs-dpms
[77.824654] Starting dynamic subtest: A-eDP1
[80.379110] Dynamic subtest A-eDP1: SUCCESS (2.555s)
[80.389475] Starting dynamic subtest: B-eDP1
[82.566229] Dynamic subtest B-eDP1: SUCCESS (2.185s)
[82.579337] Starting dynamic subtest: C-eDP1
[84.641416] Dynamic subtest C-eDP1: SUCCESS (2.072s)
[84.650526] Starting dynamic subtest: D-eDP1
[86.721862] Dynamic subtest D-eDP1: SUCCESS (2.080s)
[86.723808] Subtest basic-flip-vs-dpms: SUCCESS (8.902s)
[87.538156] [008/133] (932s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[87.645021] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[87.647350] Starting dynamic subtest: pipe-A-default-mode
[90.344579] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[90.346930] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.701s)
[91.206157] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[91.254900] Subtest non-threaded: SKIP (0.000s)
[91.310951] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[91.409053] Starting subtest: invalid-plane
[91.411180] Starting dynamic subtest: zero-id
[91.413278] Dynamic subtest zero-id: SUCCESS (0.000s)
[91.421213] Starting dynamic subtest: outrange-id
[91.423068] Dynamic subtest outrange-id: SUCCESS (0.000s)
[91.424857] Subtest invalid-plane: SUCCESS (0.001s)
[91.476918] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[91.538793] Subtest write-wc-read-gtt: SKIP (0.000s)
[91.598475] [012/133] (928s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[91.662810] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[91.771642] [013/133] (928s left) kms_big_fb (linear-32bpp-rotate-0)
[91.871970] Starting subtest: linear-32bpp-rotate-0
[93.339653] Subtest linear-32bpp-rotate-0: SUCCESS (1.468s)
[93.469009] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[93.526375] Subtest bb-start-far: SKIP (0.000s)
[93.598395] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[93.708098] Starting subtest: cursorB-vs-flipA-varying-size
[93.711813] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[93.848395] [016/133] (926s left) gem_lmem_swapping (verify)
[93.888382] Subtest verify: SKIP (0.000s)
[93.923971] [017/133] (926s left) gem_userptr_blits (mmap-offset-banned)
[93.986115] Starting subtest: mmap-offset-banned
[93.988081] Starting dynamic subtest: wb
[93.989867] Dynamic subtest wb: SUCCESS (0.000s)
[93.997125] Starting dynamic subtest: wc
[93.998692] Dynamic subtest wc: SUCCESS (0.000s)
[94.005182] Starting dynamic subtest: uc
[94.006745] Dynamic subtest uc: SUCCESS (0.000s)
[94.008398] Subtest mmap-offset-banned: SUCCESS (0.001s)
[94.104827] [018/133] (926s left) gem_softpin (evict-snoop-interruptible)
[94.167780] Starting subtest: evict-snoop-interruptible
[94.171765] Subtest evict-snoop-interruptible: SKIP (0.000s)
[94.298865] [019/133] (926s left) gem_ctx_persistence (legacy-engines-mixed-process)
[94.367474] Starting subtest: legacy-engines-mixed-process
[94.369424] Starting dynamic subtest: render
[95.875555] Dynamic subtest render: SUCCESS (1.508s)
[95.884955] Starting dynamic subtest: bsd1
[97.877819] Dynamic subtest bsd1: SUCCESS (2.001s)
[97.887597] Starting dynamic subtest: bsd2
[99.932981] Dynamic subtest bsd2: SUCCESS (2.053s)
[99.943170] Starting dynamic subtest: blt
[101.918125] Dynamic subtest blt: SUCCESS (1.984s)
[101.929102] Starting dynamic subtest: vebox
[103.877208] Dynamic subtest vebox: SUCCESS (1.957s)
[103.879826] Subtest legacy-engines-mixed-process: SUCCESS (9.510s)
[103.999350] [020/133] (916s left) gem_eio (hibernate)
[104.247436] Starting subtest: hibernate
[118.858874] Subtest hibernate: SUCCESS (14.608s)
[126.007872] [021/133] (901s left) i915_pm_rps (fence-order)
[126.102520] Starting subtest: fence-order
[129.213690] Subtest fence-order: SUCCESS (3.110s)
[129.346306] [022/133] (898s left) kms_vblank (ts-continuation-idle-hang)
[129.447409] Starting subtest: ts-continuation-idle-hang
[129.449580] Starting dynamic subtest: pipe-A-eDP-1
[155.692259] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.240s)
[155.708020] Starting dynamic subtest: pipe-D-eDP-1
[180.701252] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.006s)
[180.703252] Subtest ts-continuation-idle-hang: SUCCESS (51.249s)
[181.584504] [023/133] (846s left) perf (unprivileged-single-ctx-counters)
[181.710361] Starting subtest: unprivileged-single-ctx-counters
[181.714558] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[181.756026] [024/133] (846s left) kms_frontbuffer_tracking (fbc-tiling-4)
[181.847809] Starting subtest: fbc-tiling-4
[186.288880] Subtest fbc-tiling-4: SUCCESS (4.444s)
[187.479289] [025/133] (840s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[187.578863] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[194.316015] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.741s)
[194.431442] [026/133] (833s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[194.525919] Starting subtest: crc-primary-suspend-y-tiled-ccs
[194.528066] Starting dynamic subtest: pipe-A-eDP-1
[194.536757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.546611] Starting dynamic subtest: pipe-B-eDP-1
[194.555695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.564714] Starting dynamic subtest: pipe-C-eDP-1
[194.573203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.581737] Starting dynamic subtest: pipe-D-eDP-1
[194.590221] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.594211] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[196.773405] [027/133] (831s left) gem_spin_batch (engines)
[196.850156] Starting subtest: engines
[196.852331] Starting dynamic subtest: rcs0
[200.090067] Dynamic subtest rcs0: SUCCESS (3.237s)
[200.101660] Starting dynamic subtest: bcs0
[203.326997] Dynamic subtest bcs0: SUCCESS (3.234s)
[203.338478] Starting dynamic subtest: vcs0
[206.562776] Dynamic subtest vcs0: SUCCESS (3.235s)
[206.573926] Starting dynamic subtest: vcs1
[209.801624] Dynamic subtest vcs1: SUCCESS (3.236s)
[209.813746] Starting dynamic subtest: vecs0
[213.038951] Dynamic subtest vecs0: SUCCESS (3.234s)
[213.050570] Starting dynamic subtest: ccs0
[216.275852] Dynamic subtest ccs0: SUCCESS (3.235s)
[216.278290] Subtest engines: SUCCESS (19.424s)
[216.494874] [028/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[216.604777] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[223.626843] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.025s)
[223.786346] [029/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[223.887862] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[223.892102] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[223.981889] [030/133] (804s left) gem_partial_pwrite_pread (reads-snoop)
[224.043551] Subtest reads-snoop: SKIP (0.000s)
[224.122364] [031/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[224.224052] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[225.202546] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.979s)
[225.312234] [032/133] (802s left) kms_getfb (getfb-reject-nv12)
[225.403095] Starting subtest: getfb-reject-nv12
[225.405400] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[225.508767] [033/133] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[225.610040] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[229.849219] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.240s)
[231.010417] [034/133] (797s left) perf_pmu (render-node-busy-idle)
[231.082849] Starting subtest: render-node-busy-idle
[231.085369] Starting dynamic subtest: rcs0
[231.774293] Dynamic subtest rcs0: SUCCESS (0.690s)
[231.787087] Starting dynamic subtest: bcs0
[232.432586] Dynamic subtest bcs0: SUCCESS (0.657s)
[232.445194] Starting dynamic subtest: vcs0
[233.941490] Dynamic subtest vcs0: SUCCESS (1.505s)
[233.954319] Starting dynamic subtest: vcs1
[235.925824] Dynamic subtest vcs1: SUCCESS (1.981s)
[235.936966] Starting dynamic subtest: vecs0
[237.908686] Dynamic subtest vecs0: SUCCESS (1.980s)
[237.921272] Starting dynamic subtest: ccs0
[238.582242] Dynamic subtest ccs0: SUCCESS (0.673s)
[238.584748] Subtest render-node-busy-idle: SUCCESS (7.500s)
[238.659300] [035/133] (789s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[238.762078] Starting subtest: yf-tiled-16bpp-rotate-90
[238.766720] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[238.871871] [036/133] (789s left) kms_content_protection (atomic)
[239.013062] Starting subtest: atomic
[239.017766] Subtest atomic: SKIP (0.000s)
[239.142379] [037/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[239.240869] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[239.244890] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[239.346510] [038/133] (789s left) kms_pm_rpm (fences-dpms)
[241.078079] Starting subtest: fences-dpms
[241.083733] Subtest fences-dpms: SKIP (0.000s)
[241.647038] [039/133] (786s left) gem_mmap_gtt (basic-write-read)
[241.700456] Subtest basic-write-read: SKIP (0.000s)
[241.764374] [040/133] (786s left) gem_exec_reloc (basic-write-cpu-active)
[241.827916] Subtest basic-write-cpu-active: SKIP (0.000s)
[241.891943] [041/133] (786s left) gem_eio (unwedge-stress)
[242.095413] Starting subtest: unwedge-stress
[242.097685] Starting dynamic subtest: render
[246.445551] Dynamic subtest render: SUCCESS (4.348s)
[246.460765] Starting dynamic subtest: bsd1
[264.321458] Dynamic subtest bsd1: SUCCESS (17.874s)
[264.337530] Starting dynamic subtest: bsd2
[282.379482] Dynamic subtest bsd2: SUCCESS (18.056s)
[282.395601] Starting dynamic subtest: blt
[282.399674] Dynamic subtest blt: SKIP (0.000s)
[282.409250] Starting dynamic subtest: vebox
[300.352639] Dynamic subtest vebox: SUCCESS (17.970s)
[300.355134] Subtest unwedge-stress: SUCCESS (58.252s)
[301.957632] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[301.961737] [042/133] (726s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[302.066279] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[302.070585] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[302.159014] [043/133] (726s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[302.257276] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[302.259607] Starting dynamic subtest: pipe-A-default-mode
[304.987343] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[304.989594] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.731s)
[305.840966] [044/133] (722s left) gem_exec_store (pages)
[305.913991] Starting subtest: pages
[305.916376] Starting dynamic subtest: rcs0
[306.012126] Dynamic subtest rcs0: SUCCESS (0.100s)
[306.027561] Starting dynamic subtest: bcs0
[306.087203] Dynamic subtest bcs0: SUCCESS (0.073s)
[306.098407] Starting dynamic subtest: vcs0
[306.168077] Dynamic subtest vcs0: SUCCESS (0.079s)
[306.178595] Starting dynamic subtest: vcs1
[306.238721] Dynamic subtest vcs1: SUCCESS (0.071s)
[306.248723] Starting dynamic subtest: vecs0
[306.314774] Dynamic subtest vecs0: SUCCESS (0.075s)
[306.324672] Starting dynamic subtest: ccs0
[306.384266] Dynamic subtest ccs0: SUCCESS (0.069s)
[306.386481] Subtest pages: SUCCESS (0.474s)
[306.570745] [045/133] (722s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[306.665288] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[306.669404] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[306.752707] [046/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[306.861836] Starting subtest: psr-1p-primscrn-cur-indfb-move
[314.166828] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.308s)
[314.293905] [047/133] (714s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[314.387177] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[314.389443] Starting dynamic subtest: pipe-A-eDP-1
[314.411408] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[314.423117] Starting dynamic subtest: pipe-B-eDP-1
[314.443133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[314.452095] Starting dynamic subtest: pipe-C-eDP-1
[314.472899] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[314.481707] Starting dynamic subtest: pipe-D-eDP-1
[314.503410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[314.507730] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[316.611226] [048/133] (712s left) kms_pm_rpm (basic-rte)
[316.649079] Starting subtest: basic-rte
[319.583083] Subtest basic-rte: SUCCESS (2.935s)
[321.406060] [049/133] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[321.508180] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[321.512713] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[321.611898] [050/133] (707s left) gem_exec_schedule (submit-golden-slice)
[321.688306] Starting subtest: submit-golden-slice
[321.690315] Starting dynamic subtest: rcs0
[321.720982] Dynamic subtest rcs0: SUCCESS (0.041s)
[321.733290] Starting dynamic subtest: bcs0
[321.760234] Dynamic subtest bcs0: SUCCESS (0.039s)
[321.769541] Starting dynamic subtest: vcs0
[321.793574] Dynamic subtest vcs0: SUCCESS (0.032s)
[321.803318] Starting dynamic subtest: vcs1
[321.826819] Dynamic subtest vcs1: SUCCESS (0.032s)
[321.836287] Starting dynamic subtest: vecs0
[321.861134] Dynamic subtest vecs0: SUCCESS (0.034s)
[321.870724] Starting dynamic subtest: ccs0
[321.902807] Dynamic subtest ccs0: SUCCESS (0.040s)
[321.905648] Subtest submit-golden-slice: SUCCESS (0.224s)
[322.974377] [051/133] (705s left) kms_async_flips (async-flip-hang)
[323.073309] Starting subtest: async-flip-hang
[323.445264] Starting dynamic subtest: pipe-A-eDP-1
[338.415489] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.966s)
[338.796083] Starting dynamic subtest: pipe-B-eDP-1
[354.418349] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.624s)
[354.790418] Starting dynamic subtest: pipe-C-eDP-1
[370.412612] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.628s)
[370.793086] Starting dynamic subtest: pipe-D-eDP-1
[386.412901] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.624s)
[386.415771] Subtest async-flip-hang: SUCCESS (63.336s)
[387.577248] [052/133] (641s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[387.799601] Starting subtest: cursor-rapid-movement-128x128
[387.804597] Starting dynamic subtest: pipe-A-eDP-1
[388.343743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[388.374175] Starting dynamic subtest: pipe-D-eDP-1
[389.601507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[389.603911] Subtest cursor-rapid-movement-128x128: SUCCESS (1.801s)
[390.446263] [053/133] (638s left) syncobj_timeline (invalid-query-bad-pad)
[390.502035] Starting subtest: invalid-query-bad-pad
[390.504297] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[390.591094] [054/133] (638s left) kms_tiled_display (basic-test-pattern)
[390.698087] Subtest basic-test-pattern: SKIP (0.000s)
[390.741940] [055/133] (638s left) perf (gen12-invalid-class-instance)
[390.834446] Starting subtest: gen12-invalid-class-instance
[390.845632] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[390.888916] [056/133] (638s left) kms_invalid_mode (uint-max-clock)
[390.973530] Starting subtest: uint-max-clock
[390.975909] Starting dynamic subtest: pipe-A-eDP-1
[391.259409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[391.269644] Starting dynamic subtest: pipe-B-eDP-1
[391.271865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[391.280969] Starting dynamic subtest: pipe-C-eDP-1
[391.283206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[391.291966] Starting dynamic subtest: pipe-D-eDP-1
[391.293860] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[391.295712] Subtest uint-max-clock: SUCCESS (0.293s)
[392.083675] [057/133] (637s left) kms_psr (fbc-psr-cursor-plane-move)
[392.184484] Starting subtest: fbc-psr-cursor-plane-move
[392.186626] Starting dynamic subtest: eDP-1
[392.190796] Dynamic subtest eDP-1: SKIP (0.000s)
[392.195061] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[392.269879] [058/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[392.374383] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[392.378688] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[392.485440] [059/133] (636s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[392.617085] Starting subtest: cursorB-vs-flipB-varying-size
[392.621253] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[392.765328] [060/133] (636s left) gem_exec_reloc (basic-gtt)
[392.827289] Subtest basic-gtt: SKIP (0.000s)
[392.895332] [061/133] (636s left) gem_lmem_swapping (basic)
[392.948371] Subtest basic: SKIP (0.000s)
[392.996072] [062/133] (636s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[393.117204] Starting subtest: basic-flip-before-cursor-varying-size
[394.069454] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.949s)
[394.919561] [063/133] (634s left) kms_cursor_crc (cursor-onscreen-512x512)
[395.216502] Starting subtest: cursor-onscreen-512x512
[395.220893] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[395.371156] [064/133] (634s left) gem_exec_params (larger-than-life-batch)
[395.426083] Starting subtest: larger-than-life-batch
[397.678504] Subtest larger-than-life-batch: SUCCESS (2.252s)
[397.962284] [065/133] (631s left) gem_close_race (multigpu-basic-process)
[398.075751] Starting subtest: multigpu-basic-process
[398.079742] Subtest multigpu-basic-process: SKIP (0.000s)
[398.295838] [066/133] (631s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[398.419689] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[399.875451] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.455s)
[400.673267] [067/133] (628s left) kms_feature_discovery (display-4x)
[400.772376] Starting subtest: display-4x
[400.776481] Subtest display-4x: SKIP (0.000s)
[400.848269] [068/133] (628s left) prime_mmap (test_refcounting)
[400.912651] Starting subtest: test_refcounting
[400.914872] Starting dynamic subtest: test_refcounting-smem
[400.943999] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[400.946308] Subtest test_refcounting: SUCCESS (0.033s)
[401.039721] [069/133] (628s left) kms_dp_aux_dev (basic)
[401.095155] Starting subtest: basic
[401.317085] Subtest basic: SUCCESS (0.222s)
[401.389424] [070/133] (628s left) syncobj_wait (invalid-reset-one-illegal-handle)
[401.452352] Starting subtest: invalid-reset-one-illegal-handle
[401.454766] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[401.552419] [071/133] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[401.654349] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[401.658601] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[401.750369] [072/133] (628s left) gem_exec_reloc (basic-cpu)
[401.822633] Subtest basic-cpu: SKIP (0.000s)
[401.906679] [073/133] (627s left) gem_exec_balancer (sliced)
[401.979652] Starting subtest: sliced
[401.984350] Subtest sliced: SKIP (0.000s)
[402.288964] [074/133] (627s left) kms_plane_scaling (2x-scaler-multi-pipe)
[402.375141] Starting subtest: 2x-scaler-multi-pipe
[402.379595] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[402.471753] [075/133] (627s left) gem_ctx_persistence (engines-hang)
[402.536758] Starting subtest: engines-hang
[402.539085] Starting dynamic subtest: rcs0
[402.658572] Dynamic subtest rcs0: SUCCESS (0.120s)
[402.677319] Starting dynamic subtest: bcs0
[402.761644] Dynamic subtest bcs0: SUCCESS (0.101s)
[402.773897] Starting dynamic subtest: vcs0
[402.868691] Dynamic subtest vcs0: SUCCESS (0.105s)
[402.881908] Starting dynamic subtest: vcs1
[402.961552] Dynamic subtest vcs1: SUCCESS (0.091s)
[402.974354] Starting dynamic subtest: vecs0
[403.051884] Dynamic subtest vecs0: SUCCESS (0.088s)
[403.064737] Starting dynamic subtest: ccs0
[403.139647] Dynamic subtest ccs0: SUCCESS (0.086s)
[403.142072] Subtest engines-hang: SUCCESS (0.604s)
[403.234745] [076/133] (626s left) core_setmaster (master-drop-set-root)
[403.356877] Starting subtest: master-drop-set-root
[403.364488] Subtest master-drop-set-root: SUCCESS (0.007s)
[403.413579] [077/133] (626s left) gem_exec_flush (basic-uc-pro-default)
[403.486446] Starting subtest: basic-uc-pro-default
[408.963818] Subtest basic-uc-pro-default: SUCCESS (5.476s)
[409.153582] [078/133] (620s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[409.262748] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[409.267321] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[409.368642] [079/133] (620s left) gem_userptr_blits (forbidden-operations)
[409.442048] Starting subtest: forbidden-operations
[409.446634] Subtest forbidden-operations: SKIP (0.000s)
[409.593935] [080/133] (620s left) core_getclient (basic)
[409.650171] Starting subtest: basic
[409.652081] Subtest basic: SUCCESS (0.000s)
[409.763509] [081/133] (620s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[409.857293] Starting subtest: fbc-pr-sprite-mmap-gtt
[409.861648] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[409.931289] [082/133] (620s left) kms_flip (2x-plain-flip-fb-recreate)
[410.021555] Starting subtest: 2x-plain-flip-fb-recreate
[410.032306] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[410.113048] [083/133] (620s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[410.197062] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[410.201283] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[411.304995] [084/133] (619s left) syncobj_timeline (wait-all-delayed-signal)
[411.359349] Starting subtest: wait-all-delayed-signal
[411.462584] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[411.544474] [085/133] (618s left) gem_render_copy (linear-to-vebox-yf-tiled)
[411.613777] Starting subtest: linear-to-vebox-yf-tiled
[411.618270] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[411.822371] [086/133] (618s left) kms_cursor_crc (cursor-tearing-position-change)
[411.925842] Starting subtest: cursor-tearing-position-change
[411.927758] Starting dynamic subtest: pipe-A-eDP-1
[412.492218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[412.508036] Starting dynamic subtest: pipe-D-eDP-1
[413.729874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[413.732126] Subtest cursor-tearing-position-change: SUCCESS (1.806s)
[414.570852] [087/133] (615s left) syncobj_timeline (wait-for-submit-delayed-submit)
[414.627785] Starting subtest: wait-for-submit-delayed-submit
[414.729073] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[414.824422] [088/133] (615s left) gem_exec_params (invalid-ring)
[414.889948] Starting subtest: invalid-ring
[414.892166] Subtest invalid-ring: SUCCESS (0.000s)
[415.025539] [089/133] (615s left) gem_tiled_blits (interruptible)
[415.094484] Subtest interruptible: SKIP (0.000s)
[415.175226] [090/133] (615s left) gem_eio (banned)
[415.409893] Starting subtest: banned
[416.013516] Subtest banned: SUCCESS (0.603s)
[416.175868] [091/133] (614s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[416.266847] Starting subtest: plane-primary-overlay-mutable-zpos
[419.696325] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.427s)
[420.882853] [092/133] (609s left) kms_psr (fbc-pr-dpms)
[420.986044] Starting subtest: fbc-pr-dpms
[420.990192] Subtest fbc-pr-dpms: SKIP (0.000s)
[421.060138] [093/133] (609s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[421.152965] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[421.157167] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[421.224026] [094/133] (609s left) kms_plane_alpha_blend (alpha-transparent-fb)
[421.306385] Starting subtest: alpha-transparent-fb
[421.582601] Starting dynamic subtest: pipe-A-eDP-1
[422.214639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[422.229774] Starting dynamic subtest: pipe-D-eDP-1
[423.527060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[423.529203] Subtest alpha-transparent-fb: SUCCESS (2.220s)
[424.361943] [095/133] (606s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[424.464541] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[424.466898] Starting dynamic subtest: pipe-A
[425.522471] Dynamic subtest pipe-A: SUCCESS (1.061s)
[425.532071] Starting dynamic subtest: pipe-B
[427.659461] Dynamic subtest pipe-B: SUCCESS (2.135s)
[427.672254] Starting dynamic subtest: pipe-C
[428.844629] Dynamic subtest pipe-C: SUCCESS (1.184s)
[428.854882] Starting dynamic subtest: pipe-D
[429.997259] Dynamic subtest pipe-D: SUCCESS (1.152s)
[429.999609] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.536s)
[431.198657] [096/133] (599s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[431.290308] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[431.292705] Starting dynamic subtest: pipe-A-eDP-1
[431.563973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.242s)
[431.575048] Starting dynamic subtest: pipe-B-eDP-1
[432.857042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s)
[432.868323] Starting dynamic subtest: pipe-C-eDP-1
[434.060402] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[434.072884] Starting dynamic subtest: pipe-D-eDP-1
[435.276884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[435.278973] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.959s)
[436.417873] [097/133] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[436.506711] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[436.510764] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[436.612311] [098/133] (594s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[436.703259] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[436.707267] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[436.781450] [099/133] (594s left) kms_flip (blocking-absolute-wf_vblank)
[436.869775] Starting subtest: blocking-absolute-wf_vblank
[436.872105] Starting dynamic subtest: A-eDP1
[445.577637] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[445.592022] Starting dynamic subtest: B-eDP1
[454.314743] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[454.329768] Starting dynamic subtest: C-eDP1
[463.040645] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[463.054251] Starting dynamic subtest: D-eDP1
[471.769826] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[471.775061] Subtest blocking-absolute-wf_vblank: SUCCESS (34.905s)
[472.980283] [100/133] (558s left) tools_test (sysfs_l3_parity)
[473.043188] Starting subtest: sysfs_l3_parity
[473.127207] Subtest sysfs_l3_parity: SKIP (0.098s)
[473.200385] [101/133] (557s left) kms_psr (psr-sprite-plane-onoff)
[473.303081] Starting subtest: psr-sprite-plane-onoff
[473.305233] Starting dynamic subtest: eDP-1
[475.121220] Dynamic subtest eDP-1: SUCCESS (1.818s)
[475.123660] Subtest psr-sprite-plane-onoff: SUCCESS (1.819s)
[475.949172] [102/133] (555s left) api_intel_allocator (default-alignment)
[476.011315] Starting subtest: default-alignment
[476.013324] Subtest default-alignment: SUCCESS (0.004s)
[476.156666] [103/133] (554s left) sriov_basic (bind-unbind-vf)
[476.213721] Starting subtest: bind-unbind-vf
[476.216286] Starting dynamic subtest: vf-1
[476.298104] Dynamic subtest vf-1: FAIL (0.031s)
[476.309530] Starting dynamic subtest: vf-2
[476.382581] Dynamic subtest vf-2: FAIL (0.004s)
[476.395190] Starting dynamic subtest: vf-3
[476.470068] Dynamic subtest vf-3: FAIL (0.003s)
[476.481299] Starting dynamic subtest: vf-4
[476.554640] Dynamic subtest vf-4: FAIL (0.004s)
[476.566443] Starting dynamic subtest: vf-5
[476.639588] Dynamic subtest vf-5: FAIL (0.004s)
[476.651063] Starting dynamic subtest: vf-6
[476.724809] Dynamic subtest vf-6: FAIL (0.003s)
[476.736613] Starting dynamic subtest: vf-7
[476.809721] Dynamic subtest vf-7: FAIL (0.004s)
[476.820946] Starting dynamic subtest: vf-random
[476.888068] Dynamic subtest vf-random: FAIL (0.004s)
[476.897859] Starting dynamic subtest: vf-last
[476.957323] Dynamic subtest vf-last: FAIL (0.526s)
[476.959045] Subtest bind-unbind-vf: FAIL (0.590s)
[476.996807] [104/133] (554s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[477.054874] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[477.161058] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[477.269806] [105/133] (553s left) perf_pmu (rc6)
[477.310047] Starting subtest: rc6
[477.311868] Starting dynamic subtest: gt0
[483.678771] Dynamic subtest gt0: SUCCESS (6.366s)
[483.691699] Starting dynamic subtest: runtime-pm-gt0
[491.440372] Dynamic subtest runtime-pm-gt0: SUCCESS (7.761s)
[491.454204] Starting dynamic subtest: runtime-pm-long-gt0
[503.867797] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.424s)
[503.880791] Starting dynamic subtest: other-idle-gt0
[510.211744] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[510.224989] Starting dynamic subtest: gt1
[516.553149] Dynamic subtest gt1: SUCCESS (6.339s)
[516.566311] Starting dynamic subtest: runtime-pm-gt1
[524.055372] Dynamic subtest runtime-pm-gt1: SUCCESS (7.499s)
[524.074236] Starting dynamic subtest: runtime-pm-long-gt1
[536.506843] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.448s)
[536.520436] Starting dynamic subtest: other-idle-gt1
[542.850346] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[542.853087] Subtest rc6: SUCCESS (65.539s)
[543.973373] [106/133] (487s left) gem_exec_fence (syncobj-timeline-repeat)
[544.564735] Starting subtest: syncobj-timeline-repeat
[544.799840] Subtest syncobj-timeline-repeat: SUCCESS (0.235s)
[545.937822] [107/133] (485s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[546.030022] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[550.836223] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.809s)
[551.977656] [108/133] (479s left) kms_color (legacy-gamma-reset)
[552.068211] Starting subtest: legacy-gamma-reset
[552.070444] Starting dynamic subtest: pipe-A-eDP-1
[552.467064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[552.477497] Starting dynamic subtest: pipe-B-eDP-1
[552.482229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[552.492184] Starting dynamic subtest: pipe-C-eDP-1
[552.494576] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[552.504472] Starting dynamic subtest: pipe-D-eDP-1
[552.506432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[552.508864] Subtest legacy-gamma-reset: SUCCESS (0.441s)
[553.300202] [109/133] (478s left) gem_exec_balancer (indices)
[553.372738] Starting subtest: indices
[555.892587] Subtest indices: SUCCESS (2.518s)
[556.169333] [110/133] (475s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[556.238638] Starting subtest: yf-tiled-to-vebox-yf-tiled
[556.243517] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[556.398462] [111/133] (475s left) gem_barrier_race (remote-request)
[556.476066] Starting subtest: remote-request
[556.477979] Starting dynamic subtest: rcs0
[561.695915] Dynamic subtest rcs0: SUCCESS (5.221s)
[561.697813] Subtest remote-request: SUCCESS (5.222s)
[561.804091] [112/133] (469s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[561.861999] Starting subtest: etime-multi-wait-for-submit-submitted
[561.969052] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[562.025624] [113/133] (469s left) syncobj_timeline (multi-wait-signaled)
[562.073763] Starting subtest: multi-wait-signaled
[562.075846] Subtest multi-wait-signaled: SUCCESS (0.000s)
[562.146019] [114/133] (469s left) kms_chamelium_hpd (vga-hpd-fast)
[562.531315] Subtest vga-hpd-fast: SKIP (0.000s)
[563.321547] [115/133] (468s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[563.424450] Starting subtest: fbc-modesetfrombusy
[567.195188] Subtest fbc-modesetfrombusy: SUCCESS (3.773s)
[568.356447] [116/133] (463s left) kms_psr (psr-cursor-plane-onoff)
[568.457188] Starting subtest: psr-cursor-plane-onoff
[568.459386] Starting dynamic subtest: eDP-1
[570.145823] Dynamic subtest eDP-1: SUCCESS (1.689s)
[570.148068] Subtest psr-cursor-plane-onoff: SUCCESS (1.690s)
[570.992573] [117/133] (460s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[571.102309] Starting subtest: y-tiled-32bpp-rotate-90
[571.106659] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[571.185568] [118/133] (460s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[571.294293] Starting subtest: psr-rgb565-draw-mmap-gtt
[571.298183] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[571.378806] [119/133] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[571.470618] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[571.474716] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[571.547324] [120/133] (460s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[571.636997] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[571.639352] Starting dynamic subtest: pipe-A-eDP-1
[571.658921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[571.673516] Starting dynamic subtest: pipe-B-eDP-1
[571.692530] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[571.702652] Starting dynamic subtest: pipe-C-eDP-1
[571.722158] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[571.732342] Starting dynamic subtest: pipe-D-eDP-1
[571.751600] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[571.753788] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[573.859398] [121/133] (458s left) kms_plane_multiple (2x-tiling-none)
[573.954853] Starting subtest: 2x-tiling-none
[573.958707] Subtest 2x-tiling-none: SKIP (0.000s)
[574.002119] [122/133] (457s left) syncobj_wait (wait-any-interrupted)
[574.057784] Starting subtest: wait-any-interrupted
[574.161329] Subtest wait-any-interrupted: SUCCESS (0.102s)
[574.214718] [123/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[574.303103] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[574.307107] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.371962] [124/133] (457s left) i915_hangman (engine-error-state-capture)
[574.450383] Starting subtest: engine-error-state-capture
[574.452771] Starting dynamic subtest: rcs0
[577.841152] Dynamic subtest rcs0: SUCCESS (3.392s)
[577.852762] Starting dynamic subtest: bcs0
[583.859243] Dynamic subtest bcs0: SUCCESS (6.015s)
[583.873697] Starting dynamic subtest: vcs0
[589.810409] Dynamic subtest vcs0: SUCCESS (5.948s)
[589.824447] Starting dynamic subtest: vcs1
[594.802498] Dynamic subtest vcs1: SUCCESS (4.990s)
[594.815895] Starting dynamic subtest: vecs0
[599.795378] Dynamic subtest vecs0: SUCCESS (4.989s)
[599.810031] Starting dynamic subtest: ccs0
[604.851568] Dynamic subtest ccs0: SUCCESS (5.054s)
[604.854571] Subtest engine-error-state-capture: SUCCESS (30.404s)
[604.957674] [125/133] (427s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[605.065604] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[605.069695] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[605.147492] [126/133] (426s left) i915_drm_fdinfo (virtual-busy)
[605.189372] Starting subtest: virtual-busy
[605.193314] Subtest virtual-busy: SKIP (0.000s)
[605.236332] [127/133] (426s left) gem_ctx_param (invalid-param-set)
[605.288298] Starting subtest: invalid-param-set
[605.290498] Subtest invalid-param-set: SUCCESS (0.000s)
[605.338715] [128/133] (426s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[605.465056] Starting subtest: short-flip-after-cursor-atomic-transitions
[606.425677] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s)
[607.281218] [129/133] (424s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[607.335054] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[607.440787] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[607.497930] [130/133] (424s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[607.593964] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[607.596364] Starting dynamic subtest: pipe-A-eDP-1
[607.692382] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[607.704113] Starting dynamic subtest: pipe-B-eDP-1
[608.879997] Dynamic subtest pipe-B-eDP-1: SKIP (1.189s)
[608.884334] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.291s)
[610.045134] [131/133] (422s left) i915_query (query-regions-sanity-check)
[610.097886] Starting subtest: query-regions-sanity-check
[610.108059] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[610.206976] [132/133] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[610.317720] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[616.858067] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.542s)
[616.973686] [133/133] (415s left) gem_mmap_gtt (ptrace)
[617.025682] Subtest ptrace: SKIP (0.000s)
[617.081560] 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.