[57.318288] Initializing watchdogs
[57.318335]   /dev/watchdog0
[57.333276] [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.337590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.340465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.343797] [001/155] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[57.464431] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[57.468852] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[57.541049] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[57.645223] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[66.371748] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.634s)
[66.493579] [003/155] (951s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[66.585123] Starting subtest: primary-yf-tiled-reflect-x-180
[66.644943] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[66.744166] [004/155] (951s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[66.838184] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[66.842598] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.933251] [005/155] (951s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[67.033914] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[67.037896] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[67.117197] [006/155] (950s left) kms_atomic_transition (plane-all-transition)
[67.201589] Starting subtest: plane-all-transition
[67.203700] Starting dynamic subtest: pipe-A-eDP-1
[69.706503] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[70.010049] Starting dynamic subtest: pipe-B-eDP-1
[73.295724] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.283s)
[73.597665] Subtest plane-all-transition: SUCCESS (6.373s)
[74.415887] [007/155] (943s left) gem_exec_balancer (full-late)
[74.477830] Starting subtest: full-late
[79.144395] Subtest full-late: SUCCESS (4.659s)
[79.517824] [008/155] (938s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[79.610223] Starting subtest: plane-downscale-factor-0-75-with-rotation
[79.612622] Starting dynamic subtest: pipe-A
[79.849884] Dynamic subtest pipe-A: SUCCESS (0.242s)
[79.859671] Starting dynamic subtest: pipe-B
[81.107146] Dynamic subtest pipe-B: SUCCESS (1.255s)
[81.115737] Starting dynamic subtest: pipe-C
[82.447305] Dynamic subtest pipe-C: SUCCESS (1.339s)
[82.455609] Starting dynamic subtest: pipe-D
[83.787365] Dynamic subtest pipe-D: SUCCESS (1.338s)
[83.789707] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.177s)
[84.956774] [009/155] (933s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[85.063241] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[85.067377] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[85.153213] [010/155] (933s left) gem_readwrite (new-obj)
[85.218308] Subtest new-obj: SKIP (0.000s)
[85.273658] [011/155] (932s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[85.356521] Starting subtest: async-flip-with-page-flip-events-linear
[85.734068] Starting dynamic subtest: pipe-A-eDP-1
[88.539267] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[88.907359] Starting dynamic subtest: pipe-B-eDP-1
[91.676337] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[92.038457] Starting dynamic subtest: pipe-C-eDP-1
[94.801542] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[95.169716] Starting dynamic subtest: pipe-D-eDP-1
[97.939490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[97.942090] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.574s)
[99.121486] [012/155] (919s left) kms_plane_cursor (overlay)
[99.221813] Starting subtest: overlay
[99.226172] Starting dynamic subtest: pipe-A-eDP-1-size-64
[101.785050] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.564s)
[101.845856] Starting dynamic subtest: pipe-A-eDP-1-size-128
[104.354561] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.516s)
[104.414842] Starting dynamic subtest: pipe-A-eDP-1-size-256
[106.945664] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[107.294767] Starting dynamic subtest: pipe-B-eDP-1-size-64
[110.570166] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.283s)
[110.629575] Starting dynamic subtest: pipe-B-eDP-1-size-128
[113.149896] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.527s)
[113.208896] Starting dynamic subtest: pipe-B-eDP-1-size-256
[115.728973] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[116.076507] Starting dynamic subtest: pipe-C-eDP-1-size-64
[118.951344] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.885s)
[118.990073] Starting dynamic subtest: pipe-C-eDP-1-size-128
[121.163143] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[121.199264] Starting dynamic subtest: pipe-C-eDP-1-size-256
[123.329316] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[123.660200] Starting dynamic subtest: pipe-D-eDP-1-size-64
[126.551480] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.903s)
[126.589359] Starting dynamic subtest: pipe-D-eDP-1-size-128
[128.752686] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[128.791183] Starting dynamic subtest: pipe-D-eDP-1-size-256
[130.974333] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[131.293676] Subtest overlay: SUCCESS (32.061s)
[132.154264] [013/155] (886s left) kms_flip (flip-vs-suspend)
[132.244133] Starting subtest: flip-vs-suspend
[132.246432] Starting dynamic subtest: A-eDP1
[277.066718] Dynamic subtest A-eDP1: SUCCESS (12.152s)
[277.069452] Subtest flip-vs-suspend: SUCCESS (12.154s)
[277.202116] [014/155] (741s left) kms_lease (lessee-list)
[277.298457] Starting subtest: lessee-list
[277.300805] Starting dynamic subtest: pipe-A-eDP-1
[277.303127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[277.312852] Starting dynamic subtest: pipe-B-eDP-1
[277.314997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[277.324622] Starting dynamic subtest: pipe-C-eDP-1
[277.326999] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[277.336040] Starting dynamic subtest: pipe-D-eDP-1
[277.338710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[277.341150] Subtest lessee-list: SUCCESS (0.008s)
[277.410780] [015/155] (740s left) gem_workarounds (suspend-resume)
[277.482162] Starting subtest: suspend-resume
[294.080783] Subtest suspend-resume: SUCCESS (1.120s)
[294.183636] [016/155] (724s left) perf (gen12-oa-tlb-invalidate)
[294.317321] Starting subtest: gen12-oa-tlb-invalidate
[294.320220] Starting dynamic subtest: 0-rcs0
[304.429714] Dynamic subtest 0-rcs0: SUCCESS (9.819s)
[304.441231] Starting dynamic subtest: 1-vecs0
[314.462280] Dynamic subtest 1-vecs0: SUCCESS (9.964s)
[314.465096] Subtest gen12-oa-tlb-invalidate: SUCCESS (19.786s)
[314.506048] [017/155] (703s left) gem_exec_schedule (implicit-write-read)
[314.587325] Starting subtest: implicit-write-read
[314.589543] Starting dynamic subtest: rcs0
[314.755500] Dynamic subtest rcs0: SUCCESS (0.180s)
[314.771156] Starting dynamic subtest: vcs0
[314.899138] Dynamic subtest vcs0: SUCCESS (0.142s)
[314.912020] Starting dynamic subtest: vcs1
[315.011635] Dynamic subtest vcs1: SUCCESS (0.111s)
[315.022375] Starting dynamic subtest: vecs0
[315.127299] Dynamic subtest vecs0: SUCCESS (0.115s)
[315.137358] Starting dynamic subtest: ccs0
[315.267286] Dynamic subtest ccs0: SUCCESS (0.138s)
[315.270231] Subtest implicit-write-read: SUCCESS (0.691s)
[316.506594] [018/155] (702s left) gem_softpin (zero)
[316.568600] Starting subtest: zero
[316.574749] Subtest zero: SUCCESS (0.009s)
[316.687996] [019/155] (701s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[316.760525] Starting subtest: map-fixed-invalidate-overlap
[316.765477] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[316.883098] [020/155] (701s left) gem_userptr_blits (map-fixed-invalidate)
[316.949322] Starting subtest: map-fixed-invalidate
[316.954570] Subtest map-fixed-invalidate: SKIP (0.000s)
[317.064880] [021/155] (701s left) kms_pm_dc (dc9-dpms)
[318.161662] Starting subtest: dc9-dpms
[319.621705] Subtest dc9-dpms: SUCCESS (1.456s)
[319.689581] [022/155] (699s left) gem_ccs (ctrl-surf-copy-new-ctx)
[319.740716] Starting subtest: ctrl-surf-copy-new-ctx
[319.746082] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[319.839629] [023/155] (698s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[319.923942] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[319.929356] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[320.007252] [024/155] (698s left) kms_chamelium_edid (dp-mode-timings)
[320.394621] Subtest dp-mode-timings: SKIP (0.000s)
[321.184086] [025/155] (697s left) kms_cursor_crc (cursor-random-128x128)
[321.369897] Starting subtest: cursor-random-128x128
[321.372802] Starting dynamic subtest: pipe-A-eDP-1
[324.766882] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s)
[324.797151] Starting dynamic subtest: pipe-D-eDP-1
[328.831507] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.042s)
[328.834067] Subtest cursor-random-128x128: SUCCESS (7.457s)
[329.677055] [026/155] (689s left) kms_universal_plane (universal-plane-functional)
[329.783180] Starting subtest: universal-plane-functional
[329.785787] Starting dynamic subtest: pipe-A-eDP-1
[333.608426] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.825s)
[333.619772] Starting dynamic subtest: pipe-B-eDP-1
[338.121372] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.512s)
[338.132294] Starting dynamic subtest: pipe-C-eDP-1
[342.354039] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.231s)
[342.365273] Starting dynamic subtest: pipe-D-eDP-1
[346.550620] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.195s)
[346.553787] Subtest universal-plane-functional: SUCCESS (16.769s)
[347.369106] [027/155] (671s left) kms_getfb (getfb2-into-addfb2)
[347.458817] Starting subtest: getfb2-into-addfb2
[347.461353] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[347.563946] [028/155] (671s left) kms_big_fb (yf-tiled-addfb)
[347.667847] Starting subtest: yf-tiled-addfb
[347.672706] Subtest yf-tiled-addfb: SKIP (0.000s)
[347.781862] [029/155] (671s left) kms_cursor_crc (cursor-sliding-256x256)
[348.123320] Starting subtest: cursor-sliding-256x256
[348.126036] Starting dynamic subtest: pipe-A-eDP-1
[351.355402] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.226s)
[351.383920] Starting dynamic subtest: pipe-D-eDP-1
[355.258021] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.882s)
[355.260708] Subtest cursor-sliding-256x256: SUCCESS (7.133s)
[356.135486] [030/155] (662s left) perf_pmu (semaphore-wait-idle)
[356.176444] Starting subtest: semaphore-wait-idle
[356.179157] Starting dynamic subtest: rcs0
[356.691904] Dynamic subtest rcs0: SUCCESS (0.514s)
[356.705589] Starting dynamic subtest: bcs0
[357.205902] Dynamic subtest bcs0: SUCCESS (0.510s)
[357.219564] Starting dynamic subtest: vcs0
[357.718505] Dynamic subtest vcs0: SUCCESS (0.509s)
[357.732632] Starting dynamic subtest: vcs1
[358.232788] Dynamic subtest vcs1: SUCCESS (0.510s)
[358.253886] Starting dynamic subtest: vecs0
[358.746176] Dynamic subtest vecs0: SUCCESS (0.510s)
[358.759568] Starting dynamic subtest: ccs0
[359.262034] Dynamic subtest ccs0: SUCCESS (0.512s)
[359.265080] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[360.395110] [031/155] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[360.504222] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[360.508666] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[360.591349] [032/155] (658s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[360.687242] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[360.691723] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.763386] [033/155] (658s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[360.863552] Starting subtest: y-tiled-32bpp-rotate-270
[360.868568] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[360.946235] [034/155] (658s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[361.077103] Starting subtest: cursorA-vs-flipB-varying-size
[361.082189] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[361.220966] [035/155] (658s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[361.272381] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[361.277737] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[361.456080] [036/155] (657s left) gem_exec_parallel (userptr)
[361.517099] Starting subtest: userptr
[361.519730] Starting dynamic subtest: rcs0
[363.216265] Dynamic subtest rcs0: SUCCESS (1.702s)
[363.227965] Starting dynamic subtest: bcs0
[364.916858] Dynamic subtest bcs0: SUCCESS (1.699s)
[364.927633] Starting dynamic subtest: vcs0
[368.369374] Dynamic subtest vcs0: SUCCESS (3.449s)
[368.381786] Starting dynamic subtest: vcs1
[370.351248] Dynamic subtest vcs1: SUCCESS (1.979s)
[370.361608] Starting dynamic subtest: vecs0
[372.336313] Dynamic subtest vecs0: SUCCESS (1.982s)
[372.346284] Starting dynamic subtest: ccs0
[374.176905] Dynamic subtest ccs0: SUCCESS (1.840s)
[374.179827] Subtest userptr: SUCCESS (12.660s)
[374.362144] [037/155] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[374.467623] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[374.473504] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[374.560111] [038/155] (644s left) kms_psr (fbc-psr2-primary-page-flip)
[374.641491] Starting subtest: fbc-psr2-primary-page-flip
[374.644044] Starting dynamic subtest: eDP-1
[374.649333] Dynamic subtest eDP-1: SKIP (0.000s)
[374.654529] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[374.714940] [039/155] (644s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[374.836830] Starting subtest: cursorB-vs-flipB-toggle
[374.842337] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[374.977714] [040/155] (644s left) kms_plane_scaling (planes-upscale-factor-0-25)
[375.065550] Starting subtest: planes-upscale-factor-0-25
[375.068451] Starting dynamic subtest: pipe-A
[375.126062] Dynamic subtest pipe-A: SUCCESS (0.062s)
[375.146385] Starting dynamic subtest: pipe-B
[376.267993] Dynamic subtest pipe-B: SUCCESS (1.141s)
[376.280749] Starting dynamic subtest: pipe-C
[377.382520] Dynamic subtest pipe-C: SUCCESS (1.112s)
[377.393002] Starting dynamic subtest: pipe-D
[378.522668] Dynamic subtest pipe-D: SUCCESS (1.139s)
[378.525295] Subtest planes-upscale-factor-0-25: SUCCESS (3.460s)
[379.670200] [041/155] (639s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[379.767728] Starting subtest: sprite-rotation-90-pos-100-0
[379.773371] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[379.836732] [042/155] (639s left) gem_eio (in-flight-1us)
[380.071746] Starting subtest: in-flight-1us
[388.201576] Subtest in-flight-1us: SUCCESS (8.126s)
[388.326437] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[388.330580] [043/155] (631s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[388.427736] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[388.432395] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[388.530476] [044/155] (631s left) kms_plane (pixel-format-4-tiled-modifier)
[388.621730] Starting subtest: pixel-format-4-tiled-modifier
[388.646898] Starting dynamic subtest: pipe-A-plane-0
[389.073251] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[389.085569] Starting dynamic subtest: pipe-A-plane-3
[389.401963] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[389.412289] Starting dynamic subtest: pipe-A-plane-5
[389.417080] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[390.561851] Starting dynamic subtest: pipe-B-plane-0
[390.988498] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[391.001394] Starting dynamic subtest: pipe-B-plane-3
[391.320281] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[391.331412] Starting dynamic subtest: pipe-B-plane-5
[391.337097] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[391.627142] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.006s)
[392.432822] [045/155] (627s left) kms_cursor_edge_walk (256x256-left-edge)
[392.529217] Starting subtest: 256x256-left-edge
[392.531511] Starting dynamic subtest: pipe-A-eDP-1
[395.998721] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[396.011283] Starting dynamic subtest: pipe-D-eDP-1
[399.212551] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.214s)
[399.215509] Subtest 256x256-left-edge: SUCCESS (6.688s)
[400.022027] [046/155] (619s left) gem_exec_flush (basic-wb-pro-default)
[400.089505] Starting subtest: basic-wb-pro-default
[405.586976] Subtest basic-wb-pro-default: SUCCESS (5.467s)
[405.743275] [047/155] (614s left) gen9_exec_parse (basic-rejected)
[405.804741] Subtest basic-rejected: SKIP (0.000s)
[405.878598] [048/155] (613s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[405.976135] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[405.981257] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[406.069929] [049/155] (613s left) kms_psr (psr2-cursor-blt)
[406.159184] Starting subtest: psr2-cursor-blt
[406.161749] Starting dynamic subtest: eDP-1
[407.909045] Dynamic subtest eDP-1: SUCCESS (1.749s)
[407.911440] Subtest psr2-cursor-blt: SUCCESS (1.750s)
[408.782616] [050/155] (611s left) gem_pread (uncached)
[408.847470] Subtest uncached: SKIP (0.000s)
[408.902852] [051/155] (611s left) gem_exec_reloc (basic-write-wc-noreloc)
[408.959637] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[409.034323] [052/155] (610s left) api_intel_bb (full-batch)
[409.092601] Starting subtest: full-batch
[409.099327] Subtest full-batch: SUCCESS (0.008s)
[409.223257] [053/155] (610s left) gem_exec_fence (concurrent)
[409.410407] Starting subtest: concurrent
[409.415747] Subtest concurrent: SKIP (0.000s)
[411.470274] [054/155] (608s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[411.527604] Starting subtest: legacy-engines-hostile-preempt
[411.530722] Starting dynamic subtest: render
[411.617738] Dynamic subtest render: SUCCESS (0.090s)
[411.630412] Starting dynamic subtest: bsd1
[413.357929] Dynamic subtest bsd1: SUCCESS (1.737s)
[413.373244] Starting dynamic subtest: bsd2
[415.461187] Dynamic subtest bsd2: SUCCESS (2.045s)
[415.473520] Starting dynamic subtest: blt
[415.476469] Dynamic subtest blt: SUCCESS (0.023s)
[415.487057] Starting dynamic subtest: vebox
[417.365831] Dynamic subtest vebox: SUCCESS (1.931s)
[417.368929] Subtest legacy-engines-hostile-preempt: SUCCESS (5.839s)
[417.500119] [055/155] (602s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[417.592746] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[417.595194] Starting dynamic subtest: pipe-A-eDP-1
[417.604754] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.618242] Starting dynamic subtest: pipe-B-eDP-1
[417.627992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.638782] Starting dynamic subtest: pipe-C-eDP-1
[417.648580] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.658345] Starting dynamic subtest: pipe-D-eDP-1
[417.668502] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.673743] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[419.855774] [056/155] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[419.957502] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[419.962627] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[420.038945] [057/155] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[420.134780] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[420.139730] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[420.232636] [058/155] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[420.332854] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[420.337902] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.430833] [059/155] (599s left) gem_ctx_persistence (engines-hostile)
[420.492037] Starting subtest: engines-hostile
[420.494714] Starting dynamic subtest: rcs0
[420.610393] Dynamic subtest rcs0: SUCCESS (0.118s)
[420.622628] Starting dynamic subtest: bcs0
[420.654930] Dynamic subtest bcs0: SUCCESS (0.042s)
[420.666014] Starting dynamic subtest: vcs0
[420.764327] Dynamic subtest vcs0: SUCCESS (0.107s)
[420.777415] Starting dynamic subtest: vcs1
[420.868973] Dynamic subtest vcs1: SUCCESS (0.103s)
[420.880607] Starting dynamic subtest: vecs0
[420.945169] Dynamic subtest vecs0: SUCCESS (0.074s)
[420.955972] Starting dynamic subtest: ccs0
[421.030786] Dynamic subtest ccs0: SUCCESS (0.083s)
[421.033512] Subtest engines-hostile: SUCCESS (0.540s)
[421.110151] [060/155] (599s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[421.159609] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[421.268023] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[421.344920] [061/155] (599s left) kms_flip (2x-flip-vs-expired-vblank)
[421.430755] Starting subtest: 2x-flip-vs-expired-vblank
[421.440109] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[421.524131] [062/155] (598s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[421.611698] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[421.616185] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[422.781462] [063/155] (597s left) gem_ctx_engines (execute-allforone)
[422.842532] Starting subtest: execute-allforone
[422.862095] Subtest execute-allforone: SUCCESS (0.020s)
[424.397290] [064/155] (596s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[424.511588] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[424.516553] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[424.607028] [065/155] (595s left) perf (missing-sample-flags)
[424.709191] Starting subtest: missing-sample-flags
[424.711978] Subtest missing-sample-flags: SUCCESS (0.000s)
[424.761758] [066/155] (595s left) gem_exec_fence (submit67)
[424.930170] Starting subtest: submit67
[424.935735] Subtest submit67: SKIP (0.000s)
[426.438959] [067/155] (594s left) gem_exec_whisper (basic-normal-all)
[426.500504] Starting subtest: basic-normal-all
[429.655043] Subtest basic-normal-all: SUCCESS (3.153s)
[429.858417] [068/155] (590s left) kms_vblank (ts-continuation-suspend)
[429.953000] Starting subtest: ts-continuation-suspend
[429.955001] Starting dynamic subtest: pipe-A-eDP-1
[446.329452] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.487s)
[446.349657] Starting dynamic subtest: pipe-D-eDP-1
[463.361881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.186s)
[463.364357] Subtest ts-continuation-suspend: SUCCESS (3.677s)
[464.225617] [069/155] (556s left) prime_mmap (test_dup)
[464.281552] Starting subtest: test_dup
[464.283959] Starting dynamic subtest: test_dup-smem
[464.312430] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[464.314967] Subtest test_dup: SUCCESS (0.032s)
[464.398260] [070/155] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[464.496897] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[464.501487] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[464.605140] [071/155] (556s left) syncobj_timeline (signal-array)
[464.667777] Starting subtest: signal-array
[464.669927] Subtest signal-array: SUCCESS (0.000s)
[464.768526] [072/155] (556s left) sriov_basic (enable-vfs-autoprobe-off)
[464.815523] Starting subtest: enable-vfs-autoprobe-off
[464.817941] Starting dynamic subtest: numvfs-1
[464.893297] Dynamic subtest numvfs-1: FAIL (0.017s)
[464.908945] Starting dynamic subtest: numvfs-2
[464.970599] Dynamic subtest numvfs-2: FAIL (0.004s)
[464.982643] Starting dynamic subtest: numvfs-3
[465.045404] Dynamic subtest numvfs-3: FAIL (0.004s)
[465.059460] Starting dynamic subtest: numvfs-4
[465.122439] Dynamic subtest numvfs-4: FAIL (0.003s)
[465.133246] Starting dynamic subtest: numvfs-5
[465.193620] Dynamic subtest numvfs-5: FAIL (0.003s)
[465.204591] Starting dynamic subtest: numvfs-6
[465.265857] Dynamic subtest numvfs-6: FAIL (0.004s)
[465.276371] Starting dynamic subtest: numvfs-7
[465.339872] Dynamic subtest numvfs-7: FAIL (0.004s)
[465.351726] Starting dynamic subtest: numvfs-random
[465.417762] Dynamic subtest numvfs-random: FAIL (0.004s)
[465.429548] Starting dynamic subtest: numvfs-all
[465.493614] Dynamic subtest numvfs-all: FAIL (0.446s)
[465.495645] Subtest enable-vfs-autoprobe-off: FAIL (0.495s)
[465.534973] [073/155] (555s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[465.653414] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[467.095415] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.398s)
[467.913649] [074/155] (552s left) api_intel_allocator (fork-simple-stress-signal)
[467.971321] Starting subtest: fork-simple-stress-signal
[473.522655] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[473.601648] [075/155] (547s left) kms_feature_discovery (chamelium)
[473.716102] Starting subtest: chamelium
[473.720741] Subtest chamelium: SKIP (0.000s)
[473.794390] [076/155] (547s left) gem_exec_schedule (u-semaphore-noskip)
[473.878030] Starting subtest: u-semaphore-noskip
[474.280349] Subtest u-semaphore-noskip: SUCCESS (0.407s)
[474.622967] [077/155] (546s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[475.013838] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[475.843149] [078/155] (545s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[475.955224] Starting subtest: fbchdr-rgb565-draw-pwrite
[475.959816] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[476.086540] [079/155] (545s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[476.188987] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[476.193222] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[476.328183] [080/155] (544s left) gem_userptr_blits (sd-probe)
[476.398647] Starting subtest: sd-probe
[476.400933] Subtest sd-probe: SUCCESS (0.000s)
[476.548508] [081/155] (544s left) gen3_render_tiledx_blits
[476.672834] [082/155] (544s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[476.769287] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[476.773536] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[476.876368] [083/155] (544s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[476.982734] Starting subtest: bad-pixel-format-yf-tiled-ccs
[476.984695] Starting dynamic subtest: pipe-A-eDP-1
[477.004483] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.018976] Starting dynamic subtest: pipe-B-eDP-1
[477.037204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.047401] Starting dynamic subtest: pipe-C-eDP-1
[477.065780] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.075799] Starting dynamic subtest: pipe-D-eDP-1
[477.094676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.098402] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[479.248220] [084/155] (542s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[479.361951] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[486.124335] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.737s)
[486.272246] [085/155] (535s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[486.334860] Starting subtest: invalid-bsd1-flag-on-vebox
[486.337583] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[486.438570] [086/155] (535s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[486.532172] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[487.593269] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.058s)
[487.704528] [087/155] (533s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[487.825237] Starting subtest: basic-busy-flip-before-cursor-atomic
[487.829036] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[487.967759] [088/155] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[488.066374] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[488.069982] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.185288] [089/155] (533s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[488.240587] Starting subtest: single-wait-all-for-submit-signaled
[488.242706] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[488.336180] [090/155] (533s left) i915_drm_fdinfo (virtual-busy-hang)
[488.371406] Starting subtest: virtual-busy-hang
[488.375456] Subtest virtual-busy-hang: SKIP (0.000s)
[488.433473] [091/155] (533s left) dumb_buffer (invalid-bpp)
[488.481993] Starting subtest: invalid-bpp
[488.483790] Subtest invalid-bpp: SUCCESS (0.000s)
[488.585310] [092/155] (533s left) kms_async_flips (test-cursor-atomic)
[488.682964] Starting subtest: test-cursor-atomic
[489.057360] Starting dynamic subtest: pipe-A-eDP-1
[489.874712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[490.264842] Starting dynamic subtest: pipe-B-eDP-1
[491.022761] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[491.417951] Starting dynamic subtest: pipe-C-eDP-1
[492.172726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[492.547281] Starting dynamic subtest: pipe-D-eDP-1
[493.295316] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.759s)
[493.297629] Subtest test-cursor-atomic: SUCCESS (4.607s)
[494.479050] [093/155] (527s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[494.594301] Starting subtest: psrhdr-2p-rte
[494.598695] Subtest psrhdr-2p-rte: SKIP (0.000s)
[494.695230] [094/155] (527s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[494.744075] Starting subtest: invalid-signal-one-illegal-handle
[494.746394] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[494.853899] [095/155] (526s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[494.946614] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[494.951151] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[495.031978] [096/155] (526s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[495.136201] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[495.140086] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[495.237566] [097/155] (526s left) gem_mmap (basic)
[495.302497] Subtest basic: SKIP (0.000s)
[495.361047] [098/155] (526s left) sw_sync (alloc_timeline)
[495.398955] Starting subtest: alloc_timeline
[495.400660] Subtest alloc_timeline: SUCCESS (0.000s)
[495.454820] [099/155] (526s left) kms_big_fb (linear-64bpp-rotate-0)
[495.552096] Starting subtest: linear-64bpp-rotate-0
[497.052470] Subtest linear-64bpp-rotate-0: SUCCESS (1.501s)
[497.211814] [100/155] (524s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[497.318023] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[497.322150] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.413370] [101/155] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[497.512071] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[497.515873] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[497.609241] [102/155] (524s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[497.704970] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[497.708409] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[497.816900] [103/155] (524s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[497.915981] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[497.919433] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[498.023348] [104/155] (524s left) i915_hangman (engine-engine-error)
[498.084842] Starting subtest: engine-engine-error
[498.086933] Starting dynamic subtest: rcs0
[499.998167] Dynamic subtest rcs0: SUCCESS (1.912s)
[500.009886] Starting dynamic subtest: bcs0
[501.980737] Dynamic subtest bcs0: SUCCESS (1.980s)
[501.992499] Starting dynamic subtest: vcs0
[503.964084] Dynamic subtest vcs0: SUCCESS (1.982s)
[503.978232] Starting dynamic subtest: vcs1
[506.012155] Dynamic subtest vcs1: SUCCESS (2.045s)
[506.026339] Starting dynamic subtest: vecs0
[507.994688] Dynamic subtest vecs0: SUCCESS (1.981s)
[508.008379] Starting dynamic subtest: ccs0
[509.982247] Dynamic subtest ccs0: SUCCESS (1.983s)
[509.985942] Subtest engine-engine-error: SUCCESS (11.898s)
[510.062761] [105/155] (512s left) i915_pm_rps (thresholds-park)
[510.127491] Starting subtest: thresholds-park
[510.132224] Subtest thresholds-park: SKIP (0.001s)
[510.233079] [106/155] (512s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[510.334488] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[510.338855] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[510.455120] [107/155] (511s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[510.543574] Starting subtest: 2x-absolute-wf_vblank-interruptible
[510.556514] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[510.652389] [108/155] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[510.748477] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[510.753023] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[510.857203] [109/155] (511s left) syncobj_wait (invalid-signal-bad-pad)
[510.911776] Starting subtest: invalid-signal-bad-pad
[510.913741] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[511.022325] [110/155] (511s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[511.130807] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[511.134198] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[511.238854] [111/155] (511s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[511.336767] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[511.340628] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[511.457670] [112/155] (511s left) kms_psr (psr-sprite-plane-onoff)
[511.555039] Starting subtest: psr-sprite-plane-onoff
[511.556962] Starting dynamic subtest: eDP-1
[513.288837] Dynamic subtest eDP-1: SUCCESS (1.732s)
[513.291056] Subtest psr-sprite-plane-onoff: SUCCESS (1.733s)
[514.154023] [113/155] (508s left) gem_lmem_swapping (random-engines)
[514.195751] Subtest random-engines: SKIP (0.000s)
[514.244012] [114/155] (508s left) gem_ctx_shared (q-smoketest)
[514.310316] Starting subtest: Q-smoketest
[514.312747] Starting dynamic subtest: rcs0
[519.909276] Dynamic subtest rcs0: SUCCESS (5.497s)
[519.920304] Starting dynamic subtest: bcs0
[525.401186] Dynamic subtest bcs0: SUCCESS (5.487s)
[525.412531] Starting dynamic subtest: vcs0
[530.886265] Dynamic subtest vcs0: SUCCESS (5.481s)
[530.900894] Starting dynamic subtest: vcs1
[536.356566] Dynamic subtest vcs1: SUCCESS (5.468s)
[536.370429] Starting dynamic subtest: vecs0
[541.837101] Dynamic subtest vecs0: SUCCESS (5.474s)
[541.850226] Starting dynamic subtest: ccs0
[547.299085] Dynamic subtest ccs0: SUCCESS (5.511s)
[547.301524] Subtest Q-smoketest: SUCCESS (32.929s)
[547.446285] [115/155] (475s left) gem_pxp (display-protected-crc)
[547.567926] Starting subtest: display-protected-crc
[549.703528] Subtest display-protected-crc: SUCCESS (2.138s)
[549.830017] [116/155] (472s left) gem_lmem_swapping (heavy-verify-multi)
[549.870497] Subtest heavy-verify-multi: SKIP (0.000s)
[549.917706] [117/155] (472s left) sysfs_heartbeat_interval (nopreempt)
[549.972644] Starting subtest: nopreempt
[549.974984] Starting dynamic subtest: vecs0
[559.044630] Dynamic subtest vecs0: SUCCESS (9.066s)
[559.057798] Starting dynamic subtest: ccs0
[563.037999] Dynamic subtest ccs0: SUCCESS (3.993s)
[563.051708] Starting dynamic subtest: vcs0
[573.052927] Dynamic subtest vcs0: SUCCESS (10.013s)
[573.065744] Starting dynamic subtest: bcs0
[577.030235] Dynamic subtest bcs0: SUCCESS (3.978s)
[577.044585] Starting dynamic subtest: rcs0
[581.074698] Dynamic subtest rcs0: SUCCESS (4.042s)
[581.086216] Starting dynamic subtest: vcs1
[590.015016] Dynamic subtest vcs1: SUCCESS (8.938s)
[590.017857] Subtest nopreempt: SUCCESS (40.042s)
[590.090289] [118/155] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[590.201638] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[597.323275] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.126s)
[597.437021] [119/155] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[597.560960] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[597.565398] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[597.653158] [120/155] (425s left) kms_chamelium_color (ctm-0-25)
[597.741400] Subtest ctm-0-25: SKIP (0.000s)
[597.796202] [121/155] (425s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[597.897517] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[597.902024] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[597.994966] [122/155] (424s left) kms_psr (psr-cursor-plane-move)
[598.087593] Starting subtest: psr-cursor-plane-move
[598.089769] Starting dynamic subtest: eDP-1
[599.874356] Dynamic subtest eDP-1: SUCCESS (1.784s)
[599.876702] Subtest psr-cursor-plane-move: SUCCESS (1.785s)
[600.740566] [123/155] (422s left) gem_userptr_blits (access-control)
[600.819536] Starting subtest: access-control
[600.823986] Subtest access-control: SKIP (0.000s)
[600.938244] [124/155] (422s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[601.027604] Starting subtest: fbc-psr-cursor-mmap-cpu
[601.029958] Starting dynamic subtest: eDP-1
[601.034253] Dynamic subtest eDP-1: SKIP (0.000s)
[601.038626] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[601.101500] [125/155] (422s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[601.198996] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[601.203397] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[601.270787] [126/155] (421s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[601.386429] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[633.165482] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.770s)
[633.969770] [127/155] (389s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[634.071434] Starting subtest: x-tiled-64bpp-rotate-180
[635.739854] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.668s)
[635.911394] [128/155] (387s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[636.019000] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[636.022779] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[636.127996] [129/155] (387s left) kms_pm_rpm (system-suspend-modeset)
[638.151178] Starting subtest: system-suspend-modeset
[657.617300] Subtest system-suspend-modeset: SUCCESS (4.541s)
[658.050817] [130/155] (365s left) gem_fence_thrash (bo-write-verify-x)
[658.093012] Starting subtest: bo-write-verify-x
[658.116695] Subtest bo-write-verify-x: SKIP (0.020s)
[658.174792] [131/155] (365s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[658.226586] Starting subtest: etime-multi-wait-all-for-submit-submitted
[658.328285] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.100s)
[658.422261] [132/155] (364s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[658.504589] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[658.506814] Starting dynamic subtest: pipe-A-eDP-1
[659.426587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.889s)
[659.437742] Starting dynamic subtest: pipe-B-eDP-1
[661.062516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[661.074678] Starting dynamic subtest: pipe-C-eDP-1
[662.581130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.486s)
[662.594148] Starting dynamic subtest: pipe-D-eDP-1
[664.131287] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[664.133218] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.494s)
[665.323642] [133/155] (358s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[665.424230] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[666.438773] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s)
[666.576200] [134/155] (356s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[666.678663] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[666.682847] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[666.798663] [135/155] (356s left) gem_pxp (hw-rejects-pxp-context)
[666.905900] Starting subtest: hw-rejects-pxp-context
[666.909749] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[667.028716] [136/155] (356s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[667.121584] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[667.125494] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[667.226300] [137/155] (356s left) gem_mmap_offset (perf)
[667.281150] Starting subtest: perf
[667.282919] Starting dynamic subtest: smem0
[667.654050] Dynamic subtest smem0: SUCCESS (0.365s)
[667.656449] Subtest perf: SUCCESS (0.366s)
[667.791329] [138/155] (355s left) i915_pm_rpm (gem-evict-pwrite)
[670.025721] Starting subtest: gem-evict-pwrite
[670.030967] Subtest gem-evict-pwrite: SKIP (0.000s)
[670.419398] [139/155] (353s left) gem_userptr_blits (process-exit)
[670.475874] Starting subtest: process-exit
[670.484045] Subtest process-exit: SUCCESS (0.010s)
[670.611506] [140/155] (353s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[670.701442] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[670.705662] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[670.792960] [141/155] (353s left) kms_dp_link_training (non-uhbr-sst)
[670.875812] Starting subtest: non-uhbr-sst
[670.884468] Subtest non-uhbr-sst: SKIP (0.000s)
[670.949724] [142/155] (352s left) gem_exec_reloc (basic-write-gtt)
[671.009442] Subtest basic-write-gtt: SKIP (0.000s)
[671.077652] [143/155] (352s left) kms_addfb_basic (too-wide)
[671.165677] Starting subtest: too-wide
[671.167928] Subtest too-wide: SUCCESS (0.000s)
[671.279047] [144/155] (352s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[671.374330] Starting subtest: psr2-plane-move-sf-dmg-area
[671.376340] Starting dynamic subtest: pipe-A-eDP-1
[675.978918] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.587s)
[675.990779] Starting dynamic subtest: pipe-B-eDP-1
[681.308630] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.314s)
[681.311188] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.903s)
[682.210696] [145/155] (341s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[682.310218] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[682.314684] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[682.415450] [146/155] (341s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[682.515401] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[682.519525] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[682.640437] [147/155] (341s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[682.728418] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[682.732869] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[682.801555] [148/155] (341s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[682.938098] Starting subtest: dp-mst-type-1-suspend-resume
[682.943060] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[683.050971] [149/155] (341s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[683.101087] Subtest tiled-to-tiled: SKIP (0.000s)
[683.166109] [150/155] (341s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[683.267386] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[683.270716] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[683.389216] [151/155] (340s left) gem_caching (reads)
[683.444805] Subtest reads: SKIP (0.000s)
[683.545297] [152/155] (340s left) gem_ctx_param (invalid-param-set)
[683.587266] Starting subtest: invalid-param-set
[683.589191] Subtest invalid-param-set: SUCCESS (0.000s)
[683.687339] [153/155] (340s left) kms_color (invalid-degamma-lut-sizes)
[683.774243] Starting subtest: invalid-degamma-lut-sizes
[683.776184] Starting dynamic subtest: pipe-A
[684.069470] Dynamic subtest pipe-A: SUCCESS (0.294s)
[684.086485] Starting dynamic subtest: pipe-B
[684.088856] Dynamic subtest pipe-B: SUCCESS (0.000s)
[684.100060] Starting dynamic subtest: pipe-C
[684.102361] Dynamic subtest pipe-C: SUCCESS (0.000s)
[684.112484] Starting dynamic subtest: pipe-D
[684.114484] Dynamic subtest pipe-D: SUCCESS (0.000s)
[684.116458] Subtest invalid-degamma-lut-sizes: SUCCESS (0.298s)
[684.923945] [154/155] (339s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[685.029918] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[685.034182] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[685.123272] [155/155] (339s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[685.220992] Starting subtest: psrhdr-farfromfence-mmap-gtt
[685.225195] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[685.321166] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_readwrite
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: kms_plane_cursor
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_pm_dc
results: parsing output: 21/ for test: gem_ccs
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_chamelium_edid
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_universal_plane
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: gem_exec_parallel
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: kms_cursor_edge_walk
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_pread
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: prime_mmap
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: sriov_basic
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: api_intel_allocator
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gen3_render_tiledx_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: dumb_buffer
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_hangman
results: parsing output: 104/ for test: i915_pm_rps
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: gem_ctx_shared
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: sysfs_heartbeat_interval
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_chamelium_color
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: gem_fence_thrash
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_pxp
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_mmap_offset
results: parsing output: 137/ for test: i915_pm_rpm
results: parsing output: 138/ for test: gem_userptr_blits
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_dp_link_training
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: kms_psr2_sf
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_plane
results: parsing output: 147/ for test: kms_content_protection
results: parsing output: 148/ for test: gem_set_tiling_vs_blt
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_caching
results: parsing output: 151/ for test: gem_ctx_param
results: parsing output: 152/ for test: kms_color
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.