[56.071457] Initializing watchdogs
[56.071523]   /dev/watchdog0
[56.091525] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.095413] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.097467] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.100754] [001/155] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[56.204472] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[56.206840] Starting dynamic subtest: pipe-A-eDP-1
[57.090031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.879s)
[57.097061] Starting dynamic subtest: pipe-B-eDP-1
[58.712774] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.620s)
[58.722227] Starting dynamic subtest: pipe-C-eDP-1
[60.246405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[60.255969] Starting dynamic subtest: pipe-D-eDP-1
[61.771074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[61.773294] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.557s)
[63.233559] [002/155] (953s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[63.312688] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[63.317150] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[63.378835] [003/155] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[63.457672] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[63.461994] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[63.558350] [004/155] (953s left) api_intel_allocator (open-vm)
[63.612978] Starting subtest: open-vm
[63.617712] Subtest open-vm: SUCCESS (0.007s)
[63.732023] [005/155] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[63.805851] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[63.810374] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.907020] [006/155] (952s left) gem_ctx_bad_destroy (double-destroy)
[63.965169] Starting subtest: double-destroy
[63.967479] Subtest double-destroy: SUCCESS (0.000s)
[64.038553] [007/155] (952s left) kms_selftest (drm_cmdline_parser)
[64.071252] Starting subtest: drm_cmdline_parser
[64.083618] Starting dynamic subtest: drm_test_cmdline_force_d_only
[64.178899] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.095s)
[64.186881] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[64.264938] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.086s)
[64.272158] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[64.362510] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.098s)
[64.369741] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[64.444621] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.081s)
[64.451841] Starting dynamic subtest: drm_test_cmdline_force_e_only
[64.525623] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.081s)
[64.532636] Starting dynamic subtest: drm_test_cmdline_res
[64.615340] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.089s)
[64.622079] Starting dynamic subtest: drm_test_cmdline_res_vesa
[64.712928] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.097s)
[64.720947] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[64.817559] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.103s)
[64.824609] Starting dynamic subtest: drm_test_cmdline_res_rblank
[64.913164] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.096s)
[64.922757] Starting dynamic subtest: drm_test_cmdline_res_bpp
[64.999722] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.086s)
[65.007291] Starting dynamic subtest: drm_test_cmdline_res_refresh
[65.098938] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.099s)
[65.107119] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[65.199530] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.100s)
[65.206546] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[65.285803] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.086s)
[65.293796] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[65.373679] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.087s)
[65.383135] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[65.475841] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.101s)
[65.485378] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[65.562496] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.087s)
[65.569601] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[65.646983] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.084s)
[65.656055] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[65.738429] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.091s)
[65.745659] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[65.833818] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.094s)
[65.842951] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[65.925743] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[65.934604] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[66.016190] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.089s)
[66.023136] Starting dynamic subtest: drm_test_cmdline_name
[66.103662] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.088s)
[66.112929] Starting dynamic subtest: drm_test_cmdline_name_bpp
[66.199723] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.096s)
[66.208857] Starting dynamic subtest: drm_test_cmdline_name_option
[66.279902] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.080s)
[66.288664] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[66.383718] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.102s)
[66.393369] Starting dynamic subtest: drm_test_cmdline_rotate_0
[66.479667] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.096s)
[66.488704] Starting dynamic subtest: drm_test_cmdline_rotate_90
[66.579945] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.099s)
[66.589268] Starting dynamic subtest: drm_test_cmdline_rotate_180
[66.676779] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.097s)
[66.685792] Starting dynamic subtest: drm_test_cmdline_rotate_270
[66.800810] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.124s)
[66.809984] Starting dynamic subtest: drm_test_cmdline_hmirror
[66.897756] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.097s)
[66.906979] Starting dynamic subtest: drm_test_cmdline_vmirror
[67.000614] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s)
[67.011762] Starting dynamic subtest: drm_test_cmdline_margin_options
[67.093903] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.094s)
[67.103056] Starting dynamic subtest: drm_test_cmdline_multiple_options
[67.196707] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.102s)
[67.203792] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[67.305718] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.108s)
[67.313615] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[67.403828] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.098s)
[67.411737] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[67.494844] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.090s)
[67.503028] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[67.586329] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.093s)
[67.593548] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[67.678863] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.092s)
[67.687471] Starting dynamic subtest: drm_test_cmdline_invalid
[67.794185] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.114s)
[67.801311] Starting dynamic subtest: drm_test_cmdline_tv_options
[67.889727] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.094s)
[67.891794] Subtest drm_cmdline_parser: SUCCESS (3.816s)
[68.071920] [008/155] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[68.166299] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[72.615477] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.455s)
[73.752950] [009/155] (943s left) kms_pipe_stress (stress-xrgb8888-untiled)
[73.832591] Starting subtest: stress-xrgb8888-untiled
[79.657899] Subtest stress-xrgb8888-untiled: SUCCESS (5.824s)
[79.701151] [010/155] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[79.783708] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[79.787237] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[79.877505] [011/155] (937s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[79.946051] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[79.949402] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[80.028952] [012/155] (936s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[80.126584] Starting subtest: cursorB-vs-flipA-toggle
[80.130340] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[80.277676] [013/155] (936s left) gem_vm_create (create-ext)
[80.335196] Starting subtest: create-ext
[80.340220] Subtest create-ext: SUCCESS (0.004s)
[80.464426] [014/155] (936s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[80.551822] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[80.555568] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[80.650744] [015/155] (936s left) kms_vblank (wait-busy)
[80.723657] Starting subtest: wait-busy
[80.725625] Starting dynamic subtest: pipe-A-eDP-1
[82.616081] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[82.629998] Starting dynamic subtest: pipe-D-eDP-1
[85.229393] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[85.231702] Subtest wait-busy: SUCCESS (4.505s)
[86.044705] [016/155] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[86.132792] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[89.702876] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.577s)
[90.856455] [017/155] (926s left) kms_plane (planar-pixel-format-settings)
[90.929285] Starting subtest: planar-pixel-format-settings
[91.004428] Subtest planar-pixel-format-settings: SUCCESS (0.073s)
[91.115834] [018/155] (926s left) gem_mmap_gtt (bad-object)
[91.171979] Subtest bad-object: SKIP (0.000s)
[91.232672] [019/155] (926s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[91.362678] Starting subtest: protected-encrypted-src-copy-not-readible
[91.513513] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.152s)
[91.638422] [020/155] (925s left) kms_chamelium_audio (hdmi-audio)
[91.987875] Subtest hdmi-audio: SKIP (0.000s)
[92.859051] [021/155] (924s left) kms_psr (fbc-psr2-sprite-plane-move)
[92.938988] Starting subtest: fbc-psr2-sprite-plane-move
[92.941548] Starting dynamic subtest: eDP-1
[92.945946] Dynamic subtest eDP-1: SKIP (0.000s)
[92.950306] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[93.010822] [022/155] (924s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[93.094439] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[93.098533] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[93.183527] [023/155] (924s left) gem_ctx_param (invalid-get-no-zeromap)
[93.239962] Starting subtest: invalid-get-no-zeromap
[93.242466] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[93.339310] [024/155] (924s left) kms_chamelium_hpd (hdmi-hpd-storm)
[93.696189] Subtest hdmi-hpd-storm: SKIP (0.000s)
[94.489473] [025/155] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[94.572438] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[98.498365] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.933s)
[99.715020] [026/155] (917s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[99.795208] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[100.873662] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.078s)
[101.005106] [027/155] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[101.086774] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[101.090379] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[101.177889] [028/155] (916s left) perf (invalid-create-userspace-config)
[101.286295] Starting subtest: invalid-create-userspace-config
[101.288116] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[101.329934] [029/155] (916s left) gem_bad_reloc (negative-reloc-bltcopy)
[101.383229] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[101.451933] [030/155] (916s left) syncobj_wait (wait-all-complex)
[101.503290] Starting subtest: wait-all-complex
[101.717035] Subtest wait-all-complex: SUCCESS (0.213s)
[101.787851] [031/155] (915s left) kms_flip (modeset-vs-vblank-race-interruptible)
[101.860241] Starting subtest: modeset-vs-vblank-race-interruptible
[101.862425] Starting dynamic subtest: A-eDP1
[106.537400] Dynamic subtest A-eDP1: SUCCESS (4.676s)
[106.547640] Starting dynamic subtest: B-eDP1
[111.272093] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[111.284417] Starting dynamic subtest: C-eDP1
[115.976571] Dynamic subtest C-eDP1: SUCCESS (4.702s)
[115.986973] Starting dynamic subtest: D-eDP1
[120.615433] Dynamic subtest D-eDP1: SUCCESS (4.637s)
[120.617918] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.757s)
[121.764830] [032/155] (895s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[121.850456] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[121.854725] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[121.948545] [033/155] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[122.033242] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[122.037394] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[122.136434] [034/155] (895s left) i915_pm_rpm (gem-pread)
[124.341854] Starting subtest: gem-pread
[126.125940] Subtest gem-pread: SUCCESS (1.787s)
[126.210301] [035/155] (891s left) kms_pm_rpm (modeset-non-lpsp)
[128.419893] Starting subtest: modeset-non-lpsp
[129.565111] Subtest modeset-non-lpsp: SKIP (1.146s)
[129.931229] [036/155] (887s left) gem_caching (reads)
[129.995330] Subtest reads: SKIP (0.000s)
[130.062332] [037/155] (887s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[130.149619] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[130.153636] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[130.260826] [038/155] (887s left) kms_selftest (drm_plane_helper)
[130.299072] Starting subtest: drm_plane_helper
[130.339861] Starting dynamic subtest: drm_test_check_plane_state
[130.430223] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.091s)
[130.441233] Starting dynamic subtest: drm_test_check_invalid_plane_state
[130.522014] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.090s)
[130.524479] Subtest drm_plane_helper: SUCCESS (0.223s)
[130.661426] [039/155] (887s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[130.730770] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[130.732889] Starting dynamic subtest: pipe-A
[130.752528] Dynamic subtest pipe-A: SKIP (0.017s)
[130.761542] Starting dynamic subtest: pipe-B
[130.784270] Dynamic subtest pipe-B: SKIP (0.031s)
[130.792692] Starting dynamic subtest: pipe-C
[130.815148] Dynamic subtest pipe-C: SKIP (0.031s)
[130.823535] Starting dynamic subtest: pipe-D
[130.846846] Dynamic subtest pipe-D: SKIP (0.032s)
[130.851154] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s)
[130.948187] [040/155] (887s left) gem_userptr_blits (sync-unmap-after-close)
[131.008041] Starting subtest: sync-unmap-after-close
[131.022089] Subtest sync-unmap-after-close: SUCCESS (0.015s)
[131.125941] [041/155] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[131.210434] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[131.213792] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[131.324107] [042/155] (886s left) prime_mmap_coherency (write)
[131.370444] Starting subtest: write
[136.746489] Subtest write: SUCCESS (5.373s)
[136.879252] [043/155] (881s left) kms_invalid_mode (zero-clock)
[136.959094] Starting subtest: zero-clock
[136.961221] Starting dynamic subtest: pipe-A-eDP-1
[137.253584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[137.263580] Starting dynamic subtest: pipe-B-eDP-1
[137.265711] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[137.274142] Starting dynamic subtest: pipe-C-eDP-1
[137.276030] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[137.284015] Starting dynamic subtest: pipe-D-eDP-1
[137.285876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[137.287768] Subtest zero-clock: SUCCESS (0.301s)
[138.069081] [044/155] (880s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[138.151828] Starting subtest: 4-tiled-16bpp-rotate-180
[139.418517] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.267s)
[139.540602] [045/155] (878s left) gem_exec_schedule (preempt-engines)
[139.609101] Starting subtest: preempt-engines
[139.610999] Starting dynamic subtest: rcs0
[141.858428] Dynamic subtest rcs0: SUCCESS (2.237s)
[141.874463] Starting dynamic subtest: bcs0
[144.075772] Dynamic subtest bcs0: SUCCESS (2.229s)
[144.087629] Starting dynamic subtest: vcs0
[146.334568] Dynamic subtest vcs0: SUCCESS (2.256s)
[146.343285] Starting dynamic subtest: vcs1
[148.601158] Dynamic subtest vcs1: SUCCESS (2.265s)
[148.611772] Starting dynamic subtest: vecs0
[150.853070] Dynamic subtest vecs0: SUCCESS (2.249s)
[150.863985] Starting dynamic subtest: ccs0
[153.148768] Dynamic subtest ccs0: SUCCESS (2.293s)
[153.151948] Subtest preempt-engines: SUCCESS (13.542s)
[153.451557] [046/155] (864s left) kms_display_modes (extended-mode-basic)
[153.520285] Starting subtest: extended-mode-basic
[153.524555] Subtest extended-mode-basic: SKIP (0.000s)
[153.564575] [047/155] (864s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[153.648231] Starting subtest: psrhdr-rgb565-draw-blt
[153.652198] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[153.742700] [048/155] (864s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[153.823514] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[153.828066] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[153.912174] [049/155] (864s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[153.968465] Starting subtest: multi-wait-all-for-submit-available-submitted
[153.970783] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[154.053959] [050/155] (864s left) gem_ctx_param (invalid-param-get)
[154.100860] Starting subtest: invalid-param-get
[154.103312] Subtest invalid-param-get: SUCCESS (0.001s)
[154.201511] [051/155] (864s left) i915_suspend (basic-s3-without-i915)
[154.237484] Starting subtest: basic-s3-without-i915
[157.540221] Subtest basic-s3-without-i915: SKIP (3.300s)
[159.059303] [052/155] (859s left) i915_query (query-topology-coherent-slice-mask)
[159.125418] Starting subtest: query-topology-coherent-slice-mask
[159.129520] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[159.247412] [053/155] (859s left) dmabuf_sync_file (import-multiple-read-write)
[159.312081] Starting subtest: import-multiple-read-write
[159.314252] Subtest import-multiple-read-write: SUCCESS (0.002s)
[159.361978] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[159.365448] [054/155] (859s left) syncobj_wait (multi-wait-all-submitted-signaled)
[159.425749] Starting subtest: multi-wait-all-submitted-signaled
[159.530277] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[159.603055] [055/155] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[159.695969] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[159.699959] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[159.800787] [056/155] (858s left) gem_softpin (full)
[159.867659] Starting subtest: full
[159.876408] Subtest full: SUCCESS (0.009s)
[160.010128] [057/155] (858s left) kms_flip (flip-vs-rmfb)
[160.087403] Starting subtest: flip-vs-rmfb
[160.089764] Starting dynamic subtest: A-eDP1
[168.779946] Dynamic subtest A-eDP1: SUCCESS (8.694s)
[168.788719] Starting dynamic subtest: B-eDP1
[177.415930] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[177.433280] Starting dynamic subtest: C-eDP1
[186.027031] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[186.039087] Starting dynamic subtest: D-eDP1
[194.668795] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[194.673571] Subtest flip-vs-rmfb: SUCCESS (34.586s)
[195.845717] [058/155] (822s left) kms_flip (wf_vblank-ts-check)
[195.932164] Starting subtest: wf_vblank-ts-check
[195.934888] Starting dynamic subtest: A-eDP1
[204.887038] Dynamic subtest A-eDP1: SUCCESS (8.957s)
[204.900607] Starting dynamic subtest: B-eDP1
[213.816123] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[213.824860] Starting dynamic subtest: C-eDP1
[222.734644] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[222.744214] Starting dynamic subtest: D-eDP1
[231.662175] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[231.664497] Subtest wf_vblank-ts-check: SUCCESS (35.734s)
[232.884650] [059/155] (785s left) kms_flip (bo-too-big-interruptible)
[232.959953] Starting subtest: bo-too-big-interruptible
[232.962151] Starting dynamic subtest: A-eDP1
[234.231549] Dynamic subtest A-eDP1: SUCCESS (1.270s)
[234.244633] Starting dynamic subtest: B-eDP1
[235.479541] Dynamic subtest B-eDP1: SUCCESS (1.245s)
[235.489055] Starting dynamic subtest: C-eDP1
[236.802637] Dynamic subtest C-eDP1: SUCCESS (1.321s)
[236.811275] Starting dynamic subtest: D-eDP1
[238.049778] Dynamic subtest D-eDP1: SUCCESS (1.245s)
[238.056574] Subtest bo-too-big-interruptible: SUCCESS (5.094s)
[239.263654] [060/155] (779s left) sysfs_preempt_timeout (timeout)
[239.315728] Starting subtest: timeout
[239.318089] Starting dynamic subtest: vecs0
[249.211616] Dynamic subtest vecs0: SUCCESS (9.891s)
[249.228815] Starting dynamic subtest: ccs0
[250.393151] Dynamic subtest ccs0: SUCCESS (1.182s)
[250.401744] Starting dynamic subtest: vcs0
[260.216229] Dynamic subtest vcs0: SUCCESS (9.819s)
[260.224425] Starting dynamic subtest: bcs0
[261.431268] Dynamic subtest bcs0: SUCCESS (1.215s)
[261.441132] Starting dynamic subtest: rcs0
[262.652721] Dynamic subtest rcs0: SUCCESS (1.220s)
[262.661036] Starting dynamic subtest: vcs1
[272.248360] Dynamic subtest vcs1: SUCCESS (9.591s)
[272.250909] Subtest timeout: SUCCESS (32.930s)
[272.322480] [061/155] (746s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[272.404238] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[272.408327] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[272.500803] [062/155] (746s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[272.578161] Starting subtest: y-tiled-64bpp-rotate-270
[272.582583] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[272.686474] [063/155] (746s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[272.766092] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[272.768396] Starting dynamic subtest: pipe-A-eDP-1
[272.792073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.803600] Starting dynamic subtest: pipe-B-eDP-1
[272.825348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.833798] Starting dynamic subtest: pipe-C-eDP-1
[272.855829] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.863836] Starting dynamic subtest: pipe-D-eDP-1
[272.886097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.890218] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[275.043800] [064/155] (743s left) gem_linear_blits (basic)
[275.483062] Starting subtest: basic
[275.488145] Subtest basic: SUCCESS (0.007s)
[275.637113] [065/155] (743s left) gem_ctx_bad_destroy (invalid-pad)
[275.726893] Starting subtest: invalid-pad
[275.729844] Subtest invalid-pad: SUCCESS (0.000s)
[275.809828] [066/155] (743s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[275.903681] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[275.907950] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[275.968534] [067/155] (743s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[276.054618] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[276.056970] Starting dynamic subtest: pipe-A-eDP-1
[276.152163] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[276.160900] Starting dynamic subtest: pipe-B-eDP-1
[277.318378] Dynamic subtest pipe-B-eDP-1: SKIP (1.164s)
[277.322895] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.269s)
[278.592863] [068/155] (740s left) gem_create (create-size-update)
[278.646680] Starting subtest: create-size-update
[278.648672] Subtest create-size-update: SUCCESS (0.000s)
[278.855373] [069/155] (740s left) kms_lease (multimaster-lease)
[278.923781] Starting subtest: multimaster-lease
[278.926094] Subtest multimaster-lease: SUCCESS (0.003s)
[279.033882] [070/155] (740s left) gem_reg_read (timestamp-monotonic)
[279.085877] Starting subtest: timestamp-monotonic
[283.440450] Subtest timestamp-monotonic: SUCCESS (4.353s)
[283.517501] [071/155] (735s left) gem_exec_reloc (basic-concurrent16)
[283.574804] Subtest basic-concurrent16: SKIP (0.000s)
[283.653150] [072/155] (735s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[283.740590] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[283.745089] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[283.852200] [073/155] (735s left) kms_psr (pr-primary-render)
[283.933920] Starting subtest: pr-primary-render
[283.938211] Subtest pr-primary-render: SKIP (0.000s)
[284.011072] [074/155] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[284.105350] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[290.716876] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.616s)
[290.850179] [075/155] (728s left) gem_close_race (basic-process)
[290.914784] Starting subtest: basic-process
[290.981466] Subtest basic-process: SUCCESS (0.066s)
[291.163908] [076/155] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[291.240611] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[298.582384] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.348s)
[298.703877] [077/155] (720s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[298.782282] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[298.784259] Starting dynamic subtest: pipe-A-eDP-1
[299.665146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[299.674523] Starting dynamic subtest: pipe-B-eDP-1
[301.272963] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.604s)
[301.283089] Starting dynamic subtest: pipe-C-eDP-1
[302.819060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[302.828889] Starting dynamic subtest: pipe-D-eDP-1
[304.344826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[304.346997] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.556s)
[305.580691] [078/155] (713s left) kms_psr (psr2-sprite-render)
[305.650182] Starting subtest: psr2-sprite-render
[305.652512] Starting dynamic subtest: eDP-1
[307.371614] Dynamic subtest eDP-1: SUCCESS (1.722s)
[307.373771] Subtest psr2-sprite-render: SUCCESS (1.723s)
[308.246378] [079/155] (711s left) sw_sync (alloc_fence)
[308.289661] Starting subtest: alloc_fence
[308.292180] Subtest alloc_fence: SUCCESS (0.000s)
[308.357483] [080/155] (711s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[308.460348] Starting subtest: flip-vs-cursor-busy-crc-atomic
[309.205232] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.743s)
[310.063760] [081/155] (709s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt)
[310.154272] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt
[310.158718] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[310.257054] [082/155] (709s left) kms_rotation_crc (exhaust-fences)
[310.342092] Starting subtest: exhaust-fences
[310.346582] Subtest exhaust-fences: SKIP (0.000s)
[310.413156] [083/155] (709s left) gem_sync (basic-store-all)
[310.484945] Starting subtest: basic-store-all
[313.558292] Subtest basic-store-all: SUCCESS (3.083s)
[313.740406] [084/155] (706s left) gem_exec_whisper (basic-fds-priority)
[313.804595] Starting subtest: basic-fds-priority
[338.111830] Subtest basic-fds-priority: SUCCESS (24.303s)
[338.295108] [085/155] (681s left) gem_exec_fence (submit)
[338.474724] Starting subtest: submit
[338.479502] Subtest submit: SKIP (0.000s)
[340.314687] [086/155] (679s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[340.403389] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[340.407855] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[340.522223] [087/155] (679s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[340.594286] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[340.596573] Starting dynamic subtest: pipe-A-eDP-1
[340.650933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[340.662911] Starting dynamic subtest: pipe-B-eDP-1
[340.710672] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[340.722076] Starting dynamic subtest: pipe-C-eDP-1
[340.768054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[340.777508] Starting dynamic subtest: pipe-D-eDP-1
[340.828462] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[340.830725] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.237s)
[343.128374] [088/155] (676s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[343.182450] Starting subtest: single-wait-all-for-submit-available-submitted
[343.184776] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[343.281577] [089/155] (676s left) kms_big_fb (linear-32bpp-rotate-0)
[343.377908] Starting subtest: linear-32bpp-rotate-0
[344.890319] Subtest linear-32bpp-rotate-0: SUCCESS (1.511s)
[345.025448] [090/155] (675s left) kms_cursor_crc (cursor-sliding-512x512)
[345.277682] Starting subtest: cursor-sliding-512x512
[345.281479] Subtest cursor-sliding-512x512: SKIP (0.001s)
[345.444701] [091/155] (674s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[345.518583] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[345.521955] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.619565] [092/155] (674s left) gem_ctx_persistence (smoketest)
[345.684945] Starting subtest: smoketest
[385.180583] Subtest smoketest: SUCCESS (39.492s)
[385.261380] [093/155] (634s left) kms_dsc (dsc-basic)
[385.345990] Starting subtest: dsc-basic
[385.359060] Subtest dsc-basic: SKIP (0.000s)
[385.425523] [094/155] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[385.512164] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[392.105277] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.598s)
[392.240639] [095/155] (628s left) gem_exec_params (rsvd2-dirt)
[392.309568] Starting subtest: rsvd2-dirt
[392.313999] Subtest rsvd2-dirt: SKIP (0.000s)
[392.435354] [096/155] (627s left) kms_content_protection (lic-type-0-hdcp14)
[392.554602] Starting subtest: lic-type-0-hdcp14
[392.559232] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[392.687643] [097/155] (627s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[392.770681] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[392.774656] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[392.866442] [098/155] (627s left) gen9_exec_parse (bb-start-out)
[392.925610] Subtest bb-start-out: SKIP (0.000s)
[392.998815] [099/155] (627s left) gem_ctx_param (non-root-set)
[393.060545] Starting subtest: non-root-set
[393.074976] Subtest non-root-set: SUCCESS (0.018s)
[393.161141] [100/155] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[393.244685] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[393.248038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.352628] [101/155] (627s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[393.441125] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[393.444628] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.545749] [102/155] (626s left) gem_exec_whisper (basic-queues-forked-all)
[393.617402] Starting subtest: basic-queues-forked-all
[411.559069] Subtest basic-queues-forked-all: SUCCESS (17.935s)
[411.746148] [103/155] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[411.833844] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[418.567617] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.739s)
[418.692390] [104/155] (601s left) kms_plane_multiple (2x-tiling-y)
[418.773960] Starting subtest: 2x-tiling-y
[418.778667] Subtest 2x-tiling-y: SKIP (0.000s)
[418.846888] [105/155] (601s left) kms_pm_rpm (fences-dpms)
[420.347931] Starting subtest: fences-dpms
[420.352648] Subtest fences-dpms: SKIP (0.000s)
[421.139263] [106/155] (599s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[421.188392] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[421.190679] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[421.289394] [107/155] (599s left) gem_busy (close-race)
[421.354306] Starting subtest: close-race
[445.245288] Subtest close-race: SUCCESS (23.888s)
[445.613941] [108/155] (575s left) kms_panel_fitting (legacy)
[445.725061] Starting subtest: legacy
[445.727295] Starting dynamic subtest: pipe-A-eDP-1
[446.268911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[446.297406] Starting dynamic subtest: pipe-B-eDP-1
[447.826707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.538s)
[447.856997] Starting dynamic subtest: pipe-C-eDP-1
[449.335696] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.490s)
[449.363197] Starting dynamic subtest: pipe-D-eDP-1
[450.858338] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[450.860582] Subtest legacy: SUCCESS (5.134s)
[452.028402] [109/155] (568s left) syncobj_wait (multi-wait-signaled)
[452.097521] Starting subtest: multi-wait-signaled
[452.100111] Subtest multi-wait-signaled: SUCCESS (0.000s)
[452.198031] [110/155] (568s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[452.285492] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[452.289537] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[452.400937] [111/155] (568s left) gem_exec_capture (capture)
[452.462166] Starting subtest: capture
[452.464288] Starting dynamic subtest: rcs0-smem
[453.291965] Dynamic subtest rcs0-smem: SUCCESS (0.829s)
[453.302123] Starting dynamic subtest: bcs0-smem
[454.116659] Dynamic subtest bcs0-smem: SUCCESS (0.823s)
[454.126408] Starting dynamic subtest: vcs0-smem
[454.935336] Dynamic subtest vcs0-smem: SUCCESS (0.816s)
[454.946093] Starting dynamic subtest: vcs1-smem
[456.249925] Dynamic subtest vcs1-smem: SUCCESS (1.315s)
[456.261437] Starting dynamic subtest: vecs0-smem
[457.142618] Dynamic subtest vecs0-smem: FAIL (0.832s)
[457.154838] Starting dynamic subtest: ccs0-smem
[458.406529] Dynamic subtest ccs0-smem: SUCCESS (1.323s)
[458.408585] Subtest capture: FAIL (5.941s)
[458.532078] [112/155] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[458.622511] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[458.626696] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[458.732855] [113/155] (562s left) gem_mmap_offset (perf)
[458.782474] Starting subtest: perf
[458.784727] Starting dynamic subtest: smem0
[459.128028] Dynamic subtest smem0: SUCCESS (0.345s)
[459.130472] Subtest perf: SUCCESS (0.346s)
[459.252554] [114/155] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[459.337043] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[459.341402] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[459.446589] [115/155] (561s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[459.522879] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[459.527323] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[459.601837] [116/155] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[459.691276] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[459.695653] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[459.786651] [117/155] (561s left) kms_psr (fbc-pr-primary-mmap-cpu)
[459.875652] Starting subtest: fbc-pr-primary-mmap-cpu
[459.880047] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[459.950238] [118/155] (561s left) syncobj_timeline (reset-multiple-signaled)
[459.999786] Starting subtest: reset-multiple-signaled
[460.002074] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[460.094786] [119/155] (561s left) kms_chamelium_color (degamma)
[460.160383] Subtest degamma: SKIP (0.000s)
[460.203604] [120/155] (561s left) kms_cursor_crc (cursor-onscreen-128x128)
[460.377974] Starting subtest: cursor-onscreen-128x128
[460.380052] Starting dynamic subtest: pipe-A-eDP-1
[462.482928] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s)
[462.513266] Starting dynamic subtest: pipe-D-eDP-1
[465.290375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s)
[465.292467] Subtest cursor-onscreen-128x128: SUCCESS (4.913s)
[466.181057] [121/155] (555s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[466.258073] Starting subtest: yf-tiled-addfb-size-offset-overflow
[466.262595] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[466.355257] [122/155] (555s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[466.432738] Starting subtest: fbc-farfromfence-mmap-gtt
[466.436710] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[466.529898] [123/155] (554s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[466.614287] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[466.618705] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[466.720233] [124/155] (554s left) api_intel_bb (object-noreloc-purge-cache-simple)
[466.770945] Starting subtest: object-noreloc-purge-cache-simple
[466.773251] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[466.861387] [125/155] (554s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[466.937857] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[466.941805] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[467.036896] [126/155] (554s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[467.113888] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[474.151295] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.041s)
[474.255226] [127/155] (547s left) kms_getfb (getfb2-handle-protection)
[474.337515] Starting subtest: getfb2-handle-protection
[474.353418] Subtest getfb2-handle-protection: SUCCESS (0.018s)
[474.476111] [128/155] (547s left) i915_hangman (error-state-basic)
[474.527611] Starting subtest: error-state-basic
[474.671341] Subtest error-state-basic: SUCCESS (0.144s)
[474.746824] [129/155] (546s left) kms_color (ctm-green-to-red)
[474.825534] Starting subtest: ctm-green-to-red
[474.828066] Starting dynamic subtest: pipe-A-eDP-1
[475.518675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[475.531849] Starting dynamic subtest: pipe-B-eDP-1
[476.910887] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[476.922108] Starting dynamic subtest: pipe-C-eDP-1
[478.293355] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[478.304591] Starting dynamic subtest: pipe-D-eDP-1
[479.628834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[479.631122] Subtest ctm-green-to-red: SUCCESS (4.803s)
[480.437805] [130/155] (541s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[480.530817] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[480.534950] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[480.635416] [131/155] (541s left) gem_tiled_pread_pwrite
[480.761741] [132/155] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[480.843158] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[480.847576] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[480.924828] [133/155] (540s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[481.005733] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[481.008074] Starting dynamic subtest: pipe-A
[481.128761] Dynamic subtest pipe-A: SKIP (0.118s)
[481.138996] Starting dynamic subtest: pipe-B
[482.317909] Dynamic subtest pipe-B: SKIP (1.189s)
[482.328758] Starting dynamic subtest: pipe-C
[483.535370] Dynamic subtest pipe-C: SUCCESS (1.223s)
[483.545856] Starting dynamic subtest: pipe-D
[484.761462] Dynamic subtest pipe-D: SUCCESS (1.224s)
[484.763777] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.758s)
[485.969243] [134/155] (535s left) perf_pmu (init-wait)
[486.006582] Starting subtest: init-wait
[486.009075] Starting dynamic subtest: rcs0
[486.011457] Dynamic subtest rcs0: SUCCESS (0.002s)
[486.022896] Starting dynamic subtest: bcs0
[486.025180] Dynamic subtest bcs0: SUCCESS (0.000s)
[486.035093] Starting dynamic subtest: vcs0
[486.037172] Dynamic subtest vcs0: SUCCESS (0.001s)
[486.047083] Starting dynamic subtest: vcs1
[486.049181] Dynamic subtest vcs1: SUCCESS (0.001s)
[486.060209] Starting dynamic subtest: vecs0
[486.062197] Dynamic subtest vecs0: SUCCESS (0.001s)
[486.072222] Starting dynamic subtest: ccs0
[486.074429] Dynamic subtest ccs0: SUCCESS (0.000s)
[486.076639] Subtest init-wait: SUCCESS (0.008s)
[486.116329] [135/155] (535s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[486.387860] Starting subtest: cursor-rapid-movement-512x170
[486.392231] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[486.549325] [136/155] (535s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[486.608465] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[486.713616] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[486.792676] [137/155] (535s left) i915_drm_fdinfo (basics)
[486.829695] Starting subtest: basics
[486.832178] Subtest basics: SUCCESS (0.000s)
[486.907096] [138/155] (535s left) gem_ccs (block-multicopy-inplace)
[486.958635] Starting subtest: block-multicopy-inplace
[486.963319] Subtest block-multicopy-inplace: SKIP (0.000s)
[487.051747] [139/155] (535s left) gem_exec_balancer (indices)
[487.110753] Starting subtest: indices
[489.179077] Subtest indices: SUCCESS (2.066s)
[489.465553] [140/155] (532s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[489.550747] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[489.552931] Starting dynamic subtest: pipe-A-eDP-1
[489.576344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.589294] Starting dynamic subtest: pipe-B-eDP-1
[489.612113] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.623176] Starting dynamic subtest: pipe-C-eDP-1
[489.645193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.655643] Starting dynamic subtest: pipe-D-eDP-1
[489.677979] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.682099] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[491.802171] [141/155] (530s left) prime_busy (hang)
[491.859212] Starting subtest: hang
[491.861666] Starting dynamic subtest: rcs0
[517.715733] Dynamic subtest rcs0: SUCCESS (25.856s)
[517.725881] Starting dynamic subtest: bcs0
[524.869839] Dynamic subtest bcs0: SUCCESS (7.152s)
[524.880051] Starting dynamic subtest: vcs0
[531.908077] Dynamic subtest vcs0: SUCCESS (7.038s)
[531.918263] Starting dynamic subtest: vcs1
[538.891551] Dynamic subtest vcs1: SUCCESS (6.979s)
[538.901581] Starting dynamic subtest: vecs0
[545.862726] Dynamic subtest vecs0: SUCCESS (6.972s)
[545.876096] Starting dynamic subtest: ccs0
[559.765762] Dynamic subtest ccs0: SUCCESS (13.898s)
[559.767898] Subtest hang: SUCCESS (67.902s)
[559.873719] [142/155] (462s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[559.967861] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[559.972459] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[560.059409] [143/155] (462s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[560.111233] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[560.116119] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[560.307497] [144/155] (461s left) gem_exec_params (rel-constants-invalid-ring)
[560.358251] Starting subtest: rel-constants-invalid-ring
[560.360659] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[560.462918] [145/155] (461s left) gem_exec_schedule (preempt-user)
[560.535036] Starting subtest: preempt-user
[560.537074] Starting dynamic subtest: rcs0
[560.552509] Dynamic subtest rcs0: SUCCESS (0.023s)
[560.563808] Starting dynamic subtest: bcs0
[560.571574] Dynamic subtest bcs0: SUCCESS (0.018s)
[560.581808] Starting dynamic subtest: vcs0
[560.591861] Dynamic subtest vcs0: SUCCESS (0.020s)
[560.603293] Starting dynamic subtest: vcs1
[560.613592] Dynamic subtest vcs1: SUCCESS (0.021s)
[560.624363] Starting dynamic subtest: vecs0
[560.632531] Dynamic subtest vecs0: SUCCESS (0.018s)
[560.643552] Starting dynamic subtest: ccs0
[560.653483] Dynamic subtest ccs0: SUCCESS (0.020s)
[560.655648] Subtest preempt-user: SUCCESS (0.126s)
[562.314182] [146/155] (460s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[562.401454] Starting subtest: x-tiled-64bpp-rotate-0
[563.946350] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.546s)
[564.127057] [147/155] (458s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[564.213722] Starting subtest: fbc-psr-cursor-mmap-gtt
[564.215963] Starting dynamic subtest: eDP-1
[564.220389] Dynamic subtest eDP-1: SKIP (0.000s)
[564.224767] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[564.289090] [148/155] (458s left) kms_async_flips (async-flip-suspend-resume)
[564.356110] Starting subtest: async-flip-suspend-resume
[564.741579] Starting dynamic subtest: pipe-A-eDP-1
[583.010741] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.782s)
[583.399972] Starting dynamic subtest: pipe-B-eDP-1
[601.015866] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.989s)
[601.396676] Starting dynamic subtest: pipe-C-eDP-1
[619.016147] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.983s)
[619.377586] Starting dynamic subtest: pipe-D-eDP-1
[637.024882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.985s)
[637.027179] Subtest async-flip-suspend-resume: SUCCESS (14.260s)
[638.178663] [149/155] (384s left) perf (global-sseu-config)
[638.321532] Starting subtest: global-sseu-config
[638.326420] Subtest global-sseu-config: SKIP (0.000s)
[638.367872] [150/155] (384s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[638.475470] Starting subtest: basic-flip-before-cursor-atomic
[639.370793] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s)
[640.173740] [151/155] (382s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[640.258501] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[640.263773] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[640.348027] [152/155] (382s left) gem_mmap_wc (write-wc-read-gtt)
[640.392404] Subtest write-wc-read-gtt: SKIP (0.000s)
[640.451101] [153/155] (382s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[640.534139] Starting subtest: 4-tiled-64bpp-rotate-270
[640.552700] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[640.652962] [154/155] (382s left) gem_mmap_gtt (basic)
[640.706264] Subtest basic: SKIP (0.000s)
[640.768342] [155/155] (381s left) kms_getfb (getfb-handle-zero)
[640.836705] Starting subtest: getfb-handle-zero
[640.839299] Subtest getfb-handle-zero: SUCCESS (0.000s)
[640.942955] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_bad_destroy
results: parsing output: 6/ for test: kms_selftest
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_pipe_stress
results: parsing output: 9/ for test: kms_frontbuffer_tracking
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: gem_vm_create
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_chamelium_audio
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: gem_bad_reloc
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: gem_caching
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_selftest
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_mmap_coherency
results: parsing output: 42/ for test: kms_invalid_mode
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_display_modes
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_ctx_param
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: dmabuf_sync_file
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: sysfs_preempt_timeout
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_linear_blits
results: parsing output: 64/ for test: gem_ctx_bad_destroy
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_reg_read
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_close_race
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: gem_sync
results: parsing output: 83/ for test: gem_exec_whisper
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_dsc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_busy
results: parsing output: 107/ for test: kms_panel_fitting
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_capture
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: kms_color
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_tiled_pread_pwrite
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
results: parsing output: 133/ for test: perf_pmu
results: parsing output: 134/ for test: kms_cursor_crc
results: parsing output: 135/ for test: syncobj_timeline
results: parsing output: 136/ for test: i915_drm_fdinfo
results: parsing output: 137/ for test: gem_ccs
results: parsing output: 138/ for test: gem_exec_balancer
results: parsing output: 139/ for test: kms_ccs
results: parsing output: 140/ for test: prime_busy
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_render_copy
results: parsing output: 143/ for test: gem_exec_params
results: parsing output: 144/ for test: gem_exec_schedule
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_async_flips
results: parsing output: 148/ for test: perf
results: parsing output: 149/ for test: kms_cursor_legacy
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_mmap_wc
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: gem_mmap_gtt
results: parsing output: 154/ for test: kms_getfb
Done.