[58.834228] Initializing watchdogs
[58.834277]   /dev/watchdog0
[58.848594] [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.853052] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.855412] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.859673] [001/133] (960s left) gem_exec_schedule (submit-early-slice)
[58.958056] Starting subtest: submit-early-slice
[58.960088] Starting dynamic subtest: rcs0
[59.027924] Dynamic subtest rcs0: SUCCESS (0.073s)
[59.038178] Starting dynamic subtest: bcs0
[59.089265] Dynamic subtest bcs0: SUCCESS (0.060s)
[59.098224] Starting dynamic subtest: vcs0
[59.145072] Dynamic subtest vcs0: SUCCESS (0.056s)
[59.151833] Starting dynamic subtest: vcs1
[59.197063] Dynamic subtest vcs1: SUCCESS (0.051s)
[59.204423] Starting dynamic subtest: vecs0
[59.245840] Dynamic subtest vecs0: SUCCESS (0.048s)
[59.252591] Starting dynamic subtest: ccs0
[59.300000] Dynamic subtest ccs0: SUCCESS (0.054s)
[59.302641] Subtest submit-early-slice: SUCCESS (0.345s)
[60.972581] [002/133] (958s left) api_intel_allocator (execbuf-with-allocator)
[61.026778] Starting subtest: execbuf-with-allocator
[61.032026] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[61.142691] [003/133] (958s left) gem_mmap_gtt (pf-nonblock)
[61.209347] Subtest pf-nonblock: SKIP (0.000s)
[61.269619] [004/133] (958s left) perf (per-context-mode-unprivileged)
[61.396061] Starting subtest: per-context-mode-unprivileged
[61.400297] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[61.437295] [005/133] (958s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[61.543154] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[61.545505] Starting dynamic subtest: pipe-A
[61.895609] Dynamic subtest pipe-A: SUCCESS (0.354s)
[61.904318] Starting dynamic subtest: pipe-B
[63.315500] Dynamic subtest pipe-B: SUCCESS (1.415s)
[63.323259] Starting dynamic subtest: pipe-C
[64.742680] Dynamic subtest pipe-C: SUCCESS (1.423s)
[64.751690] Starting dynamic subtest: pipe-D
[66.174375] Dynamic subtest pipe-D: SUCCESS (1.428s)
[66.176772] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.622s)
[67.356489] [006/133] (952s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[67.570788] Starting subtest: flip-vs-cursor-toggle
[76.386123] Subtest flip-vs-cursor-toggle: SUCCESS (8.807s)
[77.185207] [007/133] (942s left) syncobj_eventfd (invalid-illegal-handle)
[77.251514] Starting subtest: invalid-illegal-handle
[77.254077] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[77.357588] [008/133] (942s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[77.452727] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[77.456906] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[77.531130] [009/133] (942s left) gem_pxp (display-protected-crc)
[77.676206] Starting subtest: display-protected-crc
[79.321843] Subtest display-protected-crc: SUCCESS (1.646s)
[79.438604] [010/133] (940s left) sysfs_heartbeat_interval (idempotent)
[79.491742] Starting subtest: idempotent
[79.494029] Starting dynamic subtest: vecs0
[79.496312] Dynamic subtest vecs0: SUCCESS (0.001s)
[79.503639] Starting dynamic subtest: ccs0
[79.505650] Dynamic subtest ccs0: SUCCESS (0.001s)
[79.513692] Starting dynamic subtest: vcs0
[79.515981] Dynamic subtest vcs0: SUCCESS (0.000s)
[79.522699] Starting dynamic subtest: bcs0
[79.524796] Dynamic subtest bcs0: SUCCESS (0.000s)
[79.531562] Starting dynamic subtest: rcs0
[79.533710] Dynamic subtest rcs0: SUCCESS (0.000s)
[79.540114] Starting dynamic subtest: vcs1
[79.541966] Dynamic subtest vcs1: SUCCESS (0.000s)
[79.543813] Subtest idempotent: SUCCESS (0.005s)
[79.589907] [011/133] (940s left) gem_blits (basic)
[79.653199] Starting subtest: basic
[81.036684] Subtest basic: SUCCESS (1.382s)
[81.141199] [012/133] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[81.238196] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[81.242582] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[81.335897] [013/133] (938s left) vgem_basic (unload)
[81.372663] Starting subtest: unload
[110.431460] Subtest unload: SUCCESS (29.052s)
[110.550528] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[110.554183] [014/133] (909s left) gem_lmem_swapping (heavy-verify-random)
[110.598918] Subtest heavy-verify-random: SKIP (0.000s)
[110.646330] [015/133] (909s left) vgem_basic (create)
[110.691694] Starting subtest: create
[110.693778] Subtest create: SUCCESS (0.000s)
[110.746520] [016/133] (909s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[110.796668] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[110.852991] [017/133] (909s left) kms_pm_rpm (package-g7)
[113.085352] Starting subtest: package-g7
[113.090377] Subtest package-g7: SKIP (0.000s)
[113.470497] [018/133] (906s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[113.564635] Starting subtest: psr-dirtyfb-ioctl
[113.567105] Starting dynamic subtest: A-eDP-1
[117.460081] Dynamic subtest A-eDP-1: SUCCESS (3.895s)
[117.462383] Subtest psr-dirtyfb-ioctl: SUCCESS (3.896s)
[118.254899] [019/133] (901s left) gem_spin_batch (resubmit)
[118.326790] Starting subtest: resubmit
[118.329471] Starting dynamic subtest: rcs0
[118.334316] Dynamic subtest rcs0: SUCCESS (0.007s)
[118.349214] Starting dynamic subtest: bcs0
[118.351510] Dynamic subtest bcs0: SUCCESS (0.002s)
[118.363518] Starting dynamic subtest: vcs0
[118.365402] Dynamic subtest vcs0: SUCCESS (0.003s)
[118.372412] Starting dynamic subtest: vcs1
[118.374316] Dynamic subtest vcs1: SUCCESS (0.004s)
[118.382197] Starting dynamic subtest: vecs0
[118.384248] Dynamic subtest vecs0: SUCCESS (0.004s)
[118.391787] Starting dynamic subtest: ccs0
[118.393702] Dynamic subtest ccs0: SUCCESS (0.005s)
[118.395595] Subtest resubmit: SUCCESS (0.029s)
[118.575223] [020/133] (901s left) gem_exec_nop (basic-sequential)
[118.654350] Starting subtest: basic-sequential
[134.983657] Subtest basic-sequential: SUCCESS (16.339s)
[135.217195] [021/133] (884s left) kms_pm_dc (dc3co-vpb-simulation)
[136.324072] Starting subtest: dc3co-vpb-simulation
[144.927028] Subtest dc3co-vpb-simulation: SKIP (8.599s)
[145.054769] [022/133] (875s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[145.163261] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[145.167744] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[145.233244] [023/133] (874s left) gem_partial_pwrite_pread (writes-after-reads-display)
[145.301243] Subtest writes-after-reads-display: SKIP (0.000s)
[145.369118] [024/133] (874s left) kms_selftest (drm_cmdline_parser)
[145.406484] Starting subtest: drm_cmdline_parser
[145.416729] Starting dynamic subtest: drm_test_cmdline_force_d_only
[145.499464] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.082s)
[145.509071] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[145.595258] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.096s)
[145.604515] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[145.691279] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.095s)
[145.700198] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[145.798091] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.106s)
[145.807061] Starting dynamic subtest: drm_test_cmdline_force_e_only
[145.891258] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.093s)
[145.899412] Starting dynamic subtest: drm_test_cmdline_res
[145.973848] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.083s)
[145.985583] Starting dynamic subtest: drm_test_cmdline_res_vesa
[146.064077] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.090s)
[146.075182] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[146.152025] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.088s)
[146.163940] Starting dynamic subtest: drm_test_cmdline_res_rblank
[146.242313] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.091s)
[146.249102] Starting dynamic subtest: drm_test_cmdline_res_bpp
[146.332459] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.090s)
[146.339067] Starting dynamic subtest: drm_test_cmdline_res_refresh
[146.421285] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.088s)
[146.427977] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[146.525341] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.104s)
[146.532059] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[146.627211] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.102s)
[146.633890] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[146.721357] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.093s)
[146.728078] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[146.823260] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.101s)
[146.829842] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[146.930195] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.108s)
[146.937339] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[147.031403] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.100s)
[147.038332] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[147.125516] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.094s)
[147.132408] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[147.223222] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.097s)
[147.230308] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[147.312413] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.089s)
[147.319445] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[147.417257] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.103s)
[147.424204] Starting dynamic subtest: drm_test_cmdline_name
[147.521302] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.104s)
[147.528206] Starting dynamic subtest: drm_test_cmdline_name_bpp
[147.621286] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.099s)
[147.627978] Starting dynamic subtest: drm_test_cmdline_name_option
[147.702712] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.082s)
[147.709764] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[147.803730] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.099s)
[147.810773] Starting dynamic subtest: drm_test_cmdline_rotate_0
[147.906309] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.102s)
[147.913338] Starting dynamic subtest: drm_test_cmdline_rotate_90
[147.989397] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.083s)
[147.996449] Starting dynamic subtest: drm_test_cmdline_rotate_180
[148.073919] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.083s)
[148.081427] Starting dynamic subtest: drm_test_cmdline_rotate_270
[148.167317] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.093s)
[148.173965] Starting dynamic subtest: drm_test_cmdline_hmirror
[148.254040] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.086s)
[148.261022] Starting dynamic subtest: drm_test_cmdline_vmirror
[148.369557] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.114s)
[148.377345] Starting dynamic subtest: drm_test_cmdline_margin_options
[148.468345] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.099s)
[148.477645] Starting dynamic subtest: drm_test_cmdline_multiple_options
[148.559541] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.091s)
[148.567145] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[148.651780] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.092s)
[148.659118] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[148.748419] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.096s)
[148.757053] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[148.863364] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.112s)
[148.871776] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[148.953403] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.091s)
[148.961628] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[149.053656] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.100s)
[149.061244] Starting dynamic subtest: drm_test_cmdline_invalid
[149.179567] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.127s)
[149.186754] Starting dynamic subtest: drm_test_cmdline_tv_options
[149.297806] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.116s)
[149.299773] Subtest drm_cmdline_parser: SUCCESS (3.892s)
[149.469119] [025/133] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[149.580912] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[149.585043] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[149.661327] [026/133] (870s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[149.725073] Subtest no-spare-fences-busy: SKIP (0.000s)
[149.793752] [027/133] (870s left) gem_exec_fence (syncobj-invalid-wait)
[150.211410] Starting subtest: syncobj-invalid-wait
[150.214184] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[151.959654] [028/133] (868s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[152.062478] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[152.066704] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[152.152226] [029/133] (868s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[152.206717] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[152.208999] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[152.288917] [030/133] (868s left) kms_psr (psr2-sprite-mmap-gtt)
[152.379027] Starting subtest: psr2-sprite-mmap-gtt
[152.381292] Starting dynamic subtest: eDP-1
[153.768612] Dynamic subtest eDP-1: SKIP (1.386s)
[153.773426] Subtest psr2-sprite-mmap-gtt: SKIP (1.387s)
[153.922915] [031/133] (866s left) gem_ctx_shared (exec-single-timeline)
[153.987179] Starting subtest: exec-single-timeline
[153.989579] Starting dynamic subtest: rcs0
[155.057663] Dynamic subtest rcs0: SUCCESS (1.068s)
[155.069048] Starting dynamic subtest: bcs0
[156.147063] Dynamic subtest bcs0: SUCCESS (1.088s)
[156.156099] Starting dynamic subtest: vcs0
[157.234376] Dynamic subtest vcs0: SUCCESS (1.084s)
[157.245564] Starting dynamic subtest: vcs1
[158.322488] Dynamic subtest vcs1: SUCCESS (1.087s)
[158.334058] Starting dynamic subtest: vecs0
[159.409846] Dynamic subtest vecs0: SUCCESS (1.086s)
[159.420650] Starting dynamic subtest: ccs0
[160.498271] Dynamic subtest ccs0: SUCCESS (1.085s)
[160.500883] Subtest exec-single-timeline: SUCCESS (6.510s)
[160.740801] [032/133] (859s left) kms_psr (pr-sprite-plane-move)
[160.847050] Starting subtest: pr-sprite-plane-move
[160.851263] Subtest pr-sprite-plane-move: SKIP (0.000s)
[160.920993] [033/133] (859s left) gem_close_race (multigpu-basic-process)
[160.987961] Starting subtest: multigpu-basic-process
[160.992536] Subtest multigpu-basic-process: SKIP (0.000s)
[161.202689] [034/133] (859s left) kms_cursor_crc (cursor-onscreen-32x10)
[161.360760] Starting subtest: cursor-onscreen-32x10
[161.406161] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[161.674734] [035/133] (859s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[161.773833] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[161.778107] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[161.843690] [036/133] (858s left) kms_pipe_crc_basic (nonblocking-crc)
[161.938788] Starting subtest: nonblocking-crc
[161.941089] Starting dynamic subtest: pipe-A-eDP-1
[162.708315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[162.719888] Starting dynamic subtest: pipe-B-eDP-1
[164.120404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s)
[164.129396] Starting dynamic subtest: pipe-C-eDP-1
[165.491356] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[165.499653] Starting dynamic subtest: pipe-D-eDP-1
[166.864853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.371s)
[166.867236] Subtest nonblocking-crc: SUCCESS (4.927s)
[167.748216] [037/133] (853s left) perf (whitelisted-registers-userspace-config)
[167.849107] Starting subtest: whitelisted-registers-userspace-config
[167.851482] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[167.896247] [038/133] (852s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[168.039409] Starting subtest: dp-mst-type-1-suspend-resume
[168.043879] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[168.167521] [039/133] (852s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[168.301699] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[179.461073] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.160s)
[180.276494] [040/133] (840s left) kms_big_fb (linear-16bpp-rotate-270)
[180.395646] Starting subtest: linear-16bpp-rotate-270
[180.415080] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[180.542345] [041/133] (840s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[180.639103] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[180.643367] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.736929] [042/133] (840s left) perf_pmu (interrupts-sync)
[180.788626] Starting subtest: interrupts-sync
[181.856496] Subtest interrupts-sync: SUCCESS (1.073s)
[181.995600] [043/133] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[182.098226] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[188.881368] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.785s)
[189.018208] [044/133] (832s left) gem_reg_read (timestamp-moving)
[189.068840] Starting subtest: timestamp-moving
[190.070230] Subtest timestamp-moving: SUCCESS (1.001s)
[190.163511] [045/133] (830s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[190.275340] Starting subtest: 4-tiled-addfb-size-offset-overflow
[190.277125] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[190.389273] [046/133] (830s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[190.481120] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[190.483405] Starting dynamic subtest: pipe-A-default-mode
[191.662465] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[191.666636] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.180s)
[191.810987] [047/133] (829s left) gen9_exec_parse (basic-rejected-ctx-param)
[191.869082] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[191.942512] [048/133] (829s left) kms_atomic (plane-overlay-legacy)
[192.040041] Starting subtest: plane-overlay-legacy
[192.042360] Starting dynamic subtest: pipe-A-eDP-1
[192.460510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[192.462931] Subtest plane-overlay-legacy: SUCCESS (0.423s)
[193.251588] [049/133] (828s left) kms_cursor_crc (cursor-tearing-position-change)
[193.362174] Starting subtest: cursor-tearing-position-change
[193.364361] Starting dynamic subtest: pipe-A-eDP-1
[193.919065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[193.927670] Starting dynamic subtest: pipe-D-eDP-1
[195.178851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[195.181310] Subtest cursor-tearing-position-change: SUCCESS (1.819s)
[196.010482] [050/133] (825s left) gem_ctx_bad_destroy (invalid-default-ctx)
[196.062690] Starting subtest: invalid-default-ctx
[196.064932] Subtest invalid-default-ctx: SUCCESS (0.000s)
[196.147866] [051/133] (825s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[196.258756] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[196.261084] Starting dynamic subtest: pipe-A-eDP-1
[196.334873] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[196.345070] Starting dynamic subtest: pipe-B-eDP-1
[197.487336] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[197.491653] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.229s)
[198.683202] [052/133] (822s left) syncobj_timeline (wait-all-snapshot)
[198.736738] Starting subtest: wait-all-snapshot
[198.816774] Subtest wait-all-snapshot: SUCCESS (0.082s)
[198.892679] [053/133] (822s left) gem_tiling_max_stride
[199.029560] [054/133] (822s left) gem_mmap_gtt (basic-small-bo-tiledx)
[199.094744] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[199.147726] [055/133] (822s left) syncobj_basic (bad-destroy)
[199.204215] Starting subtest: bad-destroy
[199.206601] Subtest bad-destroy: SUCCESS (0.000s)
[199.313034] [056/133] (822s left) i915_pm_rps (reset)
[199.376807] Starting subtest: reset
[207.847405] Subtest reset: SUCCESS (8.469s)
[207.978660] [057/133] (813s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[208.083420] Starting subtest: pipe-fbc-rte
[208.090225] Starting dynamic subtest: pipe-B-eDP-1
[213.536225] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.455s)
[213.543925] Subtest pipe-fbc-rte: SUCCESS (5.458s)
[215.798288] [058/133] (805s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[215.858427] Starting subtest: multi-wait-for-submit-available-submitted
[215.860674] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[215.949757] [059/133] (805s left) prime_busy (hang-wait)
[216.000901] Starting subtest: hang-wait
[216.003686] Starting dynamic subtest: rcs0
[242.357052] Dynamic subtest rcs0: SUCCESS (26.351s)
[242.367056] Starting dynamic subtest: bcs0
[249.509283] Dynamic subtest bcs0: SUCCESS (7.148s)
[249.518941] Starting dynamic subtest: vcs0
[256.484055] Dynamic subtest vcs0: SUCCESS (6.973s)
[256.493644] Starting dynamic subtest: vcs1
[263.523376] Dynamic subtest vcs1: SUCCESS (7.036s)
[263.533206] Starting dynamic subtest: vecs0
[270.497039] Dynamic subtest vecs0: SUCCESS (6.971s)
[270.506657] Starting dynamic subtest: ccs0
[284.397114] Dynamic subtest ccs0: SUCCESS (13.896s)
[284.400123] Subtest hang-wait: SUCCESS (68.391s)
[284.536012] [060/133] (737s left) gem_exec_schedule (pi-distinct-iova)
[284.719510] Starting subtest: pi-distinct-iova
[284.721640] Starting dynamic subtest: rcs0
[284.852945] Dynamic subtest rcs0: SUCCESS (0.135s)
[284.864381] Starting dynamic subtest: vcs0
[284.946709] Dynamic subtest vcs0: SUCCESS (0.094s)
[284.958483] Starting dynamic subtest: vcs1
[285.046107] Dynamic subtest vcs1: SUCCESS (0.098s)
[285.056889] Starting dynamic subtest: vecs0
[285.133073] Dynamic subtest vecs0: SUCCESS (0.086s)
[285.145107] Starting dynamic subtest: ccs0
[285.251346] Dynamic subtest ccs0: SUCCESS (0.117s)
[285.253989] Subtest pi-distinct-iova: SUCCESS (0.534s)
[287.033092] [061/133] (734s left) kms_invalid_mode (bad-vtotal)
[287.137771] Starting subtest: bad-vtotal
[287.139927] Starting dynamic subtest: pipe-A-eDP-1
[287.429317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[287.439727] Starting dynamic subtest: pipe-B-eDP-1
[287.441671] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[287.449637] Starting dynamic subtest: pipe-C-eDP-1
[287.452032] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[287.460126] Starting dynamic subtest: pipe-D-eDP-1
[287.462382] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[287.464797] Subtest bad-vtotal: SUCCESS (0.300s)
[288.221393] [062/133] (733s left) prime_mmap_kms (buffer-sharing)
[288.320786] Starting subtest: buffer-sharing
[288.764935] Subtest buffer-sharing: SUCCESS (0.444s)
[289.562394] [063/133] (732s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[289.660282] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[293.276730] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.619s)
[294.481614] [064/133] (727s left) kms_flip (2x-nonexisting-fb)
[294.579044] Starting subtest: 2x-nonexisting-fb
[294.590960] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[294.670843] [065/133] (727s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[294.760333] Starting subtest: plane-lut1d-pre-ctm3x4
[294.951548] Starting dynamic subtest: pipe-A-plane-0
[295.118354] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[295.127133] Starting dynamic subtest: pipe-A-plane-1
[295.284830] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[295.293273] Starting dynamic subtest: pipe-A-plane-2
[295.473318] Dynamic subtest pipe-A-plane-2: SUCCESS (0.187s)
[296.701641] Starting dynamic subtest: pipe-B-plane-0
[296.883756] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[296.892876] Starting dynamic subtest: pipe-B-plane-1
[297.050337] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[297.058913] Starting dynamic subtest: pipe-B-plane-2
[297.205823] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[298.382747] Starting dynamic subtest: pipe-C-plane-0
[298.508953] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[298.517630] Starting dynamic subtest: pipe-C-plane-1
[298.664061] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[298.673039] Starting dynamic subtest: pipe-C-plane-2
[298.797580] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[300.035654] Starting dynamic subtest: pipe-D-plane-0
[300.172873] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[300.181494] Starting dynamic subtest: pipe-D-plane-1
[300.317246] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[300.326606] Starting dynamic subtest: pipe-D-plane-2
[300.485971] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[300.776317] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.017s)
[301.593098] [066/133] (720s left) gem_vm_create (invalid-destroy)
[301.654606] Starting subtest: invalid-destroy
[301.656808] Subtest invalid-destroy: SUCCESS (0.002s)
[301.758442] [067/133] (720s left) gem_ctx_isolation (dirty-switch)
[301.827564] Starting subtest: dirty-switch
[301.830020] Starting dynamic subtest: rcs0
[302.012995] Dynamic subtest rcs0: SUCCESS (0.185s)
[302.022167] Starting dynamic subtest: bcs0
[302.208348] Dynamic subtest bcs0: SUCCESS (0.194s)
[302.221800] Starting dynamic subtest: vcs0
[302.427174] Dynamic subtest vcs0: SUCCESS (0.218s)
[302.437688] Starting dynamic subtest: vcs1
[304.068125] Dynamic subtest vcs1: SUCCESS (1.640s)
[304.078494] Starting dynamic subtest: vecs0
[306.087668] Dynamic subtest vecs0: SUCCESS (2.018s)
[306.098759] Starting dynamic subtest: ccs0
[308.147408] Dynamic subtest ccs0: SUCCESS (2.058s)
[308.149832] Subtest dirty-switch: SUCCESS (6.320s)
[308.397983] [068/133] (713s left) kms_feature_discovery (psr1)
[308.491062] Starting subtest: psr1
[308.493324] Subtest psr1: SUCCESS (0.000s)
[308.561600] [069/133] (713s left) kms_vblank (query-forked-busy-hang)
[308.664204] Starting subtest: query-forked-busy-hang
[308.666069] Starting dynamic subtest: pipe-A-eDP-1
[334.692096] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.025s)
[334.706135] Starting dynamic subtest: pipe-D-eDP-1
[349.656218] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s)
[349.658488] Subtest query-forked-busy-hang: SUCCESS (40.993s)
[350.456756] [070/133] (671s left) gem_ctx_persistence (heartbeat-many)
[350.537193] Starting subtest: heartbeat-many
[350.541926] Subtest heartbeat-many: SKIP (0.000s)
[350.677740] [071/133] (671s left) gem_exec_balancer (full)
[350.748749] Starting subtest: full
[355.775808] Subtest full: SUCCESS (5.027s)
[356.096303] [072/133] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[356.189597] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[356.193811] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[356.280828] [073/133] (666s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[356.344050] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[356.348625] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[356.542212] [074/133] (665s left) kms_addfb_basic (unused-offsets)
[356.598193] Starting subtest: unused-offsets
[356.600145] Subtest unused-offsets: SUCCESS (0.000s)
[356.732687] [075/133] (665s left) vgem_basic (second-client)
[356.784731] Starting subtest: second-client
[356.803802] Subtest second-client: SUCCESS (0.022s)
[356.869140] [076/133] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[356.969625] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[356.973998] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[357.066071] [077/133] (665s left) kms_lease (lease-invalid-crtc)
[357.157318] Starting subtest: lease-invalid-crtc
[357.159602] Starting dynamic subtest: pipe-A-eDP-1
[357.161851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[357.169922] Starting dynamic subtest: pipe-B-eDP-1
[357.171837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[357.180147] Starting dynamic subtest: pipe-C-eDP-1
[357.182306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[357.190229] Starting dynamic subtest: pipe-D-eDP-1
[357.192097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[357.193995] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[357.234726] [078/133] (665s left) dmabuf_sync_file (export-before-signal)
[357.277538] Starting subtest: export-before-signal
[357.279672] Subtest export-before-signal: SUCCESS (0.001s)
[357.332216] [079/133] (665s left) kms_getfb (getfb2-handle-closed)
[357.418993] Starting subtest: getfb2-handle-closed
[357.421287] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[357.516334] [080/133] (665s left) api_intel_bb (intel-bb-blit-y)
[357.578467] Starting subtest: intel-bb-blit-y
[361.682543] Subtest intel-bb-blit-y: SUCCESS (4.102s)
[361.805397] [081/133] (660s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[361.902517] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[361.906671] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[362.004684] [082/133] (660s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[362.138095] Starting subtest: 2x-long-flip-vs-cursor-legacy
[362.145411] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[362.290285] [083/133] (660s left) kms_chamelium_color (ctm-blue-to-red)
[362.389168] Subtest ctm-blue-to-red: SKIP (0.000s)
[362.434813] [084/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[362.531560] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[362.535645] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[362.634338] [085/133] (660s left) i915_drm_fdinfo (virtual-busy-hang-all)
[362.674250] Starting subtest: virtual-busy-hang-all
[362.678575] Subtest virtual-busy-hang-all: SKIP (0.000s)
[362.745701] [086/133] (660s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[362.790709] Starting subtest: single-wait-for-submit-unsubmitted
[362.897305] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[362.975449] [087/133] (659s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[363.096633] Starting subtest: psr2-overlay-plane-update-continuous-sf
[363.098956] Starting dynamic subtest: pipe-A-eDP-1
[364.219953] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.126s)
[364.229420] Starting dynamic subtest: pipe-B-eDP-1
[366.019634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.799s)
[366.021597] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.927s)
[366.828899] [088/133] (656s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[366.934244] Starting subtest: x-tiled-16bpp-rotate-90
[366.953898] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[367.064994] [089/133] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[367.161901] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[367.166062] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[367.248767] [090/133] (655s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[367.348061] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[367.352575] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[367.446653] [091/133] (655s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[367.544778] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[367.547077] Starting dynamic subtest: pipe-A-eDP-1
[367.567496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[367.577771] Starting dynamic subtest: pipe-B-eDP-1
[367.597240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[367.605506] Starting dynamic subtest: pipe-C-eDP-1
[367.624943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[367.634869] Starting dynamic subtest: pipe-D-eDP-1
[367.654591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[367.656822] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[369.784434] [092/133] (653s left) kms_psr (fbc-psr-primary-mmap-cpu)
[369.887223] Starting subtest: fbc-psr-primary-mmap-cpu
[369.889528] Starting dynamic subtest: eDP-1
[369.893764] Dynamic subtest eDP-1: SKIP (0.000s)
[369.897720] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.002s)
[369.962412] [093/133] (653s left) perf_pmu (busy-idle-no-semaphores)
[370.005795] Starting subtest: busy-idle-no-semaphores
[370.008153] Starting dynamic subtest: rcs0
[370.657898] Dynamic subtest rcs0: SUCCESS (0.652s)
[370.670029] Starting dynamic subtest: bcs0
[371.309874] Dynamic subtest bcs0: SUCCESS (0.649s)
[371.320766] Starting dynamic subtest: vcs0
[371.961496] Dynamic subtest vcs0: SUCCESS (0.649s)
[371.973408] Starting dynamic subtest: vcs1
[373.500375] Dynamic subtest vcs1: SUCCESS (1.536s)
[373.513702] Starting dynamic subtest: vecs0
[375.551227] Dynamic subtest vecs0: SUCCESS (2.049s)
[375.563324] Starting dynamic subtest: ccs0
[377.532578] Dynamic subtest ccs0: SUCCESS (1.978s)
[377.535418] Subtest busy-idle-no-semaphores: SUCCESS (7.529s)
[377.663817] [094/133] (645s left) gem_exec_whisper (basic-contexts-priority-all)
[377.743615] Starting subtest: basic-contexts-priority-all
[402.043216] Subtest basic-contexts-priority-all: SUCCESS (24.294s)
[402.226208] [095/133] (620s left) i915_drm_fdinfo (context-close-stress)
[402.269253] Starting subtest: context-close-stress
[413.015135] Subtest context-close-stress: SUCCESS (10.744s)
[413.096092] [096/133] (610s left) i915_query (query-topology-garbage-items)
[413.261783] Starting subtest: query-topology-garbage-items
[413.263995] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[413.351265] [097/133] (609s left) gem_softpin (evict-snoop)
[413.400840] Starting subtest: evict-snoop
[413.405351] Subtest evict-snoop: SKIP (0.000s)
[413.513795] [098/133] (609s left) gem_exec_params (mmapped)
[413.558912] Starting subtest: mmapped
[413.564318] Subtest mmapped: SUCCESS (0.003s)
[413.673792] [099/133] (609s left) prime_vgem (fence-flip-hang)
[413.742305] Subtest fence-flip-hang: SKIP (0.000s)
[413.831423] [100/133] (609s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[413.923844] Starting subtest: basic-modeset-with-all-modifiers-formats
[414.310143] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[415.068335] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.758s)
[415.082194] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[415.090207] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[415.099276] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[415.112259] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[415.123215] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[415.268364] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[415.278631] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[415.290399] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[415.298986] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[415.312727] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[415.327547] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[415.334717] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.020s)
[415.343565] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[415.357068] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[415.365557] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[415.378877] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[415.388361] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[415.400997] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[415.410509] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[415.423892] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[415.440055] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[415.445742] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[415.454601] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[415.612555] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[415.622277] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[415.634729] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[415.643377] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[415.657016] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[415.665619] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[415.679488] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[415.688113] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[415.701289] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[415.710131] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[415.723614] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[415.732499] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[415.745938] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[415.758285] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[415.768105] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[415.777814] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[415.790554] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[415.799465] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[415.957053] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[415.966161] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[415.979230] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[415.988738] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[416.001498] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[416.012298] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[416.023646] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[416.034249] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[416.046015] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.020s)
[416.054058] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[416.068132] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[416.076702] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[416.090308] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[416.098905] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[416.112529] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[416.122791] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[416.134855] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[416.536807] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.614s)
[417.356062] [101/133] (606s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[417.455893] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[417.467700] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[417.544311] [102/133] (605s left) kms_flip (2x-plain-flip-ts-check)
[417.637967] Starting subtest: 2x-plain-flip-ts-check
[417.647353] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[417.749522] [103/133] (605s left) gem_exec_create (legacy)
[417.816735] Starting subtest: legacy
[417.819092] Starting dynamic subtest: smem
[421.844644] Dynamic subtest smem: SUCCESS (4.025s)
[421.847627] Subtest legacy: SUCCESS (4.027s)
[422.043587] [104/133] (601s left) kms_cursor_crc (cursor-random-max-size)
[422.393296] Starting subtest: cursor-random-max-size
[422.400073] Subtest cursor-random-max-size: SKIP (0.000s)
[422.512276] [105/133] (601s left) gem_userptr_blits (map-fixed-invalidate-busy)
[422.574065] Starting subtest: map-fixed-invalidate-busy
[422.578720] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[422.724038] [106/133] (600s left) template (a)
[422.776539] Starting subtest: A
[422.778933] Subtest A: SUCCESS (0.000s)
[422.871773] [107/133] (600s left) kms_atomic_transition (plane-all-transition-fencing)
[422.958422] Starting subtest: plane-all-transition-fencing
[422.960618] Starting dynamic subtest: pipe-A-eDP-1
[425.455888] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[425.771854] Starting dynamic subtest: pipe-B-eDP-1
[428.991776] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.234s)
[429.289469] Subtest plane-all-transition-fencing: SUCCESS (6.331s)
[430.122880] [108/133] (593s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[430.209863] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[430.223476] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[430.296572] [109/133] (593s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[430.393308] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[430.397608] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[430.465740] [110/133] (593s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[430.564204] Starting subtest: plane-upscale-20x20-with-modifiers
[430.566478] Starting dynamic subtest: pipe-A
[430.899289] Dynamic subtest pipe-A: SUCCESS (0.338s)
[430.910117] Starting dynamic subtest: pipe-B
[432.317160] Dynamic subtest pipe-B: SUCCESS (1.417s)
[432.326283] Starting dynamic subtest: pipe-C
[433.740613] Dynamic subtest pipe-C: SUCCESS (1.422s)
[433.750402] Starting dynamic subtest: pipe-D
[435.181191] Dynamic subtest pipe-D: SUCCESS (1.439s)
[435.184047] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.621s)
[436.364501] [111/133] (587s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[436.466790] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[437.291702] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[437.466591] [112/133] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[437.557520] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[444.374162] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.818s)
[444.488986] [113/133] (579s left) kms_vrr (lobf)
[444.580806] Starting subtest: lobf
[444.585167] Subtest lobf: SKIP (0.000s)
[444.653647] [114/133] (579s left) kms_rotation_crc (exhaust-fences)
[444.740904] Starting subtest: exhaust-fences
[444.745399] Subtest exhaust-fences: SKIP (0.000s)
[444.814238] [115/133] (579s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[444.914221] Starting subtest: psr-rgb101010-draw-mmap-wc
[452.003934] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.092s)
[452.134336] [116/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[452.229595] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[459.643064] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.417s)
[459.801683] [117/133] (564s left) syncobj_basic (create-signaled)
[459.868719] Starting subtest: create-signaled
[459.871046] Subtest create-signaled: SUCCESS (0.000s)
[459.975677] [118/133] (564s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[460.044234] Starting subtest: etime-multi-wait-available-unsubmitted
[460.143075] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.101s)
[460.222889] [119/133] (563s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[460.307945] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[460.312211] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[461.394276] [120/133] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[461.488510] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[468.315294] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.829s)
[468.441353] [121/133] (555s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[468.544775] Starting subtest: crc-primary-basic-y-tiled-ccs
[468.547100] Starting dynamic subtest: pipe-A-eDP-1
[468.569787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[468.579953] Starting dynamic subtest: pipe-B-eDP-1
[468.601569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.610296] Starting dynamic subtest: pipe-C-eDP-1
[468.632713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.642596] Starting dynamic subtest: pipe-D-eDP-1
[468.664220] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.668220] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[470.776371] [122/133] (553s left) gem_readwrite (read-write)
[470.832282] Subtest read-write: SKIP (0.000s)
[470.894128] [123/133] (553s left) kms_psr (psr-primary-page-flip)
[470.976393] Starting subtest: psr-primary-page-flip
[470.978576] Starting dynamic subtest: eDP-1
[472.683464] Dynamic subtest eDP-1: SUCCESS (1.706s)
[472.685814] Subtest psr-primary-page-flip: SUCCESS (1.707s)
[473.533809] [124/133] (550s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[473.634628] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[473.636800] Starting dynamic subtest: pipe-A-eDP-1
[473.658628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.667557] Starting dynamic subtest: pipe-B-eDP-1
[473.688067] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.696364] Starting dynamic subtest: pipe-C-eDP-1
[473.716905] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.724815] Starting dynamic subtest: pipe-D-eDP-1
[473.746375] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.750660] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[475.894992] [125/133] (548s left) kms_chamelium_hpd (hdmi-hpd-fast)
[476.277419] Subtest hdmi-hpd-fast: SKIP (0.000s)
[477.125780] [126/133] (547s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[477.224946] Starting subtest: fbcpsr-rgb565-draw-pwrite
[484.232387] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.012s)
[484.359768] [127/133] (540s left) kms_psr (fbc-psr2-cursor-blt)
[484.451893] Starting subtest: fbc-psr2-cursor-blt
[484.454211] Starting dynamic subtest: eDP-1
[484.458253] Dynamic subtest eDP-1: SKIP (0.000s)
[484.462299] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[484.538928] [128/133] (540s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[484.646100] Starting subtest: verify-pxp-key-change-after-suspend-resume
[492.675324] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.031s)
[492.813780] [129/133] (531s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[492.932928] Starting subtest: y-tiled-16bpp-rotate-180
[492.937413] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[493.048723] [130/133] (531s left) syncobj_wait (single-wait-all-signaled)
[493.099449] Starting subtest: single-wait-all-signaled
[493.102163] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[493.209656] [131/133] (531s left) kms_chamelium_frames (dp-frame-dump)
[493.575800] Subtest dp-frame-dump: SKIP (0.000s)
[494.365838] [132/133] (530s left) kms_rotation_crc (primary-rotation-180)
[494.466726] Starting subtest: primary-rotation-180
[501.557560] Subtest primary-rotation-180: SUCCESS (7.092s)
[502.748655] [133/133] (522s left) kms_plane_lowres (tiling-yf)
[502.836474] Starting subtest: tiling-yf
[502.840851] Subtest tiling-yf: SKIP (0.000s)
[502.911029] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: api_intel_allocator
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: syncobj_eventfd
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: sysfs_heartbeat_interval
results: parsing output: 10/ for test: gem_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_dirtyfb
results: parsing output: 18/ for test: gem_spin_batch
results: parsing output: 19/ for test: gem_exec_nop
results: parsing output: 20/ for test: kms_pm_dc
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_selftest
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fenced_exec_thrash
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_close_race
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_content_protection
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: perf_pmu
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_reg_read
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_ctx_bad_destroy
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_tiling_max_stride
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: i915_pm_rps
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: prime_busy
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: prime_mmap_kms
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_color_pipeline
results: parsing output: 65/ for test: gem_vm_create
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_feature_discovery
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: kms_getfb
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_chamelium_color
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: i915_query
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_exec_create
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: template
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_vrr
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_readwrite
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_chamelium_frames
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: kms_plane_lowres
Done.