[62.519076] Initializing watchdogs
[62.519124]   /dev/watchdog0
[62.533877] [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]
[62.538475] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.540562] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.542656] [001/131] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[62.640079] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[66.813297] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.174s)
[67.939205] [002/131] (955s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[68.063157] Starting subtest: fbc-pr-cursor-mmap-gtt
[68.064913] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[68.212988] [003/131] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[68.304048] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[72.939587] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.635s)
[74.148645] [004/131] (948s left) gem_ringfill (basic-all)
[79.905833] Starting subtest: basic-all
[81.057762] Subtest basic-all: SUCCESS (1.150s)
[81.183697] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[81.185376] [005/131] (941s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[81.245231] Starting subtest: etime-single-wait-available-unsubmitted
[81.354906] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[81.422123] [006/131] (941s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[81.549374] Starting subtest: short-flip-after-cursor-toggle
[82.487077] Subtest short-flip-after-cursor-toggle: SUCCESS (0.937s)
[83.373350] [007/131] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[83.473060] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[90.492486] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.018s)
[90.628585] [008/131] (932s left) gem_exec_balancer (individual)
[90.691603] Starting subtest: individual
[92.897677] Subtest individual: SUCCESS (2.197s)
[93.202816] [009/131] (930s left) gem_ctx_param (set-priority-invalid-size)
[93.255422] Starting subtest: set-priority-invalid-size
[93.256495] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[93.314605] [010/131] (930s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[93.361786] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[93.467221] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[93.539516] [011/131] (929s left) gem_ctx_persistence (engines-hostile)
[93.585616] Starting subtest: engines-hostile
[93.586464] Starting dynamic subtest: rcs0
[93.703800] Dynamic subtest rcs0: SUCCESS (0.117s)
[93.713570] Starting dynamic subtest: bcs0
[93.795918] Dynamic subtest bcs0: SUCCESS (0.091s)
[93.806602] Starting dynamic subtest: vcs0
[93.910785] Dynamic subtest vcs0: SUCCESS (0.114s)
[93.920617] Starting dynamic subtest: vcs1
[94.012865] Dynamic subtest vcs1: SUCCESS (0.101s)
[94.023053] Starting dynamic subtest: vecs0
[94.109287] Dynamic subtest vecs0: SUCCESS (0.096s)
[94.118788] Starting dynamic subtest: ccs0
[94.151227] Dynamic subtest ccs0: SUCCESS (0.041s)
[94.152366] Subtest engines-hostile: SUCCESS (0.566s)
[94.234972] [012/131] (929s left) gem_tiled_partial_pwrite_pread (reads)
[94.287424] Subtest reads: SKIP (0.000s)
[94.344036] [013/131] (929s left) kms_big_fb (linear-32bpp-rotate-270)
[94.445808] Starting subtest: linear-32bpp-rotate-270
[94.466103] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[94.561977] [014/131] (928s left) kms_feature_discovery (psr1)
[94.653505] Starting subtest: psr1
[94.654419] Subtest psr1: SUCCESS (0.000s)
[94.737986] [015/131] (928s left) gem_exec_schedule (out-order)
[94.788674] Starting subtest: out-order
[94.789677] Starting dynamic subtest: rcs0
[94.895448] Dynamic subtest rcs0: SUCCESS (0.106s)
[94.905706] Starting dynamic subtest: vcs0
[94.979529] Dynamic subtest vcs0: SUCCESS (0.083s)
[94.989494] Starting dynamic subtest: vcs1
[95.057358] Dynamic subtest vcs1: SUCCESS (0.078s)
[95.068579] Starting dynamic subtest: vecs0
[95.131906] Dynamic subtest vecs0: SUCCESS (0.073s)
[95.138958] Starting dynamic subtest: ccs0
[95.221725] Dynamic subtest ccs0: SUCCESS (0.090s)
[95.223049] Subtest out-order: SUCCESS (0.433s)
[97.012806] [016/131] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[97.106930] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[97.108796] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.210383] [017/131] (926s left) kms_plane_multiple (2x-tiling-none)
[97.298901] Starting subtest: 2x-tiling-none
[97.300440] Subtest 2x-tiling-none: SKIP (0.000s)
[97.367661] [018/131] (926s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[97.469564] Starting subtest: yf-tiled-16bpp-rotate-90
[97.471494] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[97.559209] [019/131] (926s left) i915_pm_rps (reset)
[97.626753] Starting subtest: reset
[106.073330] Subtest reset: SUCCESS (8.439s)
[106.182240] [020/131] (917s left) perf_pmu (most-busy-idle-check-all)
[106.220704] Starting subtest: most-busy-idle-check-all
[106.221553] Starting dynamic subtest: rcs0
[107.925674] Dynamic subtest rcs0: SUCCESS (1.705s)
[107.936366] Starting dynamic subtest: bcs0
[109.919088] Dynamic subtest bcs0: SUCCESS (1.983s)
[109.928691] Starting dynamic subtest: vcs0
[111.902631] Dynamic subtest vcs0: SUCCESS (1.983s)
[111.912638] Starting dynamic subtest: vcs1
[113.878222] Dynamic subtest vcs1: SUCCESS (1.983s)
[113.891569] Starting dynamic subtest: vecs0
[115.935046] Dynamic subtest vecs0: SUCCESS (2.047s)
[115.946744] Starting dynamic subtest: ccs0
[117.919579] Dynamic subtest ccs0: SUCCESS (1.983s)
[117.920685] Subtest most-busy-idle-check-all: SUCCESS (11.690s)
[118.004051] [021/131] (905s left) gem_lmem_swapping (random)
[118.041316] Subtest random: SKIP (0.000s)
[118.082039] [022/131] (905s left) kms_flip (basic-flip-vs-dpms)
[118.178864] Starting subtest: basic-flip-vs-dpms
[118.180721] Starting dynamic subtest: A-eDP1
[120.723488] Dynamic subtest A-eDP1: SUCCESS (2.542s)
[120.730981] Starting dynamic subtest: B-eDP1
[122.896071] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[122.904428] Starting dynamic subtest: C-eDP1
[124.983227] Dynamic subtest C-eDP1: SUCCESS (2.085s)
[124.992034] Starting dynamic subtest: D-eDP1
[127.062067] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[127.063918] Subtest basic-flip-vs-dpms: SUCCESS (8.885s)
[127.887310] [023/131] (895s left) i915_drm_fdinfo (all-busy-check-all)
[127.920085] Starting subtest: all-busy-check-all
[127.924804] Subtest all-busy-check-all: SKIP (0.004s)
[128.004923] [024/131] (895s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[128.124143] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[129.192411] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.068s)
[129.300193] [025/131] (894s left) gem_userptr_blits (create-destroy-unsync)
[129.361074] Subtest create-destroy-unsync: SKIP (0.000s)
[129.477786] [026/131] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[129.566814] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[129.568696] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.652571] [027/131] (894s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[129.718064] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[129.845438] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[129.896842] [028/131] (894s left) kms_selftest (drm_cmdline_parser)
[129.936031] Starting subtest: drm_cmdline_parser
[129.994030] Starting dynamic subtest: drm_test_cmdline_force_d_only
[130.080832] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.088s)
[130.090491] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[130.236209] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.149s)
[130.246055] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[130.327289] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.096s)
[130.336893] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[130.421571] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.095s)
[130.428748] Starting dynamic subtest: drm_test_cmdline_force_e_only
[130.518778] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.097s)
[130.528232] Starting dynamic subtest: drm_test_cmdline_res
[130.608803] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.090s)
[130.618053] Starting dynamic subtest: drm_test_cmdline_res_vesa
[130.709286] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.100s)
[130.716507] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[130.802378] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.093s)
[130.811452] Starting dynamic subtest: drm_test_cmdline_res_rblank
[130.902272] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.100s)
[130.909523] Starting dynamic subtest: drm_test_cmdline_res_bpp
[130.993896] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.091s)
[131.001155] Starting dynamic subtest: drm_test_cmdline_res_refresh
[131.081392] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.087s)
[131.090072] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[131.167797] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.086s)
[131.175076] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[131.261109] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.093s)
[131.269156] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[131.358711] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.098s)
[131.367812] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[131.449773] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.090s)
[131.459189] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[131.536188] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.085s)
[131.545776] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[131.623905] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.087s)
[131.632741] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[131.706560] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.082s)
[131.716518] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[131.792512] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.085s)
[131.799789] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[131.888101] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.095s)
[131.895288] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[131.979887] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.092s)
[131.989257] Starting dynamic subtest: drm_test_cmdline_name
[132.068087] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.086s)
[132.076046] Starting dynamic subtest: drm_test_cmdline_name_bpp
[132.161395] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.093s)
[132.169370] Starting dynamic subtest: drm_test_cmdline_name_option
[132.252225] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.091s)
[132.264194] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[132.347292] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.094s)
[132.356225] Starting dynamic subtest: drm_test_cmdline_rotate_0
[132.425595] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.078s)
[132.434519] Starting dynamic subtest: drm_test_cmdline_rotate_90
[132.526118] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.099s)
[132.534966] Starting dynamic subtest: drm_test_cmdline_rotate_180
[132.620017] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.093s)
[132.628816] Starting dynamic subtest: drm_test_cmdline_rotate_270
[132.715147] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.094s)
[132.723858] Starting dynamic subtest: drm_test_cmdline_hmirror
[132.817171] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.102s)
[132.825878] Starting dynamic subtest: drm_test_cmdline_vmirror
[132.897298] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.080s)
[132.906715] Starting dynamic subtest: drm_test_cmdline_margin_options
[132.978235] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.081s)
[132.987290] Starting dynamic subtest: drm_test_cmdline_multiple_options
[133.079419] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.100s)
[133.088589] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[133.167647] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.089s)
[133.177053] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[133.274290] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.105s)
[133.283572] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[133.374959] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.100s)
[133.383114] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[133.469477] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.093s)
[133.477469] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[133.555789] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.087s)
[133.565147] Starting dynamic subtest: drm_test_cmdline_invalid
[133.666079] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.110s)
[133.674040] Starting dynamic subtest: drm_test_cmdline_tv_options
[133.760626] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.093s)
[133.761633] Subtest drm_cmdline_parser: SUCCESS (3.824s)
[133.911890] [029/131] (890s left) gem_userptr_blits (process-exit)
[133.973937] Starting subtest: process-exit
[133.985240] Subtest process-exit: SUCCESS (0.011s)
[134.126177] [030/131] (889s left) kms_plane_cursor (overlay)
[134.209054] Starting subtest: overlay
[134.210848] Starting dynamic subtest: pipe-A-eDP-1-size-64
[136.762197] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[136.821293] Starting dynamic subtest: pipe-A-eDP-1-size-128
[139.350396] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.539s)
[139.412101] Starting dynamic subtest: pipe-A-eDP-1-size-256
[141.917448] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[142.265307] Starting dynamic subtest: pipe-B-eDP-1-size-64
[145.602843] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.345s)
[145.664544] Starting dynamic subtest: pipe-B-eDP-1-size-128
[148.117522] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.462s)
[148.176893] Starting dynamic subtest: pipe-B-eDP-1-size-256
[150.738978] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[151.088814] Starting dynamic subtest: pipe-C-eDP-1-size-64
[154.010779] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.929s)
[154.049417] Starting dynamic subtest: pipe-C-eDP-1-size-128
[156.233535] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[156.271924] Starting dynamic subtest: pipe-C-eDP-1-size-256
[158.411462] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[158.742444] Starting dynamic subtest: pipe-D-eDP-1-size-64
[161.595256] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.861s)
[161.634214] Starting dynamic subtest: pipe-D-eDP-1-size-128
[163.761883] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[163.800656] Starting dynamic subtest: pipe-D-eDP-1-size-256
[165.951063] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[166.268708] Subtest overlay: SUCCESS (32.057s)
[167.086569] [031/131] (856s left) kms_psr (fbc-psr-cursor-render)
[167.197569] Starting subtest: fbc-psr-cursor-render
[167.198498] Starting dynamic subtest: eDP-1
[167.200338] Dynamic subtest eDP-1: SKIP (0.000s)
[167.202091] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[167.263343] [032/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[167.358236] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[174.409403] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.051s)
[174.516395] [033/131] (849s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[174.806459] Starting subtest: cursor-rapid-movement-512x512
[174.808187] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[174.970962] [034/131] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[175.057732] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[175.059496] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[175.153901] [035/131] (849s left) gem_ctx_persistence (hang)
[175.216761] Starting subtest: hang
[175.218529] Subtest hang: SKIP (0.000s)
[175.324978] [036/131] (848s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[175.427544] Starting subtest: x-tiled-8bpp-rotate-0
[176.687603] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.260s)
[176.829068] [037/131] (847s left) kms_prop_blob (blob-prop-lifetime)
[176.889855] Starting subtest: blob-prop-lifetime
[176.890830] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[177.002587] [038/131] (847s left) api_intel_allocator (execbuf-with-allocator)
[177.049045] Starting subtest: execbuf-with-allocator
[177.052564] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[177.174859] [039/131] (847s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[177.259216] Starting subtest: plane-upscale-20x20-with-modifiers
[177.259965] Starting dynamic subtest: pipe-A
[177.596229] Dynamic subtest pipe-A: SUCCESS (0.338s)
[177.604991] Starting dynamic subtest: pipe-B
[179.026345] Dynamic subtest pipe-B: SUCCESS (1.429s)
[179.035152] Starting dynamic subtest: pipe-C
[180.443481] Dynamic subtest pipe-C: SUCCESS (1.416s)
[180.451666] Starting dynamic subtest: pipe-D
[181.874976] Dynamic subtest pipe-D: SUCCESS (1.431s)
[181.875896] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.617s)
[183.037863] [040/131] (841s left) gem_ctx_param (invalid-ctx-get)
[183.088591] Starting subtest: invalid-ctx-get
[183.089569] Subtest invalid-ctx-get: SUCCESS (0.000s)
[183.156669] [041/131] (841s left) kms_psr (psr-sprite-blt)
[183.251485] Starting subtest: psr-sprite-blt
[183.252434] Starting dynamic subtest: eDP-1
[184.977619] Dynamic subtest eDP-1: SUCCESS (1.726s)
[184.978575] Subtest psr-sprite-blt: SUCCESS (1.727s)
[185.821537] [042/131] (838s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[185.915337] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[185.917267] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[186.005496] [043/131] (838s left) gem_softpin (evict-prime)
[186.068583] Starting subtest: evict-prime
[186.069471] Starting dynamic subtest: rcs0
[187.224351] Dynamic subtest rcs0: SUCCESS (1.155s)
[187.235047] Starting dynamic subtest: bcs0
[188.352734] Dynamic subtest bcs0: SUCCESS (1.126s)
[188.363719] Starting dynamic subtest: vcs0
[189.925543] Dynamic subtest vcs0: SUCCESS (1.561s)
[189.936020] Starting dynamic subtest: vcs1
[191.908812] Dynamic subtest vcs1: SUCCESS (1.979s)
[191.927335] Starting dynamic subtest: vecs0
[193.885035] Dynamic subtest vecs0: SUCCESS (1.972s)
[193.894665] Starting dynamic subtest: ccs0
[195.010805] Dynamic subtest ccs0: SUCCESS (1.133s)
[195.023501] Starting dynamic subtest: all
[196.889362] Dynamic subtest all: SUCCESS (1.867s)
[196.890380] Subtest evict-prime: SUCCESS (10.812s)
[196.954036] [044/131] (827s left) gem_exec_schedule (fairslice)
[197.008457] Starting subtest: fairslice
[197.009340] Starting dynamic subtest: rcs0
[199.047057] Dynamic subtest rcs0: SUCCESS (2.034s)
[199.055486] Starting dynamic subtest: bcs0
[201.069423] Dynamic subtest bcs0: SUCCESS (2.020s)
[201.078179] Starting dynamic subtest: vcs0
[203.097142] Dynamic subtest vcs0: SUCCESS (2.020s)
[203.106470] Starting dynamic subtest: vcs1
[205.111368] Dynamic subtest vcs1: SUCCESS (2.019s)
[205.120875] Starting dynamic subtest: vecs0
[207.132394] Dynamic subtest vecs0: SUCCESS (2.019s)
[207.141614] Starting dynamic subtest: ccs0
[209.153767] Dynamic subtest ccs0: SUCCESS (2.022s)
[209.154777] Subtest fairslice: SUCCESS (12.140s)
[209.440729] [045/131] (815s left) gem_exec_whisper (basic-contexts-priority)
[209.496703] Starting subtest: basic-contexts-priority
[234.435774] Subtest basic-contexts-priority: SUCCESS (24.892s)
[234.566326] [046/131] (790s left) prime_self_import (basic-with_two_bos)
[234.604047] Starting subtest: basic-with_two_bos
[234.621271] Subtest basic-with_two_bos: SUCCESS (0.018s)
[234.721837] [047/131] (789s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[234.814215] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[234.815205] Starting dynamic subtest: pipe-A-eDP-1
[251.754143] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.968s)
[251.763150] Starting dynamic subtest: pipe-B-eDP-1
[269.705371] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[269.714196] Starting dynamic subtest: pipe-C-eDP-1
[287.679094] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.715s)
[287.693547] Starting dynamic subtest: pipe-D-eDP-1
[305.704715] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.790s)
[305.705749] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.287s)
[312.943399] [048/131] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[313.041635] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[313.043493] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[313.134554] [049/131] (717s left) kms_color_pipeline (plane-ctm3x4)
[313.228031] Starting subtest: plane-ctm3x4
[313.376282] Starting dynamic subtest: pipe-A-plane-0
[313.581280] Dynamic subtest pipe-A-plane-0: FAIL (0.145s)
[313.590494] Starting dynamic subtest: pipe-A-plane-1
[313.735936] Dynamic subtest pipe-A-plane-1: FAIL (0.140s)
[313.744692] Starting dynamic subtest: pipe-A-plane-2
[313.905774] Dynamic subtest pipe-A-plane-2: FAIL (0.154s)
[315.012466] Starting dynamic subtest: pipe-B-plane-0
[315.236973] Dynamic subtest pipe-B-plane-0: FAIL (0.142s)
[315.248075] Starting dynamic subtest: pipe-B-plane-1
[315.407636] Dynamic subtest pipe-B-plane-1: FAIL (0.143s)
[315.416993] Starting dynamic subtest: pipe-B-plane-2
[315.554004] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[316.674607] Starting dynamic subtest: pipe-C-plane-0
[316.957111] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[316.967141] Starting dynamic subtest: pipe-C-plane-1
[317.102072] Dynamic subtest pipe-C-plane-1: FAIL (0.121s)
[317.110649] Starting dynamic subtest: pipe-C-plane-2
[317.260614] Dynamic subtest pipe-C-plane-2: FAIL (0.121s)
[318.295445] Starting dynamic subtest: pipe-D-plane-0
[318.581715] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[318.590391] Starting dynamic subtest: pipe-D-plane-1
[318.759749] Dynamic subtest pipe-D-plane-1: FAIL (0.133s)
[318.771525] Starting dynamic subtest: pipe-D-plane-2
[318.946841] Dynamic subtest pipe-D-plane-2: FAIL (0.313s)
[319.158887] Subtest plane-ctm3x4: FAIL (5.926s)
[320.042054] [050/131] (710s left) i915_suspend (basic-s3-without-i915)
[320.079285] Starting subtest: basic-s3-without-i915
[323.347095] Subtest basic-s3-without-i915: SKIP (3.255s)
[324.941854] [051/131] (705s left) perf (non-zero-reason)
[325.061588] Starting subtest: non-zero-reason
[325.062389] Starting dynamic subtest: 0-rcs0
[330.747684] Dynamic subtest 0-rcs0: SUCCESS (5.674s)
[330.758937] Starting dynamic subtest: 1-vcs1
[334.758272] Dynamic subtest 1-vcs1: SUCCESS (4.009s)
[334.759419] Subtest non-zero-reason: SUCCESS (9.685s)
[334.792087] [052/131] (696s left) kms_chamelium_frames (hdmi-crc-fast)
[335.194489] Subtest hdmi-crc-fast: SKIP (0.000s)
[336.035174] [053/131] (694s left) gem_userptr_blits (sd-probe)
[336.089239] Starting subtest: sd-probe
[336.090106] Subtest sd-probe: SUCCESS (0.000s)
[336.203488] [054/131] (694s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[336.287856] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[336.288704] Starting dynamic subtest: pipe-A-eDP-1
[336.388807] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[336.396402] Starting dynamic subtest: pipe-B-eDP-1
[337.547637] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[337.549266] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.260s)
[338.746715] [055/131] (692s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[338.871420] Starting subtest: cursorB-vs-flipA-toggle
[338.874278] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[339.024477] [056/131] (691s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[339.116908] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[339.117745] Starting dynamic subtest: pipe-A-eDP-1
[339.556013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[339.565567] Starting dynamic subtest: pipe-B-eDP-1
[339.573482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[339.580711] Starting dynamic subtest: pipe-C-eDP-1
[339.587718] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[339.594761] Starting dynamic subtest: pipe-D-eDP-1
[339.601739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[339.602510] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.455s)
[341.810334] [057/131] (689s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[341.909679] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[341.921538] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[341.999587] [058/131] (689s left) gem_exec_balancer (smoke)
[342.050362] Starting subtest: smoke
[364.745142] Subtest smoke: SUCCESS (22.645s)
[365.767379] [059/131] (665s left) kms_dirtyfb (default-dirtyfb-ioctl)
[365.857984] Starting subtest: default-dirtyfb-ioctl
[365.858769] Starting dynamic subtest: A-eDP-1
[367.478346] Dynamic subtest A-eDP-1: SUCCESS (1.618s)
[367.479173] Subtest default-dirtyfb-ioctl: SUCCESS (1.620s)
[368.337536] [060/131] (662s left) kms_psr (psr2-sprite-blt)
[368.425158] Starting subtest: psr2-sprite-blt
[368.425955] Starting dynamic subtest: eDP-1
[370.160053] Dynamic subtest eDP-1: SUCCESS (1.734s)
[370.160971] Subtest psr2-sprite-blt: SUCCESS (1.736s)
[371.030071] [061/131] (660s left) perf (non-sampling-read-error)
[371.111414] Starting subtest: non-sampling-read-error
[371.118647] Subtest non-sampling-read-error: SUCCESS (0.006s)
[371.157238] [062/131] (659s left) core_auth (basic-auth)
[371.220578] Starting subtest: basic-auth
[371.221470] Subtest basic-auth: SUCCESS (0.001s)
[371.319411] [063/131] (659s left) kms_psr (pr-primary-mmap-cpu)
[371.395143] Starting subtest: pr-primary-mmap-cpu
[371.396936] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[371.465221] [064/131] (659s left) kms_pm_rpm (fences)
[373.709613] Starting subtest: fences
[373.712374] Subtest fences: SKIP (0.000s)
[374.080230] [065/131] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[374.173201] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[374.175017] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[374.259285] [066/131] (657s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[374.310165] Starting subtest: multi-wait-available-unsubmitted-signaled
[374.311323] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[374.403351] [067/131] (656s left) kms_lease (lease-get)
[374.497067] Starting subtest: lease-get
[374.498104] Starting dynamic subtest: pipe-A-eDP-1
[374.499113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[374.515394] Starting dynamic subtest: pipe-B-eDP-1
[374.516515] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[374.528976] Starting dynamic subtest: pipe-C-eDP-1
[374.530121] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[374.538142] Starting dynamic subtest: pipe-D-eDP-1
[374.539002] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[374.539851] Subtest lease-get: SUCCESS (0.010s)
[374.623317] [068/131] (656s left) kms_flip (plain-flip-fb-recreate)
[374.711699] Starting subtest: plain-flip-fb-recreate
[374.713982] Starting dynamic subtest: A-eDP1
[383.563208] Dynamic subtest A-eDP1: SUCCESS (8.848s)
[383.574837] Starting dynamic subtest: B-eDP1
[392.404956] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[392.414878] Starting dynamic subtest: C-eDP1
[401.226994] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[401.237184] Starting dynamic subtest: D-eDP1
[410.066391] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[410.069679] Subtest plain-flip-fb-recreate: SUCCESS (35.354s)
[411.231865] [069/131] (620s left) prime_busy (after)
[411.289790] Starting subtest: after
[411.292954] Starting dynamic subtest: rcs0
[411.328820] Dynamic subtest rcs0: SUCCESS (0.036s)
[411.339267] Starting dynamic subtest: bcs0
[411.377444] Dynamic subtest bcs0: SUCCESS (0.048s)
[411.386403] Starting dynamic subtest: vcs0
[411.419467] Dynamic subtest vcs0: SUCCESS (0.041s)
[411.427765] Starting dynamic subtest: vcs1
[411.459779] Dynamic subtest vcs1: SUCCESS (0.040s)
[411.467994] Starting dynamic subtest: vecs0
[411.500768] Dynamic subtest vecs0: SUCCESS (0.040s)
[411.509867] Starting dynamic subtest: ccs0
[411.540683] Dynamic subtest ccs0: SUCCESS (0.039s)
[411.648981] Subtest after: SUCCESS (0.358s)
[411.718584] [070/131] (619s left) sw_sync (alloc_merge_fence)
[411.750769] Starting subtest: alloc_merge_fence
[411.751738] Subtest alloc_merge_fence: SUCCESS (0.000s)
[411.807235] [071/131] (619s left) kms_cursor_crc (cursor-offscreen-128x128)
[412.005333] Starting subtest: cursor-offscreen-128x128
[412.008814] Starting dynamic subtest: pipe-A-eDP-1
[413.949868] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[413.981041] Starting dynamic subtest: pipe-D-eDP-1
[416.548282] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[416.549102] Subtest cursor-offscreen-128x128: SUCCESS (4.543s)
[417.390485] [072/131] (614s left) gem_mmap_gtt (big-copy-odd)
[417.446825] Subtest big-copy-odd: SKIP (0.000s)
[417.501339] [073/131] (614s left) kms_vblank (wait-idle-hang)
[417.592232] Starting subtest: wait-idle-hang
[417.593163] Starting dynamic subtest: pipe-A-eDP-1
[444.259988] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.667s)
[444.270755] Starting dynamic subtest: pipe-D-eDP-1
[459.291464] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.027s)
[459.292337] Subtest wait-idle-hang: SUCCESS (41.701s)
[460.151482] [074/131] (571s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[460.244371] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[460.245283] Starting dynamic subtest: pipe-A-eDP-1
[460.267481] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[460.276244] Starting dynamic subtest: pipe-B-eDP-1
[460.298984] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[460.308388] Starting dynamic subtest: pipe-C-eDP-1
[460.330328] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[460.339801] Starting dynamic subtest: pipe-D-eDP-1
[460.360765] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[460.362420] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[462.527029] [075/131] (569s left) gem_exec_fence (syncobj-timeline-export)
[463.121782] Starting subtest: syncobj-timeline-export
[463.122967] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[464.612643] [076/131] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[464.713941] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[464.715579] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[464.819625] [077/131] (566s left) gem_pxp (display-protected-crc)
[464.935359] Starting subtest: display-protected-crc
[466.659529] Subtest display-protected-crc: SUCCESS (1.726s)
[466.760754] [078/131] (564s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[466.820273] Starting subtest: verify-pxp-key-change-after-suspend-resume
[473.993270] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.172s)
[482.186733] [079/131] (557s left) syncobj_wait (wait-for-submit-delayed-submit)
[482.256118] Starting subtest: wait-for-submit-delayed-submit
[482.359221] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[482.444744] [080/131] (557s left) gem_close_race (basic-threads)
[482.519946] Starting subtest: basic-threads
[483.899471] Subtest basic-threads: SUCCESS (1.380s)
[484.098504] [081/131] (555s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[484.197825] Starting subtest: y-tiled-16bpp-rotate-0
[484.199727] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[484.286364] [082/131] (555s left) fbdev (write)
[484.319413] Starting subtest: write
[484.914946] Subtest write: SUCCESS (0.585s)
[484.962732] [083/131] (555s left) prime_mmap (test_errors)
[485.015780] Starting subtest: test_errors
[485.016663] Starting dynamic subtest: test_errors-smem
[485.119287] Dynamic subtest test_errors-smem: SUCCESS (0.104s)
[485.120533] Subtest test_errors: SUCCESS (0.105s)
[485.225313] [084/131] (554s left) kms_properties (connector-properties-legacy)
[485.322428] Starting subtest: connector-properties-legacy
[485.323353] Starting dynamic subtest: pipe-A-eDP-1
[493.160579] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.835s)
[493.169327] Starting dynamic subtest: pipe-None-DP-1
[493.171069] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[493.178904] Starting dynamic subtest: pipe-None-HDMI-A-1
[493.180619] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[493.188702] Starting dynamic subtest: pipe-None-DP-2
[493.190437] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[493.198506] Starting dynamic subtest: pipe-None-HDMI-A-2
[493.200254] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[493.208164] Starting dynamic subtest: pipe-None-DP-3
[493.210300] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[493.220615] Starting dynamic subtest: pipe-None-DP-4
[493.222370] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[493.223249] Subtest connector-properties-legacy: SUCCESS (7.847s)
[494.037875] [085/131] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[494.140413] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[494.142055] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[494.241097] [086/131] (545s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[494.606330] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[495.439044] [087/131] (544s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[495.582884] Starting subtest: dp-mst-type-0-suspend-resume
[495.584871] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[495.684211] [088/131] (544s left) kms_flip (2x-plain-flip-interruptible)
[495.786726] Starting subtest: 2x-plain-flip-interruptible
[495.798385] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[495.893390] [089/131] (544s left) device_reset (unbind-reset-rebind)
[495.943801] Starting subtest: unbind-reset-rebind
[500.580707] Subtest unbind-reset-rebind: SUCCESS (4.628s)
[500.616024] [090/131] (539s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[500.755648] Starting subtest: cursorA-vs-flipB-atomic-transitions
[500.757430] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[500.895788] [091/131] (539s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[500.995632] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[501.366845] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[504.179817] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[504.190442] Starting dynamic subtest: pipe-A-eDP-1-4
[506.346204] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[506.358237] Starting dynamic subtest: pipe-A-eDP-1-4
[508.364432] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[508.373317] Starting dynamic subtest: pipe-A-eDP-1-x
[510.543128] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[510.914984] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[513.714469] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[513.731885] Starting dynamic subtest: pipe-B-eDP-1-4
[515.911677] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[515.928519] Starting dynamic subtest: pipe-B-eDP-1-4
[517.922194] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[517.931464] Starting dynamic subtest: pipe-B-eDP-1-x
[520.111827] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.187s)
[520.480213] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[523.254580] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[523.265358] Starting dynamic subtest: pipe-C-eDP-1-4
[525.430547] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[525.439690] Starting dynamic subtest: pipe-C-eDP-1-4
[527.439372] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[527.448238] Starting dynamic subtest: pipe-C-eDP-1-x
[529.630160] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[529.984931] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[532.780330] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[532.792549] Starting dynamic subtest: pipe-D-eDP-1-4
[534.956923] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[534.968722] Starting dynamic subtest: pipe-D-eDP-1-4
[536.965696] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[536.975853] Starting dynamic subtest: pipe-D-eDP-1-x
[539.144354] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[539.145511] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.138s)
[540.354684] [092/131] (499s left) gem_exec_schedule (submit-late-slice)
[540.420592] Starting subtest: submit-late-slice
[540.421501] Starting dynamic subtest: rcs0
[540.455199] Dynamic subtest rcs0: SUCCESS (0.036s)
[540.464007] Starting dynamic subtest: bcs0
[540.482835] Dynamic subtest bcs0: SUCCESS (0.027s)
[540.491477] Starting dynamic subtest: vcs0
[540.514973] Dynamic subtest vcs0: SUCCESS (0.032s)
[540.529611] Starting dynamic subtest: vcs1
[540.544586] Dynamic subtest vcs1: SUCCESS (0.029s)
[540.556347] Starting dynamic subtest: vecs0
[540.573126] Dynamic subtest vecs0: SUCCESS (0.028s)
[540.585019] Starting dynamic subtest: ccs0
[540.608044] Dynamic subtest ccs0: SUCCESS (0.034s)
[540.608903] Subtest submit-late-slice: SUCCESS (0.190s)
[541.621752] [093/131] (498s left) kms_cursor_edge_walk (256x256-right-edge)
[541.713126] Starting subtest: 256x256-right-edge
[541.713956] Starting dynamic subtest: pipe-A-eDP-1
[545.120036] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.407s)
[545.131842] Starting dynamic subtest: pipe-D-eDP-1
[548.257663] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[548.258648] Subtest 256x256-right-edge: SUCCESS (6.545s)
[549.044195] [094/131] (491s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[549.148859] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[549.150519] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[549.238490] [095/131] (491s left) kms_chamelium_color (ctm-green-to-red)
[549.319541] Subtest ctm-green-to-red: SKIP (0.000s)
[549.363241] [096/131] (491s left) api_intel_bb (offset-control)
[549.420293] Starting subtest: offset-control
[549.426995] Subtest offset-control: SUCCESS (0.007s)
[549.554844] [097/131] (490s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[549.648419] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[549.650365] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[549.734560] [098/131] (490s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[549.819231] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[549.820824] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[549.915147] [099/131] (490s left) syncobj_timeline (invalid-transfer-illegal-handle)
[549.962507] Starting subtest: invalid-transfer-illegal-handle
[549.963337] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[550.048770] [100/131] (490s left) kms_psr (fbc-psr2-dpms)
[550.148200] Starting subtest: fbc-psr2-dpms
[550.149007] Starting dynamic subtest: eDP-1
[550.150809] Dynamic subtest eDP-1: SKIP (0.000s)
[550.152478] Subtest fbc-psr2-dpms: SKIP (0.001s)
[550.218071] [101/131] (490s left) syncobj_wait (multi-wait-for-submit-signaled)
[550.262378] Starting subtest: multi-wait-for-submit-signaled
[550.263284] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[550.381959] [102/131] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[550.474829] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[550.476821] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[550.558024] [103/131] (490s left) gem_userptr_blits (map-fixed-invalidate-busy)
[550.630364] Starting subtest: map-fixed-invalidate-busy
[550.632127] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[550.744186] [104/131] (490s left) gen9_exec_parse (bb-start-cmd)
[550.796836] Subtest bb-start-cmd: SKIP (0.000s)
[550.874147] [105/131] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[550.972149] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[550.973878] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[551.061660] [106/131] (489s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[551.143046] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[551.144659] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[551.217270] [107/131] (489s left) kms_invalid_mode (zero-vdisplay)
[551.307511] Starting subtest: zero-vdisplay
[551.308338] Starting dynamic subtest: pipe-A-eDP-1
[551.594725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[551.603886] Starting dynamic subtest: pipe-B-eDP-1
[551.605152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[551.613385] Starting dynamic subtest: pipe-C-eDP-1
[551.614391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[551.622523] Starting dynamic subtest: pipe-D-eDP-1
[551.623549] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[551.624544] Subtest zero-vdisplay: SUCCESS (0.292s)
[552.465188] [108/131] (488s left) prime_vgem (basic-fence-read)
[552.542934] Starting subtest: basic-fence-read
[552.575018] Subtest basic-fence-read: SKIP (0.033s)
[552.691666] [109/131] (488s left) gem_eio (in-flight-internal-immediate)
[552.920348] Starting subtest: in-flight-internal-immediate
[554.590422] Subtest in-flight-internal-immediate: SUCCESS (1.669s)
[554.724238] [110/131] (486s left) kms_flip (absolute-wf_vblank)
[554.814335] Starting subtest: absolute-wf_vblank
[554.815263] Starting dynamic subtest: A-eDP1
[563.559989] Dynamic subtest A-eDP1: SUCCESS (8.718s)
[563.571251] Starting dynamic subtest: B-eDP1
[572.293748] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[572.304955] Starting dynamic subtest: C-eDP1
[581.027757] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[581.039397] Starting dynamic subtest: D-eDP1
[589.752856] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[589.753838] Subtest absolute-wf_vblank: SUCCESS (34.905s)
[590.920338] [111/131] (450s left) gem_lmem_swapping (massive-random)
[590.962160] Subtest massive-random: SKIP (0.000s)
[591.005500] [112/131] (450s left) gem_mmap_gtt (fault-concurrent-y)
[591.062103] Subtest fault-concurrent-Y: SKIP (0.000s)
[591.116093] [113/131] (449s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[591.204428] Starting subtest: primary-y-tiled-reflect-x-0
[591.266618] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[591.364401] [114/131] (449s left) kms_fbcon_fbt (fbc-suspend)
[591.417944] Starting subtest: fbc-suspend
[640.605330] Subtest fbc-suspend: SUCCESS (19.962s)
[641.926120] [115/131] (399s left) gem_ctx_shared (q-promotion)
[641.998235] Starting subtest: Q-promotion
[641.999655] Starting dynamic subtest: rcs0
[642.118481] Dynamic subtest rcs0: SUCCESS (0.119s)
[642.138609] Starting dynamic subtest: vcs0
[642.212797] Dynamic subtest vcs0: SUCCESS (0.092s)
[642.233643] Starting dynamic subtest: vcs1
[642.295354] Dynamic subtest vcs1: SUCCESS (0.082s)
[642.313161] Starting dynamic subtest: vecs0
[642.382929] Dynamic subtest vecs0: SUCCESS (0.085s)
[642.400364] Starting dynamic subtest: ccs0
[642.473293] Dynamic subtest ccs0: SUCCESS (0.091s)
[642.474427] Subtest Q-promotion: SUCCESS (0.475s)
[643.776609] [116/131] (397s left) i915_fb_tiling (basic-x-tiling)
[643.843011] Subtest basic-x-tiling: SKIP (0.000s)
[643.897659] [117/131] (397s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[643.997798] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[643.999579] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[644.088440] [118/131] (397s left) sysfs_preempt_timeout (timeout)
[644.130585] Starting subtest: timeout
[644.131770] Starting dynamic subtest: vecs0
[653.744562] Dynamic subtest vecs0: SUCCESS (9.596s)
[653.755407] Starting dynamic subtest: ccs0
[654.988966] Dynamic subtest ccs0: SUCCESS (1.251s)
[655.000350] Starting dynamic subtest: vcs0
[664.753246] Dynamic subtest vcs0: SUCCESS (9.748s)
[664.765157] Starting dynamic subtest: bcs0
[666.048380] Dynamic subtest bcs0: SUCCESS (1.302s)
[666.060275] Starting dynamic subtest: rcs0
[667.260695] Dynamic subtest rcs0: SUCCESS (1.211s)
[667.271512] Starting dynamic subtest: vcs1
[676.721412] Dynamic subtest vcs1: SUCCESS (9.447s)
[676.722597] Subtest timeout: SUCCESS (32.565s)
[676.784292] [119/131] (364s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[676.893791] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[680.862168] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.969s)
[682.083029] [120/131] (359s left) kms_atomic (crtc-invalid-params-fence)
[682.181350] Starting subtest: crtc-invalid-params-fence
[682.182291] Starting dynamic subtest: pipe-A-eDP-1
[682.598137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[682.599006] Subtest crtc-invalid-params-fence: SUCCESS (0.417s)
[683.491257] [121/131] (357s left) gem_softpin (evict-snoop)
[683.552182] Starting subtest: evict-snoop
[683.554060] Subtest evict-snoop: SKIP (0.000s)
[683.668334] [122/131] (357s left) kms_hdr (brightness-with-hdr)
[683.754296] Starting subtest: brightness-with-hdr
[683.756760] Subtest brightness-with-hdr: SKIP (0.000s)
[683.824373] [123/131] (357s left) gem_softpin (invalid)
[683.878995] Starting subtest: invalid
[683.884198] Subtest invalid: SUCCESS (0.006s)
[683.999002] [124/131] (357s left) kms_addfb_basic (too-wide)
[684.083538] Starting subtest: too-wide
[684.084460] Subtest too-wide: SUCCESS (0.000s)
[684.167453] [125/131] (357s left) syncobj_timeline (single-wait-available-submitted)
[684.217275] Starting subtest: single-wait-available-submitted
[684.218198] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[684.306100] [126/131] (357s left) drm_read (short-buffer-nonblock)
[684.446877] Starting subtest: short-buffer-nonblock
[684.447919] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[684.569161] [127/131] (357s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[684.648121] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[684.649873] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[684.718992] [128/131] (356s left) gem_madvise (dontneed-after-mmap)
[684.752325] Starting subtest: dontneed-after-mmap
[684.774593] Subtest dontneed-after-mmap: SUCCESS (0.023s)
[684.898124] [129/131] (356s left) kms_plane (pixel-format-y-tiled-modifier)
[684.984186] Starting subtest: pixel-format-y-tiled-modifier
[684.985938] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[685.054889] [130/131] (356s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[685.144143] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[685.145101] Starting dynamic subtest: pipe-A-eDP-1
[685.155076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[685.166270] Starting dynamic subtest: pipe-B-eDP-1
[685.175019] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[685.184529] Starting dynamic subtest: pipe-C-eDP-1
[685.192551] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[685.203548] Starting dynamic subtest: pipe-D-eDP-1
[685.211326] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[685.212998] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[687.425151] [131/131] (354s left) gem_ctx_engines (execute-allforone)
[687.492414] Starting subtest: execute-allforone
[687.509165] Subtest execute-allforone: SUCCESS (0.017s)
[688.814116] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ringfill
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_feature_discovery
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: i915_pm_rps
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_selftest
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_plane_cursor
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_prop_blob
results: parsing output: 37/ for test: api_intel_allocator
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: prime_self_import
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_color_pipeline
results: parsing output: 49/ for test: i915_suspend
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_chamelium_frames
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_dirtyfb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: core_auth
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: prime_busy
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: gem_pxp
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_close_race
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: prime_mmap
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_hpd
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: device_reset
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_chamelium_color
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_lmem_swapping
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_fbcon_fbt
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: i915_fb_tiling
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: sysfs_preempt_timeout
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_atomic
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_madvise
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_ctx_engines
Done.