[49.813620] Initializing watchdogs
[49.813688]   /dev/watchdog0
[49.829284] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[49.835318] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.837777] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.840091] [001/133] (960s left) gem_ctx_persistence (engines-cleanup)
[49.884484] Starting subtest: engines-cleanup
[49.885194] Starting dynamic subtest: rcs0
[49.924573] Dynamic subtest rcs0: SUCCESS (0.039s)
[49.936477] Starting dynamic subtest: bcs0
[49.980542] Dynamic subtest bcs0: SUCCESS (0.055s)
[49.993005] Starting dynamic subtest: vcs0
[50.030497] Dynamic subtest vcs0: SUCCESS (0.049s)
[50.042134] Starting dynamic subtest: vcs1
[50.075608] Dynamic subtest vcs1: SUCCESS (0.044s)
[50.086680] Starting dynamic subtest: vecs0
[50.116433] Dynamic subtest vecs0: SUCCESS (0.040s)
[50.117477] Subtest engines-cleanup: SUCCESS (0.229s)
[50.179948] [002/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[50.280465] Starting subtest: x-tiled-8bpp-rotate-270
[50.372456] Subtest x-tiled-8bpp-rotate-270: SKIP (0.090s)
[50.499772] [003/133] (959s left) kms_universal_plane (cursor-fb-leak)
[50.597618] Starting subtest: cursor-fb-leak
[50.599163] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.818275] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.216s)
[50.830183] Starting dynamic subtest: pipe-B-HDMI-A-1
[51.115147] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.291s)
[51.126860] Starting dynamic subtest: pipe-C-HDMI-A-1
[51.404045] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.283s)
[51.415717] Starting dynamic subtest: pipe-D-HDMI-A-1
[51.694146] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.284s)
[51.695282] Subtest cursor-fb-leak: SUCCESS (1.083s)
[51.835911] [004/133] (958s left) gem_ctx_param (invalid-size-set)
[51.871367] Starting subtest: invalid-size-set
[51.872107] Subtest invalid-size-set: SUCCESS (0.000s)
[51.929758] [005/133] (958s left) kms_flip (flip-vs-suspend)
[52.017404] Starting subtest: flip-vs-suspend
[52.019325] Starting dynamic subtest: A-HDMI-A1
[100.462754] Dynamic subtest A-HDMI-A1: SUCCESS (3.772s)
[100.469419] Starting dynamic subtest: B-HDMI-A1
[148.455932] Dynamic subtest B-HDMI-A1: SUCCESS (3.636s)
[148.462432] Starting dynamic subtest: C-HDMI-A1
[196.458194] Dynamic subtest C-HDMI-A1: SUCCESS (3.599s)
[196.465298] Starting dynamic subtest: D-HDMI-A1
[244.497339] Dynamic subtest D-HDMI-A1: SUCCESS (3.611s)
[244.500962] Subtest flip-vs-suspend: SUCCESS (14.626s)
[257.853477] [006/133] (765s left) core_debugfs (read-all-entries)
[257.896239] Starting subtest: read-all-entries
[257.933752] Subtest read-all-entries: SUCCESS (0.038s)
[258.022498] [007/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[258.111065] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[258.112395] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[258.202169] [008/133] (765s left) gem_exec_fence (expired-history)
[258.548869] Starting subtest: expired-history
[264.338990] Subtest expired-history: SUCCESS (5.711s)
[264.780158] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[264.784202] [009/133] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[264.882088] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[264.883519] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[264.973363] [010/133] (758s left) gen9_exec_parse (batch-without-end)
[265.010146] Subtest batch-without-end: SKIP (0.000s)
[265.049001] [011/133] (758s left) gem_sync (basic-all)
[265.091036] Starting subtest: basic-all
[267.343255] Subtest basic-all: SUCCESS (2.237s)
[267.522209] [012/133] (756s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[267.559259] Starting subtest: x-tiled-to-vebox-yf-tiled
[267.559998] Starting dynamic subtest: smem
[267.627434] Dynamic subtest smem: SUCCESS (0.067s)
[267.628122] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[267.808629] [013/133] (756s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[267.903677] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[268.248179] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.343s)
[268.376457] [014/133] (755s left) perf (invalid-oa-format-id)
[268.453407] Starting subtest: invalid-oa-format-id
[268.462820] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[268.498490] [015/133] (755s left) gem_softpin (evict-prime)
[268.534287] Starting subtest: evict-prime
[268.535013] Starting dynamic subtest: rcs0
[269.659381] Dynamic subtest rcs0: SUCCESS (1.119s)
[269.677313] Starting dynamic subtest: bcs0
[270.797528] Dynamic subtest bcs0: SUCCESS (1.132s)
[270.815040] Starting dynamic subtest: vcs0
[271.924403] Dynamic subtest vcs0: SUCCESS (1.122s)
[271.941402] Starting dynamic subtest: vcs1
[273.046173] Dynamic subtest vcs1: SUCCESS (1.117s)
[273.062859] Starting dynamic subtest: vecs0
[274.165251] Dynamic subtest vecs0: SUCCESS (1.115s)
[274.181876] Starting dynamic subtest: all
[275.285313] Dynamic subtest all: SUCCESS (1.116s)
[275.286245] Subtest evict-prime: SUCCESS (6.727s)
[275.375834] [016/133] (748s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[275.463634] Starting subtest: pixel-format-linear-modifier-source-clamping
[275.483438] Starting dynamic subtest: pipe-A-plane-0
[277.980499] Dynamic subtest pipe-A-plane-0: SUCCESS (2.492s)
[277.993087] Starting dynamic subtest: pipe-A-plane-3
[280.217010] Dynamic subtest pipe-A-plane-3: SUCCESS (2.233s)
[280.228662] Starting dynamic subtest: pipe-A-plane-5
[281.426378] Dynamic subtest pipe-A-plane-5: SUCCESS (1.208s)
[281.567532] Starting dynamic subtest: pipe-B-plane-0
[284.003480] Dynamic subtest pipe-B-plane-0: SUCCESS (2.442s)
[284.017519] Starting dynamic subtest: pipe-B-plane-3
[286.230202] Dynamic subtest pipe-B-plane-3: SUCCESS (2.225s)
[286.242146] Starting dynamic subtest: pipe-B-plane-5
[287.414114] Dynamic subtest pipe-B-plane-5: SUCCESS (1.182s)
[287.488624] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.013s)
[287.642834] [017/133] (736s left) kms_pm_rpm (basic-rte)
[287.677532] Starting subtest: basic-rte
[290.327517] Subtest basic-rte: SUCCESS (2.649s)
[291.692055] [018/133] (732s left) kms_psr (psr2-cursor-mmap-gtt)
[291.778743] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[291.818973] [019/133] (732s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[291.906302] Starting subtest: psr-rgb565-draw-mmap-cpu
[291.907662] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[291.990945] [020/133] (732s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[292.023889] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[292.130995] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[292.202712] [021/133] (732s left) kms_vblank (ts-continuation-idle-hang)
[292.286351] Starting subtest: ts-continuation-idle-hang
[292.287007] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.432529] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.138s)
[306.443013] Starting dynamic subtest: pipe-D-HDMI-A-1
[320.249564] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.806s)
[320.250306] Subtest ts-continuation-idle-hang: SUCCESS (27.950s)
[320.423009] [022/133] (703s left) gem_eio (wait-1us)
[320.470549] Starting subtest: wait-1us
[320.625791] Subtest wait-1us: SUCCESS (0.156s)
[320.745473] [023/133] (703s left) kms_mmap_write_crc (main)
[320.832850] Starting subtest: main
[320.834452] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.404208] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.568s)
[322.404925] Subtest main: SUCCESS (1.570s)
[322.544820] [024/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[322.639325] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[323.933122] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.293s)
[324.052884] [025/133] (700s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[324.086018] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[324.131215] [026/133] (700s left) kms_atomic (plane-primary-legacy)
[324.219971] Starting subtest: plane-primary-legacy
[324.220741] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.417457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.197s)
[324.418182] Subtest plane-primary-legacy: SUCCESS (0.199s)
[324.549389] [027/133] (699s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[324.634849] Starting subtest: addfb25-y-tiled-legacy
[324.635608] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[324.725754] [028/133] (699s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[324.812521] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[324.814139] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.820752] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[324.827956] Starting dynamic subtest: pipe-B-HDMI-A-1
[324.834503] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[324.841532] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.848074] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[324.855002] Starting dynamic subtest: pipe-D-HDMI-A-1
[324.861681] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[324.863131] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[325.041120] [029/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[325.131661] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[325.133012] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[325.234836] [030/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[325.322372] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[325.323740] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[325.406645] [031/133] (699s left) kms_psr (psr-sprite-plane-onoff)
[325.490138] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[325.536451] [032/133] (699s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[325.681104] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[325.775768] [033/133] (698s left) gem_exec_schedule (preempt-user)
[325.821280] Starting subtest: preempt-user
[325.822015] Starting dynamic subtest: rcs0
[325.843407] Dynamic subtest rcs0: SUCCESS (0.022s)
[325.851475] Starting dynamic subtest: bcs0
[325.864852] Dynamic subtest bcs0: SUCCESS (0.021s)
[325.873769] Starting dynamic subtest: vcs0
[325.886858] Dynamic subtest vcs0: SUCCESS (0.020s)
[325.895705] Starting dynamic subtest: vcs1
[325.908004] Dynamic subtest vcs1: SUCCESS (0.020s)
[325.916116] Starting dynamic subtest: vecs0
[325.927082] Dynamic subtest vecs0: SUCCESS (0.018s)
[325.927881] Subtest preempt-user: SUCCESS (0.107s)
[326.224100] [034/133] (698s left) i915_hangman (engine-engine-hang)
[326.264092] Starting subtest: engine-engine-hang
[326.264775] Starting dynamic subtest: rcs0
[326.847606] Dynamic subtest rcs0: SUCCESS (0.583s)
[326.866426] Starting dynamic subtest: bcs0
[327.433398] Dynamic subtest bcs0: SUCCESS (0.583s)
[327.452539] Starting dynamic subtest: vcs0
[328.010445] Dynamic subtest vcs0: SUCCESS (0.574s)
[328.020643] Starting dynamic subtest: vcs1
[328.584549] Dynamic subtest vcs1: SUCCESS (0.572s)
[328.596528] Starting dynamic subtest: vecs0
[329.161477] Dynamic subtest vecs0: SUCCESS (0.575s)
[329.162530] Subtest engine-engine-hang: SUCCESS (2.897s)
[329.238604] [035/133] (695s left) i915_pm_rps (waitboost)
[329.277736] Starting subtest: waitboost
[332.837365] Subtest waitboost: SUCCESS (3.526s)
[332.912379] [036/133] (691s left) gem_mmap_offset (oob-read)
[332.945365] Starting subtest: oob-read
[332.946054] Subtest oob-read: SUCCESS (0.000s)
[333.033343] [037/133] (691s left) gem_ccs (block-copy-compressed)
[333.069118] Starting subtest: block-copy-compressed
[333.070530] Subtest block-copy-compressed: SKIP (0.000s)
[333.136232] [038/133] (691s left) gem_softpin (overlap)
[333.174792] Starting subtest: overlap
[334.122676] Subtest overlap: SUCCESS (0.939s)
[334.220917] [039/133] (690s left) perf_pmu (idle-no-semaphores)
[334.255788] Starting subtest: idle-no-semaphores
[334.256499] Starting dynamic subtest: rcs0
[334.787677] Dynamic subtest rcs0: SUCCESS (0.522s)
[334.798524] Starting dynamic subtest: bcs0
[335.304202] Dynamic subtest bcs0: SUCCESS (0.514s)
[335.314682] Starting dynamic subtest: vcs0
[335.823681] Dynamic subtest vcs0: SUCCESS (0.517s)
[335.834354] Starting dynamic subtest: vcs1
[336.339445] Dynamic subtest vcs1: SUCCESS (0.513s)
[336.350246] Starting dynamic subtest: vecs0
[336.863043] Dynamic subtest vecs0: SUCCESS (0.521s)
[336.863766] Subtest idle-no-semaphores: SUCCESS (2.598s)
[336.927661] [040/133] (688s left) kms_feature_discovery (display-1x)
[337.014070] Starting subtest: display-1x
[337.014767] Subtest display-1x: SUCCESS (0.000s)
[337.077608] [041/133] (687s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[337.170710] Starting subtest: cursor-rapid-movement-64x64
[337.171395] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.415504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.246s)
[337.451263] Starting dynamic subtest: pipe-D-HDMI-A-1
[337.654058] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.212s)
[337.654795] Subtest cursor-rapid-movement-64x64: SUCCESS (0.490s)
[337.814118] [042/133] (687s left) i915_pm_rpm (system-suspend-execbuf)
[339.212549] Starting subtest: system-suspend-execbuf
[381.291201] Subtest system-suspend-execbuf: SUCCESS (27.119s)
[381.508097] [043/133] (643s left) gem_mmap_gtt (cpuset-medium-copy)
[381.543192] Starting subtest: cpuset-medium-copy
[388.075079] Subtest cpuset-medium-copy: SUCCESS (6.519s)
[388.144835] [044/133] (636s left) gem_pwrite_snooped
[388.348490] [045/133] (636s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[388.438385] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[388.439048] Starting dynamic subtest: pipe-A
[388.559354] Dynamic subtest pipe-A: SUCCESS (0.121s)
[388.569579] Starting dynamic subtest: pipe-B
[388.685775] Dynamic subtest pipe-B: SUCCESS (0.125s)
[388.696058] Starting dynamic subtest: pipe-C
[388.812290] Dynamic subtest pipe-C: SUCCESS (0.125s)
[388.820946] Starting dynamic subtest: pipe-D
[388.956804] Dynamic subtest pipe-D: SUCCESS (0.143s)
[388.957493] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.519s)
[389.135359] [046/133] (636s left) kms_psr2_su (page_flip-xrgb8888)
[389.169429] Subtest page_flip-XRGB8888: SKIP (0.000s)
[389.214241] [047/133] (636s left) kms_flip (basic-flip-vs-dpms)
[389.298287] Starting subtest: basic-flip-vs-dpms
[389.300509] Starting dynamic subtest: A-HDMI-A1
[390.036374] Dynamic subtest A-HDMI-A1: SUCCESS (0.735s)
[390.048741] Starting dynamic subtest: B-HDMI-A1
[390.683918] Dynamic subtest B-HDMI-A1: SUCCESS (0.645s)
[390.693389] Starting dynamic subtest: C-HDMI-A1
[391.327353] Dynamic subtest C-HDMI-A1: SUCCESS (0.640s)
[391.335492] Starting dynamic subtest: D-HDMI-A1
[391.976548] Dynamic subtest D-HDMI-A1: SUCCESS (0.648s)
[391.979153] Subtest basic-flip-vs-dpms: SUCCESS (2.678s)
[392.102150] [048/133] (633s left) gem_exec_balancer (invalid-balancer)
[392.148395] Starting subtest: invalid-balancer
[393.454334] Subtest invalid-balancer: SUCCESS (1.296s)
[393.641634] [049/133] (631s left) kms_setmode (basic-clone-single-crtc)
[393.675617] Starting subtest: basic-clone-single-crtc
[393.677741] Subtest basic-clone-single-crtc: SKIP (0.000s)
[393.736928] [050/133] (631s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[393.837103] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[393.838474] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[393.946569] [051/133] (631s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[394.036353] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[394.045014] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[394.113055] [052/133] (631s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[394.154233] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[394.154961] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[394.220042] [053/133] (631s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[394.304710] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[394.306539] Starting dynamic subtest: pipe-A-HDMI-A-1
[394.313362] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[394.321575] Starting dynamic subtest: pipe-B-HDMI-A-1
[394.328326] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[394.336507] Starting dynamic subtest: pipe-C-HDMI-A-1
[394.343209] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[394.351084] Starting dynamic subtest: pipe-D-HDMI-A-1
[394.357906] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[394.359309] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[394.536529] [054/133] (630s left) kms_content_protection (uevent)
[394.627775] Starting subtest: uevent
[394.632937] Subtest uevent: SKIP (0.003s)
[394.716339] [055/133] (630s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[394.804332] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[394.805649] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[394.893682] [056/133] (630s left) kms_plane (plane-position-hole-dpms)
[394.977564] Starting subtest: plane-position-hole-dpms
[395.191493] Starting dynamic subtest: pipe-A-plane-1
[395.533010] Dynamic subtest pipe-A-plane-1: SUCCESS (0.341s)
[395.541610] Starting dynamic subtest: pipe-A-plane-2
[395.846376] Dynamic subtest pipe-A-plane-2: SUCCESS (0.312s)
[395.854687] Starting dynamic subtest: pipe-A-plane-3
[396.178513] Dynamic subtest pipe-A-plane-3: SUCCESS (0.331s)
[396.188034] Starting dynamic subtest: pipe-A-plane-4
[396.516156] Dynamic subtest pipe-A-plane-4: SUCCESS (0.336s)
[396.525882] Starting dynamic subtest: pipe-A-plane-5
[396.882100] Dynamic subtest pipe-A-plane-5: SUCCESS (0.365s)
[396.891335] Starting dynamic subtest: pipe-A-plane-6
[397.229416] Dynamic subtest pipe-A-plane-6: SUCCESS (0.347s)
[397.241180] Starting dynamic subtest: pipe-A-plane-7
[397.242544] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[397.429377] Starting dynamic subtest: pipe-B-plane-1
[397.769250] Dynamic subtest pipe-B-plane-1: SUCCESS (0.346s)
[397.777663] Starting dynamic subtest: pipe-B-plane-2
[398.081440] Dynamic subtest pipe-B-plane-2: SUCCESS (0.311s)
[398.090298] Starting dynamic subtest: pipe-B-plane-3
[398.425068] Dynamic subtest pipe-B-plane-3: SUCCESS (0.341s)
[398.433403] Starting dynamic subtest: pipe-B-plane-4
[398.756070] Dynamic subtest pipe-B-plane-4: SUCCESS (0.331s)
[398.765612] Starting dynamic subtest: pipe-B-plane-5
[399.076069] Dynamic subtest pipe-B-plane-5: SUCCESS (0.319s)
[399.088276] Starting dynamic subtest: pipe-B-plane-6
[399.398948] Dynamic subtest pipe-B-plane-6: SUCCESS (0.321s)
[399.407124] Starting dynamic subtest: pipe-B-plane-7
[399.408443] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[399.409107] Subtest plane-position-hole-dpms: SUCCESS (4.422s)
[399.562390] [057/133] (626s left) gem_mmap_gtt (big-copy)
[399.600078] Starting subtest: big-copy
[405.730388] Subtest big-copy: SUCCESS (6.131s)
[405.797813] [058/133] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[405.934417] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[405.935729] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[406.021049] [059/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[406.109359] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[407.302745] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.194s)
[407.424458] [060/133] (618s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[407.512961] Starting subtest: crc-primary-suspend-y-tiled-ccs
[407.513677] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.516430] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[407.526557] Starting dynamic subtest: pipe-B-HDMI-A-1
[407.529433] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[407.539485] Starting dynamic subtest: pipe-C-HDMI-A-1
[407.542276] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[407.551941] Starting dynamic subtest: pipe-D-HDMI-A-1
[407.554563] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[407.555875] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s)
[407.744780] [061/133] (618s left) kms_chamelium_audio (dp-audio-edid)
[407.881780] Subtest dp-audio-edid: SKIP (0.000s)
[407.982223] [062/133] (617s left) perf_pmu (interrupts)
[408.023049] Starting subtest: interrupts
[409.116571] Subtest interrupts: SUCCESS (1.085s)
[409.192602] [063/133] (616s left) syncobj_wait (single-wait-all-for-submit-signaled)
[409.235349] Starting subtest: single-wait-all-for-submit-signaled
[409.236051] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[409.306272] [064/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[409.396542] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[409.397952] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[409.490105] [065/133] (616s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[409.576770] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[409.577457] Starting dynamic subtest: pipe-A-valid-mode
[410.588198] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.011s)
[410.590219] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.013s)
[410.739285] [066/133] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[410.834542] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[410.835928] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[410.942342] [067/133] (615s left) gem_exec_schedule (fairslice)
[410.985092] Starting subtest: fairslice
[410.985800] Starting dynamic subtest: rcs0
[413.006717] Dynamic subtest rcs0: SUCCESS (2.011s)
[413.017179] Starting dynamic subtest: bcs0
[415.018521] Dynamic subtest bcs0: SUCCESS (2.010s)
[415.029440] Starting dynamic subtest: vcs0
[417.030218] Dynamic subtest vcs0: SUCCESS (2.010s)
[417.040916] Starting dynamic subtest: vcs1
[419.042193] Dynamic subtest vcs1: SUCCESS (2.010s)
[419.053884] Starting dynamic subtest: vecs0
[421.052677] Dynamic subtest vecs0: SUCCESS (2.010s)
[421.053543] Subtest fairslice: SUCCESS (10.057s)
[421.341039] [068/133] (604s left) gem_userptr_blits (vma-merge)
[421.393899] Starting subtest: vma-merge
[421.447524] Subtest vma-merge: SUCCESS (0.054s)
[421.555321] [069/133] (604s left) gem_workarounds (suspend-resume-fd)
[421.604722] Starting subtest: suspend-resume-fd
[437.476187] Subtest suspend-resume-fd: SUCCESS (1.227s)
[450.622297] [070/133] (588s left) kms_flip (absolute-wf_vblank-interruptible)
[450.716803] Starting subtest: absolute-wf_vblank-interruptible
[450.719651] Starting dynamic subtest: A-HDMI-A1
[458.417733] Dynamic subtest A-HDMI-A1: SUCCESS (7.585s)
[458.426724] Starting dynamic subtest: B-HDMI-A1
[466.067409] Dynamic subtest B-HDMI-A1: SUCCESS (7.628s)
[466.076745] Starting dynamic subtest: C-HDMI-A1
[473.752666] Dynamic subtest C-HDMI-A1: SUCCESS (7.642s)
[473.760871] Starting dynamic subtest: D-HDMI-A1
[481.388333] Dynamic subtest D-HDMI-A1: SUCCESS (7.653s)
[481.391813] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.522s)
[481.539251] [071/133] (557s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[481.638745] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[481.640219] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[481.722623] [072/133] (557s left) kms_flip (2x-plain-flip)
[481.808303] Starting subtest: 2x-plain-flip
[481.817602] Subtest 2x-plain-flip: SKIP (0.009s)
[481.886527] [073/133] (557s left) gem_workarounds (reset)
[481.931688] Starting subtest: reset
[481.942418] Subtest reset: SUCCESS (0.010s)
[482.047627] [074/133] (557s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[482.137167] Starting subtest: fbcpsr-rgb565-draw-pwrite
[482.138491] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[482.230795] [075/133] (557s left) prime_mmap (test_reprime)
[482.264413] Starting subtest: test_reprime
[482.265171] Starting dynamic subtest: test_reprime-smem
[482.266905] Dynamic subtest test_reprime-smem: SUCCESS (0.002s)
[482.267596] Subtest test_reprime: SUCCESS (0.003s)
[482.375870] [076/133] (557s left) gem_exec_reloc (basic-gtt-cpu)
[482.413221] Starting subtest: basic-gtt-cpu
[482.420280] Subtest basic-gtt-cpu: SUCCESS (0.007s)
[482.539731] [077/133] (556s left) sw_sync (sync_busy_fork_unixsocket)
[482.571717] Starting subtest: sync_busy_fork_unixsocket
[482.580988] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[482.629929] [078/133] (556s left) gem_exec_whisper (basic-sync-all)
[482.673413] Starting subtest: basic-sync-all
[484.129489] Subtest basic-sync-all: SUCCESS (1.456s)
[484.300310] [079/133] (555s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[484.392175] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[484.393521] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[484.488752] [080/133] (555s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[484.941735] Starting subtest: syncobj-backward-timeline-chain-engines
[485.006891] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.073s)
[485.191824] [081/133] (554s left) kms_setmode (invalid-clone-single-crtc)
[485.224468] Starting subtest: invalid-clone-single-crtc
[485.226591] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[485.293367] [082/133] (554s left) api_intel_allocator (two-level-inception-interruptible)
[485.326503] Starting subtest: two-level-inception-interruptible
[490.783355] Subtest two-level-inception-interruptible: SUCCESS (5.423s)
[490.866374] [083/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[490.961127] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[490.962491] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[491.048234] [084/133] (548s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[491.134755] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[491.175184] [085/133] (548s left) gem_pxp (create-protected-buffer)
[491.277253] Starting subtest: create-protected-buffer
[491.278219] Subtest create-protected-buffer: SUCCESS (0.000s)
[491.372960] [086/133] (548s left) kms_big_fb (x-tiled-addfb-size-overflow)
[491.477664] Starting subtest: x-tiled-addfb-size-overflow
[491.478383] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[491.574699] [087/133] (548s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[491.658460] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[491.659823] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[491.720228] [088/133] (548s left) kms_force_connector_basic (force-edid)
[491.846778] Starting subtest: force-edid
[491.992183] Subtest force-edid: SUCCESS (0.148s)
[492.154806] [089/133] (547s left) gem_userptr_blits (readonly-unsync)
[492.197252] Subtest readonly-unsync: SKIP (0.000s)
[492.313897] [090/133] (547s left) kms_color (ctm-0-50)
[492.400624] Starting subtest: ctm-0-50
[492.401302] Starting dynamic subtest: pipe-A-HDMI-A-1
[493.211611] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.812s)
[493.221068] Starting dynamic subtest: pipe-B-HDMI-A-1
[494.005494] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.792s)
[494.015684] Starting dynamic subtest: pipe-C-HDMI-A-1
[494.799462] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.791s)
[494.808120] Starting dynamic subtest: pipe-D-HDMI-A-1
[495.585592] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.785s)
[495.586364] Subtest ctm-0-50: SUCCESS (3.185s)
[495.746558] [091/133] (544s left) gem_ctx_persistence (legacy-engines-cleanup)
[495.786949] Starting subtest: legacy-engines-cleanup
[495.787651] Starting dynamic subtest: render
[495.826949] Dynamic subtest render: SUCCESS (0.039s)
[495.844047] Starting dynamic subtest: bsd1
[495.872017] Dynamic subtest bsd1: SUCCESS (0.042s)
[495.890508] Starting dynamic subtest: bsd2
[495.912807] Dynamic subtest bsd2: SUCCESS (0.038s)
[495.929604] Starting dynamic subtest: blt
[495.965082] Dynamic subtest blt: SUCCESS (0.050s)
[495.983557] Starting dynamic subtest: vebox
[496.007876] Dynamic subtest vebox: SUCCESS (0.040s)
[496.008885] Subtest legacy-engines-cleanup: SUCCESS (0.222s)
[496.080415] [092/133] (544s left) gem_exec_reloc (basic-write-gtt-noreloc)
[496.119346] Starting subtest: basic-write-gtt-noreloc
[496.120708] Subtest basic-write-gtt-noreloc: SUCCESS (0.002s)
[496.230776] [093/133] (543s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[496.268930] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[496.269649] Starting dynamic subtest: smem
[496.377129] Dynamic subtest smem: SUCCESS (0.107s)
[496.377854] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.108s)
[496.562313] [094/133] (543s left) i915_drm_fdinfo (virtual-busy-all)
[496.597872] Starting subtest: virtual-busy-all
[497.114736] Subtest virtual-busy-all: SUCCESS (0.517s)
[497.190385] [095/133] (543s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[497.224446] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[497.331732] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[497.401160] [096/133] (542s left) gem_eio (create-ext)
[497.442449] Starting subtest: create-ext
[497.469832] Subtest create-ext: SUCCESS (0.026s)
[497.591326] [097/133] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[497.683063] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[497.684436] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[497.783316] [098/133] (542s left) kms_cursor_crc (cursor-alpha-transparent)
[497.869507] Starting subtest: cursor-alpha-transparent
[497.871294] Starting dynamic subtest: pipe-A-HDMI-A-1
[498.151997] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.280s)
[498.163257] Starting dynamic subtest: pipe-D-HDMI-A-1
[498.394522] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.240s)
[498.395246] Subtest cursor-alpha-transparent: SUCCESS (0.525s)
[498.550657] [099/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[498.642529] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[498.643904] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[498.731472] [100/133] (541s left) kms_vrr (seamless-rr-switch-drrs)
[498.815433] Starting subtest: seamless-rr-switch-drrs
[498.817407] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[498.872124] [101/133] (541s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[499.012408] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[499.101443] [102/133] (541s left) kms_lease (master-vs-lease)
[499.193061] Starting subtest: master-vs-lease
[499.193844] Subtest master-vs-lease: SUCCESS (0.001s)
[499.260299] [103/133] (541s left) kms_getfb (getfb-addfb-different-handles)
[499.345529] Starting subtest: getfb-addfb-different-handles
[499.346304] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[499.445260] [104/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[499.533321] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[499.534722] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[499.627227] [105/133] (540s left) kms_joiner (invalid-modeset-force-big-joiner)
[499.714805] Starting subtest: invalid-modeset-force-big-joiner
[499.716200] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[499.777196] [106/133] (540s left) gem_exec_store (pages)
[499.817718] Starting subtest: pages
[499.818424] Starting dynamic subtest: rcs0
[499.870821] Dynamic subtest rcs0: SUCCESS (0.052s)
[499.880839] Starting dynamic subtest: bcs0
[499.924636] Dynamic subtest bcs0: SUCCESS (0.053s)
[499.939877] Starting dynamic subtest: vcs0
[499.986372] Dynamic subtest vcs0: SUCCESS (0.060s)
[499.997026] Starting dynamic subtest: vcs1
[500.045576] Dynamic subtest vcs1: SUCCESS (0.058s)
[500.062940] Starting dynamic subtest: vecs0
[500.102252] Dynamic subtest vecs0: SUCCESS (0.054s)
[500.103173] Subtest pages: SUCCESS (0.285s)
[500.288231] [107/133] (540s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[500.373523] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[500.374910] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[500.433857] [108/133] (540s left) kms_psr (fbc-psr-sprite-plane-move)
[500.521290] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[500.564899] [109/133] (540s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[500.659284] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[500.660659] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[500.752807] [110/133] (540s left) syncobj_wait (wait-zero-handles)
[500.785672] Starting subtest: wait-zero-handles
[500.786372] Subtest wait-zero-handles: SUCCESS (0.000s)
[500.860214] [111/133] (539s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[500.946670] Starting subtest: cursor-vs-flip-toggle
[533.204436] Subtest cursor-vs-flip-toggle: SUCCESS (32.247s)
[533.334494] [112/133] (507s left) gem_ctx_engines (execute-one)
[533.382012] Starting subtest: execute-one
[534.623965] Subtest execute-one: SUCCESS (1.233s)
[534.795079] [113/133] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[534.886402] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[534.887792] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[534.985055] [114/133] (505s left) dmabuf_sync_file (export-before-signal)
[535.022685] Starting subtest: export-before-signal
[535.023395] Subtest export-before-signal: SUCCESS (0.001s)
[535.083713] [115/133] (505s left) kms_cursor_edge_walk (256x256-top-bottom)
[535.170662] Starting subtest: 256x256-top-bottom
[535.171476] Starting dynamic subtest: pipe-A-HDMI-A-1
[536.922067] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.749s)
[536.932703] Starting dynamic subtest: pipe-D-HDMI-A-1
[538.574245] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.650s)
[538.576176] Subtest 256x256-top-bottom: SUCCESS (3.404s)
[538.692726] [116/133] (502s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[538.784864] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[538.830688] [117/133] (502s left) syncobj_timeline (single-wait-for-submit-signaled)
[538.863885] Starting subtest: single-wait-for-submit-signaled
[538.864612] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[538.926294] [118/133] (502s left) gem_workarounds (basic-read-context)
[538.971911] Starting subtest: basic-read-context
[538.981386] Subtest basic-read-context: SUCCESS (0.009s)
[539.095424] [119/133] (502s left) kms_psr (pr-cursor-mmap-cpu)
[539.180773] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[539.226824] [120/133] (501s left) kms_psr (fbc-psr2-basic)
[539.312252] Subtest fbc-psr2-basic: SKIP (0.000s)
[539.355625] [121/133] (501s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[539.442394] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[539.443103] Starting dynamic subtest: pipe-A-HDMI-A-1
[539.460732] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[539.471306] Starting dynamic subtest: pipe-B-HDMI-A-1
[539.488231] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[539.496662] Starting dynamic subtest: pipe-C-HDMI-A-1
[539.514164] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[539.524242] Starting dynamic subtest: pipe-D-HDMI-A-1
[539.541111] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[539.542398] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[539.695726] [122/133] (501s left) gem_ctx_param (non-root-set)
[539.730233] Starting subtest: non-root-set
[539.743643] Subtest non-root-set: SUCCESS (0.014s)
[539.815307] [123/133] (501s left) gem_pread (display)
[539.848235] Starting subtest: display
[540.679617] Subtest display: SUCCESS (0.822s)
[540.766475] [124/133] (500s left) gem_exec_schedule (preempt-other-chain)
[540.810618] Starting subtest: preempt-other-chain
[540.811355] Starting dynamic subtest: rcs0
[540.849084] Dynamic subtest rcs0: SUCCESS (0.038s)
[540.860547] Starting dynamic subtest: bcs0
[540.886761] Dynamic subtest bcs0: SUCCESS (0.036s)
[540.898177] Starting dynamic subtest: vcs0
[540.924828] Dynamic subtest vcs0: SUCCESS (0.037s)
[540.935336] Starting dynamic subtest: vcs1
[540.962020] Dynamic subtest vcs1: SUCCESS (0.036s)
[540.971422] Starting dynamic subtest: vecs0
[541.000571] Dynamic subtest vecs0: SUCCESS (0.038s)
[541.001379] Subtest preempt-other-chain: SUCCESS (0.190s)
[541.352155] [125/133] (500s left) prime_busy (hang)
[541.391675] Starting subtest: hang
[541.392444] Starting dynamic subtest: rcs0
[555.013349] Dynamic subtest rcs0: SUCCESS (13.591s)
[555.021698] Starting dynamic subtest: bcs0
[561.797212] Dynamic subtest bcs0: SUCCESS (6.786s)
[561.807167] Starting dynamic subtest: vcs0
[568.837387] Dynamic subtest vcs0: SUCCESS (7.041s)
[568.845635] Starting dynamic subtest: vcs1
[575.815557] Dynamic subtest vcs1: SUCCESS (6.976s)
[575.824061] Starting dynamic subtest: vecs0
[582.789389] Dynamic subtest vecs0: SUCCESS (6.976s)
[582.790240] Subtest hang: SUCCESS (41.376s)
[582.858630] [126/133] (458s left) kms_pm_rpm (system-suspend-modeset)
[584.256817] Starting subtest: system-suspend-modeset
[603.685348] Subtest system-suspend-modeset: SUCCESS (4.731s)
[614.958913] [127/133] (437s left) kms_properties (invalid-properties-legacy)
[615.063162] Starting subtest: invalid-properties-legacy
[615.280984] Subtest invalid-properties-legacy: SUCCESS (0.206s)
[615.335729] [128/133] (437s left) gem_fence_thrash (bo-write-verify-y)
[615.368737] Starting subtest: bo-write-verify-y
[616.522330] Subtest bo-write-verify-y: SUCCESS (1.126s)
[616.617687] [129/133] (436s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[616.650887] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[616.651586] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[616.717404] [130/133] (435s left) kms_cursor_legacy (single-bo)
[616.805821] Starting subtest: single-bo
[616.806529] Starting dynamic subtest: pipe-A
[622.278253] Dynamic subtest pipe-A: SUCCESS (5.379s)
[622.287060] Starting dynamic subtest: pipe-B
[627.688701] Dynamic subtest pipe-B: SUCCESS (5.378s)
[627.697236] Starting dynamic subtest: pipe-C
[633.084254] Dynamic subtest pipe-C: SUCCESS (5.378s)
[633.093033] Starting dynamic subtest: pipe-D
[638.473561] Dynamic subtest pipe-D: SUCCESS (5.378s)
[638.482903] Starting dynamic subtest: all-pipes
[643.852728] Dynamic subtest all-pipes: SUCCESS (5.379s)
[643.853551] Subtest single-bo: SUCCESS (26.897s)
[643.892915] [131/133] (408s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[643.929011] Starting subtest: invalid-bsd1-flag-on-blt
[643.929768] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[644.020881] [132/133] (408s left) gem_close_race (basic-threads)
[644.063881] Starting subtest: basic-threads
[645.284502] Subtest basic-threads: SUCCESS (1.220s)
[645.465591] [133/133] (407s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[645.562502] Starting subtest: y-tiled-32bpp-rotate-0
[646.743453] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.180s)
[646.864961] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_universal_plane
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: core_debugfs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_mmap_write_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pipe_b_c_ivb
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_pwrite_snooped
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_psr2_su
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_setmode
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_setmode
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_force_connector_basic
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_joiner
results: parsing output: 105/ for test: gem_exec_store
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_workarounds
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: gem_pread
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: prime_busy
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: gem_close_race
results: parsing output: 132/ for test: kms_big_fb
Done.