[61.673074] Initializing watchdogs
[61.673127]   /dev/watchdog0
[61.689028] [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]
[61.693864] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.696564] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.698591] [001/132] (960s left) gem_exec_reloc (basic-concurrent0)
[61.760108] Subtest basic-concurrent0: SKIP (0.000s)
[61.820475] [002/132] (960s left) kms_psr2_su (page_flip-xrgb8888)
[61.878537] Subtest page_flip-XRGB8888: SKIP (0.000s)
[61.929567] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[62.036850] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[62.038570] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[62.138149] [004/132] (960s left) gem_ctx_persistence (engines-cleanup)
[62.189928] Starting subtest: engines-cleanup
[62.190960] Starting dynamic subtest: rcs0
[62.260501] Dynamic subtest rcs0: SUCCESS (0.070s)
[62.271162] Starting dynamic subtest: bcs0
[62.310694] Dynamic subtest bcs0: SUCCESS (0.049s)
[62.320520] Starting dynamic subtest: vcs0
[62.356807] Dynamic subtest vcs0: SUCCESS (0.045s)
[62.365467] Starting dynamic subtest: vcs1
[62.415397] Dynamic subtest vcs1: SUCCESS (0.058s)
[62.423354] Starting dynamic subtest: vecs0
[62.481544] Dynamic subtest vecs0: SUCCESS (0.066s)
[62.488267] Starting dynamic subtest: ccs0
[62.534395] Dynamic subtest ccs0: SUCCESS (0.052s)
[62.535915] Subtest engines-cleanup: SUCCESS (0.345s)
[62.607751] [005/132] (959s left) syncobj_eventfd (timeline-wait)
[62.647821] Starting subtest: timeline-wait
[62.658545] Subtest timeline-wait: SUCCESS (0.011s)
[62.771363] [006/132] (959s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[62.875998] Starting subtest: psr-2p-pri-indfb-multidraw
[62.877566] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[62.968016] [007/132] (959s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[63.072578] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[63.074341] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[63.137701] [008/132] (959s left) drm_read (short-buffer-wakeup)
[63.302039] Starting subtest: short-buffer-wakeup
[95.527559] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[95.666758] [009/132] (926s left) sw_sync (alloc_timeline)
[95.697128] Starting subtest: alloc_timeline
[95.697972] Subtest alloc_timeline: SUCCESS (0.000s)
[95.752326] [010/132] (926s left) kms_psr (pr-cursor-render)
[95.836582] Starting subtest: pr-cursor-render
[95.838423] Subtest pr-cursor-render: SKIP (0.000s)
[95.912194] [011/132] (926s left) kms_pm_rpm (cursor)
[97.430444] Starting subtest: cursor
[97.432725] Subtest cursor: SKIP (0.000s)
[98.139596] [012/132] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[98.242618] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[105.653104] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.411s)
[105.761216] [013/132] (916s left) gem_madvise (dontneed-before-exec)
[105.798255] Starting subtest: dontneed-before-exec
[105.820045] Subtest dontneed-before-exec: SKIP (0.022s)
[105.871846] [014/132] (916s left) perf_pmu (init-wait)
[105.904047] Starting subtest: init-wait
[105.904971] Starting dynamic subtest: rcs0
[105.905907] Dynamic subtest rcs0: SUCCESS (0.002s)
[105.913107] Starting dynamic subtest: bcs0
[105.914228] Dynamic subtest bcs0: SUCCESS (0.000s)
[105.923048] Starting dynamic subtest: vcs0
[105.924193] Dynamic subtest vcs0: SUCCESS (0.001s)
[105.930324] Starting dynamic subtest: vcs1
[105.931280] Dynamic subtest vcs1: SUCCESS (0.001s)
[105.937679] Starting dynamic subtest: vecs0
[105.938561] Dynamic subtest vecs0: SUCCESS (0.001s)
[105.944992] Starting dynamic subtest: ccs0
[105.945895] Dynamic subtest ccs0: SUCCESS (0.000s)
[105.946686] Subtest init-wait: SUCCESS (0.007s)
[105.984419] [015/132] (916s left) kms_pm_rpm (package-g7)
[107.496643] Starting subtest: package-g7
[107.499255] Subtest package-g7: SKIP (0.000s)
[108.222124] [016/132] (914s left) gem_ccs (suspend-resume)
[108.274797] Starting subtest: suspend-resume
[108.276589] Subtest suspend-resume: SKIP (0.000s)
[108.366861] [017/132] (914s left) i915_suspend (basic-s3-without-i915)
[108.398246] Starting subtest: basic-s3-without-i915
[110.051551] Subtest basic-s3-without-i915: SKIP (1.643s)
[111.648156] [018/132] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[111.733332] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[111.735117] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[111.848869] [019/132] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[111.947193] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[111.948878] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[112.043461] [020/132] (910s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[112.134363] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[112.135434] Starting dynamic subtest: pipe-A
[112.161615] Dynamic subtest pipe-A: SKIP (0.018s)
[112.171030] Starting dynamic subtest: pipe-B
[112.187380] Dynamic subtest pipe-B: SKIP (0.034s)
[112.193453] Starting dynamic subtest: pipe-C
[112.221353] Dynamic subtest pipe-C: SKIP (0.034s)
[112.227242] Starting dynamic subtest: pipe-D
[112.255534] Dynamic subtest pipe-D: SKIP (0.034s)
[112.257369] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.120s)
[112.360297] [021/132] (910s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[112.462919] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[112.464829] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[112.554505] [022/132] (910s left) kms_lease (lessee-list)
[112.635867] Starting subtest: lessee-list
[112.636711] Starting dynamic subtest: pipe-A-eDP-1
[112.638702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[112.646323] Starting dynamic subtest: pipe-B-eDP-1
[112.647069] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[112.652943] Starting dynamic subtest: pipe-C-eDP-1
[112.653773] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[112.659516] Starting dynamic subtest: pipe-D-eDP-1
[112.660508] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[112.661281] Subtest lessee-list: SUCCESS (0.009s)
[112.733014] [023/132] (910s left) i915_drm_fdinfo (memory-info-idle)
[112.768648] Starting subtest: memory-info-idle
[112.769794] Starting dynamic subtest: smem0
[112.806766] Dynamic subtest smem0: SUCCESS (0.038s)
[112.807777] Subtest memory-info-idle: SUCCESS (0.038s)
[112.871686] [024/132] (910s left) gem_exec_fence (long-history)
[113.293577] Starting subtest: long-history
[120.110964] Subtest long-history: SUCCESS (6.809s)
[120.806083] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[120.808375] [025/132] (902s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[120.908387] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[121.985871] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.078s)
[122.104648] [026/132] (900s left) gem_eio (reset-stress)
[122.332453] Starting subtest: reset-stress
[122.333405] Starting dynamic subtest: render
[127.309291] Dynamic subtest render: SUCCESS (4.976s)
[127.323721] Starting dynamic subtest: bsd1
[145.839590] Dynamic subtest bsd1: SUCCESS (18.529s)
[145.853976] Starting dynamic subtest: bsd2
[163.866284] Dynamic subtest bsd2: SUCCESS (18.025s)
[163.878560] Starting dynamic subtest: blt
[163.880194] Dynamic subtest blt: SKIP (0.000s)
[163.887969] Starting dynamic subtest: vebox
[181.891632] Dynamic subtest vebox: SUCCESS (18.024s)
[181.892806] Subtest reset-stress: SUCCESS (59.557s)
[183.359927] [027/132] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[183.462055] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[190.017251] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.556s)
[190.159424] [028/132] (832s left) kms_cursor_crc (cursor-random-32x32)
[190.299214] Starting subtest: cursor-random-32x32
[190.346679] Subtest cursor-random-32x32: SKIP (0.047s)
[190.655693] [029/132] (832s left) kms_psr (psr2-no-drrs)
[190.734409] Starting subtest: psr2-no-drrs
[190.735329] Starting dynamic subtest: eDP-1
[192.309840] Dynamic subtest eDP-1: SUCCESS (1.575s)
[192.310798] Subtest psr2-no-drrs: SUCCESS (1.576s)
[193.115638] [030/132] (830s left) syncobj_timeline (invalid-wait-illegal-handle)
[193.172968] Starting subtest: invalid-wait-illegal-handle
[193.174227] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[193.266607] [031/132] (829s left) fbdev (pan)
[193.294996] Starting subtest: pan
[193.319922] Subtest pan: SUCCESS (0.025s)
[193.384572] [032/132] (829s left) gem_exec_schedule (implicit-read-write)
[193.443947] Starting subtest: implicit-read-write
[193.444868] Starting dynamic subtest: rcs0
[193.565717] Dynamic subtest rcs0: SUCCESS (0.121s)
[193.577028] Starting dynamic subtest: vcs0
[193.646451] Dynamic subtest vcs0: SUCCESS (0.080s)
[193.656419] Starting dynamic subtest: vcs1
[193.731113] Dynamic subtest vcs1: SUCCESS (0.084s)
[193.740726] Starting dynamic subtest: vecs0
[193.823369] Dynamic subtest vecs0: SUCCESS (0.092s)
[193.833473] Starting dynamic subtest: ccs0
[193.923734] Dynamic subtest ccs0: SUCCESS (0.099s)
[193.925185] Subtest implicit-read-write: SUCCESS (0.480s)
[195.374282] [033/132] (827s left) prime_busy (before-wait)
[195.431151] Starting subtest: before-wait
[195.434347] Starting dynamic subtest: rcs0
[195.460086] Dynamic subtest rcs0: SUCCESS (0.026s)
[195.469233] Starting dynamic subtest: bcs0
[195.508085] Dynamic subtest bcs0: SUCCESS (0.047s)
[195.516577] Starting dynamic subtest: vcs0
[195.547992] Dynamic subtest vcs0: SUCCESS (0.040s)
[195.555851] Starting dynamic subtest: vcs1
[195.590118] Dynamic subtest vcs1: SUCCESS (0.042s)
[195.597184] Starting dynamic subtest: vecs0
[195.631902] Dynamic subtest vecs0: SUCCESS (0.041s)
[195.640079] Starting dynamic subtest: ccs0
[195.672811] Dynamic subtest ccs0: SUCCESS (0.040s)
[195.780718] Subtest before-wait: SUCCESS (0.348s)
[195.855899] [034/132] (827s left) kms_invalid_mode (int-max-clock)
[195.949907] Starting subtest: int-max-clock
[195.950969] Starting dynamic subtest: pipe-A-eDP-1
[196.233901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[196.245301] Starting dynamic subtest: pipe-B-eDP-1
[196.246254] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[196.257463] Starting dynamic subtest: pipe-C-eDP-1
[196.258505] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[196.268600] Starting dynamic subtest: pipe-D-eDP-1
[196.269649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[196.270539] Subtest int-max-clock: SUCCESS (0.289s)
[197.064059] [035/132] (826s left) gem_tiled_fence_blits (basic)
[197.123322] Subtest basic: SKIP (0.000s)
[197.175564] [036/132] (826s left) sw_sync (sync_random_merge)
[197.204740] Starting subtest: sync_random_merge
[197.250626] Subtest sync_random_merge: SUCCESS (0.046s)
[197.305430] [037/132] (826s left) gen9_exec_parse (bb-chained)
[197.354468] Subtest bb-chained: SKIP (0.000s)
[197.430604] [038/132] (826s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[197.526526] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[197.527462] Starting dynamic subtest: pipe-A
[197.546095] Dynamic subtest pipe-A: SKIP (0.018s)
[197.553779] Starting dynamic subtest: pipe-B
[197.580386] Dynamic subtest pipe-B: SKIP (0.034s)
[197.587787] Starting dynamic subtest: pipe-C
[197.615500] Dynamic subtest pipe-C: SKIP (0.034s)
[197.622680] Starting dynamic subtest: pipe-D
[197.650887] Dynamic subtest pipe-D: SKIP (0.035s)
[197.652738] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.123s)
[197.758435] [039/132] (825s left) kms_async_flips (alternate-sync-async-flip-atomic)
[197.845164] Starting subtest: alternate-sync-async-flip-atomic
[198.226712] Starting dynamic subtest: pipe-A-eDP-1
[201.025947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.799s)
[201.405393] Starting dynamic subtest: pipe-B-eDP-1
[204.158372] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[204.537645] Starting dynamic subtest: pipe-C-eDP-1
[207.288372] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[207.657826] Starting dynamic subtest: pipe-D-eDP-1
[210.417148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[210.418265] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.572s)
[211.587622] [040/132] (811s left) gem_exec_store (cachelines)
[211.656780] Starting subtest: cachelines
[211.657803] Starting dynamic subtest: rcs0
[211.713623] Dynamic subtest rcs0: SUCCESS (0.056s)
[211.725075] Starting dynamic subtest: bcs0
[211.765390] Dynamic subtest bcs0: SUCCESS (0.050s)
[211.776380] Starting dynamic subtest: vcs0
[211.821360] Dynamic subtest vcs0: SUCCESS (0.054s)
[211.832222] Starting dynamic subtest: vcs1
[211.875923] Dynamic subtest vcs1: SUCCESS (0.053s)
[211.885162] Starting dynamic subtest: vecs0
[211.929595] Dynamic subtest vecs0: SUCCESS (0.051s)
[211.939632] Starting dynamic subtest: ccs0
[211.984060] Dynamic subtest ccs0: SUCCESS (0.054s)
[211.985257] Subtest cachelines: SUCCESS (0.328s)
[212.168030] [041/132] (811s left) gem_exec_parallel (basic)
[212.229973] Starting subtest: basic
[212.230954] Starting dynamic subtest: rcs0
[213.664608] Dynamic subtest rcs0: SUCCESS (1.434s)
[213.673470] Starting dynamic subtest: bcs0
[215.139246] Dynamic subtest bcs0: SUCCESS (1.473s)
[215.148064] Starting dynamic subtest: vcs0
[218.341421] Dynamic subtest vcs0: SUCCESS (3.190s)
[218.352375] Starting dynamic subtest: vcs1
[220.261503] Dynamic subtest vcs1: SUCCESS (1.918s)
[220.271972] Starting dynamic subtest: vecs0
[222.311954] Dynamic subtest vecs0: SUCCESS (2.048s)
[222.322254] Starting dynamic subtest: ccs0
[223.800654] Dynamic subtest ccs0: SUCCESS (1.496s)
[223.802946] Subtest basic: SUCCESS (11.572s)
[223.983676] [042/132] (799s left) api_intel_allocator (execbuf-with-allocator)
[224.030898] Starting subtest: execbuf-with-allocator
[224.036683] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[224.145059] [043/132] (799s left) kms_psr (psr-sprite-mmap-cpu)
[224.239301] Starting subtest: psr-sprite-mmap-cpu
[224.240158] Starting dynamic subtest: eDP-1
[226.014496] Dynamic subtest eDP-1: SUCCESS (1.774s)
[226.015422] Subtest psr-sprite-mmap-cpu: SUCCESS (1.775s)
[226.861317] [044/132] (796s left) sysfs_timeslice_duration (timeout)
[226.909208] Starting subtest: timeout
[226.910068] Starting dynamic subtest: vecs0
[236.321854] Dynamic subtest vecs0: SUCCESS (9.404s)
[236.332568] Starting dynamic subtest: ccs0
[237.598851] Dynamic subtest ccs0: SUCCESS (1.283s)
[237.612613] Starting dynamic subtest: vcs0
[247.328796] Dynamic subtest vcs0: SUCCESS (9.719s)
[247.337788] Starting dynamic subtest: bcs0
[247.958453] Dynamic subtest bcs0: SUCCESS (0.637s)
[247.969278] Starting dynamic subtest: rcs0
[249.231198] Dynamic subtest rcs0: SUCCESS (1.270s)
[249.241637] Starting dynamic subtest: vcs1
[258.335362] Dynamic subtest vcs1: SUCCESS (9.094s)
[258.336297] Subtest timeout: SUCCESS (31.419s)
[258.400190] [045/132] (765s left) gem_mmap_gtt (hang-user)
[258.441128] Subtest hang-user: SKIP (0.000s)
[258.494974] [046/132] (765s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[258.585035] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[258.586867] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[258.653227] [047/132] (765s left) gem_mmap_wc (bad-object)
[258.708841] Subtest bad-object: SKIP (0.000s)
[258.772765] [048/132] (764s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[258.827564] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[258.829399] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[259.004917] [049/132] (764s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[259.094170] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[259.095905] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[259.200360] [050/132] (764s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[259.290822] Starting subtest: 4-tiled-16bpp-rotate-0
[260.650695] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.360s)
[260.779318] [051/132] (763s left) api_intel_bb (reset-flags)
[260.827915] Starting subtest: reset-flags
[260.833100] Subtest reset-flags: SUCCESS (0.007s)
[260.949029] [052/132] (762s left) gem_exec_flush (basic-uc-ro-default)
[261.005081] Starting subtest: basic-uc-ro-default
[266.459469] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[266.637867] [053/132] (757s left) kms_chamelium_frames (dp-frame-dump)
[267.029476] Subtest dp-frame-dump: SKIP (0.000s)
[267.867286] [054/132] (756s left) gem_lmem_swapping (parallel-random-verify)
[267.908603] Subtest parallel-random-verify: SKIP (0.000s)
[267.950798] [055/132] (756s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[268.097048] Starting subtest: dp-mst-lic-type-0-hdcp14
[268.099046] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[268.217963] [056/132] (755s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[268.303702] Starting subtest: fbc-pr-sprite-mmap-cpu
[268.305482] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[268.376885] [057/132] (755s left) gem_exec_reloc (basic-cpu-active)
[268.422981] Subtest basic-cpu-active: SKIP (0.000s)
[268.483574] [058/132] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[268.579958] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[268.581694] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[268.666815] [059/132] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[268.751164] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[268.753027] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[268.866153] [060/132] (755s left) prime_mmap (test_forked)
[268.918986] Starting subtest: test_forked
[268.920503] Starting dynamic subtest: test_forked-smem
[268.965282] Dynamic subtest test_forked-smem: SUCCESS (0.046s)
[268.966691] Subtest test_forked: SUCCESS (0.047s)
[269.062283] [061/132] (755s left) gem_tiled_pread_pwrite
[269.162638] [062/132] (755s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[269.242103] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[269.242878] Starting dynamic subtest: pipe-A-eDP-1
[269.250351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.258046] Starting dynamic subtest: pipe-B-eDP-1
[269.265942] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.273251] Starting dynamic subtest: pipe-C-eDP-1
[269.280590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.287814] Starting dynamic subtest: pipe-D-eDP-1
[269.295512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.297097] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[271.555995] [063/132] (752s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[271.635123] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[271.636115] Starting dynamic subtest: pipe-A-eDP-1
[271.645393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[271.653652] Starting dynamic subtest: pipe-B-eDP-1
[271.661848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[271.669883] Starting dynamic subtest: pipe-C-eDP-1
[271.676869] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[271.684341] Starting dynamic subtest: pipe-D-eDP-1
[271.690933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[271.691702] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[273.825781] [064/132] (750s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[273.915544] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[273.916444] Starting dynamic subtest: pipe-A-eDP-1
[273.924828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.933060] Starting dynamic subtest: pipe-B-eDP-1
[273.941464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.951409] Starting dynamic subtest: pipe-C-eDP-1
[273.959313] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[273.966789] Starting dynamic subtest: pipe-D-eDP-1
[273.975690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[273.977263] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[276.095653] [065/132] (748s left) kms_addfb_basic (bad-pitch-256)
[276.146359] Starting subtest: bad-pitch-256
[276.147268] Subtest bad-pitch-256: SUCCESS (0.000s)
[276.274985] [066/132] (748s left) gem_exec_capture (capture)
[276.328606] Starting subtest: capture
[276.329562] Starting dynamic subtest: rcs0-smem
[277.164021] Dynamic subtest rcs0-smem: SUCCESS (0.834s)
[277.172902] Starting dynamic subtest: bcs0-smem
[277.988792] Dynamic subtest bcs0-smem: SUCCESS (0.824s)
[277.997523] Starting dynamic subtest: vcs0-smem
[278.808437] Dynamic subtest vcs0-smem: SUCCESS (0.820s)
[278.815875] Starting dynamic subtest: vcs1-smem
[280.130787] Dynamic subtest vcs1-smem: SUCCESS (1.322s)
[280.140410] Starting dynamic subtest: vecs0-smem
[280.974918] Dynamic subtest vecs0-smem: FAIL (0.821s)
[280.983319] Starting dynamic subtest: ccs0-smem
[282.279490] Dynamic subtest ccs0-smem: SUCCESS (1.326s)
[282.280644] Subtest capture: FAIL (5.952s)
[282.386722] [067/132] (742s left) kms_draw_crc (draw-method-pwrite)
[282.478412] Starting subtest: draw-method-pwrite
[282.479323] Starting dynamic subtest: xrgb8888-untiled
[283.077825] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[283.092169] Starting dynamic subtest: rgb565-untiled
[283.566260] Dynamic subtest rgb565-untiled: SUCCESS (0.487s)
[283.575539] Starting dynamic subtest: xrgb2101010-untiled
[284.144448] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.576s)
[284.153469] Starting dynamic subtest: xbgr16161616f-untiled
[284.977506] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.831s)
[284.985743] Starting dynamic subtest: xrgb8888-xtiled
[286.999681] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.021s)
[287.007809] Starting dynamic subtest: rgb565-xtiled
[288.221796] Dynamic subtest rgb565-xtiled: SUCCESS (1.221s)
[288.231843] Starting dynamic subtest: xrgb2101010-xtiled
[290.244085] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.020s)
[290.252341] Starting dynamic subtest: xbgr16161616f-xtiled
[293.866304] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.621s)
[293.875711] Starting dynamic subtest: xrgb8888-4tiled
[295.077467] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.209s)
[295.085494] Starting dynamic subtest: rgb565-4tiled
[295.688880] Dynamic subtest rgb565-4tiled: SUCCESS (0.610s)
[295.696852] Starting dynamic subtest: xrgb2101010-4tiled
[296.910985] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.221s)
[296.920816] Starting dynamic subtest: xbgr16161616f-4tiled
[300.211203] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.299s)
[300.212234] Subtest draw-method-pwrite: SUCCESS (17.734s)
[300.300018] [068/132] (724s left) gem_userptr_blits (relocations)
[300.355408] Starting subtest: relocations
[300.357100] Subtest relocations: SKIP (0.000s)
[300.485596] [069/132] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[300.566493] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[300.568242] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[300.658483] [070/132] (723s left) i915_pm_rpm (gem-idle)
[302.480353] Starting subtest: gem-idle
[308.687813] Subtest gem-idle: SUCCESS (6.205s)
[309.029381] [071/132] (715s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[310.307088] Starting subtest: disable-crc-after-crtc
[310.308261] Starting dynamic subtest: pipe-A-eDP-1
[311.969559] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.662s)
[311.978949] Starting dynamic subtest: pipe-B-eDP-1
[314.235166] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.264s)
[314.244582] Starting dynamic subtest: pipe-C-eDP-1
[316.483522] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s)
[316.493075] Starting dynamic subtest: pipe-D-eDP-1
[318.747759] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[318.748673] Subtest disable-crc-after-crtc: SUCCESS (8.440s)
[319.581990] [072/132] (705s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[319.955126] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[320.823361] [073/132] (703s left) gem_exec_whisper (basic-sync)
[320.883561] Starting subtest: basic-sync
[329.643533] Subtest basic-sync: SUCCESS (8.747s)
[329.812187] [074/132] (694s left) gem_exec_suspend (basic)
[329.866724] Starting subtest: basic
[329.867724] Starting dynamic subtest: smem
[331.301946] Dynamic subtest smem: SUCCESS (1.426s)
[331.303226] Subtest basic: SUCCESS (1.428s)
[331.478401] [075/132] (693s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[331.606271] Starting subtest: 2x-cursor-vs-flip-legacy
[331.609242] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[331.760527] [076/132] (693s left) kms_flip (dpms-off-confusion-interruptible)
[331.851254] Starting subtest: dpms-off-confusion-interruptible
[331.852601] Starting dynamic subtest: A-eDP1
[340.546040] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[340.556526] Starting dynamic subtest: B-eDP1
[349.173462] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[349.183960] Starting dynamic subtest: C-eDP1
[357.814267] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[357.824196] Starting dynamic subtest: D-eDP1
[366.437220] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[366.438453] Subtest dpms-off-confusion-interruptible: SUCCESS (34.550s)
[367.581411] [077/132] (657s left) gem_mmap_gtt (basic-small-copy-odd)
[367.640072] Subtest basic-small-copy-odd: SKIP (0.000s)
[367.706422] [078/132] (657s left) gem_watchdog (default-virtual)
[367.765210] Starting subtest: default-virtual
[374.057620] Subtest default-virtual: SUCCESS (6.283s)
[374.127637] [079/132] (650s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[374.221243] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[374.222902] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[374.302240] [080/132] (650s left) gem_mmap_wc (coherency)
[374.347045] Subtest coherency: SKIP (0.000s)
[374.402717] [081/132] (650s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[374.497936] Starting subtest: fbcpsr-tiling-4
[381.601219] Subtest fbcpsr-tiling-4: SUCCESS (7.104s)
[381.735669] [082/132] (643s left) syncobj_wait (invalid-reset-zero-handles)
[381.798931] Starting subtest: invalid-reset-zero-handles
[381.799972] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[381.888255] [083/132] (643s left) perf (invalid-remove-userspace-config)
[382.010734] Starting subtest: invalid-remove-userspace-config
[382.017405] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[382.052850] [084/132] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[382.157125] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[382.158794] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[382.238196] [085/132] (642s left) sw_sync (timeline_closed)
[382.274564] Starting subtest: timeline_closed
[382.275542] Subtest timeline_closed: SUCCESS (0.000s)
[382.325010] [086/132] (642s left) kms_color_pipeline (plane-lut1d)
[382.420159] Starting subtest: plane-lut1d
[382.612690] Starting dynamic subtest: pipe-A-plane-0
[382.789165] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[382.797468] Starting dynamic subtest: pipe-A-plane-1
[382.933617] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[382.942254] Starting dynamic subtest: pipe-A-plane-2
[383.100131] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[384.300648] Starting dynamic subtest: pipe-B-plane-0
[384.471565] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[384.488928] Starting dynamic subtest: pipe-B-plane-1
[384.637684] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[384.645902] Starting dynamic subtest: pipe-B-plane-2
[384.804454] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[386.033968] Starting dynamic subtest: pipe-C-plane-0
[386.182725] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[386.192097] Starting dynamic subtest: pipe-C-plane-1
[386.348774] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s)
[386.356780] Starting dynamic subtest: pipe-C-plane-2
[386.504465] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[387.677385] Starting dynamic subtest: pipe-D-plane-0
[387.812773] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[387.822713] Starting dynamic subtest: pipe-D-plane-1
[387.957381] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[387.966067] Starting dynamic subtest: pipe-D-plane-2
[388.101730] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[388.388076] Subtest plane-lut1d: SUCCESS (5.968s)
[389.233717] [087/132] (635s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[389.297947] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[389.299021] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[389.409875] [088/132] (635s left) syncobj_basic (bad-destroy-pad)
[389.473027] Starting subtest: bad-destroy-pad
[389.474094] Subtest bad-destroy-pad: SUCCESS (0.000s)
[389.577842] [089/132] (635s left) i915_pm_freq_api (freq-reset-multiple)
[389.659169] Starting subtest: freq-reset-multiple
[389.660045] Starting dynamic subtest: gt0
[398.720996] Dynamic subtest gt0: SUCCESS (9.061s)
[398.728809] Starting dynamic subtest: gt1
[406.267244] Dynamic subtest gt1: SUCCESS (7.535s)
[406.268348] Subtest freq-reset-multiple: SUCCESS (16.598s)
[406.356685] [090/132] (618s left) gem_exec_schedule (u-lateslice)
[406.427505] Starting subtest: u-lateslice
[406.428428] Starting dynamic subtest: rcs0
[406.456285] Dynamic subtest rcs0: SUCCESS (0.028s)
[406.465872] Starting dynamic subtest: bcs0
[406.480635] Dynamic subtest bcs0: SUCCESS (0.024s)
[406.488535] Starting dynamic subtest: vcs0
[406.503961] Dynamic subtest vcs0: SUCCESS (0.022s)
[406.511995] Starting dynamic subtest: vcs1
[406.529211] Dynamic subtest vcs1: SUCCESS (0.024s)
[406.543549] Starting dynamic subtest: vecs0
[406.557450] Dynamic subtest vecs0: SUCCESS (0.027s)
[406.567395] Starting dynamic subtest: ccs0
[406.580950] Dynamic subtest ccs0: SUCCESS (0.023s)
[406.582042] Subtest u-lateslice: SUCCESS (0.154s)
[408.418059] [091/132] (616s left) kms_plane_lowres (tiling-yf)
[408.511892] Starting subtest: tiling-yf
[408.513772] Subtest tiling-yf: SKIP (0.000s)
[408.578500] [092/132] (616s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[408.679715] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[408.680593] Starting dynamic subtest: pipe-A-eDP-1
[408.684099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.692768] Starting dynamic subtest: pipe-B-eDP-1
[408.696894] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.706840] Starting dynamic subtest: pipe-C-eDP-1
[408.710201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.717701] Starting dynamic subtest: pipe-D-eDP-1
[408.721139] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.722819] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[411.000639] [093/132] (614s left) kms_big_fb (y-tiled-addfb)
[411.110083] Starting subtest: y-tiled-addfb
[411.111881] Subtest y-tiled-addfb: SKIP (0.000s)
[411.217947] [094/132] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[411.311710] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[411.313715] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.402107] [095/132] (614s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[411.520249] Starting subtest: flip-vs-cursor-legacy
[419.078803] Subtest flip-vs-cursor-legacy: SUCCESS (7.558s)
[419.931782] [096/132] (605s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[420.024526] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[420.025414] Starting dynamic subtest: pipe-A-eDP-1
[420.172866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[420.182308] Starting dynamic subtest: pipe-B-eDP-1
[420.189470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[420.197080] Starting dynamic subtest: pipe-C-eDP-1
[420.204225] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[420.211472] Starting dynamic subtest: pipe-D-eDP-1
[420.218518] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[420.219341] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[422.488185] [097/132] (603s left) kms_sequence (get-forked-busy)
[422.579156] Starting subtest: get-forked-busy
[422.579984] Starting dynamic subtest: pipe-A-eDP-1
[424.514812] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[424.524277] Starting dynamic subtest: pipe-B-eDP-1
[427.099163] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.582s)
[427.107222] Starting dynamic subtest: pipe-C-eDP-1
[429.734721] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.635s)
[429.742757] Starting dynamic subtest: pipe-D-eDP-1
[432.367130] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[432.369395] Subtest get-forked-busy: SUCCESS (9.790s)
[433.245330] [098/132] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[433.343439] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[433.345387] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[433.443224] [099/132] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[433.527431] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[433.529397] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[433.612716] [100/132] (591s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[433.677184] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[433.741417] [101/132] (591s left) kms_vblank (ts-continuation-modeset-hang)
[433.825276] Starting subtest: ts-continuation-modeset-hang
[433.826223] Starting dynamic subtest: pipe-A-eDP-1
[460.068813] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.241s)
[460.078684] Starting dynamic subtest: pipe-D-eDP-1
[475.176703] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.106s)
[475.177529] Subtest ts-continuation-modeset-hang: SUCCESS (41.352s)
[475.977724] [102/132] (549s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[476.093999] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[477.096129] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.002s)
[477.228417] [103/132] (548s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[477.334444] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[477.335476] Starting dynamic subtest: pipe-A-eDP-1
[477.435865] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[477.445531] Starting dynamic subtest: pipe-B-eDP-1
[478.546569] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s)
[478.548334] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.212s)
[479.739889] [104/132] (546s left) kms_debugfs (display-off-read-all)
[479.837387] Starting subtest: display-off-read-all
[480.124857] Subtest display-off-read-all: SUCCESS (0.288s)
[480.984283] [105/132] (544s left) gem_spin_batch (resubmit-all)
[481.053451] Starting subtest: resubmit-all
[481.054467] Starting dynamic subtest: rcs0
[481.068444] Dynamic subtest rcs0: SUCCESS (0.015s)
[481.084468] Starting dynamic subtest: bcs0
[481.085618] Dynamic subtest bcs0: SUCCESS (0.003s)
[481.099055] Starting dynamic subtest: vcs0
[481.099957] Dynamic subtest vcs0: SUCCESS (0.003s)
[481.107482] Starting dynamic subtest: vcs1
[481.108500] Dynamic subtest vcs1: SUCCESS (0.003s)
[481.115932] Starting dynamic subtest: vecs0
[481.116848] Dynamic subtest vecs0: SUCCESS (0.003s)
[481.124336] Starting dynamic subtest: ccs0
[481.125233] Dynamic subtest ccs0: SUCCESS (0.003s)
[481.126074] Subtest resubmit-all: SUCCESS (0.036s)
[482.318227] [106/132] (543s left) syncobj_wait (wait-all-for-submit-snapshot)
[482.374672] Starting subtest: wait-all-for-submit-snapshot
[482.456272] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[482.541439] [107/132] (543s left) gem_pxp (reject-modify-context-protection-on)
[482.659471] Starting subtest: reject-modify-context-protection-on
[482.660728] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[482.765405] [108/132] (543s left) kms_flip (blocking-wf_vblank)
[482.858129] Starting subtest: blocking-wf_vblank
[482.858924] Starting dynamic subtest: A-eDP1
[491.842589] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[491.852895] Starting dynamic subtest: B-eDP1
[500.782571] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[500.793893] Starting dynamic subtest: C-eDP1
[509.716901] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[509.727598] Starting dynamic subtest: D-eDP1
[518.655487] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[518.656392] Subtest blocking-wf_vblank: SUCCESS (35.764s)
[519.841699] [109/132] (506s left) gem_ctx_persistence (smoketest)
[519.901580] Starting subtest: smoketest
[560.259949] Subtest smoketest: SUCCESS (40.344s)
[560.324495] [110/132] (465s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[560.417426] Starting subtest: x-tiled-16bpp-rotate-0
[561.684837] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.267s)
[561.814894] [111/132] (464s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[561.908343] Starting subtest: fbc-psr-cursor-mmap-gtt
[561.909244] Starting dynamic subtest: eDP-1
[561.911191] Dynamic subtest eDP-1: SKIP (0.000s)
[561.912945] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[561.978718] [112/132] (464s left) kms_vrr (seamless-rr-switch-vrr)
[562.056411] Starting subtest: seamless-rr-switch-vrr
[562.058795] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[562.126989] [113/132] (463s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[562.193835] Starting subtest: multi-wait-available-submitted-signaled
[562.194673] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[562.288296] [114/132] (463s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[562.384270] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[562.385092] Starting dynamic subtest: pipe-A-eDP-1
[562.394165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[562.402292] Starting dynamic subtest: pipe-B-eDP-1
[562.410966] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[562.418804] Starting dynamic subtest: pipe-C-eDP-1
[562.427432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[562.434901] Starting dynamic subtest: pipe-D-eDP-1
[562.443886] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[562.445700] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[564.711963] [115/132] (461s left) syncobj_timeline (etime-multi-wait-all-submitted)
[564.784872] Starting subtest: etime-multi-wait-all-submitted
[564.888916] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[564.961027] [116/132] (461s left) kms_frontbuffer_tracking (fbc-suspend)
[565.049121] Starting subtest: fbc-suspend
[603.218576] Subtest fbc-suspend: SUCCESS (8.333s)
[607.477179] [117/132] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[607.573268] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[607.574890] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[607.669550] [118/132] (421s left) syncobj_wait (multi-wait-for-submit-signaled)
[607.722031] Starting subtest: multi-wait-for-submit-signaled
[607.723032] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[607.813540] [119/132] (421s left) kms_cursor_crc (cursor-onscreen-max-size)
[608.118239] Starting subtest: cursor-onscreen-max-size
[608.120866] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[608.239150] [120/132] (421s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[608.290458] Subtest writes-after-reads-snoop: SKIP (0.000s)
[608.355728] [121/132] (421s left) gem_mmap_gtt (basic-small-bo-tiledx)
[608.406032] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[608.460457] [122/132] (420s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[608.554386] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[608.556147] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[608.641806] [123/132] (420s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[608.732602] Starting subtest: yf-tiled-16bpp-rotate-270
[608.734560] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[608.821632] [124/132] (420s left) kms_cursor_edge_walk (128x128-left-edge)
[608.902409] Starting subtest: 128x128-left-edge
[608.903333] Starting dynamic subtest: pipe-A-eDP-1
[612.380577] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[612.389705] Starting dynamic subtest: pipe-D-eDP-1
[615.512716] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[615.513591] Subtest 128x128-left-edge: SUCCESS (6.602s)
[616.319240] [125/132] (413s left) prime_mmap_kms (buffer-sharing)
[616.398546] Starting subtest: buffer-sharing
[616.856055] Subtest buffer-sharing: SUCCESS (0.457s)
[617.654422] [126/132] (411s left) perf (blocking)
[617.738577] Starting subtest: blocking
[617.739579] Starting dynamic subtest: 0-rcs0
[627.819640] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[627.830672] Starting dynamic subtest: 1-vecs0
[637.841493] Dynamic subtest 1-vecs0: SUCCESS (10.016s)
[637.842644] Subtest blocking: SUCCESS (20.051s)
[637.875429] [127/132] (391s left) kms_getfb (getfb-reject-nv12)
[637.962120] Starting subtest: getfb-reject-nv12
[637.963015] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[638.060255] [128/132] (391s left) syncobj_timeline (transfer-timeline-point)
[638.114992] Starting subtest: transfer-timeline-point
[638.116042] Subtest transfer-timeline-point: SUCCESS (0.000s)
[638.207884] [129/132] (391s left) perf (gen8-unprivileged-single-ctx-counters)
[638.280526] Starting subtest: gen8-unprivileged-single-ctx-counters
[638.282451] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[638.322099] [130/132] (391s left) gem_exec_reloc (basic-write-read-active)
[638.381546] Subtest basic-write-read-active: SKIP (0.000s)
[638.439603] [131/132] (391s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[638.517836] Starting subtest: fbc-pr-cursor-plane-update-sf
[638.519498] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[638.600013] [132/132] (391s left) gem_exec_balancer (busy)
[638.663783] Starting subtest: busy
[640.109760] Subtest busy: SUCCESS (1.437s)
[640.570026] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_psr2_su
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: drm_read
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_madvise
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: i915_suspend
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: fbdev
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: prime_busy
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: gem_exec_store
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: sysfs_timeslice_duration
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: prime_mmap
results: parsing output: 60/ for test: gem_tiled_pread_pwrite
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gem_exec_capture
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_pm_rpm
results: parsing output: 70/ for test: kms_pipe_crc_basic
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: gem_exec_suspend
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: gem_watchdog
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: sw_sync
results: parsing output: 85/ for test: kms_color_pipeline
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: i915_pm_freq_api
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_sequence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pipe_b_c_ivb
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: kms_debugfs
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_vrr
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_partial_pwrite_pread
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: prime_mmap_kms
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_exec_balancer
Done.