[58.383118] Initializing watchdogs
[58.383162]   /dev/watchdog0
[58.397347] [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.401524] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.404320] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.407779] [001/132] (960s left) gem_ccs (ctrl-surf-copy)
[58.490086] Starting subtest: ctrl-surf-copy
[58.494631] Subtest ctrl-surf-copy: SKIP (0.000s)
[58.602013] [002/132] (960s left) kms_psr (fbc-pr-cursor-blt)
[58.686796] Starting subtest: fbc-pr-cursor-blt
[58.691143] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[58.770983] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[58.861967] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[65.973711] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.150s)
[66.127894] [004/132] (952s left) kms_vrr (flip-basic)
[66.220276] Starting subtest: flip-basic
[66.226585] Subtest flip-basic: SKIP (0.000s)
[66.289103] [005/132] (952s left) syncobj_wait (wait-delayed-signal)
[66.347429] Starting subtest: wait-delayed-signal
[66.450774] Subtest wait-delayed-signal: SUCCESS (0.103s)
[66.536988] [006/132] (952s left) kms_big_fb (linear-32bpp-rotate-180)
[66.640695] Starting subtest: linear-32bpp-rotate-180
[68.437347] Subtest linear-32bpp-rotate-180: SUCCESS (1.802s)
[68.562988] [007/132] (950s left) sw_sync (alloc_timeline)
[68.599554] Starting subtest: alloc_timeline
[68.601490] Subtest alloc_timeline: SUCCESS (0.000s)
[68.652189] [008/132] (950s left) kms_frontbuffer_tracking (fbc-tiling-4)
[68.757147] Starting subtest: fbc-tiling-4
[72.907914] Subtest fbc-tiling-4: SUCCESS (4.160s)
[74.069902] [009/132] (945s left) syncobj_eventfd (invalid-illegal-eventfd)
[74.146660] Starting subtest: invalid-illegal-eventfd
[74.149163] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[74.246097] [010/132] (944s left) gem_exec_fence (submit)
[74.431955] Starting subtest: submit
[74.437215] Subtest submit: SKIP (0.000s)
[76.008899] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[76.013456] [011/132] (943s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[76.113966] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[76.118254] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[76.179550] [012/132] (943s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[76.307206] Starting subtest: cursorB-vs-flipA-legacy
[76.311864] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[76.463668] [013/132] (942s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[76.566181] Starting subtest: fbcpsr-rgb565-draw-blt
[83.566867] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.004s)
[83.702275] [014/132] (935s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[83.824238] Starting subtest: flip-vs-cursor-varying-size
[92.650153] Subtest flip-vs-cursor-varying-size: SUCCESS (8.823s)
[93.497666] [015/132] (925s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[93.607827] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[97.618820] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.017s)
[98.809827] [016/132] (920s left) gem_exec_reloc (basic-concurrent16)
[98.871753] Subtest basic-concurrent16: SKIP (0.000s)
[98.946237] [017/132] (920s left) kms_plane_multiple (tiling-none)
[99.036385] Starting subtest: tiling-none
[99.038790] Starting dynamic subtest: pipe-A-eDP-1
[102.730864] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.694s)
[102.739447] Starting dynamic subtest: pipe-B-eDP-1
[107.101818] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.368s)
[107.113303] Starting dynamic subtest: pipe-C-eDP-1
[111.432873] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.331s)
[111.442076] Starting dynamic subtest: pipe-D-eDP-1
[115.773045] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.338s)
[115.775351] Subtest tiling-none: SUCCESS (16.735s)
[116.589171] [018/132] (902s left) perf_pmu (init-busy)
[116.644381] Starting subtest: init-busy
[116.646704] Starting dynamic subtest: rcs0
[116.649101] Dynamic subtest rcs0: SUCCESS (0.001s)
[116.657066] Starting dynamic subtest: bcs0
[116.658932] Dynamic subtest bcs0: SUCCESS (0.000s)
[116.665873] Starting dynamic subtest: vcs0
[116.667792] Dynamic subtest vcs0: SUCCESS (0.001s)
[116.674467] Starting dynamic subtest: vcs1
[116.676350] Dynamic subtest vcs1: SUCCESS (0.001s)
[116.685134] Starting dynamic subtest: vecs0
[116.686994] Dynamic subtest vecs0: SUCCESS (0.000s)
[116.694265] Starting dynamic subtest: ccs0
[116.696397] Dynamic subtest ccs0: SUCCESS (0.000s)
[116.698572] Subtest init-busy: SUCCESS (0.006s)
[116.764346] [019/132] (902s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[116.886508] Starting subtest: flip-vs-cursor-crc-legacy
[117.548467] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.662s)
[118.409960] [020/132] (901s left) syncobj_wait (multi-wait-submitted-signaled)
[118.468166] Starting subtest: multi-wait-submitted-signaled
[118.470446] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[118.555146] [021/132] (901s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[118.652331] Starting subtest: fbc-rgb565-draw-mmap-wc
[122.582404] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.934s)
[123.733227] [022/132] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[123.840078] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[123.844257] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[123.942766] [023/132] (895s left) kms_flip (flip-vs-suspend-interruptible)
[124.044022] Starting subtest: flip-vs-suspend-interruptible
[124.046316] Starting dynamic subtest: A-eDP1
[269.349808] Dynamic subtest A-eDP1: SUCCESS (11.515s)
[269.352768] Subtest flip-vs-suspend-interruptible: SUCCESS (11.517s)
[269.481766] [024/132] (750s left) kms_async_flips (async-flip-dpms)
[269.573893] Starting subtest: async-flip-dpms
[269.954112] Starting dynamic subtest: pipe-A-eDP-1
[273.761290] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.937s)
[274.132276] Starting dynamic subtest: pipe-B-eDP-1
[276.946082] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s)
[277.342975] Starting dynamic subtest: pipe-C-eDP-1
[280.163534] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.869s)
[280.533902] Starting dynamic subtest: pipe-D-eDP-1
[283.308324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[283.311048] Subtest async-flip-dpms: SUCCESS (14.017s)
[284.483708] [025/132] (735s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[284.590620] Starting subtest: y-tiled-8bpp-rotate-0
[284.595764] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[284.673177] [026/132] (735s left) gem_exec_params (invalid-ring2)
[284.728180] Starting subtest: invalid-ring2
[284.731130] Subtest invalid-ring2: SUCCESS (0.000s)
[284.838882] [027/132] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[284.940537] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[284.946078] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[285.041266] [028/132] (734s left) syncobj_timeline (single-wait-all-signaled)
[285.097114] Starting subtest: single-wait-all-signaled
[285.099730] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[285.192649] [029/132] (734s left) i915_module_load (reload-no-display)
[285.243182] Starting subtest: reload-no-display
[290.404942] Subtest reload-no-display: SUCCESS (5.186s)
[290.435995] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[290.436740] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[290.440528] [030/132] (729s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[292.921793] Starting subtest: short-flip-before-cursor-toggle
[293.869379] Subtest short-flip-before-cursor-toggle: SUCCESS (0.948s)
[294.773523] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[294.774712] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[294.778843] [031/132] (725s left) api_intel_allocator (reloc-allocator)
[294.843314] Starting subtest: reloc-allocator
[294.846255] Starting dynamic subtest: basic
[294.849110] Dynamic subtest basic: SUCCESS (0.004s)
[294.863600] Starting dynamic subtest: parallel-one
[294.866376] Dynamic subtest parallel-one: SUCCESS (0.008s)
[294.877677] Starting dynamic subtest: print
[294.880302] Dynamic subtest print: SUCCESS (0.000s)
[294.888472] Starting dynamic subtest: reuse
[294.890641] Dynamic subtest reuse: SUCCESS (0.000s)
[294.897982] Starting dynamic subtest: fork-reopen-allocator
[294.900235] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[294.902554] Subtest reloc-allocator: SUCCESS (0.035s)
[294.982560] [032/132] (725s left) drm_mm (drm_mm)
[295.021927] Starting subtest: drm_mm
[295.029849] Starting dynamic subtest: drm_test_mm_init
[295.136509] Dynamic subtest drm_test_mm_init: SUCCESS (0.106s)
[295.147949] Starting dynamic subtest: drm_test_mm_debug
[295.235511] Dynamic subtest drm_test_mm_debug: SUCCESS (0.098s)
[295.245363] Starting dynamic subtest: drm_test_mm_align32
[295.337879] Dynamic subtest drm_test_mm_align32: SUCCESS (0.103s)
[295.347583] Starting dynamic subtest: drm_test_mm_align64
[295.431320] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s)
[295.441309] Starting dynamic subtest: drm_test_mm_lowest
[295.529684] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.100s)
[295.537400] Starting dynamic subtest: drm_test_mm_highest
[295.630336] Dynamic subtest drm_test_mm_highest: SUCCESS (0.100s)
[295.633391] Subtest drm_mm: SUCCESS (0.611s)
[295.790644] [033/132] (724s left) gem_exec_reloc (basic-cpu-active)
[295.853340] Subtest basic-cpu-active: SKIP (0.000s)
[295.943896] [034/132] (724s left) kms_psr (fbc-pr-primary-mmap-gtt)
[296.030983] Starting subtest: fbc-pr-primary-mmap-gtt
[296.035679] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[296.106906] [035/132] (724s left) kms_draw_crc (draw-method-render)
[296.195865] Starting subtest: draw-method-render
[296.198005] Starting dynamic subtest: xrgb8888-untiled
[296.448863] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[296.456760] Starting dynamic subtest: rgb565-untiled
[296.692878] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[296.699975] Starting dynamic subtest: xrgb2101010-untiled
[296.925359] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[296.935521] Starting dynamic subtest: xbgr16161616f-untiled
[297.158513] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[297.166764] Starting dynamic subtest: xrgb8888-xtiled
[297.280341] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[297.288278] Starting dynamic subtest: rgb565-xtiled
[297.402294] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[297.410537] Starting dynamic subtest: xrgb2101010-xtiled
[297.524642] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[297.532899] Starting dynamic subtest: xbgr16161616f-xtiled
[297.646422] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[297.654601] Starting dynamic subtest: xrgb8888-4tiled
[297.779442] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[297.788126] Starting dynamic subtest: rgb565-4tiled
[297.890876] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[297.898508] Starting dynamic subtest: xrgb2101010-4tiled
[298.012771] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[298.022689] Starting dynamic subtest: xbgr16161616f-4tiled
[298.146161] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[298.148300] Subtest draw-method-render: SUCCESS (1.956s)
[298.227892] [036/132] (722s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[298.608324] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[299.379705] [037/132] (720s left) api_intel_bb (simple-bb-ctx)
[299.433147] Starting subtest: simple-bb-ctx
[299.440761] Subtest simple-bb-ctx: SUCCESS (0.009s)
[299.560342] [038/132] (720s left) kms_pipe_stress (stress-xrgb8888-untiled)
[299.652919] Starting subtest: stress-xrgb8888-untiled
[305.547532] Subtest stress-xrgb8888-untiled: SUCCESS (5.894s)
[305.606595] [039/132] (714s left) gem_close_race (basic-threads)
[305.668367] Starting subtest: basic-threads
[307.023092] Subtest basic-threads: SUCCESS (1.354s)
[307.216216] [040/132] (713s left) gem_render_copy (y-tiled-to-vebox-linear)
[307.269799] Starting subtest: y-tiled-to-vebox-linear
[307.275341] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[307.456618] [041/132] (713s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[307.571240] Starting subtest: basic-flip-before-cursor-legacy
[308.487639] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[309.344880] [042/132] (711s left) gem_ctx_persistence (engines-cleanup)
[309.406217] Starting subtest: engines-cleanup
[309.409350] Starting dynamic subtest: rcs0
[309.482912] Dynamic subtest rcs0: SUCCESS (0.076s)
[309.492856] Starting dynamic subtest: bcs0
[309.525522] Dynamic subtest bcs0: SUCCESS (0.040s)
[309.535803] Starting dynamic subtest: vcs0
[309.572847] Dynamic subtest vcs0: SUCCESS (0.045s)
[309.583524] Starting dynamic subtest: vcs1
[309.613771] Dynamic subtest vcs1: SUCCESS (0.039s)
[309.623241] Starting dynamic subtest: vecs0
[309.659815] Dynamic subtest vecs0: SUCCESS (0.044s)
[309.670090] Starting dynamic subtest: ccs0
[309.699447] Dynamic subtest ccs0: SUCCESS (0.038s)
[309.702206] Subtest engines-cleanup: SUCCESS (0.294s)
[309.777640] [043/132] (710s left) kms_sequence (queue-idle)
[309.867203] Starting subtest: queue-idle
[309.869313] Starting dynamic subtest: pipe-A-eDP-1
[311.668831] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[311.678486] Starting dynamic subtest: pipe-B-eDP-1
[314.108966] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[314.119100] Starting dynamic subtest: pipe-C-eDP-1
[316.525501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.416s)
[316.534413] Starting dynamic subtest: pipe-D-eDP-1
[318.954733] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[318.957344] Subtest queue-idle: SUCCESS (9.091s)
[319.770194] [044/132] (700s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[319.862161] Starting subtest: bad-rotation-90-yf-tiled-ccs
[319.864483] Starting dynamic subtest: pipe-A-eDP-1
[319.887898] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.897342] Starting dynamic subtest: pipe-B-eDP-1
[319.919958] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.927198] Starting dynamic subtest: pipe-C-eDP-1
[319.949607] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.956871] Starting dynamic subtest: pipe-D-eDP-1
[319.979477] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.984191] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[322.114661] [045/132] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[322.210727] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[322.215492] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[322.311793] [046/132] (698s left) gem_mmap_wc (bad-offset)
[322.363773] Subtest bad-offset: SKIP (0.000s)
[322.419720] [047/132] (698s left) gen9_exec_parse (bb-secure)
[322.479089] Subtest bb-secure: SKIP (0.000s)
[322.543082] [048/132] (698s left) gen9_exec_parse (unaligned-access)
[322.602340] Subtest unaligned-access: SKIP (0.000s)
[322.670334] [049/132] (698s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[322.766762] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[322.771415] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[322.835365] [050/132] (698s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[322.939414] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[322.942298] Starting dynamic subtest: pipe-A
[323.003028] Dynamic subtest pipe-A: SUCCESS (0.066s)
[323.012541] Starting dynamic subtest: pipe-B
[324.134556] Dynamic subtest pipe-B: SUCCESS (1.131s)
[324.143436] Starting dynamic subtest: pipe-C
[325.247279] Dynamic subtest pipe-C: SUCCESS (1.113s)
[325.255945] Starting dynamic subtest: pipe-D
[326.377911] Dynamic subtest pipe-D: SUCCESS (1.130s)
[326.380484] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.443s)
[327.532506] [051/132] (693s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[327.632048] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[327.634301] Starting dynamic subtest: A-eDP1
[336.581444] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[336.591646] Starting dynamic subtest: B-eDP1
[345.509205] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[345.519864] Starting dynamic subtest: C-eDP1
[354.434271] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[354.443991] Starting dynamic subtest: D-eDP1
[363.360708] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[363.366316] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.747s)
[364.609153] [052/132] (656s left) gem_exec_schedule (u-semaphore-noskip)
[364.689284] Starting subtest: u-semaphore-noskip
[365.099701] Subtest u-semaphore-noskip: SUCCESS (0.418s)
[365.441286] [053/132] (655s left) kms_cursor_crc (cursor-offscreen-max-size)
[365.730198] Starting subtest: cursor-offscreen-max-size
[365.737530] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[365.860232] [054/132] (655s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[365.962028] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[365.967374] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[366.056988] [055/132] (655s left) i915_pm_rpm (gem-pread)
[367.787238] Starting subtest: gem-pread
[370.018409] Subtest gem-pread: SUCCESS (2.230s)
[370.119715] [056/132] (651s left) i915_pm_rps (thresholds-idle-park)
[370.178149] Starting subtest: thresholds-idle-park
[370.183368] Subtest thresholds-idle-park: SKIP (0.001s)
[370.283998] [057/132] (650s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[370.373097] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[370.377867] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[370.442591] [058/132] (650s left) kms_pm_backlight (basic-brightness)
[370.540797] Starting subtest: basic-brightness
[370.592511] Starting dynamic subtest: eDP-1
[371.093445] Dynamic subtest eDP-1: SUCCESS (0.501s)
[371.096063] Subtest basic-brightness: SUCCESS (0.552s)
[371.909968] [059/132] (649s left) gem_exec_flush (basic-wb-set-default)
[371.975412] Starting subtest: basic-wb-set-default
[377.431703] Subtest basic-wb-set-default: SUCCESS (5.453s)
[377.639026] [060/132] (643s left) kms_cursor_edge_walk (128x128-right-edge)
[377.733443] Starting subtest: 128x128-right-edge
[377.736251] Starting dynamic subtest: pipe-A-eDP-1
[381.192938] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[381.202022] Starting dynamic subtest: pipe-D-eDP-1
[384.322530] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[384.325408] Subtest 128x128-right-edge: SUCCESS (6.587s)
[385.121797] [061/132] (636s left) gem_ctx_param (set-priority-range)
[385.174548] Starting subtest: set-priority-range
[385.188092] Subtest set-priority-range: SUCCESS (0.013s)
[385.284139] [062/132] (636s left) kms_chamelium_frames (dp-crc-single)
[385.664196] Subtest dp-crc-single: SKIP (0.000s)
[386.441168] [063/132] (635s left) sysfs_preempt_timeout (timeout)
[386.510763] Starting subtest: timeout
[386.513232] Starting dynamic subtest: vecs0
[395.691247] Dynamic subtest vecs0: SUCCESS (9.179s)
[395.701440] Starting dynamic subtest: ccs0
[396.964057] Dynamic subtest ccs0: SUCCESS (1.272s)
[396.972418] Starting dynamic subtest: vcs0
[406.699086] Dynamic subtest vcs0: SUCCESS (9.731s)
[406.710035] Starting dynamic subtest: bcs0
[407.970328] Dynamic subtest bcs0: SUCCESS (1.270s)
[407.979073] Starting dynamic subtest: rcs0
[409.177213] Dynamic subtest rcs0: SUCCESS (1.205s)
[409.186179] Starting dynamic subtest: vcs1
[418.667247] Dynamic subtest vcs1: SUCCESS (9.486s)
[418.670474] Subtest timeout: SUCCESS (32.158s)
[418.739405] [064/132] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[418.838523] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[418.844251] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[418.925365] [065/132] (602s left) kms_flip (dpms-off-confusion-interruptible)
[419.020131] Starting subtest: dpms-off-confusion-interruptible
[419.022917] Starting dynamic subtest: A-eDP1
[427.660101] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[427.669083] Starting dynamic subtest: B-eDP1
[436.290198] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[436.298693] Starting dynamic subtest: C-eDP1
[444.909293] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[444.919182] Starting dynamic subtest: D-eDP1
[453.541010] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[453.547161] Subtest dpms-off-confusion-interruptible: SUCCESS (34.534s)
[454.688936] [066/132] (566s left) gem_exec_capture (pi)
[454.746317] Starting subtest: pi
[454.748957] Starting dynamic subtest: rcs0
[459.184009] Dynamic subtest rcs0: SUCCESS (4.441s)
[459.195545] Starting dynamic subtest: bcs0
[463.005909] Dynamic subtest bcs0: SUCCESS (3.821s)
[463.015055] Starting dynamic subtest: vcs0
[466.890781] Dynamic subtest vcs0: SUCCESS (3.884s)
[466.902253] Starting dynamic subtest: vcs1
[470.808877] Dynamic subtest vcs1: SUCCESS (3.917s)
[470.818850] Starting dynamic subtest: vecs0
[474.731385] Dynamic subtest vecs0: SUCCESS (3.922s)
[474.742690] Starting dynamic subtest: ccs0
[478.708688] Dynamic subtest ccs0: SUCCESS (3.977s)
[478.711181] Subtest pi: SUCCESS (23.972s)
[478.794032] [067/132] (542s left) gem_lmem_swapping (heavy-verify-random-ccs)
[478.905634] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[478.953613] [068/132] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[479.060057] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[483.435957] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.380s)
[484.592811] [069/132] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[484.695498] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[484.700716] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[484.798314] [070/132] (536s left) gem_ctx_persistence (heartbeat-hostile)
[484.859187] Starting subtest: heartbeat-hostile
[484.864284] Subtest heartbeat-hostile: SKIP (0.000s)
[484.978175] [071/132] (536s left) gem_softpin (evict-prime-sanity-check)
[485.033883] Starting subtest: evict-prime-sanity-check
[485.036498] Starting dynamic subtest: rcs0
[486.171335] Dynamic subtest rcs0: SUCCESS (1.137s)
[486.183192] Starting dynamic subtest: bcs0
[487.291791] Dynamic subtest bcs0: SUCCESS (1.120s)
[487.303072] Starting dynamic subtest: vcs0
[488.683542] Dynamic subtest vcs0: SUCCESS (1.389s)
[488.695371] Starting dynamic subtest: vcs1
[490.680484] Dynamic subtest vcs1: SUCCESS (1.995s)
[490.691708] Starting dynamic subtest: vecs0
[492.654770] Dynamic subtest vecs0: SUCCESS (1.972s)
[492.666384] Starting dynamic subtest: ccs0
[493.768690] Dynamic subtest ccs0: SUCCESS (1.112s)
[493.777822] Starting dynamic subtest: all
[494.887344] Dynamic subtest all: SUCCESS (1.118s)
[494.889948] Subtest evict-prime-sanity-check: SUCCESS (9.855s)
[494.966914] [072/132] (526s left) gem_exec_schedule (pi-shared-iova)
[495.157914] Starting subtest: pi-shared-iova
[495.160525] Starting dynamic subtest: rcs0
[495.286694] Dynamic subtest rcs0: SUCCESS (0.130s)
[495.298903] Starting dynamic subtest: vcs0
[495.380646] Dynamic subtest vcs0: SUCCESS (0.093s)
[495.392521] Starting dynamic subtest: vcs1
[495.465094] Dynamic subtest vcs1: SUCCESS (0.084s)
[495.475078] Starting dynamic subtest: vecs0
[495.549367] Dynamic subtest vecs0: SUCCESS (0.083s)
[495.561260] Starting dynamic subtest: ccs0
[495.662757] Dynamic subtest ccs0: SUCCESS (0.111s)
[495.665507] Subtest pi-shared-iova: SUCCESS (0.508s)
[496.796182] [073/132] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[496.898231] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[496.902914] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[496.981864] [074/132] (524s left) gem_exec_flush (basic-wb-rw-default)
[497.045423] Starting subtest: basic-wb-rw-default
[502.515587] Subtest basic-wb-rw-default: SUCCESS (5.470s)
[502.703370] [075/132] (519s left) kms_cursor_crc (cursor-random-512x512)
[502.990201] Starting subtest: cursor-random-512x512
[502.994710] Subtest cursor-random-512x512: SKIP (0.001s)
[503.151782] [076/132] (518s left) sw_sync (sync_busy_fork_unixsocket)
[503.189928] Starting subtest: sync_busy_fork_unixsocket
[503.196336] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[503.261873] [077/132] (518s left) kms_vblank (wait-busy-hang)
[503.348522] Starting subtest: wait-busy-hang
[503.351417] Starting dynamic subtest: pipe-A-eDP-1
[529.532057] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.175s)
[529.546520] Starting dynamic subtest: pipe-D-eDP-1
[554.487084] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.949s)
[554.489803] Subtest wait-busy-hang: SUCCESS (51.128s)
[555.339552] [078/132] (466s left) gem_vm_create (invalid-create)
[555.400267] Starting subtest: invalid-create
[555.402910] Subtest invalid-create: SUCCESS (0.002s)
[555.513876] [079/132] (466s left) gem_mmap_gtt (pf-nonblock)
[555.581057] Subtest pf-nonblock: SKIP (0.000s)
[555.646830] [080/132] (466s left) syncobj_timeline (multi-wait-all-available-submitted)
[555.700502] Starting subtest: multi-wait-all-available-submitted
[555.703390] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[555.792812] [081/132] (466s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[555.884532] Starting subtest: flip-primary-invalidate-overlay
[567.506186] Subtest flip-primary-invalidate-overlay: SUCCESS (11.624s)
[567.652968] [082/132] (454s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[567.708993] Starting subtest: yf-tiled-ccs-to-x-tiled
[567.713706] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[567.892023] [083/132] (454s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[567.998485] Starting subtest: yf-tiled-64bpp-rotate-180
[568.003486] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[568.088176] [084/132] (454s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[568.181274] Starting subtest: psr-1p-primscrn-spr-indfb-move
[575.777837] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.600s)
[575.916407] [085/132] (446s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[576.002430] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[576.007861] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[576.074418] [086/132] (446s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[576.174093] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[582.991399] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.821s)
[583.104823] [087/132] (439s left) kms_color_pipeline (plane-lut1d-lut1d)
[583.200113] Starting subtest: plane-lut1d-lut1d
[583.345931] Starting dynamic subtest: pipe-A-plane-0
[583.525119] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[583.535651] Starting dynamic subtest: pipe-A-plane-1
[583.713286] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[583.723576] Starting dynamic subtest: pipe-A-plane-2
[583.867845] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[585.143404] Starting dynamic subtest: pipe-B-plane-0
[585.302034] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[585.311236] Starting dynamic subtest: pipe-B-plane-1
[585.468947] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[585.478441] Starting dynamic subtest: pipe-B-plane-2
[585.658057] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[586.823293] Starting dynamic subtest: pipe-C-plane-0
[586.972244] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[586.981855] Starting dynamic subtest: pipe-C-plane-1
[587.127417] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[587.136535] Starting dynamic subtest: pipe-C-plane-2
[587.282931] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[588.493534] Starting dynamic subtest: pipe-D-plane-0
[588.630942] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[588.640705] Starting dynamic subtest: pipe-D-plane-1
[588.798458] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[588.810503] Starting dynamic subtest: pipe-D-plane-2
[588.963968] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[589.252199] Subtest plane-lut1d-lut1d: SUCCESS (6.053s)
[590.134903] [088/132] (432s left) gem_create (create-size-update)
[590.196759] Starting subtest: create-size-update
[590.199292] Subtest create-size-update: SUCCESS (0.000s)
[590.428333] [089/132] (432s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[590.483521] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[590.590196] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[590.666326] [090/132] (431s left) gem_exec_params (rel-constants-invalid-ring)
[590.720176] Starting subtest: rel-constants-invalid-ring
[590.722906] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[590.840960] [091/132] (431s left) gem_eio (in-flight-contexts-immediate)
[591.066250] Starting subtest: in-flight-contexts-immediate
[604.739005] Subtest in-flight-contexts-immediate: SUCCESS (13.674s)
[604.907517] [092/132] (417s left) kms_addfb_basic (invalid-get-prop)
[604.963866] Starting subtest: invalid-get-prop
[604.966435] Subtest invalid-get-prop: SUCCESS (0.000s)
[605.096594] [093/132] (417s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[605.196603] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[605.201983] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[605.287094] [094/132] (417s left) syncobj_wait (single-wait-all-for-submit-signaled)
[605.349475] Starting subtest: single-wait-all-for-submit-signaled
[605.352322] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[605.450178] [095/132] (417s left) kms_pipe_crc_basic (bad-source)
[605.543527] Starting subtest: bad-source
[605.545872] Subtest bad-source: SUCCESS (0.000s)
[605.631411] [096/132] (417s left) kms_atomic_transition (plane-all-transition)
[605.737052] Starting subtest: plane-all-transition
[605.739121] Starting dynamic subtest: pipe-A-eDP-1
[608.231269] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[608.542532] Starting dynamic subtest: pipe-B-eDP-1
[611.762008] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[612.067250] Subtest plane-all-transition: SUCCESS (6.331s)
[612.890290] [097/132] (410s left) gem_eio (kms)
[613.162408] Starting subtest: kms
[630.872919] Subtest kms: SUCCESS (17.714s)
[632.050396] [098/132] (390s left) syncobj_wait (single-wait-signaled)
[632.113163] Starting subtest: single-wait-signaled
[632.115785] Subtest single-wait-signaled: SUCCESS (0.000s)
[632.205904] [099/132] (390s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[632.302784] Starting subtest: x-tiled-32bpp-rotate-180
[633.704317] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.401s)
[633.822818] [100/132] (389s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[633.892267] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[633.955140] [101/132] (389s left) kms_psr (psr-cursor-plane-move)
[634.053954] Starting subtest: psr-cursor-plane-move
[634.056248] Starting dynamic subtest: eDP-1
[635.742370] Dynamic subtest eDP-1: SUCCESS (1.688s)
[635.744749] Subtest psr-cursor-plane-move: SUCCESS (1.689s)
[636.610244] [102/132] (386s left) kms_rotation_crc (sprite-rotation-270)
[636.714970] Starting subtest: sprite-rotation-270
[636.720369] Subtest sprite-rotation-270: SKIP (0.001s)
[636.788780] [103/132] (386s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[636.883773] Starting subtest: 4-tiled-32bpp-rotate-270
[636.906166] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[637.024001] [104/132] (386s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[637.083324] Starting subtest: invalid-multi-wait-unsubmitted
[637.085743] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[637.179869] [105/132] (386s left) kms_getfb (getfb2-handle-protection)
[637.281862] Starting subtest: getfb2-handle-protection
[637.300192] Subtest getfb2-handle-protection: SUCCESS (0.019s)
[637.412215] [106/132] (385s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[637.470499] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[637.574229] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[637.650602] [107/132] (385s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[637.731051] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[637.733506] Starting dynamic subtest: pipe-A-eDP-1
[637.755388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.765937] Starting dynamic subtest: pipe-B-eDP-1
[637.788522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.797213] Starting dynamic subtest: pipe-C-eDP-1
[637.820026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.828332] Starting dynamic subtest: pipe-D-eDP-1
[637.851424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.855613] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[639.899985] [108/132] (383s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[640.016217] Starting subtest: random-ccs-data-y-tiled-ccs
[640.018643] Starting dynamic subtest: pipe-A-eDP-1
[640.045618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[640.056152] Starting dynamic subtest: pipe-B-eDP-1
[640.084437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[640.094080] Starting dynamic subtest: pipe-C-eDP-1
[640.120205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[640.128906] Starting dynamic subtest: pipe-D-eDP-1
[640.153957] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[640.158382] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[642.170156] [109/132] (381s left) prime_udl
[642.254523] [110/132] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[642.348013] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[649.690292] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.347s)
[649.815865] [111/132] (373s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[649.915615] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[649.918181] Starting dynamic subtest: pipe-A-eDP-1
[650.212056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.264s)
[650.222572] Starting dynamic subtest: pipe-B-eDP-1
[651.490993] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.270s)
[651.501306] Starting dynamic subtest: pipe-C-eDP-1
[652.789528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[652.799746] Starting dynamic subtest: pipe-D-eDP-1
[653.994741] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[653.997120] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.044s)
[655.118120] [112/132] (368s left) kms_atomic (plane-invalid-params-fence)
[655.215504] Starting subtest: plane-invalid-params-fence
[655.218383] Starting dynamic subtest: pipe-A-eDP-1
[655.579770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[655.582439] Subtest plane-invalid-params-fence: SUCCESS (0.364s)
[656.457730] [113/132] (367s left) gem_eio (suspend)
[656.690506] Starting subtest: suspend
[668.929406] Subtest suspend: SUCCESS (12.242s)
[669.072331] [114/132] (354s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[669.174501] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[669.176841] Starting dynamic subtest: pipe-A-eDP-1
[669.997899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[670.008117] Starting dynamic subtest: pipe-B-eDP-1
[671.710686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.711s)
[671.720583] Starting dynamic subtest: pipe-C-eDP-1
[673.224196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[673.240774] Starting dynamic subtest: pipe-D-eDP-1
[674.710194] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[674.712602] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.527s)
[675.863827] [115/132] (347s left) syncobj_wait (wait-any-snapshot)
[675.923415] Starting subtest: wait-any-snapshot
[676.004248] Subtest wait-any-snapshot: SUCCESS (0.083s)
[676.084154] [116/132] (347s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[676.187179] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[676.189647] Starting dynamic subtest: pipe-A-eDP-1
[676.261428] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[676.272213] Starting dynamic subtest: pipe-B-eDP-1
[677.439332] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[677.445234] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.255s)
[678.630387] [117/132] (345s left) kms_psr (pr-cursor-plane-onoff)
[678.728175] Starting subtest: pr-cursor-plane-onoff
[678.733183] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[678.798704] [118/132] (344s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[678.890336] Starting subtest: fbc-psr-cursor-mmap-cpu
[678.893091] Starting dynamic subtest: eDP-1
[678.898190] Dynamic subtest eDP-1: SKIP (0.000s)
[678.903358] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[678.962899] [119/132] (344s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[679.097398] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[679.102623] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[679.251751] [120/132] (344s left) gem_exec_whisper (basic-fds-forked-all)
[679.317533] Starting subtest: basic-fds-forked-all
[703.450411] Subtest basic-fds-forked-all: SUCCESS (24.132s)
[703.648277] [121/132] (320s left) perf_pmu (pmu-read)
[703.691510] Starting subtest: pmu-read
[703.694044] Subtest pmu-read: SUCCESS (0.003s)
[703.794264] [122/132] (320s left) kms_lease (lease-unleased-connector)
[703.889031] Starting subtest: lease-unleased-connector
[703.891294] Starting dynamic subtest: pipe-A-eDP-1
[703.894254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[703.908170] Starting dynamic subtest: pipe-B-eDP-1
[703.910635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[703.921523] Starting dynamic subtest: pipe-C-eDP-1
[703.924574] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[703.934211] Starting dynamic subtest: pipe-D-eDP-1
[703.936439] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[703.938943] Subtest lease-unleased-connector: SUCCESS (0.029s)
[704.010058] [123/132] (319s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[704.133236] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[704.138357] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[704.280071] [124/132] (319s left) gem_exec_balancer (full-late)
[704.336493] Starting subtest: full-late
[708.542284] Subtest full-late: SUCCESS (4.206s)
[708.855880] [125/132] (315s left) kms_content_protection (uevent-hdcp14)
[709.012939] Starting subtest: uevent-hdcp14
[709.017651] Subtest uevent-hdcp14: SKIP (0.000s)
[709.128897] [126/132] (314s left) gem_exec_nop (basic-series)
[709.197302] Starting subtest: basic-series
[725.685806] Subtest basic-series: SUCCESS (16.499s)
[725.905785] [127/132] (298s left) i915_query (query-garbage)
[725.964787] Starting subtest: query-garbage
[725.967344] Subtest query-garbage: SUCCESS (0.000s)
[726.059039] [128/132] (298s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[726.156400] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[727.080797] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.926s)
[727.233514] [129/132] (297s left) kms_invalid_mode (bad-hsync-start)
[727.339066] Starting subtest: bad-hsync-start
[727.341525] Starting dynamic subtest: pipe-A-eDP-1
[727.622094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[727.633255] Starting dynamic subtest: pipe-B-eDP-1
[727.635921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[727.646500] Starting dynamic subtest: pipe-C-eDP-1
[727.649491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[727.660301] Starting dynamic subtest: pipe-D-eDP-1
[727.663063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[727.665717] Subtest bad-hsync-start: SUCCESS (0.292s)
[728.447060] [130/132] (295s left) gem_mmap_wc (invalid-flags)
[728.499487] Subtest invalid-flags: SKIP (0.000s)
[728.560676] [131/132] (295s left) gem_ctx_bad_destroy (invalid-pad)
[728.605749] Starting subtest: invalid-pad
[728.608469] Subtest invalid-pad: SUCCESS (0.000s)
[728.679320] [132/132] (295s left) gem_exec_create (basic)
[728.738857] Starting subtest: basic
[728.741109] Starting dynamic subtest: smem
[732.722606] Dynamic subtest smem: SUCCESS (3.982s)
[732.725353] Subtest basic: SUCCESS (3.984s)
[732.903645] Closing watchdogs
results: parsing output: 0/ for test: gem_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_vrr
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_eventfd
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_module_load
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: drm_mm
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_pipe_stress
results: parsing output: 38/ for test: gem_close_race
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_sequence
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: i915_pm_rps
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_pm_backlight
results: parsing output: 58/ for test: gem_exec_flush
results: parsing output: 59/ for test: kms_cursor_edge_walk
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_chamelium_frames
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_capture
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: gem_softpin
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: gem_vm_create
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_psr_stress_test
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_pipe_crc_basic
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: prime_udl
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_lease
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_nop
results: parsing output: 126/ for test: i915_query
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: gem_ctx_bad_destroy
results: parsing output: 131/ for test: gem_exec_create
Done.