[65.988146] Initializing watchdogs
[65.988242]   /dev/watchdog0
[66.003500] [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]
[66.007833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.009833] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.011709] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[66.112096] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[66.113082] Starting dynamic subtest: pipe-A-eDP-1
[66.121061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[66.127237] Starting dynamic subtest: pipe-B-eDP-1
[66.134859] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[66.140293] Starting dynamic subtest: pipe-C-eDP-1
[66.148058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[66.153265] Starting dynamic subtest: pipe-D-eDP-1
[66.160500] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[66.161315] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[68.268891] [002/130] (958s left) gem_fence_thrash (bo-write-verify-x)
[68.295589] Starting subtest: bo-write-verify-x
[68.320094] Subtest bo-write-verify-x: SKIP (0.023s)
[68.384549] [003/130] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[68.477842] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[75.757349] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.293s)
[75.906671] [004/130] (950s left) gem_exec_parallel (contexts)
[75.959862] Starting subtest: contexts
[75.960856] Starting dynamic subtest: rcs0
[78.796461] Dynamic subtest rcs0: SUCCESS (2.837s)
[78.806065] Starting dynamic subtest: bcs0
[82.293076] Dynamic subtest bcs0: SUCCESS (3.493s)
[82.302332] Starting dynamic subtest: vcs0
[86.372698] Dynamic subtest vcs0: SUCCESS (4.077s)
[86.381360] Starting dynamic subtest: vcs1
[90.468253] Dynamic subtest vcs1: SUCCESS (4.094s)
[90.476644] Starting dynamic subtest: vecs0
[94.450402] Dynamic subtest vecs0: SUCCESS (3.981s)
[94.457614] Starting dynamic subtest: ccs0
[98.301232] Dynamic subtest ccs0: SUCCESS (3.850s)
[98.302573] Subtest contexts: SUCCESS (22.337s)
[98.505069] [005/130] (928s left) gem_wait (invalid-buf)
[98.566910] Starting subtest: invalid-buf
[98.567906] Subtest invalid-buf: SUCCESS (0.000s)
[98.783915] [006/130] (927s left) gem_tiled_wb
[98.900183] [007/130] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[98.993531] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[102.594650] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.601s)
[103.788402] [008/130] (922s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[103.896477] Starting subtest: x-tiled-8bpp-rotate-90
[103.917187] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[104.070229] [009/130] (922s left) i915_drm_fdinfo (most-busy-idle-check-all)
[104.105803] Starting subtest: most-busy-idle-check-all
[104.106725] Starting dynamic subtest: rcs0
[104.111428] Dynamic subtest rcs0: SKIP (0.005s)
[104.118610] Starting dynamic subtest: bcs0
[104.120284] Dynamic subtest bcs0: SKIP (0.000s)
[104.126417] Starting dynamic subtest: vcs0
[104.128285] Dynamic subtest vcs0: SKIP (0.000s)
[104.135936] Starting dynamic subtest: vcs1
[104.137607] Dynamic subtest vcs1: SKIP (0.001s)
[104.143483] Starting dynamic subtest: vecs0
[104.145166] Dynamic subtest vecs0: SKIP (0.000s)
[104.150959] Starting dynamic subtest: ccs0
[104.152804] Dynamic subtest ccs0: SKIP (0.000s)
[104.154546] Subtest most-busy-idle-check-all: SKIP (0.008s)
[104.187931] [010/130] (922s left) gem_exec_reloc (basic-wc-noreloc)
[104.290434] Subtest basic-wc-noreloc: SKIP (0.000s)
[104.378961] [011/130] (922s left) gem_mmap_offset (blt-coherency)
[104.437438] Starting subtest: blt-coherency
[104.446244] Subtest blt-coherency: SUCCESS (0.010s)
[104.602807] [012/130] (922s left) kms_dp_aux_dev
[104.967727] [013/130] (921s left) gem_exec_params (cliprects-invalid)
[105.024414] Starting subtest: cliprects-invalid
[105.025482] Subtest cliprects-invalid: SUCCESS (0.000s)
[105.146830] [014/130] (921s left) vgem_basic (mmap)
[105.263964] Starting subtest: mmap
[105.273678] Subtest mmap: SUCCESS (0.010s)
[105.345960] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[105.347553] [015/130] (921s left) kms_getfb (getfb-handle-closed)
[105.438073] Starting subtest: getfb-handle-closed
[105.439119] Subtest getfb-handle-closed: SUCCESS (0.000s)
[105.569487] [016/130] (921s left) kms_cursor_crc (cursor-offscreen-max-size)
[105.879146] Starting subtest: cursor-offscreen-max-size
[105.881913] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[106.042566] [017/130] (920s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[106.166303] Starting subtest: cursorB-vs-flipB-varying-size
[106.168056] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[106.348715] [018/130] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[106.448822] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[106.450729] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[106.583403] [019/130] (920s left) kms_big_fb (linear-8bpp-rotate-270)
[106.688984] Starting subtest: linear-8bpp-rotate-270
[106.712571] Subtest linear-8bpp-rotate-270: SKIP (0.023s)
[106.853321] [020/130] (920s left) kms_dp_linktrain_fallback (dp-fallback)
[106.943398] Starting subtest: dp-fallback
[106.946301] Subtest dp-fallback: SKIP (0.000s)
[107.029372] [021/130] (920s left) core_debugfs (read-all-entries)
[107.080257] Starting subtest: read-all-entries
[107.175906] Subtest read-all-entries: SUCCESS (0.097s)
[107.293570] [022/130] (919s left) gem_ctx_param (invalid-get-engines)
[107.349359] Starting subtest: invalid-get-engines
[107.350265] Subtest invalid-get-engines: SUCCESS (0.001s)
[107.476786] [023/130] (919s left) vgem_basic (setversion)
[107.512933] Starting subtest: setversion
[107.514816] Subtest setversion: SUCCESS (0.000s)
[107.586766] [024/130] (919s left) kms_psr (psr-primary-render)
[107.674031] Starting subtest: psr-primary-render
[107.674977] Starting dynamic subtest: eDP-1
[109.361685] Dynamic subtest eDP-1: SUCCESS (1.687s)
[109.362598] Subtest psr-primary-render: SUCCESS (1.687s)
[110.244448] [025/130] (916s left) kms_getfb (getfb-handle-zero)
[110.343363] Starting subtest: getfb-handle-zero
[110.344304] Subtest getfb-handle-zero: SUCCESS (0.000s)
[110.476646] [026/130] (916s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[110.566160] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[110.571877] Starting dynamic subtest: pipe-A-default-mode
[110.866188] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[110.869187] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.294s)
[111.668217] [027/130] (915s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[111.728174] Starting subtest: basic-batch-kernel-default-cmd
[111.729975] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[111.925806] [028/130] (915s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[112.022689] Starting subtest: fbc-farfromfence-mmap-gtt
[112.024479] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[112.152449] [029/130] (915s left) kms_plane_multiple (2x-tiling-4)
[112.245113] Starting subtest: 2x-tiling-4
[112.246952] Subtest 2x-tiling-4: SKIP (0.000s)
[112.333118] [030/130] (915s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[112.423525] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[112.424495] Starting dynamic subtest: pipe-A-eDP-1
[112.591789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.164s)
[112.599897] Starting dynamic subtest: pipe-B-eDP-1
[112.608189] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[112.614817] Starting dynamic subtest: pipe-C-eDP-1
[112.622584] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[112.628812] Starting dynamic subtest: pipe-D-eDP-1
[112.636321] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[112.637175] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.171s)
[114.848617] [031/130] (912s left) gem_eio (in-flight-suspend)
[115.069263] Starting subtest: in-flight-suspend
[161.734218] Subtest in-flight-suspend: SUCCESS (17.211s)
[168.918159] [032/130] (865s left) gen7_exec_parse (bitmasks)
[168.969718] Subtest bitmasks: SKIP (0.000s)
[169.052515] [033/130] (865s left) gem_mmap_gtt (medium-copy-xy)
[169.102019] Subtest medium-copy-XY: SKIP (0.000s)
[169.163732] [034/130] (865s left) kms_chamelium_frames (hdmi-crc-single)
[169.537273] Subtest hdmi-crc-single: SKIP (0.000s)
[170.350595] [035/130] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[170.437502] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[170.439069] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[170.558286] [036/130] (864s left) gem_exec_schedule (timeslicing)
[170.616493] Starting subtest: timeslicing
[170.617407] Starting dynamic subtest: rcs0
[170.633220] Dynamic subtest rcs0: SUCCESS (0.022s)
[170.642592] Starting dynamic subtest: bcs0
[170.652188] Dynamic subtest bcs0: SUCCESS (0.019s)
[170.659578] Starting dynamic subtest: vcs0
[170.672514] Dynamic subtest vcs0: SUCCESS (0.021s)
[170.679877] Starting dynamic subtest: vcs1
[170.691967] Dynamic subtest vcs1: SUCCESS (0.020s)
[170.699365] Starting dynamic subtest: vecs0
[170.710040] Dynamic subtest vecs0: SUCCESS (0.019s)
[170.717492] Starting dynamic subtest: ccs0
[170.729516] Dynamic subtest ccs0: SUCCESS (0.020s)
[170.730460] Subtest timeslicing: SUCCESS (0.123s)
[172.437682] [037/130] (862s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[177.442907] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[177.444694] Starting dynamic subtest: pipe-A-eDP-1
[194.502989] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.183s)
[194.512379] Starting dynamic subtest: pipe-B-eDP-1
[211.625372] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.124s)
[211.626183] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.312s)
[212.445917] [038/130] (822s left) gem_exec_schedule (deep)
[212.631098] Starting subtest: deep
[212.632139] Starting dynamic subtest: rcs0
[217.854057] Dynamic subtest rcs0: SKIP (5.217s)
[217.864341] Starting dynamic subtest: vcs0
[228.855404] Dynamic subtest vcs0: SUCCESS (11.002s)
[228.871615] Starting dynamic subtest: vcs1
[240.813621] Dynamic subtest vcs1: SUCCESS (11.959s)
[240.823571] Starting dynamic subtest: vecs0
[252.595768] Dynamic subtest vecs0: SUCCESS (11.785s)
[252.606130] Starting dynamic subtest: ccs0
[265.570070] Dynamic subtest ccs0: SUCCESS (12.977s)
[265.571768] Subtest deep: SUCCESS (52.944s)
[267.344965] [039/130] (767s left) kms_color (degamma)
[267.450631] Starting subtest: degamma
[267.451616] Starting dynamic subtest: pipe-A-eDP-1
[268.182061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[268.190247] Starting dynamic subtest: pipe-B-eDP-1
[269.628073] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[269.635837] Starting dynamic subtest: pipe-C-eDP-1
[270.991268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[271.000172] Starting dynamic subtest: pipe-D-eDP-1
[272.346241] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[272.347095] Subtest degamma: SUCCESS (4.894s)
[273.175516] [040/130] (761s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[273.289543] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[273.291275] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[273.413541] [041/130] (761s left) gem_eio (banned)
[273.645076] Starting subtest: banned
[274.274664] Subtest banned: SUCCESS (0.630s)
[274.467603] [042/130] (760s left) gem_ppgtt (flink-and-close-vma-leak)
[274.516095] Starting subtest: flink-and-close-vma-leak
[274.559146] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[274.717945] [043/130] (760s left) kms_cursor_crc (cursor-sliding-128x42)
[274.945159] Starting subtest: cursor-sliding-128x42
[274.983932] Subtest cursor-sliding-128x42: SKIP (0.038s)
[275.226626] [044/130] (759s left) kms_atomic_transition (modeset-transition-nonblocking)
[275.311244] Starting subtest: modeset-transition-nonblocking
[275.312075] Starting dynamic subtest: 1x-outputs
[286.365456] Dynamic subtest 1x-outputs: SUCCESS (11.052s)
[286.366859] Subtest modeset-transition-nonblocking: SUCCESS (11.052s)
[287.239637] [045/130] (747s left) kms_plane_alpha_blend (alpha-transparent-fb)
[287.336694] Starting subtest: alpha-transparent-fb
[287.666873] Starting dynamic subtest: pipe-A-eDP-1
[288.320482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s)
[288.333824] Starting dynamic subtest: pipe-D-eDP-1
[289.650244] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[289.651210] Subtest alpha-transparent-fb: SUCCESS (2.313s)
[290.502658] [046/130] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[290.600860] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[298.004533] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.404s)
[298.179012] [047/130] (736s left) syncobj_wait (wait-all-complex)
[298.238736] Starting subtest: wait-all-complex
[298.452391] Subtest wait-all-complex: SUCCESS (0.212s)
[298.541492] [048/130] (736s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[298.639234] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[305.294022] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.655s)
[305.438225] [049/130] (729s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[305.530790] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[305.532774] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[306.678644] [050/130] (728s left) gem_exec_whisper (basic-fds-priority)
[306.740906] Starting subtest: basic-fds-priority
[331.250882] Subtest basic-fds-priority: SUCCESS (24.507s)
[331.448046] [051/130] (703s left) gem_wait (await)
[331.515806] Starting subtest: await
[331.516726] Starting dynamic subtest: all-engines
[332.698005] Dynamic subtest all-engines: SUCCESS (1.181s)
[332.709726] Starting dynamic subtest: rcs0
[333.763861] Dynamic subtest rcs0: SUCCESS (1.064s)
[333.778404] Starting dynamic subtest: bcs0
[334.827275] Dynamic subtest bcs0: SUCCESS (1.061s)
[334.844202] Starting dynamic subtest: vcs0
[335.884296] Dynamic subtest vcs0: SUCCESS (1.055s)
[335.901422] Starting dynamic subtest: vcs1
[336.939320] Dynamic subtest vcs1: SUCCESS (1.053s)
[336.955871] Starting dynamic subtest: vecs0
[337.992266] Dynamic subtest vecs0: SUCCESS (1.051s)
[338.009330] Starting dynamic subtest: ccs0
[339.050263] Dynamic subtest ccs0: SUCCESS (1.056s)
[339.051499] Subtest await: SUCCESS (7.537s)
[339.274517] [052/130] (695s left) kms_psr (pr-no-drrs)
[339.367126] Starting subtest: pr-no-drrs
[339.368959] Subtest pr-no-drrs: SKIP (0.000s)
[339.461057] [053/130] (695s left) kms_joiner (basic-max-non-joiner)
[339.565069] Starting subtest: basic-max-non-joiner
[339.566864] Subtest basic-max-non-joiner: SKIP (0.000s)
[339.649694] [054/130] (695s left) kms_vblank (query-idle-hang)
[339.747545] Starting subtest: query-idle-hang
[339.748571] Starting dynamic subtest: pipe-A-eDP-1
[366.180908] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.437s)
[366.191155] Starting dynamic subtest: pipe-D-eDP-1
[391.193125] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[391.194359] Subtest query-idle-hang: SUCCESS (51.456s)
[392.015558] [055/130] (643s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[392.062194] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[392.062978] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[392.189595] [056/130] (643s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[392.442207] Starting subtest: cursor-rapid-movement-256x85
[392.484761] Subtest cursor-rapid-movement-256x85: SKIP (0.040s)
[392.696327] [057/130] (642s left) gem_lmem_swapping (verify-ccs)
[392.733082] Subtest verify-ccs: SKIP (0.000s)
[392.768206] [058/130] (642s left) kms_universal_plane (cursor-fb-leak)
[392.853178] Starting subtest: cursor-fb-leak
[392.853991] Starting dynamic subtest: pipe-A-eDP-1
[393.168195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.315s)
[393.177432] Starting dynamic subtest: pipe-B-eDP-1
[394.489572] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[394.500575] Starting dynamic subtest: pipe-C-eDP-1
[395.811808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.320s)
[395.820618] Starting dynamic subtest: pipe-D-eDP-1
[397.142651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[397.143588] Subtest cursor-fb-leak: SUCCESS (4.288s)
[398.335912] [059/130] (637s left) kms_getfb (getfb-reject-nv12)
[398.434373] Starting subtest: getfb-reject-nv12
[398.436425] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[398.572998] [060/130] (636s left) kms_lease (atomic-implicit-crtc)
[398.658261] Starting subtest: atomic-implicit-crtc
[398.659041] Starting dynamic subtest: pipe-A-eDP-1
[398.663204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[398.671183] Starting dynamic subtest: pipe-B-eDP-1
[398.675451] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[398.683004] Starting dynamic subtest: pipe-C-eDP-1
[398.687392] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[398.695257] Starting dynamic subtest: pipe-D-eDP-1
[398.699381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[398.700155] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[398.808367] [061/130] (636s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[398.905512] Starting subtest: flip-vs-dpms-on-nop-interruptible
[398.907716] Starting dynamic subtest: A-eDP1
[400.818202] Dynamic subtest A-eDP1: SUCCESS (1.909s)
[400.829509] Starting dynamic subtest: B-eDP1
[402.652961] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[402.665157] Starting dynamic subtest: C-eDP1
[404.475608] Dynamic subtest C-eDP1: SUCCESS (1.819s)
[404.484940] Starting dynamic subtest: D-eDP1
[406.311719] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[406.316806] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.409s)
[407.513102] [062/130] (627s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[407.602237] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[407.603086] Starting dynamic subtest: pipe-A-eDP-1
[408.351378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[408.359831] Starting dynamic subtest: pipe-B-eDP-1
[410.126931] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.774s)
[410.134922] Starting dynamic subtest: pipe-C-eDP-1
[411.952811] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.823s)
[411.961822] Starting dynamic subtest: pipe-D-eDP-1
[413.802504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.848s)
[413.803528] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.196s)
[414.932275] [063/130] (620s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[415.032887] Starting subtest: fbc-modesetfrombusy
[418.774272] Subtest fbc-modesetfrombusy: SUCCESS (3.741s)
[419.960358] [064/130] (615s left) gem_create (busy-create)
[420.017991] Starting subtest: busy-create
[420.018840] Starting dynamic subtest: smem0
[453.330935] Dynamic subtest smem0: SUCCESS (33.305s)
[453.332588] Subtest busy-create: SUCCESS (33.307s)
[453.537230] [065/130] (582s left) kms_psr (fbc-pr-sprite-render)
[453.634393] Starting subtest: fbc-pr-sprite-render
[453.636162] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[453.726094] [066/130] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[453.824817] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[453.826627] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[453.924444] [067/130] (581s left) gem_ctx_persistence (engines-queued)
[453.978494] Starting subtest: engines-queued
[453.979858] Starting dynamic subtest: rcs0
[454.072179] Dynamic subtest rcs0: SUCCESS (0.093s)
[454.083258] Starting dynamic subtest: bcs0
[454.102402] Dynamic subtest bcs0: SUCCESS (0.029s)
[454.110037] Starting dynamic subtest: vcs0
[455.366007] Dynamic subtest vcs0: SUCCESS (1.259s)
[455.377008] Starting dynamic subtest: vcs1
[457.344758] Dynamic subtest vcs1: SUCCESS (1.979s)
[457.355934] Starting dynamic subtest: vecs0
[459.329543] Dynamic subtest vecs0: SUCCESS (1.982s)
[459.340567] Starting dynamic subtest: ccs0
[459.511520] Dynamic subtest ccs0: SUCCESS (0.181s)
[459.512722] Subtest engines-queued: SUCCESS (5.533s)
[459.671941] [068/130] (575s left) gem_sync (basic-each)
[459.731620] Starting subtest: basic-each
[462.192073] Subtest basic-each: SUCCESS (2.462s)
[462.399133] [069/130] (573s left) gem_render_copy (x-tiled)
[462.459719] Starting subtest: x-tiled
[462.460848] Starting dynamic subtest: smem
[462.508236] Dynamic subtest smem: SUCCESS (0.048s)
[462.513400] Subtest x-tiled: SUCCESS (0.049s)
[462.758758] [070/130] (572s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[462.825476] Starting subtest: yf-tiled-ccs-to-x-tiled
[462.827428] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[463.030115] [071/130] (572s left) kms_flip (basic-flip-vs-wf_vblank)
[463.128589] Starting subtest: basic-flip-vs-wf_vblank
[463.130941] Starting dynamic subtest: A-eDP1
[465.074510] Dynamic subtest A-eDP1: SUCCESS (1.943s)
[465.089104] Starting dynamic subtest: B-eDP1
[467.005341] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[467.014333] Starting dynamic subtest: C-eDP1
[468.927189] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[468.936494] Starting dynamic subtest: D-eDP1
[470.849896] Dynamic subtest D-eDP1: SUCCESS (1.921s)
[470.852881] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.723s)
[472.084434] [072/130] (563s left) gem_exec_reloc (basic-gtt-wc-active)
[472.158708] Subtest basic-gtt-wc-active: SKIP (0.000s)
[472.224020] [073/130] (563s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[472.312671] Starting subtest: async-flip-with-page-flip-events-tiled
[472.690045] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[473.668974] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.762s)
[473.678372] Starting dynamic subtest: pipe-A-eDP-1-4
[473.813010] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.196s)
[473.821822] Starting dynamic subtest: pipe-A-eDP-1-4
[473.871091] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.008s)
[473.879307] Starting dynamic subtest: pipe-A-eDP-1-x
[474.013541] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.168s)
[474.199586] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[475.182031] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (0.910s)
[475.192068] Starting dynamic subtest: pipe-B-eDP-1-4
[475.417807] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.175s)
[475.426417] Starting dynamic subtest: pipe-B-eDP-1-4
[475.476503] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.008s)
[475.484815] Starting dynamic subtest: pipe-B-eDP-1-x
[475.640432] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.224s)
[475.871338] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[478.606879] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[478.616061] Starting dynamic subtest: pipe-C-eDP-1-4
[480.850445] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.243s)
[480.858497] Starting dynamic subtest: pipe-C-eDP-1-4
[482.859134] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[482.867234] Starting dynamic subtest: pipe-C-eDP-1-x
[485.027192] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[485.389262] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[488.132688] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.750s)
[488.147653] Starting dynamic subtest: pipe-D-eDP-1-4
[490.309488] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[490.320253] Starting dynamic subtest: pipe-D-eDP-1-4
[492.319210] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[492.327429] Starting dynamic subtest: pipe-D-eDP-1-x
[494.497839] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[494.498945] Subtest async-flip-with-page-flip-events-tiled: FAIL (22.185s)
[495.741550] [074/130] (540s left) gem_softpin (allocator-basic-reserve)
[495.791429] Starting subtest: allocator-basic-reserve
[495.861946] Subtest allocator-basic-reserve: SUCCESS (0.070s)
[496.019541] [075/130] (539s left) perf_pmu (pmu-read)
[496.060105] Starting subtest: pmu-read
[496.061837] Subtest pmu-read: SUCCESS (0.003s)
[496.189231] [076/130] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[496.288686] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[496.290413] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.400501] [077/130] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[496.492913] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[496.494893] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[496.620580] [078/130] (539s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[496.669085] Starting subtest: single-wait-for-submit-available-submitted
[496.670182] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[496.806201] [079/130] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[496.896507] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[496.898247] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[497.004535] [080/130] (539s left) gem_render_copy (yf-tiled-to-vebox-linear)
[497.065696] Starting subtest: yf-tiled-to-vebox-linear
[497.067746] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[497.268819] [081/130] (538s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[497.840205] Starting subtest: syncobj-stationary-timeline-chain-engines
[497.959809] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.123s)
[499.486548] [082/130] (536s left) kms_psr (fbc-pr-primary-mmap-gtt)
[499.585381] Starting subtest: fbc-pr-primary-mmap-gtt
[499.587192] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[499.675299] [083/130] (536s left) gem_mmap_wc (copy)
[499.731577] Subtest copy: SKIP (0.000s)
[499.790837] [084/130] (536s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[499.881349] Starting subtest: plane-upscale-factor-0-25-with-rotation
[499.882128] Starting dynamic subtest: pipe-A
[500.108554] Dynamic subtest pipe-A: SUCCESS (0.227s)
[500.123330] Starting dynamic subtest: pipe-B
[501.409649] Dynamic subtest pipe-B: SUCCESS (1.299s)
[501.417953] Starting dynamic subtest: pipe-C
[502.743235] Dynamic subtest pipe-C: SUCCESS (1.333s)
[502.753419] Starting dynamic subtest: pipe-D
[504.070714] Dynamic subtest pipe-D: SUCCESS (1.327s)
[504.071669] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.191s)
[505.259657] [085/130] (530s left) gem_exec_schedule (preemptive-hang)
[505.431226] Starting subtest: preemptive-hang
[505.433030] Starting dynamic subtest: rcs0
[514.524671] Dynamic subtest rcs0: SUCCESS (9.094s)
[514.534660] Starting dynamic subtest: bcs0
[523.570894] Dynamic subtest bcs0: SUCCESS (9.047s)
[523.580385] Starting dynamic subtest: vcs0
[532.490348] Dynamic subtest vcs0: SUCCESS (8.920s)
[532.501027] Starting dynamic subtest: vcs1
[541.460917] Dynamic subtest vcs1: SUCCESS (8.968s)
[541.471150] Starting dynamic subtest: vecs0
[550.476607] Dynamic subtest vecs0: SUCCESS (9.016s)
[550.484668] Starting dynamic subtest: ccs0
[559.530313] Dynamic subtest ccs0: SUCCESS (9.052s)
[559.531532] Subtest preemptive-hang: SUCCESS (54.106s)
[559.811439] [086/130] (476s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[559.914161] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[559.915020] Starting dynamic subtest: pipe-A-eDP-1
[559.923405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[559.931535] Starting dynamic subtest: pipe-B-eDP-1
[559.939899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.948075] Starting dynamic subtest: pipe-C-eDP-1
[559.956498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.964025] Starting dynamic subtest: pipe-D-eDP-1
[559.972673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.974319] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[562.205354] [087/130] (474s left) gem_exec_suspend (basic-s3)
[562.273705] Starting subtest: basic-S3
[562.274742] Starting dynamic subtest: smem
[584.012830] Dynamic subtest smem: SUCCESS (7.105s)
[584.014531] Subtest basic-S3: SUCCESS (7.108s)
[590.226658] [088/130] (452s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[590.338756] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[590.340440] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[590.453859] [089/130] (451s left) gem_huc_copy (huc-copy)
[590.512630] Starting subtest: huc-copy
[590.516508] Subtest huc-copy: SUCCESS (0.004s)
[590.664826] [090/130] (451s left) kms_flip (flip-vs-expired-vblank)
[590.747742] Starting subtest: flip-vs-expired-vblank
[590.749948] Starting dynamic subtest: A-eDP1
[599.400116] Dynamic subtest A-eDP1: SUCCESS (8.859s)
[599.410645] Starting dynamic subtest: B-eDP1
[608.021956] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[608.032640] Starting dynamic subtest: C-eDP1
[616.641089] Dynamic subtest C-eDP1: SUCCESS (8.658s)
[616.650627] Starting dynamic subtest: D-eDP1
[625.347937] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[625.351031] Subtest flip-vs-expired-vblank: SUCCESS (34.987s)
[626.604074] [091/130] (415s left) i915_pm_rc6_residency (rc6-fence)
[626.648487] Starting subtest: rc6-fence
[626.680176] Starting dynamic subtest: gt0
[640.976061] Dynamic subtest gt0: SUCCESS (14.288s)
[640.988790] Starting dynamic subtest: gt1
[654.984801] Dynamic subtest gt1: SUCCESS (14.006s)
[654.988208] Subtest rc6-fence: SUCCESS (28.331s)
[655.084190] [092/130] (387s left) kms_plane (plane-position-hole)
[655.180548] Starting subtest: plane-position-hole
[655.693456] Starting dynamic subtest: pipe-A-plane-1
[656.951966] Dynamic subtest pipe-A-plane-1: SUCCESS (1.259s)
[656.960625] Starting dynamic subtest: pipe-A-plane-2
[658.166944] Dynamic subtest pipe-A-plane-2: SUCCESS (1.214s)
[658.176626] Starting dynamic subtest: pipe-A-plane-3
[659.414440] Dynamic subtest pipe-A-plane-3: SUCCESS (1.247s)
[659.423354] Starting dynamic subtest: pipe-A-plane-4
[660.667827] Dynamic subtest pipe-A-plane-4: SUCCESS (1.253s)
[660.676841] Starting dynamic subtest: pipe-A-plane-5
[660.692866] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[661.909458] Starting dynamic subtest: pipe-B-plane-1
[663.148527] Dynamic subtest pipe-B-plane-1: SUCCESS (1.246s)
[663.157001] Starting dynamic subtest: pipe-B-plane-2
[664.462407] Dynamic subtest pipe-B-plane-2: SUCCESS (1.314s)
[664.471141] Starting dynamic subtest: pipe-B-plane-3
[665.686285] Dynamic subtest pipe-B-plane-3: SUCCESS (1.223s)
[665.695611] Starting dynamic subtest: pipe-B-plane-4
[666.903569] Dynamic subtest pipe-B-plane-4: SUCCESS (1.217s)
[666.914426] Starting dynamic subtest: pipe-B-plane-5
[666.930995] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[666.931884] Subtest plane-position-hole: SUCCESS (11.753s)
[667.728296] [093/130] (374s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[667.819648] Starting subtest: random-ccs-data-yf-tiled-ccs
[667.820432] Starting dynamic subtest: pipe-A-eDP-1
[667.829378] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[667.837983] Starting dynamic subtest: pipe-B-eDP-1
[667.846939] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[667.855703] Starting dynamic subtest: pipe-C-eDP-1
[667.864270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[667.872560] Starting dynamic subtest: pipe-D-eDP-1
[667.881296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[667.882852] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[670.003649] [094/130] (372s left) i915_hangman (engine-engine-error)
[670.065793] Starting subtest: engine-engine-error
[670.066808] Starting dynamic subtest: rcs0
[671.978814] Dynamic subtest rcs0: SUCCESS (1.911s)
[671.990075] Starting dynamic subtest: bcs0
[673.962272] Dynamic subtest bcs0: SUCCESS (1.981s)
[673.973371] Starting dynamic subtest: vcs0
[675.946385] Dynamic subtest vcs0: SUCCESS (1.982s)
[675.957675] Starting dynamic subtest: vcs1
[677.994023] Dynamic subtest vcs1: SUCCESS (2.045s)
[678.005312] Starting dynamic subtest: vecs0
[679.978205] Dynamic subtest vecs0: SUCCESS (1.982s)
[679.988272] Starting dynamic subtest: ccs0
[681.962048] Dynamic subtest ccs0: SUCCESS (1.981s)
[681.963830] Subtest engine-engine-error: SUCCESS (11.899s)
[682.123197] [095/130] (360s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[682.222934] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[689.500705] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.281s)
[689.668840] [096/130] (352s left) gem_pwrite (basic-exhaustion)
[689.733260] Subtest basic-exhaustion: SKIP (0.000s)
[689.786141] [097/130] (352s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[689.839382] Starting subtest: etime-single-wait-available-unsubmitted
[689.943891] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[690.037319] [098/130] (352s left) kms_prime (basic-crc-vgem)
[690.113964] Starting subtest: basic-crc-vgem
[690.114773] Starting dynamic subtest: second-to-first
[691.110291] Dynamic subtest second-to-first: SUCCESS (0.997s)
[691.112739] Subtest basic-crc-vgem: SUCCESS (0.999s)
[691.218187] [099/130] (351s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[691.356579] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[691.357599] Starting dynamic subtest: pipe-A-default-mode
[691.649005] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[691.650872] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.292s)
[692.533265] [100/130] (350s left) gem_exec_balancer (invalid-bonds)
[692.595807] Starting subtest: invalid-bonds
[692.597511] Subtest invalid-bonds: SKIP (0.000s)
[692.930401] [101/130] (349s left) gem_exec_balancer (sliced)
[692.994895] Starting subtest: sliced
[692.996740] Subtest sliced: SKIP (0.000s)
[693.308938] [102/130] (349s left) gem_exec_parallel (basic)
[693.373182] Starting subtest: basic
[693.374007] Starting dynamic subtest: rcs0
[694.823410] Dynamic subtest rcs0: SUCCESS (1.449s)
[694.833868] Starting dynamic subtest: bcs0
[696.352846] Dynamic subtest bcs0: SUCCESS (1.526s)
[696.365257] Starting dynamic subtest: vcs0
[697.964581] Dynamic subtest vcs0: SUCCESS (1.606s)
[697.974185] Starting dynamic subtest: vcs1
[699.979363] Dynamic subtest vcs1: SUCCESS (2.010s)
[699.990297] Starting dynamic subtest: vecs0
[701.963373] Dynamic subtest vecs0: SUCCESS (1.981s)
[701.974710] Starting dynamic subtest: ccs0
[703.447250] Dynamic subtest ccs0: SUCCESS (1.483s)
[703.448341] Subtest basic: SUCCESS (10.071s)
[703.651759] [103/130] (339s left) prime_busy (after)
[703.712444] Starting subtest: after
[703.715721] Starting dynamic subtest: rcs0
[703.757304] Dynamic subtest rcs0: SUCCESS (0.041s)
[703.767764] Starting dynamic subtest: bcs0
[703.842210] Dynamic subtest bcs0: SUCCESS (0.084s)
[703.851540] Starting dynamic subtest: vcs0
[703.884863] Dynamic subtest vcs0: SUCCESS (0.042s)
[703.893647] Starting dynamic subtest: vcs1
[703.927964] Dynamic subtest vcs1: SUCCESS (0.042s)
[703.936625] Starting dynamic subtest: vecs0
[703.969976] Dynamic subtest vecs0: SUCCESS (0.041s)
[703.978797] Starting dynamic subtest: ccs0
[704.013945] Dynamic subtest ccs0: SUCCESS (0.043s)
[704.123279] Subtest after: SUCCESS (0.408s)
[704.234960] [104/130] (338s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[704.337067] Starting subtest: y-tiled-64bpp-rotate-0
[704.338858] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[704.450056] [105/130] (338s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[704.537854] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[704.539544] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[704.671894] [106/130] (338s left) gem_mmap_wc (read-write-distinct)
[704.720387] Subtest read-write-distinct: SKIP (0.000s)
[704.804621] [107/130] (338s left) gem_ctx_sseu (engines)
[704.861642] Subtest engines: SKIP (0.000s)
[704.962659] [108/130] (338s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[705.019510] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[705.128092] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[705.225083] [109/130] (337s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[705.347761] Starting subtest: basic-flip-before-cursor-atomic
[706.279050] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.930s)
[707.168924] [110/130] (335s left) syncobj_wait (single-wait-all-signaled)
[707.231022] Starting subtest: single-wait-all-signaled
[707.231953] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[707.365145] [111/130] (335s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[707.471155] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[708.118710] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[708.317220] [112/130] (334s left) perf (gen12-unprivileged-single-ctx-counters)
[708.441139] Starting subtest: gen12-unprivileged-single-ctx-counters
[708.441923] Starting dynamic subtest: rcs0
[708.480041] Dynamic subtest rcs0: SUCCESS (0.039s)
[708.481051] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.040s)
[708.525235] [113/130] (334s left) kms_psr (psr-cursor-blt)
[708.667453] Starting subtest: psr-cursor-blt
[708.668896] Starting dynamic subtest: eDP-1
[710.350008] Dynamic subtest eDP-1: SUCCESS (1.683s)
[710.351040] Subtest psr-cursor-blt: SUCCESS (1.685s)
[711.238711] [114/130] (332s left) gem_ccs (ctrl-surf-copy)
[711.296692] Starting subtest: ctrl-surf-copy
[711.298461] Subtest ctrl-surf-copy: SKIP (0.000s)
[711.429939] [115/130] (331s left) kms_flip (2x-absolute-wf_vblank)
[711.508452] Starting subtest: 2x-absolute-wf_vblank
[711.518974] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[711.622334] [116/130] (331s left) kms_pm_dc (dc3co-vpb-simulation)
[712.717603] Starting subtest: dc3co-vpb-simulation
[721.759748] Subtest dc3co-vpb-simulation: SKIP (9.037s)
[721.898203] [117/130] (321s left) i915_query (test-query-geometry-subslices)
[721.951740] Starting subtest: test-query-geometry-subslices
[721.952752] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[722.078437] [118/130] (321s left) kms_psr (fbc-psr-sprite-render)
[722.170904] Starting subtest: fbc-psr-sprite-render
[722.171861] Starting dynamic subtest: eDP-1
[722.173718] Dynamic subtest eDP-1: SKIP (0.000s)
[722.175330] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[722.267405] [119/130] (321s left) gem_userptr_blits (sync-overlap)
[722.321508] Starting subtest: sync-overlap
[722.322559] Subtest sync-overlap: SUCCESS (0.000s)
[722.483400] [120/130] (320s left) prime_vgem (fence-read-hang)
[722.547862] Subtest fence-read-hang: SKIP (0.000s)
[722.673074] [121/130] (320s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[722.727498] Starting subtest: invalid-single-wait-all-unsubmitted
[722.728390] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[722.860796] [122/130] (320s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[722.968248] Starting subtest: yf-tiled-64bpp-rotate-270
[722.970083] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[723.080263] [123/130] (320s left) core_setmaster (master-drop-set-shared-fd)
[723.180097] Starting subtest: master-drop-set-shared-fd
[723.198899] Subtest master-drop-set-shared-fd: SUCCESS (0.020s)
[723.229907] [124/130] (320s left) gem_ctx_create (basic-files)
[723.289402] Starting subtest: basic-files
[725.386106] Subtest basic-files: SUCCESS (2.096s)
[727.045198] [125/130] (316s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[727.098027] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[727.162194] [126/130] (316s left) kms_color (ctm-blue-to-red)
[727.256953] Starting subtest: ctm-blue-to-red
[727.258018] Starting dynamic subtest: pipe-A-eDP-1
[727.981551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[727.990069] Starting dynamic subtest: pipe-B-eDP-1
[729.368323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[729.377353] Starting dynamic subtest: pipe-C-eDP-1
[730.668333] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[730.677284] Starting dynamic subtest: pipe-D-eDP-1
[731.982161] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[731.983185] Subtest ctm-blue-to-red: SUCCESS (4.727s)
[732.864815] [127/130] (310s left) gem_eio (in-flight-external)
[733.091734] Starting subtest: in-flight-external
[734.100844] Subtest in-flight-external: SUCCESS (1.009s)
[734.256261] [128/130] (309s left) kms_frontbuffer_tracking (fbc-2p-rte)
[734.353972] Starting subtest: fbc-2p-rte
[734.355763] Subtest fbc-2p-rte: SKIP (0.000s)
[734.494825] [129/130] (309s left) syncobj_wait (wait-all-for-submit-complex)
[734.550872] Starting subtest: wait-all-for-submit-complex
[734.767284] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[734.857685] [130/130] (308s left) kms_properties (colorop-properties-atomic)
[734.935408] Starting subtest: colorop-properties-atomic
[734.936372] Starting dynamic subtest: pipe-A-eDP-1
[735.270859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[735.280994] Starting dynamic subtest: pipe-B-eDP-1
[736.300406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.029s)
[736.311338] Starting dynamic subtest: pipe-C-eDP-1
[737.324508] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.022s)
[737.333624] Starting dynamic subtest: pipe-D-eDP-1
[738.350018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[738.351014] Subtest colorop-properties-atomic: SUCCESS (3.414s)
[739.167992] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_fence_thrash
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: gem_wait
results: parsing output: 5/ for test: gem_tiled_wb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_dp_aux_dev
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_dp_linktrain_fallback
results: parsing output: 20/ for test: core_debugfs
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ppgtt
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: i915_pm_rc6_residency
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prime
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: core_setmaster
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
Done.