[55.669925] Initializing watchdogs
[55.669973]   /dev/watchdog0
[55.685426] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[55.689576] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.691911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.695236] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[55.806361] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[62.661775] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.771s)
[62.794376] [002/133] (953s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[62.897169] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[62.901739] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[62.998782] [003/133] (953s left) gem_eio (banned)
[63.129191] Starting subtest: banned
[63.498836] Subtest banned: SUCCESS (0.369s)
[63.648849] [004/133] (952s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[64.013352] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[64.800198] [005/133] (951s left) drm_read (empty-nonblock)
[64.949060] Starting subtest: empty-nonblock
[64.951640] Subtest empty-nonblock: SUCCESS (0.000s)
[65.074937] [006/133] (951s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[65.148400] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[65.174719] Starting dynamic subtest: pipe-A-plane-0
[65.834585] Dynamic subtest pipe-A-plane-0: SUCCESS (0.656s)
[65.842129] Starting dynamic subtest: pipe-A-plane-3
[66.269266] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[67.417708] Starting dynamic subtest: pipe-B-plane-0
[68.101873] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[68.110864] Starting dynamic subtest: pipe-B-plane-3
[68.536435] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[68.852686] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.688s)
[69.715343] [007/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[69.786793] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[69.790889] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[69.897209] [008/133] (946s left) gem_eio (in-flight-internal-10ms)
[70.100989] Starting subtest: in-flight-internal-10ms
[71.275822] Subtest in-flight-internal-10ms: SUCCESS (1.172s)
[71.394126] [009/133] (945s left) kms_pm_rpm (package-g7)
[73.394088] Starting subtest: package-g7
[73.398803] Subtest package-g7: SKIP (0.000s)
[73.771441] [010/133] (942s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[73.865109] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[74.523053] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[74.670504] [011/133] (941s left) sw_sync (sync_multi_producer_single_consumer)
[74.706577] Starting subtest: sync_multi_producer_single_consumer
[75.783183] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[75.839663] [012/133] (940s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[75.895436] Starting subtest: y-tiled-ccs-to-x-tiled
[75.900223] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[76.097815] [013/133] (940s left) gem_wait (invalid-buf)
[76.150675] Starting subtest: invalid-buf
[76.153114] Subtest invalid-buf: SUCCESS (0.000s)
[76.361193] [014/133] (940s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[76.421150] Subtest tiled-to-untiled: SKIP (0.000s)
[76.487156] [015/133] (940s left) kms_draw_crc (draw-method-render)
[76.555947] Starting subtest: draw-method-render
[76.557836] Starting dynamic subtest: xrgb8888-untiled
[76.776765] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[76.785843] Starting dynamic subtest: rgb565-untiled
[76.998780] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[77.008696] Starting dynamic subtest: xrgb2101010-untiled
[77.210477] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[77.218845] Starting dynamic subtest: xbgr16161616f-untiled
[77.457879] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[77.466000] Starting dynamic subtest: xrgb8888-xtiled
[77.577050] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[77.586522] Starting dynamic subtest: rgb565-xtiled
[77.688390] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[77.697318] Starting dynamic subtest: xrgb2101010-xtiled
[77.799659] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[77.808078] Starting dynamic subtest: xbgr16161616f-xtiled
[77.922220] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[77.932423] Starting dynamic subtest: xrgb8888-4tiled
[78.044171] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[78.052908] Starting dynamic subtest: rgb565-4tiled
[78.155536] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[78.163540] Starting dynamic subtest: xrgb2101010-4tiled
[78.278058] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[78.286499] Starting dynamic subtest: xbgr16161616f-4tiled
[78.400369] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[78.402201] Subtest draw-method-render: SUCCESS (1.845s)
[78.500851] [016/133] (938s left) perf (non-system-wide-paranoid)
[78.610810] Starting subtest: non-system-wide-paranoid
[78.638651] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[78.680254] [017/133] (938s left) kms_dp_linktrain_fallback (dp-fallback)
[78.751242] Starting subtest: dp-fallback
[78.756775] Subtest dp-fallback: SKIP (0.000s)
[78.819824] [018/133] (938s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[78.888959] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[78.890958] Starting dynamic subtest: pipe-A-eDP-1
[79.655609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[79.671872] Starting dynamic subtest: pipe-B-eDP-1
[81.222496] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s)
[81.232237] Starting dynamic subtest: pipe-C-eDP-1
[82.710342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.486s)
[82.720388] Starting dynamic subtest: pipe-D-eDP-1
[84.247579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[84.249720] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.345s)
[85.421101] [019/133] (931s left) gem_exec_schedule (pi-userfault)
[85.596324] Starting subtest: pi-userfault
[85.598721] Starting dynamic subtest: rcs0
[85.605514] Dynamic subtest rcs0: SUCCESS (0.012s)
[85.616149] Starting dynamic subtest: bcs0
[85.618047] Dynamic subtest bcs0: SUCCESS (0.007s)
[85.626235] Starting dynamic subtest: vcs0
[85.628417] Dynamic subtest vcs0: SUCCESS (0.009s)
[85.636541] Starting dynamic subtest: vcs1
[85.638437] Dynamic subtest vcs1: SUCCESS (0.008s)
[85.646375] Starting dynamic subtest: vecs0
[85.648715] Dynamic subtest vecs0: SUCCESS (0.007s)
[85.656563] Starting dynamic subtest: ccs0
[85.658496] Dynamic subtest ccs0: SUCCESS (0.009s)
[85.660424] Subtest pi-userfault: SUCCESS (0.055s)
[85.829914] [020/133] (931s left) i915_drm_fdinfo (basics)
[85.867661] Starting subtest: basics
[85.869945] Subtest basics: SUCCESS (0.000s)
[85.932386] [021/133] (931s left) kms_chamelium_hpd (hdmi-hpd-storm)
[86.299352] Subtest hdmi-hpd-storm: SKIP (0.000s)
[87.114541] [022/133] (929s left) perf (invalid-open-flags)
[87.209296] Starting subtest: invalid-open-flags
[87.211700] Subtest invalid-open-flags: SUCCESS (0.000s)
[87.255151] [023/133] (929s left) sw_sync (alloc_merge_fence)
[87.297305] Starting subtest: alloc_merge_fence
[87.299928] Subtest alloc_merge_fence: SUCCESS (0.000s)
[87.346268] [024/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[87.420521] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[87.424614] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[87.513404] [025/133] (929s left) gem_exec_params (no-bsd)
[87.578821] Starting subtest: no-bsd
[87.581088] Subtest no-bsd: SUCCESS (0.002s)
[89.280465] [026/133] (927s left) kms_chamelium_color (ctm-limited-range)
[89.361430] Subtest ctm-limited-range: SKIP (0.000s)
[89.440053] [027/133] (927s left) kms_plane (plane-panning-bottom-right)
[89.533981] Starting subtest: plane-panning-bottom-right
[89.536307] Starting dynamic subtest: pipe-A
[91.215619] Dynamic subtest pipe-A: SUCCESS (1.679s)
[91.226989] Starting dynamic subtest: pipe-B
[93.495074] Dynamic subtest pipe-B: SUCCESS (2.278s)
[93.497403] Subtest plane-panning-bottom-right: SUCCESS (3.960s)
[94.303692] [028/133] (922s left) perf (global-sseu-config-invalid)
[94.408052] Starting subtest: global-sseu-config-invalid
[94.412468] Subtest global-sseu-config-invalid: SKIP (0.000s)
[94.449240] [029/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[94.531867] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[98.916793] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.388s)
[100.031057] [030/133] (917s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[100.089963] Starting subtest: yf-tiled-to-vebox-yf-tiled
[100.094654] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[100.275991] [031/133] (917s left) gem_exec_balancer (bonded-chain)
[100.331621] Starting subtest: bonded-chain
[107.287247] Subtest bonded-chain: SUCCESS (6.954s)
[108.257989] [032/133] (909s left) kms_color (ctm-blue-to-red)
[108.331856] Starting subtest: ctm-blue-to-red
[108.334749] Starting dynamic subtest: pipe-A-eDP-1
[108.997317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[109.006636] Starting dynamic subtest: pipe-B-eDP-1
[110.418638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[110.430887] Starting dynamic subtest: pipe-C-eDP-1
[111.785157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[111.794215] Starting dynamic subtest: pipe-D-eDP-1
[113.094830] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[113.096843] Subtest ctm-blue-to-red: SUCCESS (4.761s)
[113.956442] [033/133] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[114.034482] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[121.075377] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.044s)
[121.179929] [034/133] (896s left) kms_3d (basic)
[121.236215] Starting subtest: basic
[121.240709] Subtest basic: SKIP (0.000s)
[121.325692] [035/133] (896s left) kms_psr (fbc-psr-cursor-plane-move)
[121.400895] Starting subtest: fbc-psr-cursor-plane-move
[121.403124] Starting dynamic subtest: eDP-1
[121.407200] Dynamic subtest eDP-1: SKIP (0.000s)
[121.411257] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[121.482187] [036/133] (896s left) gem_eio (create-ext)
[121.680750] Starting subtest: create-ext
[121.967094] Subtest create-ext: SUCCESS (0.286s)
[122.081619] [037/133] (895s left) i915_power (sanity)
[122.144058] Starting subtest: sanity
[126.187915] Subtest sanity: SUCCESS (4.038s)
[128.332238] [038/133] (889s left) gem_linear_blits (normal)
[128.687905] Starting subtest: normal
[133.517955] Subtest normal: SUCCESS (4.827s)
[133.667635] [039/133] (884s left) syncobj_timeline (wait-all-complex)
[133.765054] Starting subtest: wait-all-complex
[133.979534] Subtest wait-all-complex: SUCCESS (0.212s)
[134.058968] [040/133] (883s left) kms_busy (extended-pageflip-hang-newfb)
[134.141906] Starting subtest: extended-pageflip-hang-newfb
[134.143896] Starting dynamic subtest: pipe-A
[161.045084] Dynamic subtest pipe-A: SUCCESS (26.900s)
[161.054681] Starting dynamic subtest: pipe-D
[176.021093] Dynamic subtest pipe-D: SUCCESS (14.971s)
[176.023369] Subtest extended-pageflip-hang-newfb: SUCCESS (41.877s)
[176.822998] [041/133] (840s left) prime_vgem (basic-fence-flip)
[176.966304] Starting subtest: basic-fence-flip
[177.235362] Subtest basic-fence-flip: SUCCESS (0.272s)
[177.353707] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[177.357129] [042/133] (840s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[177.436253] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[177.440633] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[177.526429] [043/133] (840s left) kms_vblank (wait-busy-hang)
[177.611647] Starting subtest: wait-busy-hang
[177.613908] Starting dynamic subtest: pipe-A-eDP-1
[203.965687] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.351s)
[203.979909] Starting dynamic subtest: pipe-D-eDP-1
[229.053862] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.083s)
[229.056215] Subtest wait-busy-hang: SUCCESS (51.438s)
[229.905247] [044/133] (788s left) gem_ctx_param (invalid-param-get)
[229.963112] Starting subtest: invalid-param-get
[229.965759] Subtest invalid-param-get: SUCCESS (0.001s)
[230.076766] [045/133] (787s left) perf (polling-parameterized)
[230.199618] Starting subtest: polling-parameterized
[250.219791] Subtest polling-parameterized: SUCCESS (20.017s)
[250.271823] [046/133] (767s left) gem_ctx_param (invalid-get-ringsize)
[250.313723] Starting subtest: invalid-get-ringsize
[250.315999] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[250.429885] [047/133] (767s left) kms_cursor_crc (cursor-onscreen-128x42)
[250.642653] Starting subtest: cursor-onscreen-128x42
[250.689045] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[250.914428] [048/133] (767s left) i915_pm_rc6_residency (media-rc6-accuracy)
[250.972871] Starting subtest: media-rc6-accuracy
[250.977272] Subtest media-rc6-accuracy: SKIP (0.000s)
[251.076597] [049/133] (767s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[251.166922] Starting subtest: fbc-1p-pri-indfb-multidraw
[264.214360] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.050s)
[265.615562] [050/133] (752s left) perf_pmu (rc6)
[265.659311] Starting subtest: rc6
[265.661140] Starting dynamic subtest: gt0
[272.017834] Dynamic subtest gt0: SUCCESS (6.358s)
[272.037955] Starting dynamic subtest: runtime-pm-gt0
[279.805438] Dynamic subtest runtime-pm-gt0: SUCCESS (7.785s)
[279.820348] Starting dynamic subtest: runtime-pm-long-gt0
[292.268661] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.460s)
[292.281628] Starting dynamic subtest: other-idle-gt0
[298.611081] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[298.623879] Starting dynamic subtest: gt1
[304.952502] Dynamic subtest gt1: SUCCESS (6.339s)
[304.965193] Starting dynamic subtest: runtime-pm-gt1
[312.428415] Dynamic subtest runtime-pm-gt1: SUCCESS (7.473s)
[312.439256] Starting dynamic subtest: runtime-pm-long-gt1
[324.852294] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.421s)
[324.864738] Starting dynamic subtest: other-idle-gt1
[331.194851] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[331.197961] Subtest rc6: SUCCESS (65.535s)
[332.341865] [051/133] (685s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[332.397511] Starting subtest: wait-all-for-submit-delayed-submit
[332.499872] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[332.552385] [052/133] (685s left) kms_flip (flip-vs-rmfb)
[332.634403] Starting subtest: flip-vs-rmfb
[332.636721] Starting dynamic subtest: A-eDP1
[341.263710] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[341.275369] Starting dynamic subtest: B-eDP1
[349.893739] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[349.905390] Starting dynamic subtest: C-eDP1
[358.509459] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[358.522100] Starting dynamic subtest: D-eDP1
[367.139690] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[367.144808] Subtest flip-vs-rmfb: SUCCESS (34.510s)
[368.304149] [053/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[368.399077] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[368.403179] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[368.475555] [054/133] (649s left) kms_big_fb (linear-32bpp-rotate-90)
[368.574210] Starting subtest: linear-32bpp-rotate-90
[368.596189] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[368.691977] [055/133] (649s left) gem_exec_balancer (parallel-keep-submit-fence)
[368.948105] Starting subtest: parallel-keep-submit-fence
[370.155471] Subtest parallel-keep-submit-fence: SUCCESS (1.211s)
[370.241157] [056/133] (648s left) gen9_exec_parse (basic-rejected)
[370.309062] Subtest basic-rejected: SKIP (0.000s)
[370.380231] [057/133] (648s left) gem_lmem_swapping (verify-random-ccs)
[370.421353] Subtest verify-random-ccs: SKIP (0.000s)
[370.459764] [058/133] (648s left) kms_psr2_su (frontbuffer-xrgb8888)
[370.513087] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[370.576802] [059/133] (647s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[370.652663] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[370.654921] Starting dynamic subtest: pipe-A-eDP-1
[370.677518] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[370.689091] Starting dynamic subtest: pipe-B-eDP-1
[370.709400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[370.718201] Starting dynamic subtest: pipe-C-eDP-1
[370.738543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[370.746972] Starting dynamic subtest: pipe-D-eDP-1
[370.767621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[370.771671] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[372.875384] [060/133] (645s left) gem_exec_store (dword)
[372.933363] Starting subtest: dword
[372.935640] Starting dynamic subtest: rcs0
[373.008987] Dynamic subtest rcs0: SUCCESS (0.076s)
[373.022051] Starting dynamic subtest: bcs0
[373.050366] Dynamic subtest bcs0: SUCCESS (0.040s)
[373.061079] Starting dynamic subtest: vcs0
[373.093102] Dynamic subtest vcs0: SUCCESS (0.041s)
[373.103810] Starting dynamic subtest: vcs1
[373.135246] Dynamic subtest vcs1: SUCCESS (0.040s)
[373.146244] Starting dynamic subtest: vecs0
[373.176154] Dynamic subtest vecs0: SUCCESS (0.039s)
[373.187152] Starting dynamic subtest: ccs0
[373.219333] Dynamic subtest ccs0: SUCCESS (0.041s)
[373.221691] Subtest dword: SUCCESS (0.289s)
[373.384999] [061/133] (645s left) gen7_exec_parse (basic-allocation)
[373.444179] Subtest basic-allocation: SKIP (0.000s)
[373.507062] [062/133] (645s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[373.593266] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[373.595111] Starting dynamic subtest: pipe-A-eDP-1
[374.004999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s)
[374.017876] Starting dynamic subtest: pipe-B-eDP-1
[374.038185] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[374.047815] Starting dynamic subtest: pipe-C-eDP-1
[374.066069] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[374.075456] Starting dynamic subtest: pipe-D-eDP-1
[374.095299] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[374.097537] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.427s)
[376.228017] [063/133] (642s left) kms_psr (psr-cursor-mmap-gtt)
[376.300521] Starting subtest: psr-cursor-mmap-gtt
[376.302802] Starting dynamic subtest: eDP-1
[378.040212] Dynamic subtest eDP-1: SUCCESS (1.738s)
[378.042727] Subtest psr-cursor-mmap-gtt: SUCCESS (1.739s)
[378.885436] [064/133] (639s left) syncobj_timeline (multi-wait-all-signaled)
[378.933541] Starting subtest: multi-wait-all-signaled
[378.935499] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[378.997512] [065/133] (639s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[380.503392] Starting subtest: dpms-mode-unset-lpsp
[384.233265] Subtest dpms-mode-unset-lpsp: SUCCESS (3.733s)
[384.577977] [066/133] (634s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[384.649234] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[384.651508] Starting dynamic subtest: pipe-A-default-mode
[387.444190] Dynamic subtest pipe-A-default-mode: SUCCESS (2.795s)
[387.446519] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.796s)
[388.262758] [067/133] (630s left) gem_create (create-ext-set-pat)
[388.424052] Starting subtest: create-ext-set-pat
[388.426739] Subtest create-ext-set-pat: SUCCESS (0.001s)
[388.494435] [068/133] (630s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[388.575431] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[394.998528] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.425s)
[395.078124] [069/133] (623s left) gem_render_tiled_blits (basic)
[395.136779] Subtest basic: SKIP (0.000s)
[395.204559] [070/133] (623s left) kms_legacy_colorkey (basic)
[395.285283] Starting subtest: basic
[395.287432] Starting dynamic subtest: pipe-A
[395.329918] Dynamic subtest pipe-A: SUCCESS (0.045s)
[395.345929] Starting dynamic subtest: pipe-B
[395.348012] Dynamic subtest pipe-B: SUCCESS (0.001s)
[395.356656] Starting dynamic subtest: pipe-C
[395.358704] Dynamic subtest pipe-C: SUCCESS (0.000s)
[395.367379] Starting dynamic subtest: pipe-D
[395.369506] Dynamic subtest pipe-D: SUCCESS (0.000s)
[395.371594] Subtest basic: SUCCESS (0.051s)
[395.407697] [071/133] (623s left) kms_flip (flip-vs-expired-vblank)
[395.490245] Starting subtest: flip-vs-expired-vblank
[395.492528] Starting dynamic subtest: A-eDP1
[404.119656] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[404.132573] Starting dynamic subtest: B-eDP1
[412.752372] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[412.765764] Starting dynamic subtest: C-eDP1
[421.371520] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[421.382326] Starting dynamic subtest: D-eDP1
[430.001311] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[430.006268] Subtest flip-vs-expired-vblank: SUCCESS (34.516s)
[431.154419] [072/133] (587s left) kms_flip (bo-too-big-interruptible)
[431.236416] Starting subtest: bo-too-big-interruptible
[431.238552] Starting dynamic subtest: A-eDP1
[432.507809] Dynamic subtest A-eDP1: SUCCESS (1.269s)
[432.521962] Starting dynamic subtest: B-eDP1
[433.745918] Dynamic subtest B-eDP1: SUCCESS (1.235s)
[433.758052] Starting dynamic subtest: C-eDP1
[434.985167] Dynamic subtest C-eDP1: SUCCESS (1.238s)
[434.995614] Starting dynamic subtest: D-eDP1
[436.231443] Dynamic subtest D-eDP1: SUCCESS (1.244s)
[436.233857] Subtest bo-too-big-interruptible: SUCCESS (4.997s)
[437.421975] [073/133] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[437.513073] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[437.517306] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[437.592202] [074/133] (581s left) kms_flip (flip-vs-dpms-on-nop)
[437.662120] Starting subtest: flip-vs-dpms-on-nop
[437.664333] Starting dynamic subtest: A-eDP1
[439.536065] Dynamic subtest A-eDP1: SUCCESS (1.876s)
[439.548785] Starting dynamic subtest: B-eDP1
[441.372509] Dynamic subtest B-eDP1: SUCCESS (1.833s)
[441.387145] Starting dynamic subtest: C-eDP1
[443.190831] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[443.200751] Starting dynamic subtest: D-eDP1
[445.037624] Dynamic subtest D-eDP1: SUCCESS (1.845s)
[445.039977] Subtest flip-vs-dpms-on-nop: SUCCESS (7.381s)
[446.202865] [075/133] (572s left) gem_ctx_persistence (smoketest)
[446.273600] Starting subtest: smoketest
[486.172668] Subtest smoketest: SUCCESS (39.894s)
[486.227678] [076/133] (532s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[486.320531] Starting subtest: y-tiled-16bpp-rotate-270
[486.324903] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[486.389428] [077/133] (532s left) kms_fence_pin_leak
[486.525897] [078/133] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[486.596447] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[493.351865] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.758s)
[493.464124] [079/133] (525s left) kms_psr (psr2-basic)
[493.548944] Starting subtest: psr2-basic
[493.551263] Starting dynamic subtest: eDP-1
[495.189281] Dynamic subtest eDP-1: SUCCESS (1.638s)
[495.191147] Subtest psr2-basic: SUCCESS (1.639s)
[495.959458] [080/133] (523s left) syncobj_timeline (host-signal-points)
[496.021564] Starting subtest: host-signal-points
[496.023542] Subtest host-signal-points: SUCCESS (0.004s)
[496.100766] [081/133] (523s left) api_intel_allocator (alloc-simple)
[496.156257] Starting subtest: alloc-simple
[496.158426] Subtest alloc-simple: SUCCESS (0.003s)
[496.247895] [082/133] (523s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[496.338281] Starting subtest: psr-rgb565-draw-render
[503.246068] Subtest psr-rgb565-draw-render: SUCCESS (6.909s)
[503.313766] [083/133] (516s left) kms_addfb_basic (too-high)
[503.394939] Starting subtest: too-high
[503.397284] Subtest too-high: SUCCESS (0.000s)
[503.467101] [084/133] (516s left) kms_content_protection (uevent)
[503.600746] Starting subtest: uevent
[503.605311] Subtest uevent: SKIP (0.000s)
[503.700443] [085/133] (515s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[503.782593] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[503.786883] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[503.829652] [086/133] (515s left) api_intel_bb (object-noreloc-keep-cache-simple)
[503.893885] Starting subtest: object-noreloc-keep-cache-simple
[503.898601] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[503.991354] [087/133] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[504.080268] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[504.084139] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[504.164416] [088/133] (515s left) kms_flip (blocking-absolute-wf_vblank)
[504.233128] Starting subtest: blocking-absolute-wf_vblank
[504.234762] Starting dynamic subtest: A-eDP1
[512.972631] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[512.983162] Starting dynamic subtest: B-eDP1
[521.707832] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[521.717789] Starting dynamic subtest: C-eDP1
[530.420111] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[530.430034] Starting dynamic subtest: D-eDP1
[539.152062] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[539.156766] Subtest blocking-absolute-wf_vblank: SUCCESS (34.924s)
[540.353477] [089/133] (479s left) gem_exec_flush (basic-wb-ro-default)
[540.414841] Starting subtest: basic-wb-ro-default
[545.871756] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[546.035225] [090/133] (473s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[546.118070] Starting subtest: fbc-indfb-scaledprimary
[549.037856] Subtest fbc-indfb-scaledprimary: SUCCESS (2.924s)
[550.161424] [091/133] (469s left) kms_pipe_crc_basic (nonblocking-crc)
[550.233064] Starting subtest: nonblocking-crc
[550.235477] Starting dynamic subtest: pipe-A-eDP-1
[551.004860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.772s)
[551.014944] Starting dynamic subtest: pipe-B-eDP-1
[552.375761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[552.390755] Starting dynamic subtest: pipe-C-eDP-1
[553.776293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[553.787321] Starting dynamic subtest: pipe-D-eDP-1
[555.106218] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[555.108471] Subtest nonblocking-crc: SUCCESS (4.873s)
[555.894473] [092/133] (463s left) syncobj_timeline (invalid-query-one-illegal-handle)
[555.945827] Starting subtest: invalid-query-one-illegal-handle
[555.948130] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[556.001604] [093/133] (463s left) syncobj_wait (wait-for-submit-complex)
[556.046840] Starting subtest: wait-for-submit-complex
[556.108849] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[556.163525] [094/133] (463s left) kms_psr (psr-sprite-plane-onoff)
[556.234951] Starting subtest: psr-sprite-plane-onoff
[556.237266] Starting dynamic subtest: eDP-1
[557.984885] Dynamic subtest eDP-1: SUCCESS (1.749s)
[557.987203] Subtest psr-sprite-plane-onoff: SUCCESS (1.750s)
[558.774595] [095/133] (461s left) gem_mmap_offset (open-flood)
[558.837730] Starting subtest: open-flood
[580.324798] Subtest open-flood: SUCCESS (21.489s)
[580.405688] [096/133] (439s left) gem_lmem_swapping (heavy-verify-random)
[580.450052] Subtest heavy-verify-random: SKIP (0.000s)
[580.490604] [097/133] (439s left) kms_rotation_crc (cursor-rotation-180)
[580.565294] Starting subtest: cursor-rotation-180
[582.049690] Subtest cursor-rotation-180: SUCCESS (1.484s)
[583.234407] [098/133] (436s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[583.315843] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[583.318633] Starting dynamic subtest: pipe-A
[583.335190] Dynamic subtest pipe-A: SKIP (0.016s)
[583.346338] Starting dynamic subtest: pipe-B
[583.363748] Dynamic subtest pipe-B: SKIP (0.028s)
[583.374212] Starting dynamic subtest: pipe-C
[583.394793] Dynamic subtest pipe-C: SKIP (0.029s)
[583.404660] Starting dynamic subtest: pipe-D
[583.422960] Dynamic subtest pipe-D: SKIP (0.029s)
[583.426796] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.105s)
[583.490381] [099/133] (436s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[583.570904] Starting subtest: modeset-transition-nonblocking-fencing
[583.573204] Starting dynamic subtest: 1x-outputs
[594.716700] Dynamic subtest 1x-outputs: SUCCESS (11.147s)
[594.719799] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.148s)
[595.556665] [100/133] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[595.634410] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[595.638456] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[595.704609] [101/133] (424s left) kms_plane_multiple (2x-tiling-y)
[595.785403] Starting subtest: 2x-tiling-y
[595.789509] Subtest 2x-tiling-y: SKIP (0.000s)
[595.835855] [102/133] (424s left) gem_exec_params (mmapped)
[595.898750] Starting subtest: mmapped
[595.901234] Subtest mmapped: SUCCESS (0.002s)
[595.990241] [103/133] (424s left) gem_pread (self)
[596.053150] Subtest self: SKIP (0.000s)
[596.126550] [104/133] (424s left) kms_cursor_edge_walk (256x256-top-edge)
[596.203296] Starting subtest: 256x256-top-edge
[596.205633] Starting dynamic subtest: pipe-A-eDP-1
[599.639973] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[599.650271] Starting dynamic subtest: pipe-D-eDP-1
[602.772343] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[602.774647] Subtest 256x256-top-edge: SUCCESS (6.570s)
[603.553773] [105/133] (416s left) syncobj_wait (wait-any-snapshot)
[603.611275] Starting subtest: wait-any-snapshot
[603.692021] Subtest wait-any-snapshot: SUCCESS (0.082s)
[603.743496] [106/133] (416s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[603.824659] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[603.828709] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[603.884438] [107/133] (416s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[603.950727] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[603.955594] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[604.110740] [108/133] (416s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[604.673281] Starting subtest: syncobj-timeline-invalid-wait
[604.675650] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[606.282905] [109/133] (414s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[606.367881] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[606.370187] Starting dynamic subtest: pipe-A-eDP-1
[606.395639] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[606.407540] Starting dynamic subtest: pipe-B-eDP-1
[606.430313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[606.439383] Starting dynamic subtest: pipe-C-eDP-1
[606.462478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[606.471404] Starting dynamic subtest: pipe-D-eDP-1
[606.496352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[606.500523] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[608.524173] [110/133] (412s left) kms_getfb (getfb2-handle-not-fb)
[608.585418] Starting subtest: getfb2-handle-not-fb
[608.587357] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[608.658245] [111/133] (411s left) vgem_basic (dmabuf-mmap)
[608.709670] Starting subtest: dmabuf-mmap
[608.714563] Subtest dmabuf-mmap: SUCCESS (0.008s)
[608.757422] [112/133] (411s left) gem_softpin (allocator-nopin)
[608.813139] Starting subtest: allocator-nopin
[608.900483] Subtest allocator-nopin: SUCCESS (0.086s)
[608.992789] [113/133] (411s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[609.076644] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[609.081076] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[609.151564] [114/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[609.230269] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[609.234407] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[609.300707] [115/133] (411s left) kms_joiner (basic-force-ultra-joiner)
[609.385920] Starting subtest: basic-force-ultra-joiner
[609.389941] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[609.430323] [116/133] (411s left) syncobj_eventfd (invalid-bad-pad)
[609.491473] Starting subtest: invalid-bad-pad
[609.493469] Subtest invalid-bad-pad: SUCCESS (0.000s)
[609.565494] [117/133] (411s left) kms_psr (fbc-pr-sprite-plane-move)
[609.651687] Starting subtest: fbc-pr-sprite-plane-move
[609.655393] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[609.708180] [118/133] (411s left) drm_buddy (drm_buddy)
[609.747266] Starting subtest: drm_buddy
[609.751344] Subtest drm_buddy: SKIP (0.001s)
[609.792686] [119/133] (411s left) syncobj_basic (bad-pad-fd-to-handle)
[609.840276] Starting subtest: bad-pad-fd-to-handle
[609.841845] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[609.906664] [120/133] (411s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[610.000071] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[610.003902] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[610.070430] [121/133] (410s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[610.121885] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[610.190748] [122/133] (410s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[610.264821] Starting subtest: psr-rgb101010-draw-mmap-wc
[617.206523] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.944s)
[617.304713] [123/133] (403s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[617.396723] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[618.221071] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[618.384727] [124/133] (402s left) sysfs_timeslice_duration (idempotent)
[618.450113] Starting subtest: idempotent
[618.452576] Starting dynamic subtest: vecs0
[618.454889] Dynamic subtest vecs0: SUCCESS (0.001s)
[618.467037] Starting dynamic subtest: ccs0
[618.469127] Dynamic subtest ccs0: SUCCESS (0.001s)
[618.478687] Starting dynamic subtest: vcs0
[618.480833] Dynamic subtest vcs0: SUCCESS (0.000s)
[618.491299] Starting dynamic subtest: bcs0
[618.493616] Dynamic subtest bcs0: SUCCESS (0.001s)
[618.502864] Starting dynamic subtest: rcs0
[618.505084] Dynamic subtest rcs0: SUCCESS (0.001s)
[618.514195] Starting dynamic subtest: vcs1
[618.516335] Dynamic subtest vcs1: SUCCESS (0.000s)
[618.518507] Subtest idempotent: SUCCESS (0.012s)
[618.555258] [125/133] (402s left) kms_vblank (query-busy-hang)
[618.634116] Starting subtest: query-busy-hang
[618.636358] Starting dynamic subtest: pipe-A-eDP-1
[644.990081] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.354s)
[645.005214] Starting dynamic subtest: pipe-D-eDP-1
[670.010345] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.018s)
[670.012675] Subtest query-busy-hang: SUCCESS (51.376s)
[670.810606] [126/133] (350s left) perf_pmu (init-sema)
[670.858600] Starting subtest: init-sema
[670.860976] Starting dynamic subtest: rcs0
[670.863308] Dynamic subtest rcs0: SUCCESS (0.002s)
[670.873277] Starting dynamic subtest: bcs0
[670.875504] Dynamic subtest bcs0: SUCCESS (0.001s)
[670.885139] Starting dynamic subtest: vcs0
[670.887313] Dynamic subtest vcs0: SUCCESS (0.000s)
[670.896251] Starting dynamic subtest: vcs1
[670.898441] Dynamic subtest vcs1: SUCCESS (0.000s)
[670.907781] Starting dynamic subtest: vecs0
[670.909690] Dynamic subtest vecs0: SUCCESS (0.000s)
[670.918696] Starting dynamic subtest: ccs0
[670.920641] Dynamic subtest ccs0: SUCCESS (0.000s)
[670.922580] Subtest init-sema: SUCCESS (0.008s)
[670.962968] [127/133] (350s left) gem_ccs (ctrl-surf-copy)
[671.012265] Starting subtest: ctrl-surf-copy
[671.016648] Subtest ctrl-surf-copy: SKIP (0.000s)
[671.081426] [128/133] (350s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[671.190570] Starting subtest: cursorA-vs-flipB-atomic-transitions
[671.195073] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[671.311591] [129/133] (350s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[671.517042] Starting subtest: cursor-rapid-movement-64x21
[671.561147] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[671.785384] [130/133] (349s left) gem_exec_schedule (thriceslice)
[671.841279] Starting subtest: thriceslice
[671.842892] Starting dynamic subtest: rcs0
[671.869551] Dynamic subtest rcs0: SUCCESS (0.029s)
[671.879774] Starting dynamic subtest: bcs0
[671.899500] Dynamic subtest bcs0: SUCCESS (0.029s)
[671.910746] Starting dynamic subtest: vcs0
[671.929093] Dynamic subtest vcs0: SUCCESS (0.029s)
[671.941105] Starting dynamic subtest: vcs1
[671.979168] Dynamic subtest vcs1: SUCCESS (0.049s)
[671.990307] Starting dynamic subtest: vecs0
[672.010344] Dynamic subtest vecs0: SUCCESS (0.029s)
[672.020043] Starting dynamic subtest: ccs0
[672.041208] Dynamic subtest ccs0: SUCCESS (0.030s)
[672.043033] Subtest thriceslice: SUCCESS (0.201s)
[672.319773] [131/133] (349s left) i915_pm_freq_api (freq-basic-api)
[672.381208] Starting subtest: freq-basic-api
[672.383682] Starting dynamic subtest: gt0
[672.386258] Dynamic subtest gt0: SUCCESS (0.003s)
[672.398119] Starting dynamic subtest: gt1
[672.400073] Dynamic subtest gt1: SUCCESS (0.004s)
[672.401944] Subtest freq-basic-api: SUCCESS (0.011s)
[672.476188] [132/133] (349s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[672.561537] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[672.565654] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[672.607360] [133/133] (348s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[672.690090] Starting subtest: fbc-2p-pri-indfb-multidraw
[672.694721] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[672.774756] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_chamelium_edid
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: gem_set_tiling_vs_blt
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_dp_linktrain_fallback
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_chamelium_color
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_3d
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: i915_power
results: parsing output: 37/ for test: gem_linear_blits
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: i915_pm_rc6_residency
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: gen7_exec_parse
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: gem_create
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_tiled_blits
results: parsing output: 69/ for test: kms_legacy_colorkey
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_fence_pin_leak
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_pread
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_getfb
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_joiner
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: drm_buddy
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: gem_ccs
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_pm_freq_api
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.