[34.467018] Initializing watchdogs
[34.467054]   /dev/watchdog0
[34.471594] [001/129] (960s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[34.500400] Starting subtest: addfb25-x-tiled-mismatch-legacy
[34.501111] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[34.676085] [002/129] (960s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[34.789050] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[34.801512] [003/129] (960s left) gem_mmap_gtt (basic-copy)
[34.832727] Starting subtest: basic-copy
[35.248715] Subtest basic-copy: SUCCESS (0.416s)
[35.344292] [004/129] (959s left) kms_flip (blocking-wf_vblank)
[35.454352] Starting subtest: blocking-wf_vblank
[35.455047] Starting dynamic subtest: A-HDMI-A1
[51.179656] Dynamic subtest A-HDMI-A1: SUCCESS (15.724s)
[51.186722] Starting dynamic subtest: B-HDMI-A1
[51.650489] Dynamic subtest B-HDMI-A1: FAIL (0.451s)
[51.651144] Subtest blocking-wf_vblank: FAIL (16.178s)
[51.730593] [005/129] (943s left) gem_workarounds (suspend-resume-fd)
[51.771597] Starting subtest: suspend-resume-fd
[68.960837] Subtest suspend-resume-fd: SUCCESS (17.295s)
[75.014659] [006/129] (925s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[75.118748] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[75.119401] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.125836] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[75.131053] Starting dynamic subtest: pipe-B-HDMI-A-1
[75.139066] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[75.140980] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[75.157336] [007/129] (925s left) kms_cursor_edge_walk (256x256-left-edge)
[75.261801] Starting subtest: 256x256-left-edge
[75.262507] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.955176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.694s)
[78.960713] Starting dynamic subtest: pipe-B-HDMI-A-1
[82.561111] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.606s)
[82.561897] Subtest 256x256-left-edge: SUCCESS (7.302s)
[82.616860] [008/129] (918s left) gem_mmap_gtt (basic-small-copy)
[82.643776] Starting subtest: basic-small-copy
[84.739296] Subtest basic-small-copy: SUCCESS (2.095s)
[84.754813] [009/129] (916s left) perf_pmu (semaphore-wait)
[84.814463] Starting subtest: semaphore-wait
[84.815149] Starting dynamic subtest: rcs0
[85.323578] Dynamic subtest rcs0: SUCCESS (0.508s)
[85.332268] Starting dynamic subtest: bcs0
[85.832784] Dynamic subtest bcs0: SUCCESS (0.509s)
[85.841585] Starting dynamic subtest: vcs0
[86.342884] Dynamic subtest vcs0: SUCCESS (0.510s)
[86.350451] Starting dynamic subtest: vecs0
[86.853884] Dynamic subtest vecs0: SUCCESS (0.510s)
[86.855186] Subtest semaphore-wait: SUCCESS (2.038s)
[86.926218] [010/129] (914s left) kms_vblank (ts-continuation-dpms-suspend)
[87.033773] Starting subtest: ts-continuation-dpms-suspend
[87.034435] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.066490] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (17.029s)
[104.071593] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.052222] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (16.984s)
[121.052945] Subtest ts-continuation-dpms-suspend: SUCCESS (34.015s)
[125.144163] [011/129] (879s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[125.258618] Starting subtest: psr-modesetfrombusy
[125.259895] Subtest psr-modesetfrombusy: SKIP (0.000s)
[125.321442] [012/129] (879s left) gem_media_vme
[125.370056] [013/129] (879s left) gem_ctx_param (get-priority-new-ctx)
[125.400905] Starting subtest: get-priority-new-ctx
[125.401588] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[125.424385] [014/129] (879s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[125.525790] Starting subtest: y-tiled-32bpp-rotate-0
[127.065550] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.540s)
[127.192168] [015/129] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[127.301469] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[127.302795] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[127.356563] [016/129] (877s left) i915_module_load (reload-with-fault-injection)
[127.383943] Starting subtest: reload-with-fault-injection
[135.352262] Subtest reload-with-fault-injection: SUCCESS (7.967s)
[135.372305] [017/129] (869s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[137.939344] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[137.940667] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[138.021735] [018/129] (867s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[138.059144] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[138.059818] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[138.079302] [019/129] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[138.178314] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[138.179591] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[138.247820] [020/129] (866s left) kms_cursor_crc (cursor-onscreen-128x128)
[138.359143] Starting subtest: cursor-onscreen-128x128
[138.367124] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.871064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.504s)
[140.893566] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.297564] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.408s)
[143.298296] Subtest cursor-onscreen-128x128: SUCCESS (4.938s)
[143.377019] [021/129] (861s left) kms_feature_discovery (chamelium)
[143.474458] Starting subtest: chamelium
[143.475772] Subtest chamelium: SKIP (0.000s)
[143.485759] [022/129] (861s left) gem_spin_batch (resubmit)
[143.517708] Starting subtest: resubmit
[143.518390] Starting dynamic subtest: rcs0
[143.522585] Dynamic subtest rcs0: SUCCESS (0.005s)
[143.529356] Starting dynamic subtest: bcs0
[143.530035] Dynamic subtest bcs0: SUCCESS (0.003s)
[143.535033] Starting dynamic subtest: vcs0
[143.535696] Dynamic subtest vcs0: SUCCESS (0.001s)
[143.540126] Starting dynamic subtest: vecs0
[143.540790] Dynamic subtest vecs0: SUCCESS (0.001s)
[143.541436] Subtest resubmit: SUCCESS (0.010s)
[143.669715] [023/129] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[143.794386] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[143.795693] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[143.866899] [024/129] (861s left) gen9_exec_parse (basic-rejected)
[143.903969] Subtest basic-rejected: SKIP (0.000s)
[143.923132] [025/129] (861s left) api_intel_allocator (standalone)
[143.975382] Starting subtest: standalone
[143.992066] Subtest standalone: SUCCESS (0.017s)
[144.075677] [026/129] (861s left) perf (buffer-fill)
[144.137524] Starting subtest: buffer-fill
[144.138266] Starting dynamic subtest: 0-rcs0
[145.887007] Dynamic subtest 0-rcs0: SUCCESS (1.750s)
[145.887804] Subtest buffer-fill: SUCCESS (1.750s)
[145.917373] [027/129] (859s left) kms_content_protection (atomic)
[146.069235] Starting subtest: atomic
[146.211059] Subtest atomic: SKIP (0.138s)
[146.358552] [028/129] (858s left) kms_psr (pr-suspend)
[146.468391] Subtest pr-suspend: SKIP (0.000s)
[146.492451] [029/129] (858s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[146.608767] Starting subtest: yf-tiled-16bpp-rotate-90
[146.610032] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[146.684966] [030/129] (858s left) sw_sync (sync_merge_invalid)
[146.718684] Starting subtest: sync_merge_invalid
[146.720048] Subtest sync_merge_invalid: SUCCESS (0.001s)
[146.736759] [031/129] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[146.845421] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[146.846700] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[146.931990] [032/129] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[147.035418] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[149.463033] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.428s)
[149.602282] [033/129] (855s left) kms_pm_backlight (basic-brightness)
[149.708538] Subtest basic-brightness: SKIP (0.000s)
[149.749328] [034/129] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[149.852715] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[152.176168] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.325s)
[152.291952] [035/129] (853s left) gem_exec_balancer (bonded-chain)
[152.323483] Starting subtest: bonded-chain
[152.977129] Subtest bonded-chain: SUCCESS (0.653s)
[153.778236] [036/129] (851s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[153.879696] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[155.193058] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.313s)
[155.328300] [037/129] (850s left) prime_mmap (test_map_unmap)
[155.359320] Starting subtest: test_map_unmap
[155.359980] Starting dynamic subtest: test_map_unmap-smem
[155.390226] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[155.390898] Subtest test_map_unmap: SUCCESS (0.032s)
[155.468076] [038/129] (850s left) gem_mmap_gtt (basic-short)
[155.501181] Starting subtest: basic-short
[155.516493] Subtest basic-short: SUCCESS (0.015s)
[155.579696] [039/129] (849s left) syncobj_basic (test-valid-cycle)
[155.610117] Starting subtest: test-valid-cycle
[155.610792] Subtest test-valid-cycle: SUCCESS (0.000s)
[155.650368] [040/129] (849s left) gem_flink_basic (flink-lifetime)
[155.690737] Starting subtest: flink-lifetime
[155.691385] Subtest flink-lifetime: SUCCESS (0.001s)
[155.773892] [041/129] (849s left) prime_busy (before)
[155.813669] Starting subtest: before
[155.815866] Starting dynamic subtest: rcs0
[155.842201] Dynamic subtest rcs0: SUCCESS (0.026s)
[155.850868] Starting dynamic subtest: bcs0
[155.897076] Dynamic subtest bcs0: SUCCESS (0.054s)
[155.914636] Starting dynamic subtest: vcs0
[155.928334] Dynamic subtest vcs0: SUCCESS (0.030s)
[155.946577] Starting dynamic subtest: vecs0
[155.957490] Dynamic subtest vecs0: SUCCESS (0.029s)
[156.066549] Subtest before: SUCCESS (0.252s)
[156.115175] [042/129] (849s left) kms_psr (psr2-sprite-mmap-gtt)
[156.220497] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[156.256124] [043/129] (849s left) kms_vrr (flip-dpms)
[156.364827] Starting subtest: flip-dpms
[156.366961] Subtest flip-dpms: SKIP (0.000s)
[156.377481] [044/129] (849s left) kms_cursor_crc (cursor-onscreen-max-size)
[156.484398] Starting subtest: cursor-onscreen-max-size
[156.486348] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[156.570463] [045/129] (849s left) gem_exec_schedule (preempt-user)
[156.604704] Starting subtest: preempt-user
[156.605365] Starting dynamic subtest: rcs0
[156.619577] Dynamic subtest rcs0: SUCCESS (0.015s)
[156.624636] Starting dynamic subtest: bcs0
[156.631828] Dynamic subtest bcs0: SUCCESS (0.012s)
[156.636996] Starting dynamic subtest: vcs0
[156.644934] Dynamic subtest vcs0: SUCCESS (0.013s)
[156.650100] Starting dynamic subtest: vecs0
[156.657185] Dynamic subtest vecs0: SUCCESS (0.012s)
[156.657864] Subtest preempt-user: SUCCESS (0.053s)
[156.920860] [046/129] (848s left) gem_mmap (big-bo)
[156.952171] Starting subtest: big-bo
[157.099345] Subtest big-bo: SUCCESS (0.147s)
[157.159689] [047/129] (848s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[157.294606] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[157.305149] [048/129] (848s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[157.342138] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[157.448312] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[157.500623] [049/129] (848s left) gem_exec_reloc (basic-cpu-noreloc)
[157.536413] Subtest basic-cpu-noreloc: SKIP (0.000s)
[157.624751] [050/129] (848s left) kms_plane_cursor (viewport)
[157.732774] Starting subtest: viewport
[157.734097] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[160.467870] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.734s)
[160.551895] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[163.275895] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.732s)
[163.370353] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[166.103023] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.751s)
[166.235116] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[168.987156] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.758s)
[169.052430] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[171.776344] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.732s)
[171.847649] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[174.565465] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.732s)
[174.650424] Subtest viewport: SUCCESS (16.917s)
[174.706648] [051/129] (831s left) gem_exec_schedule (implicit-read-write)
[174.744718] Starting subtest: implicit-read-write
[174.745379] Starting dynamic subtest: rcs0
[174.789155] Dynamic subtest rcs0: SUCCESS (0.046s)
[174.797728] Starting dynamic subtest: bcs0
[174.835087] Dynamic subtest bcs0: SUCCESS (0.045s)
[174.843130] Starting dynamic subtest: vcs0
[174.882348] Dynamic subtest vcs0: SUCCESS (0.047s)
[174.894447] Starting dynamic subtest: vecs0
[174.932931] Dynamic subtest vecs0: SUCCESS (0.050s)
[174.934146] Subtest implicit-read-write: SUCCESS (0.190s)
[175.206368] [052/129] (830s left) gem_exec_params (batch-first)
[175.240317] Starting subtest: batch-first
[175.241996] Subtest batch-first: SUCCESS (0.002s)
[175.348188] [053/129] (830s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[175.454054] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[175.455453] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[175.488277] [054/129] (830s left) kms_chamelium_edid (hdmi-edid-read)
[175.655686] Subtest hdmi-edid-read: SKIP (0.000s)
[175.717464] [055/129] (830s left) gem_exec_parallel (userptr)
[175.749208] Starting subtest: userptr
[175.749896] Starting dynamic subtest: rcs0
[177.080595] Dynamic subtest rcs0: SUCCESS (1.331s)
[177.085770] Starting dynamic subtest: bcs0
[178.384615] Dynamic subtest bcs0: SUCCESS (1.304s)
[178.390841] Starting dynamic subtest: vcs0
[179.691763] Dynamic subtest vcs0: SUCCESS (1.307s)
[179.697309] Starting dynamic subtest: vecs0
[180.994894] Dynamic subtest vecs0: SUCCESS (1.303s)
[180.995763] Subtest userptr: SUCCESS (5.246s)
[181.153646] [056/129] (824s left) gem_mmap_gtt (hang)
[181.186992] Starting subtest: hang
[186.623360] Subtest hang: SUCCESS (5.436s)
[186.680098] [057/129] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[186.777087] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[186.778370] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[186.829809] [058/129] (819s left) sw_sync (sync_busy_fork)
[186.851761] Starting subtest: sync_busy_fork
[187.861800] Subtest sync_busy_fork: SUCCESS (1.010s)
[187.885631] [059/129] (818s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[187.922802] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[187.923454] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[187.970186] [060/129] (817s left) gem_busy (semaphore)
[188.144413] Starting subtest: semaphore
[188.145324] Starting dynamic subtest: rcs0
[188.215346] Dynamic subtest rcs0: SUCCESS (0.075s)
[188.227900] Starting dynamic subtest: bcs0
[188.244283] Dynamic subtest bcs0: SUCCESS (0.029s)
[188.260700] Starting dynamic subtest: vcs0
[188.273418] Dynamic subtest vcs0: SUCCESS (0.028s)
[188.287420] Starting dynamic subtest: vecs0
[188.303390] Dynamic subtest vecs0: SUCCESS (0.029s)
[188.304549] Subtest semaphore: SUCCESS (0.164s)
[188.504279] [061/129] (817s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[188.605844] Starting subtest: 2x-long-flip-vs-cursor-atomic
[188.607908] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[188.644331] [062/129] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[188.747477] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[188.748756] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[188.824388] [063/129] (817s left) kms_addfb_basic (unused-handle)
[188.855481] Starting subtest: unused-handle
[188.856190] Subtest unused-handle: SUCCESS (0.000s)
[188.993295] [064/129] (817s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[189.026273] Starting subtest: y-tiled-to-vebox-x-tiled
[189.026987] Starting dynamic subtest: smem
[189.143176] Dynamic subtest smem: SUCCESS (0.109s)
[189.150685] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.109s)
[189.281805] [065/129] (816s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[189.381844] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[189.382497] Starting dynamic subtest: pipe-A-valid-mode
[189.434183] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[189.435878] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.051s)
[189.486282] [066/129] (816s left) kms_chamelium_color (ctm-0-75)
[189.583449] Subtest ctm-0-75: SKIP (0.000s)
[189.596641] [067/129] (816s left) sw_sync (sync_multi_consumer)
[189.619039] Starting subtest: sync_multi_consumer
[190.028656] Subtest sync_multi_consumer: SUCCESS (0.410s)
[190.038111] [068/129] (816s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[190.134622] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[190.135894] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[190.207693] [069/129] (815s left) debugfs_test (basic-hwmon)
[190.237859] Starting subtest: basic-hwmon
[190.239161] Subtest basic-hwmon: SKIP (0.000s)
[190.349971] [070/129] (815s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[190.447808] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[190.448696] Starting dynamic subtest: pipe-A
[196.603099] Dynamic subtest pipe-A: SUCCESS (6.154s)
[196.616995] Starting dynamic subtest: pipe-B
[201.860526] Dynamic subtest pipe-B: SUCCESS (5.256s)
[201.861721] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (11.412s)
[202.016518] [071/129] (804s left) gem_ctx_persistence (engines-persistence)
[202.064198] Starting subtest: engines-persistence
[202.064880] Starting dynamic subtest: rcs0
[202.841369] Dynamic subtest rcs0: SUCCESS (0.776s)
[202.850611] Starting dynamic subtest: bcs0
[203.607373] Dynamic subtest bcs0: SUCCESS (0.765s)
[203.616842] Starting dynamic subtest: vcs0
[204.375343] Dynamic subtest vcs0: SUCCESS (0.767s)
[204.384750] Starting dynamic subtest: vecs0
[205.145347] Dynamic subtest vecs0: SUCCESS (0.769s)
[205.146540] Subtest engines-persistence: SUCCESS (3.081s)
[205.183468] [072/129] (801s left) kms_sequence (get-forked-busy)
[205.288130] Starting subtest: get-forked-busy
[205.289805] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.066081] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.776s)
[208.089560] Starting dynamic subtest: pipe-B-HDMI-A-1
[210.805471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.737s)
[210.806719] Subtest get-forked-busy: SUCCESS (5.517s)
[210.910847] [073/129] (795s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[211.026671] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[211.068966] [074/129] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[211.169551] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[213.609020] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.441s)
[213.734945] [075/129] (792s left) drm_fdinfo (all-busy-idle-check-all)
[213.761965] Starting subtest: all-busy-idle-check-all
[214.384262] Subtest all-busy-idle-check-all: SUCCESS (0.622s)
[214.424423] [076/129] (791s left) gem_lmem_swapping (heavy-random)
[214.454476] Subtest heavy-random: SKIP (0.000s)
[214.469872] [077/129] (791s left) syncobj_timeline (wait-any-snapshot)
[214.500352] Starting subtest: wait-any-snapshot
[214.581680] Subtest wait-any-snapshot: SUCCESS (0.081s)
[214.644759] [078/129] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[214.764726] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[214.766051] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[214.835794] [079/129] (791s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[214.937351] Starting subtest: invalid-modeset-force-ultra-joiner
[214.938689] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[214.980355] [080/129] (791s left) kms_mmap_write_crc (main)
[215.089345] Starting subtest: main
[215.090027] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.350720] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.258s)
[218.351645] Subtest main: SUCCESS (3.259s)
[218.458676] [081/129] (787s left) gem_ctx_exec (basic)
[218.481686] Starting subtest: basic
[218.483293] Subtest basic: SUCCESS (0.001s)
[218.568935] [082/129] (787s left) kms_psr (fbc-pr-cursor-render)
[218.669433] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[218.708180] [083/129] (787s left) gem_ctx_persistence (many-contexts)
[218.742436] Starting subtest: many-contexts
[258.912283] Subtest many-contexts: SUCCESS (40.168s)
[258.930324] [084/129] (747s left) gem_ctx_engines (invalid-engines)
[258.961565] Starting subtest: invalid-engines
[258.982319] Subtest invalid-engines: FAIL (0.012s)
[259.120751] [085/129] (747s left) kms_atomic_transition (plane-all-transition-fencing)
[259.219041] Starting subtest: plane-all-transition-fencing
[259.220567] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.452750] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.232s)
[263.507176] Starting dynamic subtest: pipe-B-HDMI-A-1
[267.750287] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.247s)
[267.776792] Subtest plane-all-transition-fencing: SUCCESS (8.557s)
[267.871628] [086/129] (738s left) gem_exec_whisper (basic-fds-forked)
[267.904210] Starting subtest: basic-fds-forked
[270.229298] Subtest basic-fds-forked: SUCCESS (2.325s)
[270.371926] [087/129] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[270.475604] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[270.476903] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[270.542050] [088/129] (736s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[270.641218] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[270.643061] Starting dynamic subtest: pipe-A-HDMI-A-1
[270.649448] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[270.655397] Starting dynamic subtest: pipe-B-HDMI-A-1
[270.662775] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[270.664434] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.003s)
[270.681450] [089/129] (735s left) prime_vgem (fence-read-hang)
[270.811152] Subtest fence-read-hang: SKIP (0.000s)
[270.891746] [090/129] (735s left) kms_hdr (bpc-switch-suspend)
[270.994079] Starting subtest: bpc-switch-suspend
[270.996069] Subtest bpc-switch-suspend: SKIP (0.000s)
[271.034720] [091/129] (735s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[271.059362] Starting subtest: etime-multi-wait-all-for-submit-submitted
[271.167523] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[271.210668] [092/129] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[271.313792] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[271.315078] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[271.374716] [093/129] (735s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[271.482091] Starting subtest: cursorA-vs-flipA-atomic-transitions
[282.334449] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.851s)
[282.446626] [094/129] (724s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[282.549811] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[283.850318] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.300s)
[284.001178] [095/129] (722s left) kms_flip (2x-wf_vblank-ts-check)
[284.115388] Starting subtest: 2x-wf_vblank-ts-check
[284.116717] Subtest 2x-wf_vblank-ts-check: SKIP (0.001s)
[284.205625] [096/129] (722s left) gem_softpin (evict-snoop-interruptible)
[284.235907] Starting subtest: evict-snoop-interruptible
[284.237236] Subtest evict-snoop-interruptible: SKIP (0.000s)
[284.259317] [097/129] (722s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[284.429233] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[284.487735] [098/129] (722s left) i915_pm_rpm (gem-idle)
[285.931651] Starting subtest: gem-idle
[291.165030] Subtest gem-idle: SUCCESS (5.234s)
[291.315112] [099/129] (715s left) gem_mmap_gtt (cpuset-big-copy-xy)
[291.354036] Starting subtest: cpuset-big-copy-XY
[315.247109] Subtest cpuset-big-copy-XY: SUCCESS (23.893s)
[315.324726] [100/129] (691s left) gem_exec_reloc (basic-write-cpu-active)
[315.377193] Subtest basic-write-cpu-active: SKIP (0.000s)
[315.456582] [101/129] (691s left) gem_pxp (reject-modify-context-protection-on)
[317.990857] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[318.012362] [102/129] (688s left) perf_pmu (busy-hang)
[318.041673] Starting subtest: busy-hang
[318.042334] Starting dynamic subtest: rcs0
[319.124620] Dynamic subtest rcs0: SUCCESS (1.080s)
[319.132560] Starting dynamic subtest: bcs0
[320.172599] Dynamic subtest bcs0: SUCCESS (1.046s)
[320.181061] Starting dynamic subtest: vcs0
[321.223877] Dynamic subtest vcs0: SUCCESS (1.050s)
[321.231431] Starting dynamic subtest: vecs0
[322.267382] Dynamic subtest vecs0: SUCCESS (1.042s)
[322.268514] Subtest busy-hang: SUCCESS (4.224s)
[322.306598] [103/129] (684s left) gem_spin_batch (spin-all-new)
[322.336535] Starting subtest: spin-all-new
[322.341602] Subtest spin-all-new: SUCCESS (0.005s)
[322.506823] [104/129] (684s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[322.531961] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[322.611299] [105/129] (684s left) gem_pwrite (basic-self)
[322.641354] Subtest basic-self: SKIP (0.000s)
[322.705257] [106/129] (684s left) gem_userptr_blits (sync-unmap)
[322.741078] Starting subtest: sync-unmap
[322.751139] Subtest sync-unmap: SUCCESS (0.010s)
[322.838948] [107/129] (684s left) drm_fdinfo (virtual-busy-all)
[322.877165] Starting subtest: virtual-busy-all
[322.877844] Subtest virtual-busy-all: SUCCESS (0.000s)
[322.902923] [108/129] (684s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[323.017180] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[323.383945] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.367s)
[323.540055] [109/129] (683s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[323.647068] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[323.648391] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[323.719230] [110/129] (683s left) gem_render_copy_redux (flink)
[323.752493] Starting subtest: flink
[324.345828] Subtest flink: SUCCESS (0.593s)
[324.451880] [111/129] (682s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[324.554928] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[324.556348] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[324.572811] [112/129] (682s left) i915_pm_rps (reset)
[324.606864] Starting subtest: reset
[328.124537] Subtest reset: SUCCESS (3.518s)
[328.210636] [113/129] (678s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[328.252823] Starting subtest: multi-wait-available-unsubmitted-submitted
[328.253479] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[328.271270] [114/129] (678s left) gem_mmap_gtt (big-bo-tiledx)
[328.302339] Starting subtest: big-bo-tiledX
[328.377867] Subtest big-bo-tiledX: SUCCESS (0.076s)
[328.471715] [115/129] (678s left) perf (i915-ref-count)
[328.557199] Starting subtest: i915-ref-count
[328.583725] Subtest i915-ref-count: SUCCESS (0.026s)
[328.625229] [116/129] (678s left) gem_exec_fair (basic-pace)
[328.665457] Starting subtest: basic-pace
[328.666131] Starting dynamic subtest: rcs0
[334.192018] Dynamic subtest rcs0: SUCCESS (5.528s)
[334.198358] Starting dynamic subtest: bcs0
[338.583853] Dynamic subtest bcs0: FAIL (4.375s)
[338.597147] Starting dynamic subtest: vcs0
[344.100260] Dynamic subtest vcs0: SUCCESS (5.522s)
[344.108343] Starting dynamic subtest: vecs0
[348.488420] Dynamic subtest vecs0: FAIL (4.377s)
[348.489553] Subtest basic-pace: FAIL (19.805s)
[348.635412] [117/129] (658s left) gem_userptr_blits (unsync-unmap-cycles)
[348.671435] Subtest unsync-unmap-cycles: SKIP (0.000s)
[348.764302] [118/129] (658s left) gem_exec_fence (concurrent)
[348.913223] Starting subtest: concurrent
[348.914490] Starting dynamic subtest: rcs0
[348.947564] Dynamic subtest rcs0: SUCCESS (0.033s)
[348.960291] Starting dynamic subtest: bcs0
[348.979435] Dynamic subtest bcs0: SUCCESS (0.030s)
[348.996876] Starting dynamic subtest: vcs0
[349.012429] Dynamic subtest vcs0: SUCCESS (0.031s)
[349.029335] Starting dynamic subtest: vecs0
[349.045401] Dynamic subtest vecs0: SUCCESS (0.031s)
[349.046515] Subtest concurrent: SUCCESS (0.133s)
[349.468042] [119/129] (657s left) gem_exec_balancer (parallel-out-fence)
[350.286954] Subtest parallel-out-fence: SKIP (0.000s)
[350.319074] [120/129] (656s left) syncobj_basic (bad-create-flags)
[350.343760] Starting subtest: bad-create-flags
[350.344423] Subtest bad-create-flags: SUCCESS (0.000s)
[350.357259] [121/129] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[350.465464] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[350.466754] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[350.540905] [122/129] (656s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[350.645984] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[350.647309] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[350.659977] [123/129] (656s left) syncobj_timeline (invalid-transfer-illegal-handle)
[350.684742] Starting subtest: invalid-transfer-illegal-handle
[350.685396] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[350.697848] [124/129] (656s left) kms_pm_dc (dc5-psr)
[351.806402] Starting subtest: dc5-psr
[351.807701] Subtest dc5-psr: SKIP (0.000s)
[351.901763] [125/129] (655s left) kms_atomic (atomic-invalid-params)
[352.007889] Starting subtest: atomic-invalid-params
[352.009534] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.241110] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.231s)
[352.242046] Subtest atomic-invalid-params: SUCCESS (0.233s)
[352.350387] [126/129] (654s left) kms_flip (bo-too-big-interruptible)
[352.454356] Starting subtest: bo-too-big-interruptible
[352.455863] Starting dynamic subtest: A-HDMI-A1
[352.728607] Dynamic subtest A-HDMI-A1: SUCCESS (0.272s)
[352.741801] Starting dynamic subtest: B-HDMI-A1
[352.945910] Dynamic subtest B-HDMI-A1: SUCCESS (0.215s)
[352.948753] Subtest bo-too-big-interruptible: SUCCESS (0.494s)
[353.075962] [127/129] (654s left) kms_prop_blob (blob-prop-lifetime)
[353.101258] Starting subtest: blob-prop-lifetime
[353.101930] Subtest blob-prop-lifetime: SUCCESS (0.000s)
[353.121466] [128/129] (654s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[353.227012] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[353.227711] Starting dynamic subtest: pipe-A-valid-mode
[353.275969] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[353.277656] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.048s)
[353.333102] [129/129] (653s left) kms_psr (pr-cursor-plane-move)
[353.430391] Subtest pr-cursor-plane-move: SKIP (0.000s)
[353.468644] Closing watchdogs
Done.