[57.027344] Initializing watchdogs
[57.027394]   /dev/watchdog0
[57.042192] [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]
[57.047025] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.049810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.053380] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[57.179819] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[60.959457] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.785s)
[62.111646] [002/133] (955s left) gem_exec_async (concurrent-writes)
[62.176804] Starting subtest: concurrent-writes
[62.179140] Starting dynamic subtest: rcs0
[62.191258] Dynamic subtest rcs0: SUCCESS (0.017s)
[62.203446] Starting dynamic subtest: bcs0
[62.205609] Dynamic subtest bcs0: SUCCESS (0.008s)
[62.213454] Starting dynamic subtest: vcs0
[62.215711] Dynamic subtest vcs0: SUCCESS (0.006s)
[62.222988] Starting dynamic subtest: vcs1
[62.224853] Dynamic subtest vcs1: SUCCESS (0.007s)
[62.232790] Starting dynamic subtest: vecs0
[62.234680] Dynamic subtest vecs0: SUCCESS (0.007s)
[62.241251] Starting dynamic subtest: ccs0
[62.243161] Dynamic subtest ccs0: SUCCESS (0.006s)
[62.244988] Subtest concurrent-writes: SUCCESS (0.053s)
[62.461044] [003/133] (955s left) kms_psr (pr-primary-blt)
[62.559636] Starting subtest: pr-primary-blt
[62.564104] Subtest pr-primary-blt: SKIP (0.000s)
[62.628386] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[63.010489] Subtest dp-crc-fast: SKIP (0.000s)
[63.807889] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[63.985619] Starting subtest: pi-shared-iova
[63.987802] Starting dynamic subtest: rcs0
[64.059283] Dynamic subtest rcs0: SUCCESS (0.077s)
[64.068061] Starting dynamic subtest: vcs0
[64.124564] Dynamic subtest vcs0: SUCCESS (0.065s)
[64.134191] Starting dynamic subtest: vcs1
[64.183798] Dynamic subtest vcs1: SUCCESS (0.059s)
[64.194997] Starting dynamic subtest: vecs0
[64.235589] Dynamic subtest vecs0: SUCCESS (0.052s)
[64.246661] Starting dynamic subtest: ccs0
[64.291994] Dynamic subtest ccs0: SUCCESS (0.056s)
[64.294785] Subtest pi-shared-iova: SUCCESS (0.310s)
[66.035504] [006/133] (951s left) kms_busy (basic-hang)
[66.139211] Starting subtest: basic-hang
[66.141184] Starting dynamic subtest: flip-pipe-A
[66.765817] Dynamic subtest flip-pipe-A: SUCCESS (0.627s)
[66.775638] Starting dynamic subtest: modeset-pipe-A
[70.168405] Dynamic subtest modeset-pipe-A: SUCCESS (3.401s)
[70.177468] Starting dynamic subtest: flip-pipe-D
[71.360487] Dynamic subtest flip-pipe-D: SUCCESS (1.190s)
[71.368398] Starting dynamic subtest: modeset-pipe-D
[74.803088] Dynamic subtest modeset-pipe-D: SUCCESS (3.443s)
[74.805263] Subtest basic-hang: SUCCESS (8.666s)
[75.609714] [007/133] (942s left) kms_flip (basic-flip-vs-dpms)
[75.724229] Starting subtest: basic-flip-vs-dpms
[75.726669] Starting dynamic subtest: A-eDP1
[78.306121] Dynamic subtest A-eDP1: SUCCESS (2.584s)
[78.315070] Starting dynamic subtest: B-eDP1
[80.477758] Dynamic subtest B-eDP1: SUCCESS (2.170s)
[80.485758] Starting dynamic subtest: C-eDP1
[82.546589] Dynamic subtest C-eDP1: SUCCESS (2.065s)
[82.556100] Starting dynamic subtest: D-eDP1
[84.621429] Dynamic subtest D-eDP1: SUCCESS (2.073s)
[84.623458] Subtest basic-flip-vs-dpms: SUCCESS (8.903s)
[85.440560] [008/133] (932s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[85.539434] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[85.541843] Starting dynamic subtest: pipe-A-default-mode
[88.244609] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[88.246683] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.706s)
[89.115571] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[89.172762] Subtest non-threaded: SKIP (0.000s)
[89.223834] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[89.320676] Starting subtest: invalid-plane
[89.323032] Starting dynamic subtest: zero-id
[89.325286] Dynamic subtest zero-id: SUCCESS (0.000s)
[89.334093] Starting dynamic subtest: outrange-id
[89.335963] Dynamic subtest outrange-id: SUCCESS (0.000s)
[89.337904] Subtest invalid-plane: SUCCESS (0.001s)
[89.389495] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[89.449027] Subtest write-wc-read-gtt: SKIP (0.000s)
[89.505607] [012/133] (928s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[89.570287] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[89.639909] [013/133] (928s left) kms_big_fb (linear-32bpp-rotate-0)
[89.746110] Starting subtest: linear-32bpp-rotate-0
[91.314826] Subtest linear-32bpp-rotate-0: SUCCESS (1.568s)
[91.446795] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[91.497263] Subtest bb-start-far: SKIP (0.000s)
[91.554392] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[91.685304] Starting subtest: cursorB-vs-flipA-varying-size
[91.689190] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[91.858226] [016/133] (926s left) gem_lmem_swapping (verify)
[91.912798] Subtest verify: SKIP (0.000s)
[91.958381] [017/133] (926s left) gem_userptr_blits (mmap-offset-banned)
[92.019471] Starting subtest: mmap-offset-banned
[92.021500] Starting dynamic subtest: wb
[92.023143] Dynamic subtest wb: SUCCESS (0.000s)
[92.032336] Starting dynamic subtest: wc
[92.034152] Dynamic subtest wc: SUCCESS (0.000s)
[92.041158] Starting dynamic subtest: uc
[92.042923] Dynamic subtest uc: SUCCESS (0.000s)
[92.044787] Subtest mmap-offset-banned: SUCCESS (0.001s)
[92.157283] [018/133] (926s left) gem_softpin (evict-snoop-interruptible)
[92.220395] Starting subtest: evict-snoop-interruptible
[92.224109] Subtest evict-snoop-interruptible: SKIP (0.000s)
[92.347179] [019/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process)
[92.406974] Starting subtest: legacy-engines-mixed-process
[92.408753] Starting dynamic subtest: render
[93.914687] Dynamic subtest render: SUCCESS (1.510s)
[93.925151] Starting dynamic subtest: bsd1
[95.902653] Dynamic subtest bsd1: SUCCESS (1.986s)
[95.913100] Starting dynamic subtest: bsd2
[97.925448] Dynamic subtest bsd2: SUCCESS (2.018s)
[97.935222] Starting dynamic subtest: blt
[99.876261] Dynamic subtest blt: SUCCESS (1.953s)
[99.887171] Starting dynamic subtest: vebox
[101.921898] Dynamic subtest vebox: SUCCESS (2.044s)
[101.924367] Subtest legacy-engines-mixed-process: SUCCESS (9.518s)
[102.005133] [020/133] (916s left) gem_eio (hibernate)
[102.257337] Starting subtest: hibernate
[116.982934] Subtest hibernate: SUCCESS (14.726s)
[126.153610] [021/133] (901s left) i915_pm_rps (fence-order)
[126.247318] Starting subtest: fence-order
[129.318274] Subtest fence-order: SUCCESS (3.073s)
[129.447269] [022/133] (898s left) kms_vblank (ts-continuation-idle-hang)
[129.554589] Starting subtest: ts-continuation-idle-hang
[129.557077] Starting dynamic subtest: pipe-A-eDP-1
[155.677329] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.120s)
[155.692506] Starting dynamic subtest: pipe-D-eDP-1
[180.706046] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[180.708265] Subtest ts-continuation-idle-hang: SUCCESS (51.148s)
[181.525769] [023/133] (845s left) perf (unprivileged-single-ctx-counters)
[181.656902] Starting subtest: unprivileged-single-ctx-counters
[181.660602] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[181.696973] [024/133] (845s left) kms_frontbuffer_tracking (fbc-tiling-4)
[181.809155] Starting subtest: fbc-tiling-4
[186.111040] Subtest fbc-tiling-4: SUCCESS (4.304s)
[187.248912] [025/133] (840s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[187.359892] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[194.045151] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.688s)
[194.159512] [026/133] (833s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[194.258923] Starting subtest: crc-primary-suspend-y-tiled-ccs
[194.261171] Starting dynamic subtest: pipe-A-eDP-1
[194.269951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.281300] Starting dynamic subtest: pipe-B-eDP-1
[194.290070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.299675] Starting dynamic subtest: pipe-C-eDP-1
[194.307818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.316798] Starting dynamic subtest: pipe-D-eDP-1
[194.324817] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.328694] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[196.447799] [027/133] (831s left) gem_spin_batch (engines)
[196.533724] Starting subtest: engines
[196.536031] Starting dynamic subtest: rcs0
[199.773822] Dynamic subtest rcs0: SUCCESS (3.235s)
[199.785790] Starting dynamic subtest: bcs0
[203.016837] Dynamic subtest bcs0: SUCCESS (3.237s)
[203.028510] Starting dynamic subtest: vcs0
[206.253026] Dynamic subtest vcs0: SUCCESS (3.235s)
[206.265676] Starting dynamic subtest: vcs1
[209.493448] Dynamic subtest vcs1: SUCCESS (3.238s)
[209.505239] Starting dynamic subtest: vecs0
[212.732772] Dynamic subtest vecs0: SUCCESS (3.237s)
[212.744840] Starting dynamic subtest: ccs0
[215.971192] Dynamic subtest ccs0: SUCCESS (3.236s)
[215.973614] Subtest engines: SUCCESS (19.434s)
[216.239947] [028/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[216.349380] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[223.452075] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.106s)
[223.587379] [029/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[223.680561] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[223.684892] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[223.789908] [030/133] (804s left) gem_partial_pwrite_pread (reads-snoop)
[223.851215] Subtest reads-snoop: SKIP (0.000s)
[223.927927] [031/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[224.033723] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[225.044579] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.011s)
[225.186632] [032/133] (802s left) kms_getfb (getfb-reject-nv12)
[225.283239] Starting subtest: getfb-reject-nv12
[225.285195] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[225.387549] [033/133] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[225.489103] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[229.811868] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.325s)
[230.994940] [034/133] (797s left) perf_pmu (render-node-busy-idle)
[231.099852] Starting subtest: render-node-busy-idle
[231.102426] Starting dynamic subtest: rcs0
[231.794912] Dynamic subtest rcs0: SUCCESS (0.697s)
[231.808121] Starting dynamic subtest: bcs0
[232.461779] Dynamic subtest bcs0: SUCCESS (0.665s)
[232.476775] Starting dynamic subtest: vcs0
[233.940575] Dynamic subtest vcs0: SUCCESS (1.475s)
[233.952192] Starting dynamic subtest: vcs1
[235.925278] Dynamic subtest vcs1: SUCCESS (1.982s)
[235.937420] Starting dynamic subtest: vecs0
[237.908702] Dynamic subtest vecs0: SUCCESS (1.980s)
[237.928155] Starting dynamic subtest: ccs0
[238.579250] Dynamic subtest ccs0: SUCCESS (0.669s)
[238.581854] Subtest render-node-busy-idle: SUCCESS (7.483s)
[238.654843] [035/133] (789s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[238.764956] Starting subtest: yf-tiled-16bpp-rotate-90
[238.769410] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[238.877680] [036/133] (789s left) kms_content_protection (atomic)
[239.016587] Starting subtest: atomic
[239.021252] Subtest atomic: SKIP (0.000s)
[239.160741] [037/133] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[239.269977] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[239.274222] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[239.369894] [038/133] (788s left) kms_pm_rpm (fences-dpms)
[241.091271] Starting subtest: fences-dpms
[241.096942] Subtest fences-dpms: SKIP (0.000s)
[241.630994] [039/133] (786s left) gem_mmap_gtt (basic-write-read)
[241.699944] Subtest basic-write-read: SKIP (0.000s)
[241.756560] [040/133] (786s left) gem_exec_reloc (basic-write-cpu-active)
[241.816776] Subtest basic-write-cpu-active: SKIP (0.000s)
[241.885749] [041/133] (786s left) gem_eio (unwedge-stress)
[242.089693] Starting subtest: unwedge-stress
[242.091769] Starting dynamic subtest: render
[246.486046] Dynamic subtest render: SUCCESS (4.395s)
[246.501265] Starting dynamic subtest: bsd1
[264.321706] Dynamic subtest bsd1: SUCCESS (17.834s)
[264.338788] Starting dynamic subtest: bsd2
[282.363580] Dynamic subtest bsd2: SUCCESS (18.042s)
[282.379404] Starting dynamic subtest: blt
[282.383634] Dynamic subtest blt: SKIP (0.000s)
[282.392976] Starting dynamic subtest: vebox
[300.342919] Dynamic subtest vebox: SUCCESS (17.977s)
[300.345289] Subtest unwedge-stress: SUCCESS (58.251s)
[301.956249] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[301.959621] [042/133] (726s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[302.067368] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[302.071877] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[302.155995] [043/133] (726s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[302.251200] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[302.253423] Starting dynamic subtest: pipe-A-default-mode
[304.965111] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[304.967419] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.713s)
[305.797318] [044/133] (722s left) gem_exec_store (pages)
[305.870857] Starting subtest: pages
[305.873242] Starting dynamic subtest: rcs0
[305.963785] Dynamic subtest rcs0: SUCCESS (0.096s)
[305.976207] Starting dynamic subtest: bcs0
[306.044075] Dynamic subtest bcs0: SUCCESS (0.079s)
[306.056250] Starting dynamic subtest: vcs0
[306.120036] Dynamic subtest vcs0: SUCCESS (0.075s)
[306.134912] Starting dynamic subtest: vcs1
[306.198154] Dynamic subtest vcs1: SUCCESS (0.076s)
[306.211508] Starting dynamic subtest: vecs0
[306.277943] Dynamic subtest vecs0: SUCCESS (0.078s)
[306.289637] Starting dynamic subtest: ccs0
[306.353383] Dynamic subtest ccs0: SUCCESS (0.074s)
[306.355727] Subtest pages: SUCCESS (0.486s)
[306.536939] [045/133] (721s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[306.637396] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[306.642068] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[306.718324] [046/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[306.820574] Starting subtest: psr-1p-primscrn-cur-indfb-move
[314.252169] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.434s)
[314.402955] [047/133] (714s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[314.503887] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[314.506146] Starting dynamic subtest: pipe-A-eDP-1
[314.529514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[314.541908] Starting dynamic subtest: pipe-B-eDP-1
[314.563419] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[314.573167] Starting dynamic subtest: pipe-C-eDP-1
[314.594775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[314.604212] Starting dynamic subtest: pipe-D-eDP-1
[314.626152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[314.630193] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[316.795641] [048/133] (711s left) kms_pm_rpm (basic-rte)
[316.833956] Starting subtest: basic-rte
[320.599534] Subtest basic-rte: SUCCESS (3.768s)
[322.419408] [049/133] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[322.519042] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[322.523275] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[322.610726] [050/133] (706s left) gem_exec_schedule (submit-golden-slice)
[322.693359] Starting subtest: submit-golden-slice
[322.695642] Starting dynamic subtest: rcs0
[322.723260] Dynamic subtest rcs0: SUCCESS (0.036s)
[322.735637] Starting dynamic subtest: bcs0
[322.758651] Dynamic subtest bcs0: SUCCESS (0.035s)
[322.768762] Starting dynamic subtest: vcs0
[322.795425] Dynamic subtest vcs0: SUCCESS (0.035s)
[322.806242] Starting dynamic subtest: vcs1
[322.831116] Dynamic subtest vcs1: SUCCESS (0.035s)
[322.841655] Starting dynamic subtest: vecs0
[322.868409] Dynamic subtest vecs0: SUCCESS (0.037s)
[322.878869] Starting dynamic subtest: ccs0
[322.906085] Dynamic subtest ccs0: SUCCESS (0.037s)
[322.908354] Subtest submit-golden-slice: SUCCESS (0.220s)
[324.010512] [051/133] (704s left) kms_async_flips (async-flip-hang)
[324.120794] Starting subtest: async-flip-hang
[324.496333] Starting dynamic subtest: pipe-A-eDP-1
[339.377345] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.881s)
[339.750654] Starting dynamic subtest: pipe-B-eDP-1
[355.378068] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.633s)
[355.765477] Starting dynamic subtest: pipe-C-eDP-1
[371.374831] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.614s)
[371.750335] Starting dynamic subtest: pipe-D-eDP-1
[387.372797] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.629s)
[387.375599] Subtest async-flip-hang: SUCCESS (63.253s)
[388.545251] [052/133] (640s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[388.776046] Starting subtest: cursor-rapid-movement-128x128
[388.780924] Starting dynamic subtest: pipe-A-eDP-1
[389.323085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[389.354406] Starting dynamic subtest: pipe-D-eDP-1
[390.563184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[390.565406] Subtest cursor-rapid-movement-128x128: SUCCESS (1.786s)
[391.428793] [053/133] (637s left) syncobj_timeline (invalid-query-bad-pad)
[391.494664] Starting subtest: invalid-query-bad-pad
[391.496828] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[391.583633] [054/133] (637s left) kms_tiled_display (basic-test-pattern)
[391.700456] Subtest basic-test-pattern: SKIP (0.000s)
[391.752840] [055/133] (637s left) perf (gen12-invalid-class-instance)
[391.841106] Starting subtest: gen12-invalid-class-instance
[391.856448] Subtest gen12-invalid-class-instance: SUCCESS (0.015s)
[391.905970] [056/133] (637s left) kms_invalid_mode (uint-max-clock)
[391.997941] Starting subtest: uint-max-clock
[392.000203] Starting dynamic subtest: pipe-A-eDP-1
[392.285470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[392.295988] Starting dynamic subtest: pipe-B-eDP-1
[392.297928] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[392.307658] Starting dynamic subtest: pipe-C-eDP-1
[392.309932] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[392.321697] Starting dynamic subtest: pipe-D-eDP-1
[392.323832] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[392.326092] Subtest uint-max-clock: SUCCESS (0.295s)
[393.144371] [057/133] (635s left) kms_psr (fbc-psr-cursor-plane-move)
[393.246786] Starting subtest: fbc-psr-cursor-plane-move
[393.248981] Starting dynamic subtest: eDP-1
[393.253018] Dynamic subtest eDP-1: SKIP (0.000s)
[393.256978] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[393.322325] [058/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[393.421959] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[393.426128] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[393.541908] [059/133] (635s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[393.664247] Starting subtest: cursorB-vs-flipB-varying-size
[393.670599] Subtest cursorB-vs-flipB-varying-size: SKIP (0.003s)
[393.846739] [060/133] (635s left) gem_exec_reloc (basic-gtt)
[393.908745] Subtest basic-gtt: SKIP (0.000s)
[393.986863] [061/133] (635s left) gem_lmem_swapping (basic)
[394.032913] Subtest basic: SKIP (0.000s)
[394.082590] [062/133] (635s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[394.198649] Starting subtest: basic-flip-before-cursor-varying-size
[395.129958] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[395.969692] [063/133] (633s left) kms_cursor_crc (cursor-onscreen-512x512)
[396.258910] Starting subtest: cursor-onscreen-512x512
[396.263344] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[396.414918] [064/133] (632s left) gem_exec_params (larger-than-life-batch)
[396.469246] Starting subtest: larger-than-life-batch
[398.681583] Subtest larger-than-life-batch: SUCCESS (2.211s)
[399.943459] [065/133] (629s left) gem_close_race (multigpu-basic-process)
[400.060752] Starting subtest: multigpu-basic-process
[400.065212] Subtest multigpu-basic-process: SKIP (0.000s)
[400.283565] [066/133] (629s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[400.416967] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[401.839829] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.424s)
[402.641227] [067/133] (626s left) kms_feature_discovery (display-4x)
[402.734979] Starting subtest: display-4x
[402.739277] Subtest display-4x: SKIP (0.000s)
[402.811172] [068/133] (626s left) prime_mmap (test_refcounting)
[402.866020] Starting subtest: test_refcounting
[402.868205] Starting dynamic subtest: test_refcounting-smem
[402.896322] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[402.898859] Subtest test_refcounting: SUCCESS (0.034s)
[402.987764] [069/133] (626s left) kms_dp_aux_dev (basic)
[403.042092] Starting subtest: basic
[403.263948] Subtest basic: SUCCESS (0.222s)
[403.337669] [070/133] (626s left) syncobj_wait (invalid-reset-one-illegal-handle)
[403.396820] Starting subtest: invalid-reset-one-illegal-handle
[403.399208] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[403.496920] [071/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[403.584203] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[403.588126] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[403.682416] [072/133] (625s left) gem_exec_reloc (basic-cpu)
[403.741038] Subtest basic-cpu: SKIP (0.000s)
[403.804496] [073/133] (625s left) gem_exec_balancer (sliced)
[403.865710] Starting subtest: sliced
[403.869969] Subtest sliced: SKIP (0.000s)
[404.155157] [074/133] (625s left) kms_plane_scaling (2x-scaler-multi-pipe)
[404.254986] Starting subtest: 2x-scaler-multi-pipe
[404.259251] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[404.349046] [075/133] (625s left) gem_ctx_persistence (engines-hang)
[404.407852] Starting subtest: engines-hang
[404.409722] Starting dynamic subtest: rcs0
[404.515763] Dynamic subtest rcs0: SUCCESS (0.110s)
[404.529280] Starting dynamic subtest: bcs0
[404.630677] Dynamic subtest bcs0: SUCCESS (0.113s)
[404.644149] Starting dynamic subtest: vcs0
[404.719740] Dynamic subtest vcs0: SUCCESS (0.087s)
[404.732532] Starting dynamic subtest: vcs1
[404.811845] Dynamic subtest vcs1: SUCCESS (0.090s)
[404.825269] Starting dynamic subtest: vecs0
[404.901718] Dynamic subtest vecs0: SUCCESS (0.088s)
[404.914752] Starting dynamic subtest: ccs0
[404.995799] Dynamic subtest ccs0: SUCCESS (0.092s)
[404.998528] Subtest engines-hang: SUCCESS (0.591s)
[405.093752] [076/133] (624s left) core_setmaster (master-drop-set-root)
[405.183635] Starting subtest: master-drop-set-root
[405.195032] Subtest master-drop-set-root: SUCCESS (0.009s)
[405.246086] [077/133] (624s left) gem_exec_flush (basic-uc-pro-default)
[405.303968] Starting subtest: basic-uc-pro-default
[410.767967] Subtest basic-uc-pro-default: SUCCESS (5.466s)
[410.968588] [078/133] (618s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[411.064385] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[411.068773] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[411.157909] [079/133] (618s left) gem_userptr_blits (forbidden-operations)
[411.236981] Starting subtest: forbidden-operations
[411.241047] Subtest forbidden-operations: SKIP (0.000s)
[411.362039] [080/133] (618s left) core_getclient (basic)
[411.414361] Starting subtest: basic
[411.416297] Subtest basic: SUCCESS (0.000s)
[411.508464] [081/133] (618s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[411.605448] Starting subtest: fbc-pr-sprite-mmap-gtt
[411.609585] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[411.678691] [082/133] (618s left) kms_flip (2x-plain-flip-fb-recreate)
[411.765755] Starting subtest: 2x-plain-flip-fb-recreate
[411.775237] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[411.892428] [083/133] (618s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[411.996543] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[412.000464] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[413.163968] [084/133] (616s left) syncobj_timeline (wait-all-delayed-signal)
[413.216793] Starting subtest: wait-all-delayed-signal
[413.322265] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[413.400216] [085/133] (616s left) gem_render_copy (linear-to-vebox-yf-tiled)
[413.461646] Starting subtest: linear-to-vebox-yf-tiled
[413.466351] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[413.645263] [086/133] (616s left) kms_cursor_crc (cursor-tearing-position-change)
[413.759398] Starting subtest: cursor-tearing-position-change
[413.761852] Starting dynamic subtest: pipe-A-eDP-1
[414.337081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[414.349522] Starting dynamic subtest: pipe-D-eDP-1
[415.609602] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[415.611914] Subtest cursor-tearing-position-change: SUCCESS (1.849s)
[416.432979] [087/133] (613s left) syncobj_timeline (wait-for-submit-delayed-submit)
[416.484054] Starting subtest: wait-for-submit-delayed-submit
[416.588338] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[416.667402] [088/133] (613s left) gem_exec_params (invalid-ring)
[416.723638] Starting subtest: invalid-ring
[416.726159] Subtest invalid-ring: SUCCESS (0.000s)
[416.835907] [089/133] (613s left) gem_tiled_blits (interruptible)
[416.896585] Subtest interruptible: SKIP (0.000s)
[416.978230] [090/133] (613s left) gem_eio (banned)
[417.209209] Starting subtest: banned
[417.848342] Subtest banned: SUCCESS (0.641s)
[418.013507] [091/133] (612s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[418.114543] Starting subtest: plane-primary-overlay-mutable-zpos
[421.559079] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.442s)
[422.752424] [092/133] (607s left) kms_psr (fbc-pr-dpms)
[422.849905] Starting subtest: fbc-pr-dpms
[422.854156] Subtest fbc-pr-dpms: SKIP (0.000s)
[422.923926] [093/133] (607s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[423.026201] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[423.030296] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[423.098136] [094/133] (607s left) kms_plane_alpha_blend (alpha-transparent-fb)
[423.187974] Starting subtest: alpha-transparent-fb
[423.477769] Starting dynamic subtest: pipe-A-eDP-1
[424.124904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[424.137229] Starting dynamic subtest: pipe-D-eDP-1
[425.476333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[425.478645] Subtest alpha-transparent-fb: SUCCESS (2.289s)
[426.299376] [095/133] (604s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[426.393730] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[426.396062] Starting dynamic subtest: pipe-A
[427.441481] Dynamic subtest pipe-A: SUCCESS (1.050s)
[427.451907] Starting dynamic subtest: pipe-B
[429.604502] Dynamic subtest pipe-B: SUCCESS (2.161s)
[429.614940] Starting dynamic subtest: pipe-C
[430.802419] Dynamic subtest pipe-C: SUCCESS (1.197s)
[430.813219] Starting dynamic subtest: pipe-D
[431.967598] Dynamic subtest pipe-D: SUCCESS (1.160s)
[431.970250] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.573s)
[433.147846] [096/133] (597s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[433.239986] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[433.242327] Starting dynamic subtest: pipe-A-eDP-1
[433.534467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.262s)
[433.547417] Starting dynamic subtest: pipe-B-eDP-1
[434.837268] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[434.848477] Starting dynamic subtest: pipe-C-eDP-1
[436.114131] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[436.125134] Starting dynamic subtest: pipe-D-eDP-1
[437.372161] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[437.374066] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.105s)
[438.563565] [097/133] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[438.657968] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[438.662689] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[438.751076] [098/133] (591s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[438.843697] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[438.848071] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[438.920664] [099/133] (591s left) kms_flip (blocking-absolute-wf_vblank)
[439.022354] Starting subtest: blocking-absolute-wf_vblank
[439.024744] Starting dynamic subtest: A-eDP1
[447.723915] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[447.740081] Starting dynamic subtest: B-eDP1
[456.460168] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[456.481069] Starting dynamic subtest: C-eDP1
[465.180664] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[465.191723] Starting dynamic subtest: D-eDP1
[473.921818] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[473.926889] Subtest blocking-absolute-wf_vblank: SUCCESS (34.905s)
[475.138422] [100/133] (555s left) tools_test (sysfs_l3_parity)
[475.196062] Starting subtest: sysfs_l3_parity
[475.264712] Subtest sysfs_l3_parity: SKIP (0.081s)
[475.336375] [101/133] (555s left) kms_psr (psr-sprite-plane-onoff)
[475.433989] Starting subtest: psr-sprite-plane-onoff
[475.436309] Starting dynamic subtest: eDP-1
[477.181820] Dynamic subtest eDP-1: SUCCESS (1.748s)
[477.184334] Subtest psr-sprite-plane-onoff: SUCCESS (1.749s)
[477.998393] [102/133] (552s left) api_intel_allocator (default-alignment)
[478.058387] Starting subtest: default-alignment
[478.060759] Subtest default-alignment: SUCCESS (0.003s)
[478.173421] [103/133] (552s left) sriov_basic (bind-unbind-vf)
[478.226481] Starting subtest: bind-unbind-vf
[478.228782] Starting dynamic subtest: vf-1
[478.309973] Dynamic subtest vf-1: FAIL (0.031s)
[478.320717] Starting dynamic subtest: vf-2
[478.395212] Dynamic subtest vf-2: FAIL (0.004s)
[478.408032] Starting dynamic subtest: vf-3
[478.482050] Dynamic subtest vf-3: FAIL (0.004s)
[478.493645] Starting dynamic subtest: vf-4
[478.566466] Dynamic subtest vf-4: FAIL (0.004s)
[478.576701] Starting dynamic subtest: vf-5
[478.650595] Dynamic subtest vf-5: FAIL (0.004s)
[478.662076] Starting dynamic subtest: vf-6
[478.735472] Dynamic subtest vf-6: FAIL (0.004s)
[478.747111] Starting dynamic subtest: vf-7
[478.822874] Dynamic subtest vf-7: FAIL (0.004s)
[478.834205] Starting dynamic subtest: vf-random
[478.906336] Dynamic subtest vf-random: FAIL (0.004s)
[478.918279] Starting dynamic subtest: vf-last
[478.980453] Dynamic subtest vf-last: FAIL (0.524s)
[478.982183] Subtest bind-unbind-vf: FAIL (0.589s)
[479.020022] [104/133] (551s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[479.093392] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[479.200705] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[479.278725] [105/133] (551s left) perf_pmu (rc6)
[479.321441] Starting subtest: rc6
[479.323690] Starting dynamic subtest: gt0
[485.698302] Dynamic subtest gt0: SUCCESS (6.374s)
[485.715054] Starting dynamic subtest: runtime-pm-gt0
[493.464516] Dynamic subtest runtime-pm-gt0: SUCCESS (7.766s)
[493.478026] Starting dynamic subtest: runtime-pm-long-gt0
[505.948814] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.481s)
[505.962320] Starting dynamic subtest: other-idle-gt0
[512.294128] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[512.307751] Starting dynamic subtest: gt1
[518.636918] Dynamic subtest gt1: SUCCESS (6.340s)
[518.651602] Starting dynamic subtest: runtime-pm-gt1
[526.087527] Dynamic subtest runtime-pm-gt1: SUCCESS (7.448s)
[526.100979] Starting dynamic subtest: runtime-pm-long-gt1
[538.568491] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.478s)
[538.582964] Starting dynamic subtest: other-idle-gt1
[544.912331] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[544.915174] Subtest rc6: SUCCESS (65.592s)
[546.068991] [106/133] (485s left) gem_exec_fence (syncobj-timeline-repeat)
[546.648494] Starting subtest: syncobj-timeline-repeat
[546.888471] Subtest syncobj-timeline-repeat: SUCCESS (0.240s)
[547.980223] [107/133] (483s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[548.092263] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[552.966107] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.879s)
[554.136968] [108/133] (477s left) kms_color (legacy-gamma-reset)
[554.226361] Starting subtest: legacy-gamma-reset
[554.228777] Starting dynamic subtest: pipe-A-eDP-1
[554.616756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[554.627735] Starting dynamic subtest: pipe-B-eDP-1
[554.632254] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[554.642866] Starting dynamic subtest: pipe-C-eDP-1
[554.645132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[554.655655] Starting dynamic subtest: pipe-D-eDP-1
[554.657794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[554.660051] Subtest legacy-gamma-reset: SUCCESS (0.432s)
[555.463313] [109/133] (475s left) gem_exec_balancer (indices)
[555.528337] Starting subtest: indices
[557.874960] Subtest indices: SUCCESS (2.346s)
[558.159510] [110/133] (473s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[558.223478] Starting subtest: yf-tiled-to-vebox-yf-tiled
[558.228353] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[558.386012] [111/133] (472s left) gem_barrier_race (remote-request)
[558.456297] Starting subtest: remote-request
[558.458589] Starting dynamic subtest: rcs0
[563.612026] Dynamic subtest rcs0: SUCCESS (5.147s)
[563.614643] Subtest remote-request: SUCCESS (5.149s)
[563.713312] [112/133] (467s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[563.769059] Starting subtest: etime-multi-wait-for-submit-submitted
[563.873766] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[563.928633] [113/133] (467s left) syncobj_timeline (multi-wait-signaled)
[563.976290] Starting subtest: multi-wait-signaled
[563.978616] Subtest multi-wait-signaled: SUCCESS (0.000s)
[564.050946] [114/133] (467s left) kms_chamelium_hpd (vga-hpd-fast)
[564.436338] Subtest vga-hpd-fast: SKIP (0.000s)
[565.285799] [115/133] (466s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[565.385569] Starting subtest: fbc-modesetfrombusy
[569.157286] Subtest fbc-modesetfrombusy: SUCCESS (3.775s)
[570.307893] [116/133] (461s left) kms_psr (psr-cursor-plane-onoff)
[570.408251] Starting subtest: psr-cursor-plane-onoff
[570.410635] Starting dynamic subtest: eDP-1
[572.133331] Dynamic subtest eDP-1: SUCCESS (1.724s)
[572.135689] Subtest psr-cursor-plane-onoff: SUCCESS (1.725s)
[572.968455] [117/133] (458s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[573.070088] Starting subtest: y-tiled-32bpp-rotate-90
[573.074758] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[573.158629] [118/133] (458s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[573.255750] Starting subtest: psr-rgb565-draw-mmap-gtt
[573.259944] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[573.327427] [119/133] (458s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[573.432664] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[573.436655] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[573.508838] [120/133] (458s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[573.607220] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[573.609577] Starting dynamic subtest: pipe-A-eDP-1
[573.630718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[573.643357] Starting dynamic subtest: pipe-B-eDP-1
[573.662330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[573.675749] Starting dynamic subtest: pipe-C-eDP-1
[573.703580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[573.713863] Starting dynamic subtest: pipe-D-eDP-1
[573.733238] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[573.735162] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.009s)
[575.823202] [121/133] (455s left) kms_plane_multiple (2x-tiling-none)
[575.916591] Starting subtest: 2x-tiling-none
[575.920853] Subtest 2x-tiling-none: SKIP (0.000s)
[575.991301] [122/133] (455s left) syncobj_wait (wait-any-interrupted)
[576.048574] Starting subtest: wait-any-interrupted
[576.150929] Subtest wait-any-interrupted: SUCCESS (0.102s)
[576.209062] [123/133] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[576.307781] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[576.312282] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[576.394533] [124/133] (455s left) i915_hangman (engine-error-state-capture)
[576.455790] Starting subtest: engine-error-state-capture
[576.458035] Starting dynamic subtest: rcs0
[579.892048] Dynamic subtest rcs0: SUCCESS (3.434s)
[579.905442] Starting dynamic subtest: bcs0
[585.843667] Dynamic subtest bcs0: SUCCESS (5.948s)
[585.858659] Starting dynamic subtest: vcs0
[591.794359] Dynamic subtest vcs0: SUCCESS (5.948s)
[591.808283] Starting dynamic subtest: vcs1
[596.852058] Dynamic subtest vcs1: SUCCESS (5.055s)
[596.864997] Starting dynamic subtest: vecs0
[602.867888] Dynamic subtest vecs0: SUCCESS (6.013s)
[602.881978] Starting dynamic subtest: ccs0
[608.883985] Dynamic subtest ccs0: SUCCESS (6.013s)
[608.887046] Subtest engine-error-state-capture: SUCCESS (32.428s)
[608.944871] [125/133] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[609.042767] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[609.046795] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[609.101171] [126/133] (422s left) i915_drm_fdinfo (virtual-busy)
[609.145723] Starting subtest: virtual-busy
[609.149633] Subtest virtual-busy: SKIP (0.000s)
[609.196501] [127/133] (422s left) gem_ctx_param (invalid-param-set)
[609.251104] Starting subtest: invalid-param-set
[609.253526] Subtest invalid-param-set: SUCCESS (0.000s)
[609.306787] [128/133] (422s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[609.421291] Starting subtest: short-flip-after-cursor-atomic-transitions
[610.383049] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.960s)
[611.172459] [129/133] (420s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[611.225716] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[611.328343] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[611.382666] [130/133] (420s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[611.479308] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[611.481568] Starting dynamic subtest: pipe-A-eDP-1
[611.565577] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[611.577044] Starting dynamic subtest: pipe-B-eDP-1
[612.685264] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[612.690085] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.210s)
[613.853942] [131/133] (418s left) i915_query (query-regions-sanity-check)
[613.909678] Starting subtest: query-regions-sanity-check
[613.917290] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[614.038751] [132/133] (418s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[614.143316] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[620.729549] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.589s)
[620.820718] [133/133] (411s left) gem_mmap_gtt (ptrace)
[620.879838] Subtest ptrace: SKIP (0.000s)
[620.942256] 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.