[58.293438] Initializing watchdogs
[58.293484]   /dev/watchdog0
[58.308911] [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]
[58.313732] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.315951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.319382] [001/132] (960s left) kms_psr (fbc-pr-sprite-plane-move)
[58.438122] Starting subtest: fbc-pr-sprite-plane-move
[58.442724] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[58.507998] [002/132] (960s left) kms_draw_crc (draw-method-mmap-gtt)
[58.609498] Starting subtest: draw-method-mmap-gtt
[58.613676] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[58.703165] [003/132] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[58.796979] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[58.801128] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[58.864765] [004/132] (960s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[58.960268] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[58.962588] Starting dynamic subtest: pipe-A-eDP-1
[59.071649] Dynamic subtest pipe-A-eDP-1: SKIP (0.115s)
[59.080595] Starting dynamic subtest: pipe-B-eDP-1
[60.212602] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[60.217156] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.252s)
[61.420226] [005/132] (957s left) prime_busy (before)
[61.487693] Starting subtest: before
[61.492541] Starting dynamic subtest: rcs0
[61.527768] Dynamic subtest rcs0: SUCCESS (0.036s)
[61.537060] Starting dynamic subtest: bcs0
[61.567642] Dynamic subtest bcs0: SUCCESS (0.040s)
[61.576283] Starting dynamic subtest: vcs0
[61.609612] Dynamic subtest vcs0: SUCCESS (0.042s)
[61.617132] Starting dynamic subtest: vcs1
[61.650730] Dynamic subtest vcs1: SUCCESS (0.040s)
[61.660127] Starting dynamic subtest: vecs0
[61.690364] Dynamic subtest vecs0: SUCCESS (0.040s)
[61.698630] Starting dynamic subtest: ccs0
[61.731201] Dynamic subtest ccs0: SUCCESS (0.040s)
[61.839826] Subtest before: SUCCESS (0.349s)
[61.914177] [006/132] (957s left) gem_ringfill (basic-all)
[67.369074] Starting subtest: basic-all
[68.519460] Subtest basic-all: SUCCESS (1.148s)
[68.639661] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[68.642949] [007/132] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[68.757491] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[69.415332] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[69.576926] [008/132] (949s left) kms_psr (psr2-sprite-mmap-gtt)
[69.682845] Starting subtest: psr2-sprite-mmap-gtt
[69.685132] Starting dynamic subtest: eDP-1
[71.129243] Dynamic subtest eDP-1: SKIP (1.442s)
[71.134868] Subtest psr2-sprite-mmap-gtt: SKIP (1.443s)
[71.267674] [009/132] (947s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[71.358800] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[71.361118] Starting dynamic subtest: pipe-A-eDP-1
[77.242304] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.884s)
[77.251728] Starting dynamic subtest: pipe-B-eDP-1
[83.913996] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.670s)
[83.916317] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.555s)
[84.800035] [010/132] (934s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[84.864632] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[84.866803] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[84.973078] [011/132] (934s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[85.099620] Starting subtest: cursorA-vs-flipA-atomic
[96.238105] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.137s)
[97.038574] [012/132] (922s left) kms_chamelium_hpd (hdmi-hpd-fast)
[97.426224] Subtest hdmi-hpd-fast: SKIP (0.000s)
[98.246726] [013/132] (921s left) syncobj_wait (reset-during-wait-for-submit)
[98.298646] Starting subtest: reset-during-wait-for-submit
[98.402514] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[98.476158] [014/132] (920s left) sw_sync (sync_merge_same)
[98.520707] Starting subtest: sync_merge_same
[98.522767] Subtest sync_merge_same: SUCCESS (0.000s)
[98.575372] [015/132] (920s left) kms_pipe_crc_basic (nonblocking-crc)
[98.663995] Starting subtest: nonblocking-crc
[98.666395] Starting dynamic subtest: pipe-A-eDP-1
[99.429849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.766s)
[99.439602] Starting dynamic subtest: pipe-B-eDP-1
[100.896623] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[100.906040] Starting dynamic subtest: pipe-C-eDP-1
[102.308574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[102.317578] Starting dynamic subtest: pipe-D-eDP-1
[103.690134] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s)
[103.692500] Subtest nonblocking-crc: SUCCESS (5.027s)
[104.499092] [016/132] (914s left) gem_exec_reloc (basic-wc-cpu-active)
[104.563160] Subtest basic-wc-cpu-active: SKIP (0.000s)
[104.632673] [017/132] (914s left) syncobj_timeline (single-wait-all-available-submitted)
[104.684680] Starting subtest: single-wait-all-available-submitted
[104.686991] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[104.795023] [018/132] (914s left) gem_wait (await)
[104.857103] Starting subtest: await
[104.859596] Starting dynamic subtest: all-engines
[105.948410] Dynamic subtest all-engines: SUCCESS (1.091s)
[105.964185] Starting dynamic subtest: rcs0
[107.006720] Dynamic subtest rcs0: SUCCESS (1.057s)
[107.023315] Starting dynamic subtest: bcs0
[108.064659] Dynamic subtest bcs0: SUCCESS (1.056s)
[108.081998] Starting dynamic subtest: vcs0
[109.119572] Dynamic subtest vcs0: SUCCESS (1.054s)
[109.135087] Starting dynamic subtest: vcs1
[110.172860] Dynamic subtest vcs1: SUCCESS (1.052s)
[110.188028] Starting dynamic subtest: vecs0
[111.226897] Dynamic subtest vecs0: SUCCESS (1.053s)
[111.242783] Starting dynamic subtest: ccs0
[112.283716] Dynamic subtest ccs0: SUCCESS (1.056s)
[112.286286] Subtest await: SUCCESS (7.427s)
[112.481936] [019/132] (907s left) kms_getfb (getfb2-handle-protection)
[112.582827] Starting subtest: getfb2-handle-protection
[112.603850] Subtest getfb2-handle-protection: SUCCESS (0.021s)
[112.724915] [020/132] (906s left) gem_exec_fence (syncobj-timeline-export)
[113.246659] Starting subtest: syncobj-timeline-export
[113.251973] Subtest syncobj-timeline-export: SUCCESS (0.005s)
[114.436862] [021/132] (905s left) gem_mmap_gtt (basic-small-bo)
[114.488860] Subtest basic-small-bo: SKIP (0.000s)
[114.544155] [022/132] (905s left) gem_mmap_wc (set-cache-level)
[114.604267] Subtest set-cache-level: SKIP (0.000s)
[114.659557] [023/132] (905s left) gem_exec_reloc (basic-write-wc-noreloc)
[114.716606] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[114.780751] [024/132] (904s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[114.877917] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[114.882140] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[114.948387] [025/132] (904s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[115.071377] Starting subtest: 2x-long-cursor-vs-flip-atomic
[115.076089] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[115.216764] [026/132] (904s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[115.267994] Starting subtest: multi-wait-available-submitted-signaled
[115.270375] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[115.361206] [027/132] (904s left) kms_cursor_edge_walk (256x256-left-edge)
[115.453821] Starting subtest: 256x256-left-edge
[115.455831] Starting dynamic subtest: pipe-A-eDP-1
[118.895404] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[118.903200] Starting dynamic subtest: pipe-D-eDP-1
[122.100643] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.204s)
[122.102963] Subtest 256x256-left-edge: SUCCESS (6.648s)
[122.925847] [028/132] (896s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[123.029430] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[123.034051] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[124.155515] [029/132] (895s left) sysfs_timeslice_duration (timeout)
[124.209218] Starting subtest: timeout
[124.211081] Starting dynamic subtest: vecs0
[133.345715] Dynamic subtest vecs0: SUCCESS (9.133s)
[133.356286] Starting dynamic subtest: ccs0
[134.541068] Dynamic subtest ccs0: SUCCESS (1.195s)
[134.550574] Starting dynamic subtest: vcs0
[144.350063] Dynamic subtest vcs0: SUCCESS (9.808s)
[144.364700] Starting dynamic subtest: bcs0
[144.907849] Dynamic subtest bcs0: SUCCESS (0.557s)
[144.916269] Starting dynamic subtest: rcs0
[146.162969] Dynamic subtest rcs0: SUCCESS (1.255s)
[146.172708] Starting dynamic subtest: vcs1
[155.358829] Dynamic subtest vcs1: SUCCESS (9.192s)
[155.361264] Subtest timeout: SUCCESS (31.147s)
[155.431400] [030/132] (864s left) gem_softpin (reverse)
[155.490801] Starting subtest: reverse
[155.500231] Subtest reverse: SUCCESS (0.009s)
[155.641974] [031/132] (864s left) kms_pm_dc (dc9-dpms)
[156.746372] Starting subtest: dc9-dpms
[158.186465] Subtest dc9-dpms: SUCCESS (1.443s)
[158.252714] [032/132] (861s left) gem_exec_balancer (sliced)
[158.320811] Starting subtest: sliced
[158.325486] Subtest sliced: SKIP (0.000s)
[158.621899] [033/132] (861s left) gem_exec_schedule (preempt-engines)
[158.694778] Starting subtest: preempt-engines
[158.696792] Starting dynamic subtest: rcs0
[160.956469] Dynamic subtest rcs0: SUCCESS (2.261s)
[160.967804] Starting dynamic subtest: bcs0
[163.254762] Dynamic subtest bcs0: SUCCESS (2.297s)
[163.270792] Starting dynamic subtest: vcs0
[165.570328] Dynamic subtest vcs0: SUCCESS (2.315s)
[165.579509] Starting dynamic subtest: vcs1
[167.856478] Dynamic subtest vcs1: SUCCESS (2.283s)
[167.865658] Starting dynamic subtest: vecs0
[170.185560] Dynamic subtest vecs0: SUCCESS (2.328s)
[170.193530] Starting dynamic subtest: ccs0
[172.518681] Dynamic subtest ccs0: SUCCESS (2.332s)
[172.521638] Subtest preempt-engines: SUCCESS (13.824s)
[172.816973] [034/132] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[172.922311] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[172.926749] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[173.024657] [035/132] (847s left) sw_sync (alloc_merge_fence)
[173.065973] Starting subtest: alloc_merge_fence
[173.067992] Subtest alloc_merge_fence: SUCCESS (0.000s)
[173.119497] [036/132] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[173.212283] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[173.216480] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[173.305263] [037/132] (846s left) gem_ctx_persistence (legacy-engines-mixed-process)
[173.363475] Starting subtest: legacy-engines-mixed-process
[173.365576] Starting dynamic subtest: render
[175.334988] Dynamic subtest render: SUCCESS (1.973s)
[175.343424] Starting dynamic subtest: bsd1
[177.302343] Dynamic subtest bsd1: SUCCESS (1.963s)
[177.313051] Starting dynamic subtest: bsd2
[179.314912] Dynamic subtest bsd2: SUCCESS (2.014s)
[179.325489] Starting dynamic subtest: blt
[181.360876] Dynamic subtest blt: SUCCESS (2.044s)
[181.371449] Starting dynamic subtest: vebox
[183.351084] Dynamic subtest vebox: SUCCESS (1.989s)
[183.353644] Subtest legacy-engines-mixed-process: SUCCESS (9.990s)
[183.436158] [038/132] (836s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[183.535312] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[183.561306] Starting dynamic subtest: pipe-A-plane-0
[184.005688] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[184.014663] Starting dynamic subtest: pipe-A-plane-3
[184.261258] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[184.270915] Starting dynamic subtest: pipe-A-plane-5
[184.275184] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[185.431197] Starting dynamic subtest: pipe-B-plane-0
[185.876482] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[185.885417] Starting dynamic subtest: pipe-B-plane-3
[186.165500] Dynamic subtest pipe-B-plane-3: SUCCESS (0.289s)
[186.175213] Starting dynamic subtest: pipe-B-plane-5
[186.179589] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[186.486428] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.950s)
[187.311124] [039/132] (833s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[187.422228] Starting subtest: cursorB-vs-flipA-atomic
[187.426753] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[187.583131] [040/132] (832s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[187.695728] Starting subtest: x-tiled-64bpp-rotate-180
[189.430999] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.736s)
[189.620899] [041/132] (830s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[189.733726] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[193.844247] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.114s)
[195.017484] [042/132] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[195.126973] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[195.131190] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[195.253660] [043/132] (825s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[195.338601] Starting subtest: pr-primary-plane-update-sf-dmg-area
[195.342690] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[195.416730] [044/132] (825s left) kms_color (ctm-red-to-blue)
[195.507183] Starting subtest: ctm-red-to-blue
[195.509403] Starting dynamic subtest: pipe-A-eDP-1
[196.227454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[196.236562] Starting dynamic subtest: pipe-B-eDP-1
[197.616183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[197.625731] Starting dynamic subtest: pipe-C-eDP-1
[198.987642] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[198.997023] Starting dynamic subtest: pipe-D-eDP-1
[200.320761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[200.322923] Subtest ctm-red-to-blue: SUCCESS (4.813s)
[201.128899] [045/132] (819s left) gem_userptr_blits (unsync-unmap-cycles)
[201.207671] Subtest unsync-unmap-cycles: SKIP (0.000s)
[201.333305] [046/132] (819s left) kms_content_protection (uevent)
[201.484769] Starting subtest: uevent
[201.489386] Subtest uevent: SKIP (0.000s)
[201.616834] [047/132] (819s left) gem_pipe_control_store_loop (fresh-buffer)
[201.675817] Starting subtest: fresh-buffer
[203.829046] Subtest fresh-buffer: SUCCESS (2.152s)
[203.955993] [048/132] (816s left) kms_chamelium_frames (dp-crc-multiple)
[204.346304] Subtest dp-crc-multiple: SKIP (0.000s)
[205.144454] [049/132] (815s left) perf (global-sseu-config)
[205.283971] Starting subtest: global-sseu-config
[205.287783] Subtest global-sseu-config: SKIP (0.000s)
[205.329183] [050/132] (815s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[205.400591] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[205.456847] [051/132] (815s left) kms_pm_rpm (i2c)
[207.489058] Starting subtest: i2c
[212.857417] Subtest i2c: SUCCESS (5.370s)
[212.946111] [052/132] (807s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[213.040513] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[213.044859] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[213.147665] [053/132] (807s left) kms_flip (modeset-vs-vblank-race)
[213.245162] Starting subtest: modeset-vs-vblank-race
[213.247447] Starting dynamic subtest: A-eDP1
[217.956726] Dynamic subtest A-eDP1: SUCCESS (4.710s)
[217.970076] Starting dynamic subtest: B-eDP1
[222.672427] Dynamic subtest B-eDP1: SUCCESS (4.713s)
[222.681992] Starting dynamic subtest: C-eDP1
[227.362871] Dynamic subtest C-eDP1: SUCCESS (4.688s)
[227.371532] Starting dynamic subtest: D-eDP1
[232.015406] Dynamic subtest D-eDP1: SUCCESS (4.652s)
[232.020477] Subtest modeset-vs-vblank-race: SUCCESS (18.777s)
[233.176610] [054/132] (787s left) gem_eio (suspend)
[233.421524] Starting subtest: suspend
[245.749610] Subtest suspend: SUCCESS (12.327s)
[252.900548] [055/132] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[253.016182] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[259.592869] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.580s)
[259.696690] [056/132] (768s left) kms_big_fb (linear-addfb)
[259.798495] Starting subtest: linear-addfb
[259.800426] Subtest linear-addfb: SUCCESS (0.000s)
[259.887116] [057/132] (768s left) api_intel_allocator (gem-pool)
[259.949540] Starting subtest: gem-pool
[259.954208] Subtest gem-pool: SUCCESS (0.008s)
[260.075530] [058/132] (768s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[260.309760] Starting subtest: cursor-rapid-movement-128x42
[260.359324] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[260.571128] [059/132] (767s left) gen9_exec_parse (bb-start-far)
[260.641056] Subtest bb-start-far: SKIP (0.000s)
[260.702603] [060/132] (767s left) kms_rmfb (close-fd)
[260.797968] Starting subtest: close-fd
[260.799846] Starting dynamic subtest: pipe-A-eDP-1
[260.906271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[260.916920] Starting dynamic subtest: pipe-B-eDP-1
[262.120477] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.212s)
[262.131012] Starting dynamic subtest: pipe-C-eDP-1
[263.259095] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.138s)
[263.269199] Starting dynamic subtest: pipe-D-eDP-1
[264.387061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[264.389280] Subtest close-fd: SUCCESS (3.588s)
[265.602457] [061/132] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[265.702569] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[265.706728] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[265.816434] [062/132] (762s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[265.914612] Starting subtest: fbc-rgb565-draw-mmap-cpu
[269.920559] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.009s)
[271.113140] [063/132] (757s left) kms_lease (cursor-implicit-plane)
[271.205935] Starting subtest: cursor-implicit-plane
[271.208298] Starting dynamic subtest: pipe-A-eDP-1
[271.663262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[271.673242] Starting dynamic subtest: pipe-B-eDP-1
[272.831749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[272.842563] Starting dynamic subtest: pipe-C-eDP-1
[273.950685] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[273.960631] Starting dynamic subtest: pipe-D-eDP-1
[275.071397] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[275.073805] Subtest cursor-implicit-plane: SUCCESS (3.867s)
[275.945499] [064/132] (752s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[275.995467] Starting subtest: etime-single-wait-all-available-unsubmitted
[276.098319] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[276.180937] [065/132] (752s left) i915_query (query-regions-garbage-items)
[276.245841] Starting subtest: query-regions-garbage-items
[276.248291] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[276.345635] [066/132] (752s left) gem_pxp (verify-pxp-stale-ctx-execution)
[276.470962] Starting subtest: verify-pxp-stale-ctx-execution
[277.532748] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[277.653717] [067/132] (750s left) gem_fence_thrash (bo-write-verify-x)
[277.686527] Starting subtest: bo-write-verify-x
[277.709403] Subtest bo-write-verify-x: SKIP (0.019s)
[277.772419] [068/132] (750s left) kms_big_fb (yf-tiled-addfb)
[277.870364] Starting subtest: yf-tiled-addfb
[277.874682] Subtest yf-tiled-addfb: SKIP (0.000s)
[277.966679] [069/132] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[278.068650] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[278.072602] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[278.170607] [070/132] (750s left) kms_flip (flip-vs-panning-vs-hang)
[278.261097] Starting subtest: flip-vs-panning-vs-hang
[278.263386] Starting dynamic subtest: A-eDP1
[317.840503] Dynamic subtest A-eDP1: SUCCESS (39.577s)
[317.851752] Starting dynamic subtest: D-eDP1
[367.822574] Dynamic subtest D-eDP1: SUCCESS (49.979s)
[367.824959] Subtest flip-vs-panning-vs-hang: SUCCESS (89.559s)
[369.026445] [071/132] (659s left) kms_joiner (basic-force-big-joiner)
[369.152830] Starting subtest: basic-force-big-joiner
[369.157223] Subtest basic-force-big-joiner: SKIP (0.000s)
[369.235134] [072/132] (659s left) kms_plane_cursor (overlay)
[369.328020] Starting subtest: overlay
[369.332314] Starting dynamic subtest: pipe-A-eDP-1-size-64
[371.902123] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[371.962309] Starting dynamic subtest: pipe-A-eDP-1-size-128
[374.491790] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[374.552862] Starting dynamic subtest: pipe-A-eDP-1-size-256
[377.060099] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[377.417796] Starting dynamic subtest: pipe-B-eDP-1-size-64
[380.655972] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.249s)
[380.716464] Starting dynamic subtest: pipe-B-eDP-1-size-128
[383.189281] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[383.250825] Starting dynamic subtest: pipe-B-eDP-1-size-256
[385.702277] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[386.056524] Starting dynamic subtest: pipe-C-eDP-1-size-64
[388.895260] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.849s)
[388.934045] Starting dynamic subtest: pipe-C-eDP-1-size-128
[391.084139] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.159s)
[391.121853] Starting dynamic subtest: pipe-C-eDP-1-size-256
[393.273021] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.159s)
[393.604435] Starting dynamic subtest: pipe-D-eDP-1-size-64
[396.439542] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.846s)
[396.477235] Starting dynamic subtest: pipe-D-eDP-1-size-128
[398.639203] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[398.678074] Starting dynamic subtest: pipe-D-eDP-1-size-256
[400.805480] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s)
[401.123220] Subtest overlay: SUCCESS (31.794s)
[401.955410] [073/132] (626s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[402.050069] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[402.052387] Starting dynamic subtest: pipe-A-eDP-1
[402.362261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[402.374074] Starting dynamic subtest: pipe-B-eDP-1
[403.619273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[403.631034] Starting dynamic subtest: pipe-C-eDP-1
[404.849427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[404.859663] Starting dynamic subtest: pipe-D-eDP-1
[406.055973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[406.057933] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.978s)
[407.188273] [074/132] (621s left) kms_draw_crc (fill-fb)
[407.286248] Starting subtest: fill-fb
[407.816514] Subtest fill-fb: SUCCESS (0.532s)
[407.937206] [075/132] (620s left) syncobj_timeline (invalid-query-illegal-handle)
[407.992539] Starting subtest: invalid-query-illegal-handle
[407.994518] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[408.110593] [076/132] (620s left) gem_exec_whisper (basic-queues-forked-all)
[408.188881] Starting subtest: basic-queues-forked-all
[430.598690] Subtest basic-queues-forked-all: SUCCESS (22.407s)
[430.781709] [077/132] (598s left) kms_plane_scaling (planes-downscale-factor-0-5)
[430.891749] Starting subtest: planes-downscale-factor-0-5
[430.893939] Starting dynamic subtest: pipe-A
[430.913824] Dynamic subtest pipe-A: SKIP (0.018s)
[430.924081] Starting dynamic subtest: pipe-B
[430.944699] Dynamic subtest pipe-B: SKIP (0.031s)
[430.954859] Starting dynamic subtest: pipe-C
[430.978164] Dynamic subtest pipe-C: SKIP (0.032s)
[430.987935] Starting dynamic subtest: pipe-D
[431.008415] Dynamic subtest pipe-D: SKIP (0.031s)
[431.012090] Subtest planes-downscale-factor-0-5: SKIP (0.115s)
[431.121967] [078/132] (597s left) gem_sync (basic-each)
[431.193818] Starting subtest: basic-each
[433.718099] Subtest basic-each: SUCCESS (2.535s)
[433.904707] [079/132] (595s left) i915_drm_fdinfo (virtual-busy)
[433.942776] Starting subtest: virtual-busy
[433.947276] Subtest virtual-busy: SKIP (0.000s)
[434.001921] [080/132] (595s left) gem_exec_reloc (basic-cpu-noreloc)
[434.066037] Subtest basic-cpu-noreloc: SKIP (0.000s)
[434.138443] [081/132] (595s left) gem_mmap_offset (clear-via-pagefault)
[434.201580] Starting subtest: clear-via-pagefault
[434.204073] Starting dynamic subtest: smem0
[614.621424] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[668.988469] Closing watchdogs
[668.989856] Initializing watchdogs
[668.989888]   /dev/watchdog0
[669.006829] [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]
[669.013261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[669.014750] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[669.015181] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[669.018646] [082/132] (360s left) syncobj_wait (invalid-reset-zero-handles)
[669.092590] Starting subtest: invalid-reset-zero-handles
[669.095184] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[669.195052] [083/132] (360s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[669.292176] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[673.584567] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.297s)
[674.761713] [084/132] (354s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[674.866382] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[675.534788] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[675.699672] [085/132] (353s left) perf_pmu (busy-idle)
[675.747402] Starting subtest: busy-idle
[675.749600] Starting dynamic subtest: rcs0
[676.438864] Dynamic subtest rcs0: SUCCESS (0.694s)
[676.453153] Starting dynamic subtest: bcs0
[677.109724] Dynamic subtest bcs0: SUCCESS (0.669s)
[677.121145] Starting dynamic subtest: vcs0
[678.309343] Dynamic subtest vcs0: SUCCESS (1.196s)
[678.320935] Starting dynamic subtest: vcs1
[680.359102] Dynamic subtest vcs1: SUCCESS (2.047s)
[680.370616] Starting dynamic subtest: vecs0
[682.341425] Dynamic subtest vecs0: SUCCESS (1.980s)
[682.352668] Starting dynamic subtest: ccs0
[683.011265] Dynamic subtest ccs0: SUCCESS (0.669s)
[683.013802] Subtest busy-idle: SUCCESS (7.267s)
[683.134793] [086/132] (346s left) gem_ctx_persistence (engines-persistence)
[683.197669] Starting subtest: engines-persistence
[683.200110] Starting dynamic subtest: rcs0
[684.006899] Dynamic subtest rcs0: SUCCESS (0.809s)
[684.021076] Starting dynamic subtest: bcs0
[684.746655] Dynamic subtest bcs0: SUCCESS (0.738s)
[684.756801] Starting dynamic subtest: vcs0
[685.517856] Dynamic subtest vcs0: SUCCESS (0.770s)
[685.530081] Starting dynamic subtest: vcs1
[686.310646] Dynamic subtest vcs1: SUCCESS (0.791s)
[686.323426] Starting dynamic subtest: vecs0
[687.057033] Dynamic subtest vecs0: SUCCESS (0.745s)
[687.069778] Starting dynamic subtest: ccs0
[687.820101] Dynamic subtest ccs0: SUCCESS (0.761s)
[687.822557] Subtest engines-persistence: SUCCESS (4.623s)
[687.935412] [087/132] (341s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[688.039434] Starting subtest: y-tiled-32bpp-rotate-180
[688.043525] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[688.141938] [088/132] (341s left) gem_mmap_gtt (big-bo-tiledx)
[688.202571] Subtest big-bo-tiledX: SKIP (0.000s)
[688.267482] [089/132] (341s left) i915_pm_rpm (gem-evict-pwrite)
[690.505036] Starting subtest: gem-evict-pwrite
[690.509912] Subtest gem-evict-pwrite: SKIP (0.000s)
[690.873833] [090/132] (338s left) kms_psr (fbc-psr-cursor-blt)
[690.966066] Starting subtest: fbc-psr-cursor-blt
[690.968296] Starting dynamic subtest: eDP-1
[690.972561] Dynamic subtest eDP-1: SKIP (0.000s)
[690.976767] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[691.040650] [091/132] (338s left) gem_create (create-ext-placement-sanity-check)
[691.207541] Starting subtest: create-ext-placement-sanity-check
[691.212615] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[691.305888] [092/132] (338s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[691.405580] Starting subtest: modeset-transition-nonblocking-fencing
[691.408045] Starting dynamic subtest: 1x-outputs
[702.211694] Dynamic subtest 1x-outputs: SUCCESS (10.808s)
[702.214040] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.810s)
[703.087769] [093/132] (326s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[703.135161] Starting subtest: multi-wait-all-for-submit-signaled
[703.137430] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[703.239262] [094/132] (326s left) kms_scaling_modes (scaling-mode-full-aspect)
[703.338382] Starting subtest: scaling-mode-full-aspect
[703.340586] Starting dynamic subtest: pipe-A-eDP-1
[703.430952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[703.442282] Starting dynamic subtest: pipe-B-eDP-1
[704.600472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[704.613213] Starting dynamic subtest: pipe-C-eDP-1
[705.829101] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[705.839525] Starting dynamic subtest: pipe-D-eDP-1
[706.961115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[706.963400] Subtest scaling-mode-full-aspect: SUCCESS (3.625s)
[708.139936] [095/132] (321s left) prime_mmap (test_correct)
[708.206244] Starting subtest: test_correct
[708.208305] Starting dynamic subtest: test_correct-smem
[708.236223] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[708.238636] Subtest test_correct: SUCCESS (0.034s)
[708.334050] [096/132] (321s left) api_intel_bb (render)
[708.391886] Starting subtest: render
[708.393764] Starting dynamic subtest: render-none-512
[708.491712] Dynamic subtest render-none-512: SUCCESS (0.101s)
[708.504565] Starting dynamic subtest: render-none-1024
[708.881039] Dynamic subtest render-none-1024: SUCCESS (0.387s)
[708.891891] Starting dynamic subtest: render-x-512
[708.965985] Dynamic subtest render-x-512: SUCCESS (0.085s)
[708.978564] Starting dynamic subtest: render-x-1024
[709.316999] Dynamic subtest render-x-1024: SUCCESS (0.349s)
[709.329912] Starting dynamic subtest: render-y-512
[709.402778] Dynamic subtest render-y-512: SUCCESS (0.085s)
[709.415029] Starting dynamic subtest: render-y-1024
[709.750312] Dynamic subtest render-y-1024: SUCCESS (0.346s)
[709.752934] Subtest render: SUCCESS (1.359s)
[709.878306] [097/132] (319s left) kms_async_flips (async-flip-dpms)
[709.976891] Starting subtest: async-flip-dpms
[710.350379] Starting dynamic subtest: pipe-A-eDP-1
[714.147657] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.796s)
[714.538729] Starting dynamic subtest: pipe-B-eDP-1
[717.317105] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[717.684247] Starting dynamic subtest: pipe-C-eDP-1
[720.482135] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.807s)
[720.860863] Starting dynamic subtest: pipe-D-eDP-1
[723.644594] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.793s)
[723.646908] Subtest async-flip-dpms: SUCCESS (13.670s)
[724.831950] [098/132] (305s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[724.927012] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[724.931338] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[725.000439] [099/132] (304s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[725.110893] Starting subtest: fb-8bpc-vs-panel-6bpc
[725.113411] Starting dynamic subtest: pipe-A-eDP-1
[726.517087] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.407s)
[726.519346] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.409s)
[727.385523] [100/132] (302s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[727.483523] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[727.487679] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[727.575457] [101/132] (302s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[727.686891] Starting subtest: psr-1p-primscrn-spr-indfb-move
[735.256832] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.573s)
[735.388558] [102/132] (294s left) prime_self_import (basic-with_fd_dup)
[735.429555] Starting subtest: basic-with_fd_dup
[735.447236] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[735.560554] [103/132] (294s left) gem_exec_fence (syncobj-wait)
[736.056074] Starting subtest: syncobj-wait
[737.338079] Subtest syncobj-wait: SUCCESS (1.281s)
[737.688178] [104/132] (292s left) gem_exec_balancer (full)
[737.734755] Starting subtest: full
[742.241123] Subtest full: SUCCESS (4.506s)
[742.551895] [105/132] (287s left) gem_exec_schedule (semaphore-noskip)
[742.624506] Starting subtest: semaphore-noskip
[743.122094] Subtest semaphore-noskip: SUCCESS (0.501s)
[743.472090] [106/132] (286s left) kms_vblank (query-busy)
[743.572985] Starting subtest: query-busy
[743.574889] Starting dynamic subtest: pipe-A-eDP-1
[745.456727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s)
[745.473637] Starting dynamic subtest: pipe-D-eDP-1
[747.991719] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[747.994042] Subtest query-busy: SUCCESS (4.420s)
[748.802456] [107/132] (281s left) kms_psr (fbc-psr-suspend)
[748.897022] Starting subtest: fbc-psr-suspend
[748.899158] Starting dynamic subtest: eDP-1
[748.903124] Dynamic subtest eDP-1: SKIP (0.000s)
[748.907037] Subtest fbc-psr-suspend: SKIP (0.001s)
[748.971991] [108/132] (281s left) core_setmaster (master-drop-set-shared-fd)
[749.056370] Starting subtest: master-drop-set-shared-fd
[749.075170] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[749.116202] [109/132] (281s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[749.215633] Starting subtest: psr-rgb101010-draw-blt
[756.491274] Subtest psr-rgb101010-draw-blt: SUCCESS (7.278s)
[756.619154] [110/132] (273s left) fbdev (read)
[756.669414] Starting subtest: read
[757.197772] Subtest read: SUCCESS (0.529s)
[757.260823] [111/132] (273s left) gem_madvise (dontneed-before-mmap)
[757.299548] Starting subtest: dontneed-before-mmap
[757.326827] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[757.430393] [112/132] (273s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[757.524870] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[757.527133] Starting dynamic subtest: pipe-A-eDP-1
[757.548645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[757.559252] Starting dynamic subtest: pipe-B-eDP-1
[757.579180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[757.589380] Starting dynamic subtest: pipe-C-eDP-1
[757.616146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[757.627661] Starting dynamic subtest: pipe-D-eDP-1
[757.648930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[757.652938] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[759.801902] [113/132] (270s left) kms_cursor_crc (cursor-offscreen-32x10)
[759.961952] Starting subtest: cursor-offscreen-32x10
[760.009504] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[760.284786] [114/132] (270s left) gem_render_copy (x-tiled)
[760.352548] Starting subtest: x-tiled
[760.354862] Starting dynamic subtest: smem
[760.395751] Dynamic subtest smem: SUCCESS (0.043s)
[760.398060] Subtest x-tiled: SUCCESS (0.044s)
[760.582462] [115/132] (270s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[760.680046] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[760.682399] Starting dynamic subtest: pipe-A-eDP-1
[760.705225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[760.718342] Starting dynamic subtest: pipe-B-eDP-1
[760.740349] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[760.750638] Starting dynamic subtest: pipe-C-eDP-1
[760.772193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[760.782164] Starting dynamic subtest: pipe-D-eDP-1
[760.804600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[760.808983] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[762.935927] [116/132] (267s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[762.995061] Starting subtest: y-tiled-ccs-to-y-tiled
[762.999692] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[763.174815] [117/132] (267s left) gem_mmap_offset (pf-nonblock)
[763.245084] Starting subtest: pf-nonblock
[763.250552] Subtest pf-nonblock: SUCCESS (0.006s)
[763.384206] [118/132] (267s left) syncobj_eventfd (invalid-illegal-handle)
[763.441866] Starting subtest: invalid-illegal-handle
[763.444047] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[763.547032] [119/132] (267s left) syncobj_wait (reset-multiple-signaled)
[763.601423] Starting subtest: reset-multiple-signaled
[763.603590] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[763.718932] [120/132] (267s left) i915_pm_freq_api (freq-suspend)
[763.799615] Starting subtest: freq-suspend
[763.801998] Starting dynamic subtest: gt0
[779.965466] Dynamic subtest gt0: SUCCESS (1.655s)
[779.978470] Starting dynamic subtest: gt1
[796.981236] Dynamic subtest gt1: SUCCESS (1.631s)
[796.984570] Subtest freq-suspend: SUCCESS (3.289s)
[803.082516] [121/132] (233s left) kms_addfb_basic (bad-pitch-999)
[803.142652] Starting subtest: bad-pitch-999
[803.145134] Subtest bad-pitch-999: SUCCESS (0.000s)
[803.269987] [122/132] (233s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[803.373677] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[810.356995] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.978s)
[810.461926] [123/132] (226s left) kms_addfb_basic (basic)
[810.519427] Starting subtest: basic
[810.521401] Subtest basic: SUCCESS (0.000s)
[810.668644] [124/132] (226s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[810.728812] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[810.792166] [125/132] (226s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[810.886383] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[818.158921] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.271s)
[818.286634] [126/132] (218s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[818.389009] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[818.394175] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[818.469105] [127/132] (218s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[818.538272] Subtest writes-after-reads: SKIP (0.000s)
[818.610221] [128/132] (218s left) kms_vblank (ts-continuation-idle-hang)
[818.701075] Starting subtest: ts-continuation-idle-hang
[818.703641] Starting dynamic subtest: pipe-A-eDP-1
[845.010863] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.302s)
[845.026091] Starting dynamic subtest: pipe-D-eDP-1
[859.996884] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.980s)
[859.999654] Subtest ts-continuation-idle-hang: SUCCESS (41.287s)
[860.853832] [129/132] (176s left) gem_exec_schedule (u-submit-late-slice)
[860.924485] Starting subtest: u-submit-late-slice
[860.926618] Starting dynamic subtest: rcs0
[860.951186] Dynamic subtest rcs0: SUCCESS (0.038s)
[860.962242] Starting dynamic subtest: bcs0
[860.980689] Dynamic subtest bcs0: SUCCESS (0.028s)
[860.991265] Starting dynamic subtest: vcs0
[861.009302] Dynamic subtest vcs0: SUCCESS (0.029s)
[861.020015] Starting dynamic subtest: vcs1
[861.045263] Dynamic subtest vcs1: SUCCESS (0.035s)
[861.060289] Starting dynamic subtest: vecs0
[861.081231] Dynamic subtest vecs0: SUCCESS (0.035s)
[861.092276] Starting dynamic subtest: ccs0
[861.113214] Dynamic subtest ccs0: SUCCESS (0.031s)
[861.115962] Subtest u-submit-late-slice: SUCCESS (0.201s)
[862.333503] [130/132] (174s left) gem_exec_flush (basic-batch-kernel-default-wb)
[862.396487] Starting subtest: basic-batch-kernel-default-wb
[869.339405] Subtest basic-batch-kernel-default-wb: SUCCESS (6.942s)
[869.534609] [131/132] (167s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[869.635096] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[869.637779] Starting dynamic subtest: pipe-A-eDP-1
[869.664964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[869.676231] Starting dynamic subtest: pipe-B-eDP-1
[869.704043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[869.714835] Starting dynamic subtest: pipe-C-eDP-1
[869.742746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[869.753181] Starting dynamic subtest: pipe-D-eDP-1
[869.781954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[869.786761] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[871.841035] [132/132] (165s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[871.941239] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[871.946830] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[872.037319] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: prime_busy
results: parsing output: 5/ for test: gem_ringfill
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: kms_pipe_crc_basic
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: gem_softpin
results: parsing output: 30/ for test: kms_pm_dc
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: gem_pipe_control_store_loop
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_pipe_b_c_ivb
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: api_intel_allocator
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_rmfb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: i915_query
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: gem_fence_thrash
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_joiner
results: parsing output: 71/ for test: kms_plane_cursor
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_draw_crc
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: gem_sync
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: i915_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_atomic_transition
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_scaling_modes
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_dither
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_self_import
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: core_setmaster
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: fbdev
results: parsing output: 110/ for test: gem_madvise
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: syncobj_eventfd
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: i915_pm_freq_api
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_big_fb
Done.