[55.811033] Initializing watchdogs
[55.811081]   /dev/watchdog0
[55.826119] [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]
[55.830457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.832842] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.836167] [001/132] (960s left) gem_exec_whisper (basic-contexts-all)
[55.921134] Starting subtest: basic-contexts-all
[67.990948] Subtest basic-contexts-all: SUCCESS (12.045s)
[68.199064] [002/132] (948s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[68.307058] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[75.608512] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.300s)
[75.769925] [003/132] (940s left) kms_addfb_basic (bad-pitch-256)
[75.836794] Starting subtest: bad-pitch-256
[75.838745] Subtest bad-pitch-256: SUCCESS (0.000s)
[76.008562] [004/132] (940s left) kms_big_fb (linear-addfb)
[76.108387] Starting subtest: linear-addfb
[76.110694] Subtest linear-addfb: SUCCESS (0.000s)
[76.237553] [005/132] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[76.336801] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[76.340839] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[76.449838] [006/132] (940s left) kms_vrr (negative-basic)
[76.546106] Starting subtest: negative-basic
[76.552642] Starting dynamic subtest: pipe-A-eDP-1
[81.965093] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[82.256252] Subtest negative-basic: SUCCESS (5.710s)
[83.111824] [007/132] (933s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[83.218826] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[83.221167] Starting dynamic subtest: pipe-A-eDP-1
[83.241901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[83.249818] Starting dynamic subtest: pipe-B-eDP-1
[83.269371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[83.277100] Starting dynamic subtest: pipe-C-eDP-1
[83.295810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[83.303567] Starting dynamic subtest: pipe-D-eDP-1
[83.322773] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[83.325029] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[85.396606] [008/132] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[85.501647] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[85.505739] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[85.633342] [009/132] (931s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[85.734685] Starting subtest: fbc-pr-cursor-mmap-cpu
[85.739131] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[85.816446] [010/132] (930s left) kms_getfb (getfb-handle-valid)
[85.917263] Starting subtest: getfb-handle-valid
[85.919609] Subtest getfb-handle-valid: SUCCESS (0.000s)
[86.026092] [011/132] (930s left) gem_exec_reloc (basic-gtt-noreloc)
[86.084099] Subtest basic-gtt-noreloc: SKIP (0.000s)
[86.157595] [012/132] (930s left) kms_feature_discovery (display)
[86.247892] Starting subtest: display
[86.250164] Subtest display: SUCCESS (0.000s)
[86.344705] [013/132] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[86.450218] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[86.453813] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[86.576699] [014/132] (930s left) kms_getfb (getfb-handle-not-fb)
[86.669734] Starting subtest: getfb-handle-not-fb
[86.671757] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[86.772436] [015/132] (930s left) prime_vgem (basic-write)
[86.914980] Starting subtest: basic-write
[86.920954] Subtest basic-write: SKIP (0.006s)
[87.045011] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[87.048224] [016/132] (929s left) kms_atomic_interruptible (universal-setplane-primary)
[87.143982] Starting subtest: universal-setplane-primary
[87.145859] Starting dynamic subtest: pipe-A-eDP-1
[94.530072] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s)
[94.532359] Subtest universal-setplane-primary: SUCCESS (7.385s)
[95.373997] [017/132] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[95.485042] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[102.735067] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.253s)
[102.911337] [018/132] (914s left) kms_color (ctm-0-75)
[103.011872] Starting subtest: ctm-0-75
[103.014117] Starting dynamic subtest: pipe-A-eDP-1
[107.694685] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.683s)
[107.703091] Starting dynamic subtest: pipe-B-eDP-1
[113.242931] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.546s)
[113.252613] Starting dynamic subtest: pipe-C-eDP-1
[118.558048] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.313s)
[118.566804] Starting dynamic subtest: pipe-D-eDP-1
[123.890741] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.332s)
[123.892930] Subtest ctm-0-75: SUCCESS (20.876s)
[124.738502] [019/132] (892s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[124.842536] Starting subtest: psr-rgb565-draw-blt
[131.760771] Subtest psr-rgb565-draw-blt: SUCCESS (6.920s)
[131.913257] [020/132] (885s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[132.009892] Starting subtest: y-tiled-8bpp-rotate-90
[132.016230] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[132.137585] [021/132] (884s left) gem_exec_fence (syncobj-signal)
[132.562022] Starting subtest: syncobj-signal
[132.567793] Subtest syncobj-signal: SUCCESS (0.005s)
[134.018163] [022/132] (883s left) kms_prop_blob (invalid-get-prop-any)
[134.078602] Starting subtest: invalid-get-prop-any
[134.080645] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[134.201982] [023/132] (882s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[134.315320] Starting subtest: psr-2p-primscrn-cur-indfb-move
[134.319598] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[134.445464] [024/132] (882s left) kms_atomic_transition (plane-all-transition-nonblocking)
[134.535639] Starting subtest: plane-all-transition-nonblocking
[134.537829] Starting dynamic subtest: pipe-A-eDP-1
[137.033925] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[137.340950] Starting dynamic subtest: pipe-B-eDP-1
[140.564642] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.234s)
[140.872626] Subtest plane-all-transition-nonblocking: SUCCESS (6.338s)
[141.710040] [025/132] (875s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[141.811413] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[141.813734] Starting dynamic subtest: pipe-A-default-mode
[142.103455] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[142.108299] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.288s)
[142.933115] [026/132] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[143.029893] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[143.034314] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[143.167145] [027/132] (874s left) gem_mmap_gtt (basic-small-bo-tiledx)
[143.227158] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[143.314945] [028/132] (874s left) kms_plane_alpha_blend (constant-alpha-mid)
[143.396071] Starting subtest: constant-alpha-mid
[143.687790] Starting dynamic subtest: pipe-A-eDP-1
[144.449387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[144.457296] Starting dynamic subtest: pipe-D-eDP-1
[145.889886] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s)
[145.892231] Subtest constant-alpha-mid: SUCCESS (2.493s)
[146.691440] [029/132] (870s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[146.778840] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[146.781186] Starting dynamic subtest: pipe-A-default-mode
[147.952892] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[147.957069] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.173s)
[148.157094] [030/132] (869s left) kms_content_protection (uevent)
[148.293223] Starting subtest: uevent
[148.297896] Subtest uevent: SKIP (0.000s)
[148.437516] [031/132] (869s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[148.494526] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[148.600098] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[148.688283] [032/132] (868s left) kms_flip (absolute-wf_vblank)
[148.774308] Starting subtest: absolute-wf_vblank
[148.776680] Starting dynamic subtest: A-eDP1
[157.572206] Dynamic subtest A-eDP1: SUCCESS (8.796s)
[157.581814] Starting dynamic subtest: B-eDP1
[166.303680] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[166.311956] Starting dynamic subtest: C-eDP1
[175.027511] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[175.035643] Starting dynamic subtest: D-eDP1
[183.767964] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[183.772869] Subtest absolute-wf_vblank: SUCCESS (34.999s)
[184.989196] [033/132] (832s left) syncobj_timeline (host-signal-points)
[185.045900] Starting subtest: host-signal-points
[185.050373] Subtest host-signal-points: SUCCESS (0.004s)
[185.198214] [034/132] (832s left) kms_universal_plane (universal-plane-pageflip-windowed)
[185.291180] Starting subtest: universal-plane-pageflip-windowed
[185.293422] Starting dynamic subtest: pipe-A-eDP-1
[185.871370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[185.879780] Starting dynamic subtest: pipe-B-eDP-1
[187.105167] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[187.114912] Starting dynamic subtest: pipe-C-eDP-1
[188.314798] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[188.322930] Starting dynamic subtest: pipe-D-eDP-1
[189.555533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[189.557458] Subtest universal-plane-pageflip-windowed: SUCCESS (4.263s)
[190.402541] [035/132] (827s left) kms_psr (psr-sprite-mmap-cpu)
[190.502867] Starting subtest: psr-sprite-mmap-cpu
[190.505152] Starting dynamic subtest: eDP-1
[192.205063] Dynamic subtest eDP-1: SUCCESS (1.703s)
[192.207734] Subtest psr-sprite-mmap-cpu: SUCCESS (1.705s)
[193.055348] [036/132] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[193.156562] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[193.160722] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[193.274866] [037/132] (824s left) gem_exec_create (madvise)
[193.326245] Starting subtest: madvise
[193.328516] Starting dynamic subtest: smem
[213.973612] Dynamic subtest smem: SUCCESS (20.645s)
[213.978757] Subtest madvise: SUCCESS (20.646s)
[214.941785] [038/132] (802s left) kms_busy (extended-modeset-hang-oldfb)
[215.048982] Starting subtest: extended-modeset-hang-oldfb
[215.051450] Starting dynamic subtest: pipe-A
[226.718779] Dynamic subtest pipe-A: SUCCESS (11.670s)
[226.727522] Starting dynamic subtest: pipe-D
[239.075852] Dynamic subtest pipe-D: SUCCESS (12.355s)
[239.078460] Subtest extended-modeset-hang-oldfb: SUCCESS (24.030s)
[239.901040] [039/132] (777s left) kms_universal_plane (cursor-fb-leak)
[239.996200] Starting subtest: cursor-fb-leak
[239.998457] Starting dynamic subtest: pipe-A-eDP-1
[240.287753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[240.297534] Starting dynamic subtest: pipe-B-eDP-1
[241.592601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[241.603291] Starting dynamic subtest: pipe-C-eDP-1
[242.908103] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s)
[242.917266] Starting dynamic subtest: pipe-D-eDP-1
[244.242199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[244.244622] Subtest cursor-fb-leak: SUCCESS (4.248s)
[245.437657] [040/132] (772s left) gem_mmap_wc (write-gtt-read-wc)
[245.494303] Subtest write-gtt-read-wc: SKIP (0.000s)
[245.565425] [041/132] (772s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[245.657149] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[245.796290] [042/132] (772s left) kms_plane_lowres (tiling-y)
[245.895195] Starting subtest: tiling-y
[245.899529] Subtest tiling-y: SKIP (0.000s)
[245.987136] [043/132] (772s left) api_intel_allocator (reopen)
[246.037913] Starting subtest: reopen
[246.042535] Subtest reopen: SUCCESS (0.005s)
[246.188505] [044/132] (771s left) kms_cursor_crc (cursor-random-128x128)
[246.389173] Starting subtest: cursor-random-128x128
[246.391103] Starting dynamic subtest: pipe-A-eDP-1
[249.731195] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.338s)
[249.757925] Starting dynamic subtest: pipe-D-eDP-1
[253.740793] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[253.743301] Subtest cursor-random-128x128: SUCCESS (7.353s)
[254.600144] [045/132] (763s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[254.713695] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[272.142896] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.426s)
[273.045018] [046/132] (745s left) sriov_basic (enable-vfs-bind-unbind-each)
[273.113665] Starting subtest: enable-vfs-bind-unbind-each
[273.116129] Starting dynamic subtest: numvfs-1
[273.196100] Dynamic subtest numvfs-1: FAIL (0.032s)
[273.203977] Starting dynamic subtest: numvfs-2
[273.275433] Dynamic subtest numvfs-2: FAIL (0.004s)
[273.285857] Starting dynamic subtest: numvfs-3
[273.358841] Dynamic subtest numvfs-3: FAIL (0.004s)
[273.367712] Starting dynamic subtest: numvfs-4
[273.439907] Dynamic subtest numvfs-4: FAIL (0.004s)
[273.449674] Starting dynamic subtest: numvfs-5
[273.521937] Dynamic subtest numvfs-5: FAIL (0.006s)
[273.531159] Starting dynamic subtest: numvfs-6
[273.604304] Dynamic subtest numvfs-6: FAIL (0.004s)
[273.614343] Starting dynamic subtest: numvfs-7
[273.687107] Dynamic subtest numvfs-7: FAIL (0.004s)
[273.696164] Starting dynamic subtest: numvfs-random
[273.768891] Dynamic subtest numvfs-random: FAIL (0.004s)
[273.771293] Subtest enable-vfs-bind-unbind-each: FAIL (0.066s)
[273.809776] [047/132] (744s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[273.915615] Starting subtest: 4-tiled-8bpp-rotate-180
[275.083371] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.169s)
[275.251580] [048/132] (742s left) gem_workarounds (basic-read-context)
[275.314019] Starting subtest: basic-read-context
[275.329098] Subtest basic-read-context: SUCCESS (0.015s)
[275.480232] [049/132] (742s left) perf (invalid-open-flags)
[275.602038] Starting subtest: invalid-open-flags
[275.603917] Subtest invalid-open-flags: SUCCESS (0.000s)
[275.643558] [050/132] (742s left) gem_gpgpu_fill (basic)
[275.706132] Starting subtest: basic
[275.708077] Starting dynamic subtest: smem
[275.712839] Dynamic subtest smem: SUCCESS (0.009s)
[275.714986] Subtest basic: SUCCESS (0.009s)
[275.844967] [051/132] (742s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[275.938725] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[275.942233] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[276.056367] [052/132] (742s left) i915_pm_rps (thresholds)
[276.115169] Starting subtest: thresholds
[276.118829] Subtest thresholds: SKIP (0.001s)
[276.182946] [053/132] (742s left) kms_psr (psr2-primary-mmap-cpu)
[276.273228] Starting subtest: psr2-primary-mmap-cpu
[276.275157] Starting dynamic subtest: eDP-1
[278.023770] Dynamic subtest eDP-1: SUCCESS (1.749s)
[278.025933] Subtest psr2-primary-mmap-cpu: SUCCESS (1.750s)
[278.904987] [054/132] (739s left) api_intel_bb (destroy-bb)
[278.956899] Starting subtest: destroy-bb
[278.964811] Subtest destroy-bb: SUCCESS (0.008s)
[279.101708] [055/132] (739s left) gem_ctx_param (invalid-set-no-zeromap)
[279.154984] Starting subtest: invalid-set-no-zeromap
[279.157437] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[279.242625] [056/132] (739s left) gem_lmem_swapping (random)
[279.279830] Subtest random: SKIP (0.000s)
[279.324932] [057/132] (739s left) gem_spin_batch (resubmit-all)
[279.390679] Starting subtest: resubmit-all
[279.392975] Starting dynamic subtest: rcs0
[279.402818] Dynamic subtest rcs0: SUCCESS (0.012s)
[279.416205] Starting dynamic subtest: bcs0
[279.418352] Dynamic subtest bcs0: SUCCESS (0.002s)
[279.425919] Starting dynamic subtest: vcs0
[279.427838] Dynamic subtest vcs0: SUCCESS (0.002s)
[279.436106] Starting dynamic subtest: vcs1
[279.437951] Dynamic subtest vcs1: SUCCESS (0.001s)
[279.445131] Starting dynamic subtest: vecs0
[279.446991] Dynamic subtest vecs0: SUCCESS (0.002s)
[279.454245] Starting dynamic subtest: ccs0
[279.456143] Dynamic subtest ccs0: SUCCESS (0.002s)
[279.457994] Subtest resubmit-all: SUCCESS (0.026s)
[280.967683] [058/132] (737s left) gem_pxp (reject-modify-context-protection-off-2)
[281.086623] Starting subtest: reject-modify-context-protection-off-2
[281.089080] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[281.219806] [059/132] (737s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[281.339199] Starting subtest: cursorA-vs-flipB-varying-size
[281.343585] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[281.508554] [060/132] (737s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[281.569642] Starting subtest: y-tiled-to-vebox-yf-tiled
[281.574165] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[281.756550] [061/132] (736s left) perf_pmu (busy)
[281.792754] Starting subtest: busy
[281.795191] Starting dynamic subtest: rcs0
[282.409447] Dynamic subtest rcs0: SUCCESS (0.617s)
[282.419861] Starting dynamic subtest: bcs0
[282.981039] Dynamic subtest bcs0: SUCCESS (0.570s)
[282.992755] Starting dynamic subtest: vcs0
[284.884210] Dynamic subtest vcs0: SUCCESS (1.899s)
[284.895919] Starting dynamic subtest: vcs1
[286.933609] Dynamic subtest vcs1: SUCCESS (2.046s)
[286.945078] Starting dynamic subtest: vecs0
[288.916511] Dynamic subtest vecs0: SUCCESS (1.979s)
[288.928065] Starting dynamic subtest: ccs0
[289.489256] Dynamic subtest ccs0: SUCCESS (0.572s)
[289.491743] Subtest busy: SUCCESS (7.698s)
[289.604858] [062/132] (729s left) perf_pmu (semaphore-busy)
[289.640558] Starting subtest: semaphore-busy
[289.642931] Starting dynamic subtest: rcs0
[291.316661] Dynamic subtest rcs0: SUCCESS (1.671s)
[291.327358] Starting dynamic subtest: bcs0
[292.949974] Dynamic subtest bcs0: SUCCESS (1.630s)
[292.961052] Starting dynamic subtest: vcs0
[297.421525] Dynamic subtest vcs0: SUCCESS (4.468s)
[297.433199] Starting dynamic subtest: vcs1
[303.437924] Dynamic subtest vcs1: SUCCESS (6.013s)
[303.449275] Starting dynamic subtest: vecs0
[309.389955] Dynamic subtest vecs0: SUCCESS (5.949s)
[309.400792] Starting dynamic subtest: ccs0
[312.531048] Dynamic subtest ccs0: SUCCESS (3.137s)
[312.533820] Subtest semaphore-busy: SUCCESS (22.887s)
[312.691076] [063/132] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[312.797555] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[319.797532] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.004s)
[319.948092] [064/132] (698s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[320.051773] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[320.054344] Starting dynamic subtest: pipe-A
[320.075387] Dynamic subtest pipe-A: SKIP (0.017s)
[320.088768] Starting dynamic subtest: pipe-B
[320.103380] Dynamic subtest pipe-B: SKIP (0.029s)
[320.113501] Starting dynamic subtest: pipe-C
[320.133446] Dynamic subtest pipe-C: SKIP (0.030s)
[320.142138] Starting dynamic subtest: pipe-D
[320.161583] Dynamic subtest pipe-D: SKIP (0.029s)
[320.165475] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.108s)
[320.292878] [065/132] (698s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[320.389881] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[320.394515] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[321.493380] [066/132] (697s left) gem_mmap_offset (partial-mmap)
[321.542486] Starting subtest: partial-mmap
[321.544801] Starting dynamic subtest: smem0
[321.547232] Dynamic subtest smem0: SUCCESS (0.005s)
[321.549518] Subtest partial-mmap: SUCCESS (0.006s)
[321.684485] [067/132] (697s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[321.775814] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[321.778170] Starting dynamic subtest: pipe-A-eDP-1
[321.801178] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[321.809759] Starting dynamic subtest: pipe-B-eDP-1
[321.830286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[321.838408] Starting dynamic subtest: pipe-C-eDP-1
[321.859335] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[321.867865] Starting dynamic subtest: pipe-D-eDP-1
[321.891030] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[321.895239] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[323.952068] [068/132] (695s left) i915_query (query-topology-kernel-writes)
[324.009586] Starting subtest: query-topology-kernel-writes
[324.011992] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[324.138129] [069/132] (694s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[324.236785] Starting subtest: psr-1p-primscrn-cur-indfb-move
[331.500803] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.266s)
[331.693140] [070/132] (687s left) dmabuf_sync_file (export-multiwait)
[331.733306] Starting subtest: export-multiwait
[331.735478] Subtest export-multiwait: SUCCESS (0.000s)
[331.798602] [071/132] (687s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[331.889820] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[331.893775] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[332.000366] [072/132] (687s left) syncobj_timeline (wait-for-submit-delayed-submit)
[332.051622] Starting subtest: wait-for-submit-delayed-submit
[332.153263] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[332.246185] [073/132] (686s left) syncobj_basic (bad-pad-handle-to-fd)
[332.299755] Starting subtest: bad-pad-handle-to-fd
[332.301770] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[332.412953] [074/132] (686s left) gem_pread (self)
[332.471734] Subtest self: SKIP (0.000s)
[332.534767] [075/132] (686s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[332.629275] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[332.631190] Starting dynamic subtest: pipe-A-eDP-1
[332.647854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[332.657382] Starting dynamic subtest: pipe-B-eDP-1
[332.673300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[332.681406] Starting dynamic subtest: pipe-C-eDP-1
[332.697497] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[332.706182] Starting dynamic subtest: pipe-D-eDP-1
[332.722905] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[332.724870] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[334.861160] [076/132] (684s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[334.945343] Starting subtest: random-ccs-data-yf-tiled-ccs
[334.947635] Starting dynamic subtest: pipe-A-eDP-1
[334.972620] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[334.981915] Starting dynamic subtest: pipe-B-eDP-1
[335.005721] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.014333] Starting dynamic subtest: pipe-C-eDP-1
[335.038338] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.046819] Starting dynamic subtest: pipe-D-eDP-1
[335.071681] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.076016] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[337.128804] [077/132] (682s left) kms_psr (pr-cursor-blt)
[337.218290] Starting subtest: pr-cursor-blt
[337.222381] Subtest pr-cursor-blt: SKIP (0.000s)
[337.313048] [078/132] (682s left) gem_userptr_blits (create-destroy-sync)
[337.384262] Starting subtest: create-destroy-sync
[342.398604] Subtest create-destroy-sync: SUCCESS (5.014s)
[342.541187] [079/132] (676s left) i915_pm_rps (basic-api)
[342.596398] Starting subtest: basic-api
[342.601027] Subtest basic-api: SKIP (0.001s)
[342.679148] [080/132] (676s left) gem_reg_read (bad-register)
[342.734796] Starting subtest: bad-register
[342.736737] Subtest bad-register: SUCCESS (0.000s)
[342.843799] [081/132] (676s left) gem_eio (throttle)
[343.042570] Starting subtest: throttle
[343.323564] Subtest throttle: SUCCESS (0.282s)
[343.501062] [082/132] (676s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[343.617566] Starting subtest: cursorB-vs-flipB-toggle
[343.621469] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[343.785118] [083/132] (675s left) gem_ctx_shared (detached-shared-gtt)
[343.848497] Starting subtest: detached-shared-gtt
[346.001488] Subtest detached-shared-gtt: SUCCESS (2.151s)
[346.942258] [084/132] (672s left) perf (invalid-oa-format-id)
[347.041420] Starting subtest: invalid-oa-format-id
[347.053317] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[347.093864] [085/132] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[347.201639] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[347.205702] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[347.315038] [086/132] (672s left) gem_create (create-ext-placement-sanity-check)
[347.491389] Starting subtest: create-ext-placement-sanity-check
[347.494450] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[347.593027] [087/132] (672s left) kms_addfb_basic (invalid-get-prop-any)
[347.647994] Starting subtest: invalid-get-prop-any
[347.650343] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[347.809889] [088/132] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[347.902608] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[347.906607] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[348.011367] [089/132] (671s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[352.962459] Starting subtest: pr-cursor-plane-move-continuous-sf
[352.967469] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[353.846208] [090/132] (666s left) kms_pm_backlight (bad-brightness)
[353.933970] Starting subtest: bad-brightness
[353.987857] Starting dynamic subtest: eDP-1
[354.306585] Dynamic subtest eDP-1: SUCCESS (0.318s)
[354.309027] Subtest bad-brightness: SUCCESS (0.374s)
[355.179533] [091/132] (664s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[355.287648] Starting subtest: yf-tiled-8bpp-rotate-270
[355.292035] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[355.416952] [092/132] (664s left) kms_lease (multimaster-lease)
[355.499562] Starting subtest: multimaster-lease
[355.501904] Subtest multimaster-lease: SUCCESS (0.004s)
[355.632195] [093/132] (664s left) fbdev (read)
[355.673870] Starting subtest: read
[356.205731] Subtest read: SUCCESS (0.527s)
[356.288382] [094/132] (663s left) kms_chamelium_frames (dp-crc-single)
[356.667992] Subtest dp-crc-single: SKIP (0.000s)
[357.470539] [095/132] (662s left) perf (oa-formats)
[357.553818] Starting subtest: oa-formats
[357.556215] Starting dynamic subtest: 0-rcs0
[357.565530] Dynamic subtest 0-rcs0: SUCCESS (0.011s)
[357.574570] Starting dynamic subtest: 1-vecs0
[357.587866] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[357.590225] Subtest oa-formats: SUCCESS (0.035s)
[357.634137] [096/132] (662s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[357.731152] Starting subtest: fbc-rgb565-draw-mmap-gtt
[357.735072] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[357.856976] [097/132] (662s left) kms_psr (psr2-sprite-render)
[357.949262] Starting subtest: psr2-sprite-render
[357.951569] Starting dynamic subtest: eDP-1
[359.698627] Dynamic subtest eDP-1: SUCCESS (1.749s)
[359.700884] Subtest psr2-sprite-render: SUCCESS (1.751s)
[360.590396] [098/132] (659s left) kms_flip (flip-vs-rmfb-interruptible)
[360.682351] Starting subtest: flip-vs-rmfb-interruptible
[360.684676] Starting dynamic subtest: A-eDP1
[369.353103] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[369.364369] Starting dynamic subtest: B-eDP1
[377.986960] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[377.997201] Starting dynamic subtest: C-eDP1
[386.609236] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[386.620295] Starting dynamic subtest: D-eDP1
[395.240494] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[395.244743] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.561s)
[396.433261] [099/132] (623s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[396.542442] Starting subtest: x-tiled-64bpp-rotate-180
[398.093346] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.550s)
[398.270820] [100/132] (622s left) gem_exec_schedule (semaphore-power)
[398.452431] Subtest semaphore-power: SKIP (0.000s)
[398.653937] [101/132] (621s left) kms_content_protection (dp-mst-lic-type-1)
[398.793982] Starting subtest: dp-mst-lic-type-1
[398.798451] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[398.940977] [102/132] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[399.034645] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[399.039236] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[399.148693] [103/132] (621s left) gen9_exec_parse (bb-oversize)
[399.196357] Subtest bb-oversize: SKIP (0.000s)
[399.276847] [104/132] (621s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[399.369178] Starting subtest: psr-dirtyfb-ioctl
[399.371495] Starting dynamic subtest: A-eDP-1
[403.302245] Dynamic subtest A-eDP-1: SUCCESS (3.933s)
[403.304597] Subtest psr-dirtyfb-ioctl: SUCCESS (3.935s)
[404.136171] [105/132] (616s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[404.236133] Starting subtest: primary-yf-tiled-reflect-x-0
[404.295789] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[404.410535] [106/132] (616s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[404.507523] Starting subtest: fbc-psr2-primary-mmap-cpu
[404.509436] Starting dynamic subtest: eDP-1
[404.513463] Dynamic subtest eDP-1: SKIP (0.000s)
[404.517532] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[404.592128] [107/132] (615s left) gem_exec_schedule (noreorder-priority)
[404.774622] Starting subtest: noreorder-priority
[404.776632] Starting dynamic subtest: rcs0
[405.928865] Dynamic subtest rcs0: SUCCESS (1.157s)
[405.941244] Starting dynamic subtest: vcs0
[407.865548] Dynamic subtest vcs0: SUCCESS (1.934s)
[407.877774] Starting dynamic subtest: vcs1
[409.921473] Dynamic subtest vcs1: SUCCESS (2.053s)
[409.933263] Starting dynamic subtest: vecs0
[411.947418] Dynamic subtest vecs0: SUCCESS (2.023s)
[411.959662] Starting dynamic subtest: ccs0
[413.111708] Dynamic subtest ccs0: SUCCESS (1.163s)
[413.114219] Subtest noreorder-priority: SUCCESS (8.342s)
[413.313803] [108/132] (607s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[413.369287] Starting subtest: invalid-single-wait-all-unsubmitted
[413.371640] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[413.485627] [109/132] (607s left) kms_flip (2x-flip-vs-wf_vblank)
[413.574121] Starting subtest: 2x-flip-vs-wf_vblank
[413.585593] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[413.675210] [110/132] (607s left) kms_pwrite_crc
[415.266249] [111/132] (605s left) kms_flip (basic-plain-flip)
[415.370720] Starting subtest: basic-plain-flip
[415.372792] Starting dynamic subtest: A-eDP1
[417.045282] Dynamic subtest A-eDP1: SUCCESS (1.676s)
[417.056304] Starting dynamic subtest: B-eDP1
[418.677462] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[418.686896] Starting dynamic subtest: C-eDP1
[420.306464] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[420.319089] Starting dynamic subtest: D-eDP1
[421.932861] Dynamic subtest D-eDP1: SUCCESS (1.625s)
[421.938182] Subtest basic-plain-flip: SUCCESS (6.569s)
[423.121301] [112/132] (597s left) kms_joiner (basic-big-joiner)
[423.225778] Subtest basic-big-joiner: SKIP (0.000s)
[423.294983] [113/132] (597s left) i915_hangman (gt-engine-hang)
[423.361616] Starting subtest: gt-engine-hang
[423.363852] Starting dynamic subtest: rcs0
[424.883504] Dynamic subtest rcs0: SUCCESS (1.522s)
[424.896069] Starting dynamic subtest: bcs0
[426.867268] Dynamic subtest bcs0: SUCCESS (1.981s)
[426.880189] Starting dynamic subtest: vcs0
[428.849600] Dynamic subtest vcs0: SUCCESS (1.980s)
[428.861955] Starting dynamic subtest: vcs1
[430.898812] Dynamic subtest vcs1: SUCCESS (2.046s)
[430.911146] Starting dynamic subtest: vecs0
[432.882196] Dynamic subtest vecs0: SUCCESS (1.980s)
[432.893987] Starting dynamic subtest: ccs0
[434.866067] Dynamic subtest ccs0: SUCCESS (1.981s)
[434.868976] Subtest gt-engine-hang: SUCCESS (11.506s)
[434.963051] [114/132] (585s left) kms_async_flips (test-time-stamp)
[435.058289] Starting subtest: test-time-stamp
[435.447818] Starting dynamic subtest: pipe-A-eDP-1
[436.225203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s)
[436.602534] Starting dynamic subtest: pipe-B-eDP-1
[437.363942] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[437.757208] Starting dynamic subtest: pipe-C-eDP-1
[438.515379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[438.893202] Starting dynamic subtest: pipe-D-eDP-1
[439.650498] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.761s)
[439.652738] Subtest test-time-stamp: SUCCESS (4.592s)
[440.817678] [115/132] (580s left) kms_setmode (invalid-clone-single-crtc-stealing)
[440.872056] Starting subtest: invalid-clone-single-crtc-stealing
[440.878667] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[440.999555] [116/132] (579s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[445.992595] Starting subtest: fbc-psr2-cursor-plane-update-sf
[445.995038] Starting dynamic subtest: pipe-A-eDP-1
[446.786559] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[446.797235] Starting dynamic subtest: pipe-B-eDP-1
[447.916091] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[447.920200] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.921s)
[449.124185] [117/132] (571s left) i915_drm_fdinfo (memory-info-purgeable)
[449.166727] Starting subtest: memory-info-purgeable
[449.169137] Starting dynamic subtest: smem0
[451.756108] Dynamic subtest smem0: SUCCESS (2.590s)
[451.758358] Subtest memory-info-purgeable: SUCCESS (2.591s)
[451.854888] [118/132] (569s left) gem_wait (write-wait)
[451.915535] Starting subtest: write-wait
[451.917656] Starting dynamic subtest: all-engines
[453.061957] Dynamic subtest all-engines: SUCCESS (1.145s)
[453.072190] Starting dynamic subtest: rcs0
[454.126115] Dynamic subtest rcs0: SUCCESS (1.062s)
[454.141692] Starting dynamic subtest: bcs0
[455.186714] Dynamic subtest bcs0: SUCCESS (1.058s)
[455.204087] Starting dynamic subtest: vcs0
[456.241967] Dynamic subtest vcs0: SUCCESS (1.053s)
[456.257069] Starting dynamic subtest: vcs1
[457.297571] Dynamic subtest vcs1: SUCCESS (1.053s)
[457.313328] Starting dynamic subtest: vecs0
[458.354328] Dynamic subtest vecs0: SUCCESS (1.054s)
[458.371972] Starting dynamic subtest: ccs0
[459.412106] Dynamic subtest ccs0: SUCCESS (1.056s)
[459.414695] Subtest write-wait: SUCCESS (7.497s)
[459.637996] [119/132] (561s left) gem_ctx_persistence (heartbeat-close)
[459.698938] Starting subtest: heartbeat-close
[459.703577] Subtest heartbeat-close: SKIP (0.000s)
[459.821412] [120/132] (561s left) kms_pm_rpm (cursor-dpms)
[462.056339] Starting subtest: cursor-dpms
[462.061489] Subtest cursor-dpms: SKIP (0.000s)
[462.450653] [121/132] (558s left) syncobj_timeline (reset-unsignaled)
[462.499329] Starting subtest: reset-unsignaled
[462.501524] Subtest reset-unsignaled: SUCCESS (0.000s)
[462.611315] [122/132] (558s left) kms_addfb_basic (size-max)
[462.704199] Starting subtest: size-max
[462.706075] Subtest size-max: SUCCESS (0.000s)
[462.829472] [123/132] (558s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[462.934971] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[463.614344] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[463.795764] [124/132] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[463.894535] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[463.898754] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[464.018376] [125/132] (557s left) sw_sync (sync_random_merge)
[464.054476] Starting subtest: sync_random_merge
[464.095059] Subtest sync_random_merge: SUCCESS (0.043s)
[464.175896] [126/132] (557s left) kms_cursor_crc (cursor-tearing-position-change)
[464.289831] Starting subtest: cursor-tearing-position-change
[464.292079] Starting dynamic subtest: pipe-A-eDP-1
[464.868924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[464.879359] Starting dynamic subtest: pipe-D-eDP-1
[466.080151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[466.082513] Subtest cursor-tearing-position-change: SUCCESS (1.788s)
[466.932745] [127/132] (554s left) gem_exec_balancer (hang)
[467.191421] Starting subtest: hang
[468.913416] Subtest hang: SUCCESS (1.727s)
[469.096351] [128/132] (552s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[469.187411] Starting subtest: blocking-absolute-wf_vblank-interruptible
[469.189744] Starting dynamic subtest: A-eDP1
[477.872373] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[477.883088] Starting dynamic subtest: B-eDP1
[486.595254] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[486.606705] Starting dynamic subtest: C-eDP1
[495.319644] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[495.329257] Starting dynamic subtest: D-eDP1
[504.043892] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[504.048786] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.861s)
[505.275711] [129/132] (516s left) gem_exec_schedule (fifo)
[505.351027] Starting subtest: fifo
[505.353316] Starting dynamic subtest: rcs0
[505.441448] Dynamic subtest rcs0: SUCCESS (0.102s)
[505.453359] Starting dynamic subtest: vcs0
[505.519579] Dynamic subtest vcs0: SUCCESS (0.077s)
[505.531921] Starting dynamic subtest: vcs1
[505.595662] Dynamic subtest vcs1: SUCCESS (0.076s)
[505.608056] Starting dynamic subtest: vecs0
[505.673521] Dynamic subtest vecs0: SUCCESS (0.077s)
[505.683338] Starting dynamic subtest: ccs0
[505.764390] Dynamic subtest ccs0: SUCCESS (0.089s)
[505.766959] Subtest fifo: SUCCESS (0.426s)
[507.022861] [130/132] (514s left) gem_exec_fence (basic-busy)
[507.204488] Starting subtest: basic-busy
[507.206783] Starting dynamic subtest: rcs0
[507.287178] Dynamic subtest rcs0: SUCCESS (0.082s)
[507.296366] Starting dynamic subtest: bcs0
[507.341666] Dynamic subtest bcs0: SUCCESS (0.052s)
[507.353353] Starting dynamic subtest: vcs0
[507.403253] Dynamic subtest vcs0: SUCCESS (0.059s)
[507.415051] Starting dynamic subtest: vcs1
[507.456441] Dynamic subtest vcs1: SUCCESS (0.051s)
[507.467703] Starting dynamic subtest: vecs0
[507.519870] Dynamic subtest vecs0: SUCCESS (0.061s)
[507.531577] Starting dynamic subtest: ccs0
[507.587048] Dynamic subtest ccs0: SUCCESS (0.065s)
[507.589759] Subtest basic-busy: SUCCESS (0.383s)
[508.958347] [131/132] (512s left) syncobj_timeline (signal-point-0)
[509.018632] Starting subtest: signal-point-0
[509.021081] Subtest signal-point-0: SUCCESS (0.000s)
[509.138200] [132/132] (512s left) sw_sync (alloc_timeline)
[509.170338] Starting subtest: alloc_timeline
[509.172641] Subtest alloc_timeline: SUCCESS (0.000s)
[509.243582] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_whisper
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_getfb
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_feature_discovery
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_color
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_prop_blob
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_create
results: parsing output: 37/ for test: kms_busy
results: parsing output: 38/ for test: kms_universal_plane
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: kms_plane_lowres
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_workarounds
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_gpgpu_fill
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_pm_rps
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: i915_query
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: dmabuf_sync_file
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_reg_read
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_pm_backlight
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: kms_chamelium_frames
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: kms_dirtyfb
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_pwrite_crc
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_joiner
results: parsing output: 112/ for test: i915_hangman
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_setmode
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_wait
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: sw_sync
Done.