[60.827478] Initializing watchdogs
[60.827528]   /dev/watchdog0
[60.841709] [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]
[60.846594] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.849149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.852916] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[60.977069] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[60.979397] Starting dynamic subtest: pipe-A-eDP-1
[60.999607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[61.008427] Starting dynamic subtest: pipe-B-eDP-1
[61.027909] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.034739] Starting dynamic subtest: pipe-C-eDP-1
[61.053481] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.061040] Starting dynamic subtest: pipe-D-eDP-1
[61.080308] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[61.082587] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[63.299875] [002/130] (958s left) gem_fence_thrash (bo-write-verify-x)
[63.338305] Starting subtest: bo-write-verify-x
[63.368377] Subtest bo-write-verify-x: SKIP (0.027s)
[63.434975] [003/130] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[63.548856] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[71.006970] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.447s)
[71.151525] [004/130] (950s left) gem_exec_parallel (contexts)
[71.213984] Starting subtest: contexts
[71.216433] Starting dynamic subtest: rcs0
[74.143227] Dynamic subtest rcs0: SUCCESS (2.925s)
[74.153871] Starting dynamic subtest: bcs0
[77.394091] Dynamic subtest bcs0: SUCCESS (3.248s)
[77.402152] Starting dynamic subtest: vcs0
[81.434037] Dynamic subtest vcs0: SUCCESS (4.034s)
[81.444077] Starting dynamic subtest: vcs1
[85.357065] Dynamic subtest vcs1: SUCCESS (3.922s)
[85.367322] Starting dynamic subtest: vecs0
[89.350230] Dynamic subtest vecs0: SUCCESS (3.991s)
[89.359688] Starting dynamic subtest: ccs0
[92.838862] Dynamic subtest ccs0: SUCCESS (3.484s)
[92.843273] Subtest contexts: SUCCESS (21.609s)
[93.050810] [005/130] (928s left) gem_wait (invalid-buf)
[93.110297] Starting subtest: invalid-buf
[93.112646] Subtest invalid-buf: SUCCESS (0.000s)
[93.364270] [006/130] (928s left) gem_tiled_wb
[93.484347] [007/130] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[93.584598] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[97.143940] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.563s)
[98.368616] [008/130] (923s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[98.462059] Starting subtest: x-tiled-8bpp-rotate-90
[98.486637] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[98.629069] [009/130] (923s left) i915_drm_fdinfo (most-busy-idle-check-all)
[98.673585] Starting subtest: most-busy-idle-check-all
[98.675813] Starting dynamic subtest: rcs0
[98.680191] Dynamic subtest rcs0: SKIP (0.005s)
[98.688698] Starting dynamic subtest: bcs0
[98.693019] Dynamic subtest bcs0: SKIP (0.000s)
[98.700868] Starting dynamic subtest: vcs0
[98.704827] Dynamic subtest vcs0: SKIP (0.000s)
[98.712686] Starting dynamic subtest: vcs1
[98.717042] Dynamic subtest vcs1: SKIP (0.000s)
[98.725076] Starting dynamic subtest: vecs0
[98.729363] Dynamic subtest vecs0: SKIP (0.001s)
[98.736903] Starting dynamic subtest: ccs0
[98.741354] Dynamic subtest ccs0: SKIP (0.001s)
[98.745880] Subtest most-busy-idle-check-all: SKIP (0.009s)
[98.781783] [010/130] (922s left) gem_exec_reloc (basic-wc-noreloc)
[98.896952] Subtest basic-wc-noreloc: SKIP (0.000s)
[98.972698] [011/130] (922s left) gem_mmap_offset (blt-coherency)
[99.040933] Starting subtest: blt-coherency
[99.048610] Subtest blt-coherency: SUCCESS (0.010s)
[99.224885] [012/130] (922s left) kms_dp_aux_dev
[99.606793] [013/130] (922s left) gem_exec_params (cliprects-invalid)
[99.665223] Starting subtest: cliprects-invalid
[99.667343] Subtest cliprects-invalid: SUCCESS (0.000s)
[99.803631] [014/130] (922s left) vgem_basic (mmap)
[99.926205] Starting subtest: mmap
[99.936961] Subtest mmap: SUCCESS (0.012s)
[100.014239] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[100.017315] [015/130] (921s left) kms_getfb (getfb-handle-closed)
[100.116087] Starting subtest: getfb-handle-closed
[100.118345] Subtest getfb-handle-closed: SUCCESS (0.000s)
[100.240794] [016/130] (921s left) kms_cursor_crc (cursor-offscreen-max-size)
[100.562969] Starting subtest: cursor-offscreen-max-size
[100.568580] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[100.735542] [017/130] (921s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[100.882062] Starting subtest: cursorB-vs-flipB-varying-size
[100.885895] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[101.074538] [018/130] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[101.170460] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[101.174110] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.305779] [019/130] (920s left) kms_big_fb (linear-8bpp-rotate-270)
[101.408465] Starting subtest: linear-8bpp-rotate-270
[101.429556] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[101.565039] [020/130] (920s left) kms_dp_linktrain_fallback (dp-fallback)
[101.657447] Starting subtest: dp-fallback
[101.662957] Subtest dp-fallback: SKIP (0.000s)
[101.762115] [021/130] (920s left) core_debugfs (read-all-entries)
[101.819126] Starting subtest: read-all-entries
[101.916557] Subtest read-all-entries: SUCCESS (0.096s)
[102.041061] [022/130] (920s left) gem_ctx_param (invalid-get-engines)
[102.095446] Starting subtest: invalid-get-engines
[102.097531] Subtest invalid-get-engines: SUCCESS (0.001s)
[102.233381] [023/130] (919s left) vgem_basic (setversion)
[102.284421] Starting subtest: setversion
[102.288599] Subtest setversion: SUCCESS (0.000s)
[102.368715] [024/130] (919s left) kms_psr (psr-primary-render)
[102.452234] Starting subtest: psr-primary-render
[102.454089] Starting dynamic subtest: eDP-1
[104.241696] Dynamic subtest eDP-1: SUCCESS (1.788s)
[104.243703] Subtest psr-primary-render: SUCCESS (1.789s)
[105.129288] [025/130] (917s left) kms_getfb (getfb-handle-zero)
[105.229205] Starting subtest: getfb-handle-zero
[105.231159] Subtest getfb-handle-zero: SUCCESS (0.000s)
[105.351877] [026/130] (916s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[105.440264] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[105.442536] Starting dynamic subtest: pipe-A-default-mode
[105.728253] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[105.732841] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.287s)
[106.550311] [027/130] (915s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[106.610613] Starting subtest: basic-batch-kernel-default-cmd
[106.614875] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[106.816741] [028/130] (915s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[106.928561] Starting subtest: fbc-farfromfence-mmap-gtt
[106.932796] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[107.062881] [029/130] (915s left) kms_plane_multiple (2x-tiling-4)
[107.158554] Starting subtest: 2x-tiling-4
[107.162645] Subtest 2x-tiling-4: SKIP (0.000s)
[107.255727] [030/130] (915s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[107.350916] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[107.353305] Starting dynamic subtest: pipe-A-eDP-1
[107.527985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.168s)
[107.537939] Starting dynamic subtest: pipe-B-eDP-1
[107.558284] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[107.566145] Starting dynamic subtest: pipe-C-eDP-1
[107.584990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[107.592523] Starting dynamic subtest: pipe-D-eDP-1
[107.611382] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[107.613607] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.178s)
[109.825154] [031/130] (912s left) gem_eio (in-flight-suspend)
[110.079639] Starting subtest: in-flight-suspend
[157.497855] Subtest in-flight-suspend: SUCCESS (17.877s)
[157.664031] [032/130] (864s left) gen7_exec_parse (bitmasks)
[157.742973] Subtest bitmasks: SKIP (0.000s)
[157.828230] [033/130] (864s left) gem_mmap_gtt (medium-copy-xy)
[157.894939] Subtest medium-copy-XY: SKIP (0.000s)
[157.955607] [034/130] (864s left) kms_chamelium_frames (hdmi-crc-single)
[158.364590] Subtest hdmi-crc-single: SKIP (0.000s)
[159.204439] [035/130] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[159.312994] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[159.317560] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[159.428788] [036/130] (863s left) gem_exec_schedule (timeslicing)
[159.514264] Starting subtest: timeslicing
[159.516655] Starting dynamic subtest: rcs0
[159.524999] Dynamic subtest rcs0: SUCCESS (0.021s)
[159.537666] Starting dynamic subtest: bcs0
[159.546316] Dynamic subtest bcs0: SUCCESS (0.021s)
[159.555752] Starting dynamic subtest: vcs0
[159.567999] Dynamic subtest vcs0: SUCCESS (0.021s)
[159.577496] Starting dynamic subtest: vcs1
[159.592013] Dynamic subtest vcs1: SUCCESS (0.023s)
[159.605927] Starting dynamic subtest: vecs0
[159.613492] Dynamic subtest vecs0: SUCCESS (0.021s)
[159.626722] Starting dynamic subtest: ccs0
[159.636445] Dynamic subtest ccs0: SUCCESS (0.022s)
[159.638780] Subtest timeslicing: SUCCESS (0.130s)
[161.534307] [037/130] (861s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[166.603819] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[166.606306] Starting dynamic subtest: pipe-A-eDP-1
[183.864274] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.191s)
[183.875234] Starting dynamic subtest: pipe-B-eDP-1
[201.093427] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.219s)
[201.095560] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.414s)
[201.907228] [038/130] (820s left) gem_exec_schedule (deep)
[202.101769] Starting subtest: deep
[202.104337] Starting dynamic subtest: rcs0
[207.625711] Dynamic subtest rcs0: SKIP (5.518s)
[207.637626] Starting dynamic subtest: vcs0
[218.702162] Dynamic subtest vcs0: SUCCESS (11.074s)
[218.716110] Starting dynamic subtest: vcs1
[230.773609] Dynamic subtest vcs1: SUCCESS (12.065s)
[230.785500] Starting dynamic subtest: vecs0
[242.803085] Dynamic subtest vecs0: SUCCESS (12.013s)
[242.815638] Starting dynamic subtest: ccs0
[255.318664] Dynamic subtest ccs0: SUCCESS (12.521s)
[255.321944] Subtest deep: SUCCESS (53.196s)
[257.139055] [039/130] (765s left) kms_color (degamma)
[257.240582] Starting subtest: degamma
[257.242443] Starting dynamic subtest: pipe-A-eDP-1
[257.993316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[258.004017] Starting dynamic subtest: pipe-B-eDP-1
[259.427831] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[259.438658] Starting dynamic subtest: pipe-C-eDP-1
[260.812062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[260.823711] Starting dynamic subtest: pipe-D-eDP-1
[262.234536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[262.236932] Subtest degamma: SUCCESS (4.998s)
[263.130826] [040/130] (759s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[263.236758] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[263.241004] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[263.347181] [041/130] (759s left) gem_eio (banned)
[263.575728] Starting subtest: banned
[264.184807] Subtest banned: SUCCESS (0.609s)
[264.377416] [042/130] (758s left) gem_ppgtt (flink-and-close-vma-leak)
[264.442199] Starting subtest: flink-and-close-vma-leak
[264.483053] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[264.652125] [043/130] (758s left) kms_cursor_crc (cursor-sliding-128x42)
[264.887015] Starting subtest: cursor-sliding-128x42
[264.936520] Subtest cursor-sliding-128x42: SKIP (0.044s)
[265.199143] [044/130] (757s left) kms_atomic_transition (modeset-transition-nonblocking)
[265.313384] Starting subtest: modeset-transition-nonblocking
[265.315034] Starting dynamic subtest: 1x-outputs
[276.383725] Dynamic subtest 1x-outputs: SUCCESS (11.072s)
[276.386004] Subtest modeset-transition-nonblocking: SUCCESS (11.073s)
[277.271106] [045/130] (745s left) kms_plane_alpha_blend (alpha-transparent-fb)
[277.366768] Starting subtest: alpha-transparent-fb
[277.658600] Starting dynamic subtest: pipe-A-eDP-1
[278.279100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[278.298714] Starting dynamic subtest: pipe-D-eDP-1
[279.613380] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[279.615795] Subtest alpha-transparent-fb: SUCCESS (2.247s)
[280.439239] [046/130] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[280.544798] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[287.963307] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.420s)
[288.099752] [047/130] (735s left) syncobj_wait (wait-all-complex)
[288.161914] Starting subtest: wait-all-complex
[288.374629] Subtest wait-all-complex: SUCCESS (0.212s)
[288.470685] [048/130] (734s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[288.575622] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[295.310050] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.736s)
[295.459099] [049/130] (727s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[295.564037] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[295.568575] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[296.707031] [050/130] (726s left) gem_exec_whisper (basic-fds-priority)
[296.777839] Starting subtest: basic-fds-priority
[320.819181] Subtest basic-fds-priority: SUCCESS (24.035s)
[321.032798] [051/130] (702s left) gem_wait (await)
[321.112699] Starting subtest: await
[321.115428] Starting dynamic subtest: all-engines
[322.295367] Dynamic subtest all-engines: SUCCESS (1.182s)
[322.307789] Starting dynamic subtest: rcs0
[323.389955] Dynamic subtest rcs0: SUCCESS (1.092s)
[323.407325] Starting dynamic subtest: bcs0
[324.453469] Dynamic subtest bcs0: SUCCESS (1.060s)
[324.470712] Starting dynamic subtest: vcs0
[325.509247] Dynamic subtest vcs0: SUCCESS (1.054s)
[325.526533] Starting dynamic subtest: vcs1
[326.565312] Dynamic subtest vcs1: SUCCESS (1.053s)
[326.582884] Starting dynamic subtest: vecs0
[327.619272] Dynamic subtest vecs0: SUCCESS (1.051s)
[327.636001] Starting dynamic subtest: ccs0
[328.676247] Dynamic subtest ccs0: SUCCESS (1.055s)
[328.678663] Subtest await: SUCCESS (7.563s)
[328.902572] [052/130] (694s left) kms_psr (pr-no-drrs)
[328.999810] Starting subtest: pr-no-drrs
[329.003933] Subtest pr-no-drrs: SKIP (0.000s)
[329.099254] [053/130] (694s left) kms_joiner (basic-max-non-joiner)
[329.202401] Starting subtest: basic-max-non-joiner
[329.206623] Subtest basic-max-non-joiner: SKIP (0.000s)
[329.282076] [054/130] (694s left) kms_vblank (query-idle-hang)
[329.386005] Starting subtest: query-idle-hang
[329.388177] Starting dynamic subtest: pipe-A-eDP-1
[356.286718] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.891s)
[356.302430] Starting dynamic subtest: pipe-D-eDP-1
[381.193563] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.896s)
[381.195543] Subtest query-idle-hang: SUCCESS (51.791s)
[382.088078] [055/130] (641s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[382.151437] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[382.153845] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[382.295275] [056/130] (641s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[382.572756] Starting subtest: cursor-rapid-movement-256x85
[382.622958] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[382.856317] [057/130] (640s left) gem_lmem_swapping (verify-ccs)
[382.902431] Subtest verify-ccs: SKIP (0.000s)
[382.953499] [058/130] (640s left) kms_universal_plane (cursor-fb-leak)
[383.054059] Starting subtest: cursor-fb-leak
[383.055927] Starting dynamic subtest: pipe-A-eDP-1
[383.374857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.323s)
[383.385935] Starting dynamic subtest: pipe-B-eDP-1
[384.777616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[384.792949] Starting dynamic subtest: pipe-C-eDP-1
[386.079966] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[386.090630] Starting dynamic subtest: pipe-D-eDP-1
[387.419310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[387.421692] Subtest cursor-fb-leak: SUCCESS (4.368s)
[388.625579] [059/130] (635s left) kms_getfb (getfb-reject-nv12)
[388.714392] Starting subtest: getfb-reject-nv12
[388.716534] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[388.861647] [060/130] (634s left) kms_lease (atomic-implicit-crtc)
[388.964921] Starting subtest: atomic-implicit-crtc
[388.967034] Starting dynamic subtest: pipe-A-eDP-1
[388.978158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[388.988769] Starting dynamic subtest: pipe-B-eDP-1
[388.999800] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[389.009397] Starting dynamic subtest: pipe-C-eDP-1
[389.020139] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[389.029044] Starting dynamic subtest: pipe-D-eDP-1
[389.039716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[389.041600] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[389.134948] [061/130] (634s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[389.235589] Starting subtest: flip-vs-dpms-on-nop-interruptible
[389.237459] Starting dynamic subtest: A-eDP1
[391.099049] Dynamic subtest A-eDP1: SUCCESS (1.862s)
[391.109043] Starting dynamic subtest: B-eDP1
[392.927580] Dynamic subtest B-eDP1: SUCCESS (1.827s)
[392.940337] Starting dynamic subtest: C-eDP1
[394.741556] Dynamic subtest C-eDP1: SUCCESS (1.814s)
[394.752757] Starting dynamic subtest: D-eDP1
[396.570986] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[396.576757] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.341s)
[397.781916] [062/130] (626s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[397.884929] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[397.887018] Starting dynamic subtest: pipe-A-eDP-1
[398.628950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[398.638532] Starting dynamic subtest: pipe-B-eDP-1
[400.401973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.771s)
[400.412385] Starting dynamic subtest: pipe-C-eDP-1
[402.220744] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[402.231797] Starting dynamic subtest: pipe-D-eDP-1
[404.051600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.831s)
[404.053549] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.162s)
[405.301421] [063/130] (618s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[405.409037] Starting subtest: fbc-modesetfrombusy
[409.234833] Subtest fbc-modesetfrombusy: SUCCESS (3.830s)
[410.435369] [064/130] (613s left) gem_create (busy-create)
[410.498952] Starting subtest: busy-create
[410.500916] Starting dynamic subtest: smem0
[444.510595] Dynamic subtest smem0: SUCCESS (34.014s)
[444.513226] Subtest busy-create: SUCCESS (34.016s)
[444.724385] [065/130] (579s left) kms_psr (fbc-pr-sprite-render)
[444.827876] Starting subtest: fbc-pr-sprite-render
[444.832138] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[444.925041] [066/130] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[445.037454] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[445.041804] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[445.160924] [067/130] (578s left) gem_ctx_persistence (engines-queued)
[445.220056] Starting subtest: engines-queued
[445.222357] Starting dynamic subtest: rcs0
[445.299471] Dynamic subtest rcs0: SUCCESS (0.079s)
[445.309786] Starting dynamic subtest: bcs0
[445.390429] Dynamic subtest bcs0: SUCCESS (0.089s)
[445.403407] Starting dynamic subtest: vcs0
[447.450673] Dynamic subtest vcs0: SUCCESS (2.056s)
[447.463514] Starting dynamic subtest: vcs1
[449.433357] Dynamic subtest vcs1: SUCCESS (1.980s)
[449.446404] Starting dynamic subtest: vecs0
[451.416742] Dynamic subtest vecs0: SUCCESS (1.981s)
[451.430188] Starting dynamic subtest: ccs0
[451.611028] Dynamic subtest ccs0: SUCCESS (0.193s)
[451.613413] Subtest engines-queued: SUCCESS (6.390s)
[451.786717] [068/130] (572s left) gem_sync (basic-each)
[451.857472] Starting subtest: basic-each
[454.419119] Subtest basic-each: SUCCESS (2.570s)
[454.634278] [069/130] (569s left) gem_render_copy (x-tiled)
[454.701319] Starting subtest: x-tiled
[454.703575] Starting dynamic subtest: smem
[454.746501] Dynamic subtest smem: SUCCESS (0.048s)
[454.749004] Subtest x-tiled: SUCCESS (0.048s)
[455.035034] [070/130] (569s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[455.092942] Starting subtest: yf-tiled-ccs-to-x-tiled
[455.097121] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[455.306622] [071/130] (568s left) kms_flip (basic-flip-vs-wf_vblank)
[455.408827] Starting subtest: basic-flip-vs-wf_vblank
[455.410701] Starting dynamic subtest: A-eDP1
[457.340370] Dynamic subtest A-eDP1: SUCCESS (1.933s)
[457.350483] Starting dynamic subtest: B-eDP1
[459.278981] Dynamic subtest B-eDP1: SUCCESS (1.937s)
[459.289288] Starting dynamic subtest: C-eDP1
[461.193133] Dynamic subtest C-eDP1: SUCCESS (1.912s)
[461.205644] Starting dynamic subtest: D-eDP1
[463.125712] Dynamic subtest D-eDP1: SUCCESS (1.931s)
[463.128091] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.722s)
[464.379071] [072/130] (559s left) gem_exec_reloc (basic-gtt-wc-active)
[464.448346] Subtest basic-gtt-wc-active: SKIP (0.000s)
[464.530203] [073/130] (559s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[464.625632] Starting subtest: async-flip-with-page-flip-events-tiled
[465.008691] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[466.344372] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.753s)
[466.355550] Starting dynamic subtest: pipe-A-eDP-1-4
[466.679459] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.650s)
[466.688976] Starting dynamic subtest: pipe-A-eDP-1-4
[466.802751] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.016s)
[466.813670] Starting dynamic subtest: pipe-A-eDP-1-x
[467.103552] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.167s)
[467.113550] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[468.384098] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.189s)
[468.394113] Starting dynamic subtest: pipe-B-eDP-1-4
[468.746729] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.176s)
[468.758351] Starting dynamic subtest: pipe-B-eDP-1-4
[468.873097] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.008s)
[468.883827] Starting dynamic subtest: pipe-B-eDP-1-x
[469.175581] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.612s)
[469.369138] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[472.111126] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[472.121273] Starting dynamic subtest: pipe-C-eDP-1-4
[474.275126] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[474.285319] Starting dynamic subtest: pipe-C-eDP-1-4
[476.285056] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[476.295705] Starting dynamic subtest: pipe-C-eDP-1-x
[478.454099] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[478.835697] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[481.557572] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.729s)
[481.568546] Starting dynamic subtest: pipe-D-eDP-1-4
[483.733172] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[483.743206] Starting dynamic subtest: pipe-D-eDP-1-4
[485.743579] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[485.754558] Starting dynamic subtest: pipe-D-eDP-1-x
[487.922562] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[487.924954] Subtest async-flip-with-page-flip-events-tiled: FAIL (23.295s)
[489.165271] [074/130] (535s left) gem_softpin (allocator-basic-reserve)
[489.231857] Starting subtest: allocator-basic-reserve
[489.295351] Subtest allocator-basic-reserve: SUCCESS (0.063s)
[489.462507] [075/130] (535s left) perf_pmu (pmu-read)
[489.498409] Starting subtest: pmu-read
[489.500590] Subtest pmu-read: SUCCESS (0.003s)
[489.637430] [076/130] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[489.736643] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[489.741423] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.854115] [077/130] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[489.963117] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[489.967119] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[490.093788] [078/130] (534s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[490.138350] Starting subtest: single-wait-for-submit-available-submitted
[490.140342] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[490.283084] [079/130] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[490.381298] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[490.384674] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[490.514843] [080/130] (534s left) gem_render_copy (yf-tiled-to-vebox-linear)
[490.579633] Starting subtest: yf-tiled-to-vebox-linear
[490.583431] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[490.790882] [081/130] (533s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[491.366832] Starting subtest: syncobj-stationary-timeline-chain-engines
[491.492242] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.127s)
[492.557183] [082/130] (532s left) kms_psr (fbc-pr-primary-mmap-gtt)
[492.655229] Starting subtest: fbc-pr-primary-mmap-gtt
[492.659556] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[492.750324] [083/130] (532s left) gem_mmap_wc (copy)
[492.814651] Subtest copy: SKIP (0.000s)
[492.884210] [084/130] (531s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[492.983982] Starting subtest: plane-upscale-factor-0-25-with-rotation
[492.986211] Starting dynamic subtest: pipe-A
[493.208243] Dynamic subtest pipe-A: SUCCESS (0.226s)
[493.218225] Starting dynamic subtest: pipe-B
[494.519521] Dynamic subtest pipe-B: SUCCESS (1.310s)
[494.530153] Starting dynamic subtest: pipe-C
[495.860437] Dynamic subtest pipe-C: SUCCESS (1.340s)
[495.870842] Starting dynamic subtest: pipe-D
[497.179974] Dynamic subtest pipe-D: SUCCESS (1.317s)
[497.182355] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.198s)
[498.381959] [085/130] (526s left) gem_exec_schedule (preemptive-hang)
[498.552838] Starting subtest: preemptive-hang
[498.555608] Starting dynamic subtest: rcs0
[507.558553] Dynamic subtest rcs0: SUCCESS (9.009s)
[507.570374] Starting dynamic subtest: bcs0
[516.580072] Dynamic subtest bcs0: SUCCESS (9.015s)
[516.591090] Starting dynamic subtest: vcs0
[525.542137] Dynamic subtest vcs0: SUCCESS (8.962s)
[525.553817] Starting dynamic subtest: vcs1
[534.628498] Dynamic subtest vcs1: SUCCESS (9.083s)
[534.639432] Starting dynamic subtest: vecs0
[543.583051] Dynamic subtest vecs0: SUCCESS (8.950s)
[543.594002] Starting dynamic subtest: ccs0
[552.548357] Dynamic subtest ccs0: SUCCESS (8.965s)
[552.550760] Subtest preemptive-hang: SUCCESS (53.991s)
[552.856426] [086/130] (472s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[552.962927] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[552.965014] Starting dynamic subtest: pipe-A-eDP-1
[552.987003] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.998710] Starting dynamic subtest: pipe-B-eDP-1
[553.019145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[553.028499] Starting dynamic subtest: pipe-C-eDP-1
[553.049069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[553.058449] Starting dynamic subtest: pipe-D-eDP-1
[553.080300] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[553.084558] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[555.236285] [087/130] (469s left) gem_exec_suspend (basic-s3)
[555.304819] Starting subtest: basic-S3
[555.307224] Starting dynamic subtest: smem
[576.168361] Dynamic subtest smem: SUCCESS (7.078s)
[576.171619] Subtest basic-S3: SUCCESS (7.080s)
[576.384979] [088/130] (448s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[576.492291] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[576.497475] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[576.632505] [089/130] (448s left) gem_huc_copy (huc-copy)
[576.693603] Starting subtest: huc-copy
[576.699658] Subtest huc-copy: SUCCESS (0.004s)
[576.848949] [090/130] (448s left) kms_flip (flip-vs-expired-vblank)
[576.953138] Starting subtest: flip-vs-expired-vblank
[576.955758] Starting dynamic subtest: A-eDP1
[585.678785] Dynamic subtest A-eDP1: SUCCESS (8.605s)
[585.690430] Starting dynamic subtest: B-eDP1
[594.318398] Dynamic subtest B-eDP1: SUCCESS (8.597s)
[594.329616] Starting dynamic subtest: C-eDP1
[602.969607] Dynamic subtest C-eDP1: SUCCESS (8.633s)
[602.980473] Starting dynamic subtest: D-eDP1
[611.611752] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[611.614326] Subtest flip-vs-expired-vblank: SUCCESS (34.482s)
[612.809079] [091/130] (412s left) i915_pm_rc6_residency (rc6-fence)
[612.866232] Starting subtest: rc6-fence
[612.884742] Starting dynamic subtest: gt0
[627.178957] Dynamic subtest gt0: SUCCESS (14.291s)
[627.192472] Starting dynamic subtest: gt1
[641.189998] Dynamic subtest gt1: SUCCESS (14.004s)
[641.193168] Subtest rc6-fence: SUCCESS (28.321s)
[641.293264] [092/130] (383s left) kms_plane (plane-position-hole)
[641.425503] Starting subtest: plane-position-hole
[641.953614] Starting dynamic subtest: pipe-A-plane-1
[643.284571] Dynamic subtest pipe-A-plane-1: SUCCESS (1.331s)
[643.295849] Starting dynamic subtest: pipe-A-plane-2
[644.600861] Dynamic subtest pipe-A-plane-2: SUCCESS (1.315s)
[644.615416] Starting dynamic subtest: pipe-A-plane-3
[645.909520] Dynamic subtest pipe-A-plane-3: SUCCESS (1.309s)
[645.921638] Starting dynamic subtest: pipe-A-plane-4
[647.148245] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[647.160978] Starting dynamic subtest: pipe-A-plane-5
[647.175501] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[648.322523] Starting dynamic subtest: pipe-B-plane-1
[649.634267] Dynamic subtest pipe-B-plane-1: SUCCESS (1.331s)
[649.646699] Starting dynamic subtest: pipe-B-plane-2
[650.914070] Dynamic subtest pipe-B-plane-2: SUCCESS (1.278s)
[650.926745] Starting dynamic subtest: pipe-B-plane-3
[652.192638] Dynamic subtest pipe-B-plane-3: SUCCESS (1.277s)
[652.203345] Starting dynamic subtest: pipe-B-plane-4
[653.516775] Dynamic subtest pipe-B-plane-4: SUCCESS (1.320s)
[653.528356] Starting dynamic subtest: pipe-B-plane-5
[653.543468] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[653.546381] Subtest plane-position-hole: SUCCESS (12.113s)
[654.423980] [093/130] (370s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[654.516358] Starting subtest: random-ccs-data-yf-tiled-ccs
[654.519090] Starting dynamic subtest: pipe-A-eDP-1
[654.547897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[654.558755] Starting dynamic subtest: pipe-B-eDP-1
[654.587148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[654.598357] Starting dynamic subtest: pipe-C-eDP-1
[654.628086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[654.639453] Starting dynamic subtest: pipe-D-eDP-1
[654.668571] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[654.673340] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[656.708451] [094/130] (368s left) i915_hangman (engine-engine-error)
[656.777622] Starting subtest: engine-engine-error
[656.780504] Starting dynamic subtest: rcs0
[658.181909] Dynamic subtest rcs0: SUCCESS (1.405s)
[658.196113] Starting dynamic subtest: bcs0
[660.164531] Dynamic subtest bcs0: SUCCESS (1.979s)
[660.181886] Starting dynamic subtest: vcs0
[662.149942] Dynamic subtest vcs0: SUCCESS (1.982s)
[662.163731] Starting dynamic subtest: vcs1
[664.134332] Dynamic subtest vcs1: SUCCESS (1.981s)
[664.152765] Starting dynamic subtest: vecs0
[666.117875] Dynamic subtest vecs0: SUCCESS (1.979s)
[666.131948] Starting dynamic subtest: ccs0
[668.165222] Dynamic subtest ccs0: SUCCESS (2.044s)
[668.168269] Subtest engine-engine-error: SUCCESS (11.387s)
[668.273630] [095/130] (357s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[668.380275] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[675.805483] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.426s)
[675.992457] [096/130] (349s left) gem_pwrite (basic-exhaustion)
[676.059589] Subtest basic-exhaustion: SKIP (0.000s)
[676.120434] [097/130] (349s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[676.169601] Starting subtest: etime-single-wait-available-unsubmitted
[676.275337] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[676.373797] [098/130] (349s left) kms_prime (basic-crc-vgem)
[676.462594] Starting subtest: basic-crc-vgem
[676.465396] Starting dynamic subtest: second-to-first
[677.510528] Dynamic subtest second-to-first: SUCCESS (1.049s)
[677.513373] Subtest basic-crc-vgem: SUCCESS (1.050s)
[677.622817] [099/130] (347s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[677.708060] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[677.710402] Starting dynamic subtest: pipe-A-default-mode
[677.998410] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[678.004418] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.289s)
[678.852418] [100/130] (346s left) gem_exec_balancer (invalid-bonds)
[678.916265] Starting subtest: invalid-bonds
[678.922158] Subtest invalid-bonds: SKIP (0.000s)
[679.253892] [101/130] (346s left) gem_exec_balancer (sliced)
[679.313608] Starting subtest: sliced
[679.319599] Subtest sliced: SKIP (0.000s)
[679.625909] [102/130] (346s left) gem_exec_parallel (basic)
[679.689650] Starting subtest: basic
[679.692629] Starting dynamic subtest: rcs0
[681.376364] Dynamic subtest rcs0: SUCCESS (1.687s)
[681.389517] Starting dynamic subtest: bcs0
[683.195718] Dynamic subtest bcs0: SUCCESS (1.819s)
[683.209497] Starting dynamic subtest: vcs0
[685.160927] Dynamic subtest vcs0: SUCCESS (1.963s)
[685.174614] Starting dynamic subtest: vcs1
[687.142990] Dynamic subtest vcs1: SUCCESS (1.982s)
[687.156832] Starting dynamic subtest: vecs0
[689.126849] Dynamic subtest vecs0: SUCCESS (1.981s)
[689.140608] Starting dynamic subtest: ccs0
[690.947469] Dynamic subtest ccs0: SUCCESS (1.819s)
[690.950434] Subtest basic: SUCCESS (11.262s)
[691.168821] [103/130] (334s left) prime_busy (after)
[691.230074] Starting subtest: after
[691.235852] Starting dynamic subtest: rcs0
[691.265997] Dynamic subtest rcs0: SUCCESS (0.032s)
[691.277871] Starting dynamic subtest: bcs0
[691.340468] Dynamic subtest bcs0: SUCCESS (0.073s)
[691.352313] Starting dynamic subtest: vcs0
[691.385027] Dynamic subtest vcs0: SUCCESS (0.044s)
[691.395475] Starting dynamic subtest: vcs1
[691.427446] Dynamic subtest vcs1: SUCCESS (0.042s)
[691.437691] Starting dynamic subtest: vecs0
[691.471110] Dynamic subtest vecs0: SUCCESS (0.043s)
[691.481597] Starting dynamic subtest: ccs0
[691.515216] Dynamic subtest ccs0: SUCCESS (0.044s)
[691.623151] Subtest after: SUCCESS (0.392s)
[691.734076] [104/130] (333s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[691.847748] Starting subtest: y-tiled-64bpp-rotate-0
[691.852505] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[691.967440] [105/130] (333s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[692.061254] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[692.066352] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[692.181714] [106/130] (333s left) gem_mmap_wc (read-write-distinct)
[692.247302] Subtest read-write-distinct: SKIP (0.000s)
[692.307762] [107/130] (333s left) gem_ctx_sseu (engines)
[692.362881] Subtest engines: SKIP (0.000s)
[692.444364] [108/130] (333s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[692.500771] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[692.602476] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[692.707844] [109/130] (333s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[692.828314] Starting subtest: basic-flip-before-cursor-atomic
[693.741387] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[694.574071] [110/130] (331s left) syncobj_wait (single-wait-all-signaled)
[694.634408] Starting subtest: single-wait-all-signaled
[694.637150] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[694.774854] [111/130] (331s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[694.879718] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[695.504183] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[695.712988] [112/130] (330s left) perf (gen12-unprivileged-single-ctx-counters)
[695.858401] Starting subtest: gen12-unprivileged-single-ctx-counters
[695.860766] Starting dynamic subtest: rcs0
[695.945507] Dynamic subtest rcs0: SUCCESS (0.086s)
[695.948468] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.087s)
[696.000433] [113/130] (330s left) kms_psr (psr-cursor-blt)
[696.116333] Starting subtest: psr-cursor-blt
[696.118814] Starting dynamic subtest: eDP-1
[697.850447] Dynamic subtest eDP-1: SUCCESS (1.732s)
[697.852983] Subtest psr-cursor-blt: SUCCESS (1.733s)
[698.736140] [114/130] (327s left) gem_ccs (ctrl-surf-copy)
[698.793163] Starting subtest: ctrl-surf-copy
[698.798116] Subtest ctrl-surf-copy: SKIP (0.000s)
[698.928910] [115/130] (327s left) kms_flip (2x-absolute-wf_vblank)
[699.024422] Starting subtest: 2x-absolute-wf_vblank
[699.035876] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[699.142236] [116/130] (327s left) kms_pm_dc (dc3co-vpb-simulation)
[700.254464] Starting subtest: dc3co-vpb-simulation
[708.892732] Subtest dc3co-vpb-simulation: SKIP (8.633s)
[709.051954] [117/130] (317s left) i915_query (test-query-geometry-subslices)
[709.114360] Starting subtest: test-query-geometry-subslices
[709.117302] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[709.238448] [118/130] (317s left) kms_psr (fbc-psr-sprite-render)
[709.340322] Starting subtest: fbc-psr-sprite-render
[709.342832] Starting dynamic subtest: eDP-1
[709.347605] Dynamic subtest eDP-1: SKIP (0.000s)
[709.352829] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[709.442860] [119/130] (316s left) gem_userptr_blits (sync-overlap)
[709.513262] Starting subtest: sync-overlap
[709.515770] Subtest sync-overlap: SUCCESS (0.000s)
[709.665376] [120/130] (316s left) prime_vgem (fence-read-hang)
[709.763495] Subtest fence-read-hang: SKIP (0.000s)
[709.910678] [121/130] (316s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[709.974387] Starting subtest: invalid-single-wait-all-unsubmitted
[709.976593] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[710.110378] [122/130] (316s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[710.205432] Starting subtest: yf-tiled-64bpp-rotate-270
[710.210282] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[710.341451] [123/130] (316s left) core_setmaster (master-drop-set-shared-fd)
[710.443265] Starting subtest: master-drop-set-shared-fd
[710.464881] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[710.505799] [124/130] (316s left) gem_ctx_create (basic-files)
[710.558309] Starting subtest: basic-files
[712.567377] Subtest basic-files: SUCCESS (2.008s)
[714.288719] [125/130] (312s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[714.356479] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[714.423673] [126/130] (312s left) kms_color (ctm-blue-to-red)
[714.540898] Starting subtest: ctm-blue-to-red
[714.543835] Starting dynamic subtest: pipe-A-eDP-1
[715.249190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[715.261288] Starting dynamic subtest: pipe-B-eDP-1
[716.592497] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[716.604210] Starting dynamic subtest: pipe-C-eDP-1
[717.963268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[717.975413] Starting dynamic subtest: pipe-D-eDP-1
[719.313608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[719.316581] Subtest ctm-blue-to-red: SUCCESS (4.775s)
[720.155398] [127/130] (306s left) gem_eio (in-flight-external)
[720.391013] Starting subtest: in-flight-external
[722.289596] Subtest in-flight-external: SUCCESS (1.900s)
[722.474242] [128/130] (304s left) kms_frontbuffer_tracking (fbc-2p-rte)
[722.596397] Starting subtest: fbc-2p-rte
[722.601145] Subtest fbc-2p-rte: SKIP (0.000s)
[722.736131] [129/130] (304s left) syncobj_wait (wait-all-for-submit-complex)
[722.787644] Starting subtest: wait-all-for-submit-complex
[723.001476] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[723.106344] [130/130] (303s left) kms_properties (colorop-properties-atomic)
[723.201036] Starting subtest: colorop-properties-atomic
[723.203011] Starting dynamic subtest: pipe-A-eDP-1
[723.540684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.338s)
[723.551749] Starting dynamic subtest: pipe-B-eDP-1
[724.589408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[724.600860] Starting dynamic subtest: pipe-C-eDP-1
[725.628911] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[725.640625] Starting dynamic subtest: pipe-D-eDP-1
[726.657196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[726.659862] Subtest colorop-properties-atomic: SUCCESS (3.455s)
[727.480214] 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.