[62.233192] Initializing watchdogs
[62.233272]   /dev/watchdog0
[62.252318] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.262574] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.267092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.269330] [001/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[62.454853] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[62.455703] Starting dynamic subtest: pipe-A-DP-3
[62.463935] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[62.471342] Starting dynamic subtest: pipe-B-DP-3
[62.479401] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[62.486544] Starting dynamic subtest: pipe-C-DP-3
[62.494595] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[62.501839] Starting dynamic subtest: pipe-D-DP-3
[62.510295] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[62.512240] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[62.964353] [002/133] (959s left) kms_psr (pr-primary-render)
[63.143767] Subtest pr-primary-render: SKIP (0.000s)
[63.193951] [003/133] (959s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[63.371485] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[63.372345] Starting dynamic subtest: pipe-A-valid-mode
[65.260756] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.894s)
[65.262503] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.895s)
[65.570262] [004/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[65.749264] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[65.750141] Starting dynamic subtest: pipe-A-DP-3
[65.758498] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[65.766179] Starting dynamic subtest: pipe-B-DP-3
[65.774387] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[65.781955] Starting dynamic subtest: pipe-C-DP-3
[65.790051] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[65.797313] Starting dynamic subtest: pipe-D-DP-3
[65.806330] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[65.808186] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[66.211978] [005/133] (956s left) kms_pm_rpm (modeset-lpsp)
[68.128579] Starting subtest: modeset-lpsp
[68.532479] Subtest modeset-lpsp: SKIP (0.404s)
[68.925011] [006/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[69.180509] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[69.325314] [007/133] (953s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[71.925919] Starting subtest: verify-pxp-stale-buf-optout-execution
[71.928159] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[72.060478] [008/133] (951s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[72.241462] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[72.256872] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s)
[72.418258] [009/133] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[72.597449] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[72.599186] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[72.794444] [010/133] (950s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[72.966893] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[72.972075] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[73.141388] [011/133] (950s left) kms_async_flips (crc)
[73.318888] Starting subtest: crc
[73.555474] Starting dynamic subtest: pipe-A-DP-3
[75.965543] Dynamic subtest pipe-A-DP-3: SUCCESS (2.412s)
[76.186831] Starting dynamic subtest: pipe-B-DP-3
[78.404884] Dynamic subtest pipe-B-DP-3: SUCCESS (2.226s)
[78.589669] Starting dynamic subtest: pipe-C-DP-3
[80.792129] Dynamic subtest pipe-C-DP-3: SUCCESS (2.210s)
[80.970965] Starting dynamic subtest: pipe-D-DP-3
[83.174967] Dynamic subtest pipe-D-DP-3: SUCCESS (2.212s)
[83.175984] Subtest crc: SUCCESS (9.856s)
[83.662115] [012/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[83.843306] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[83.844970] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[84.029927] [013/133] (939s left) gem_softpin (allocator-nopin-reserve)
[84.105981] Starting subtest: allocator-nopin-reserve
[84.354652] Subtest allocator-nopin-reserve: SUCCESS (0.248s)
[84.512386] [014/133] (939s left) i915_drm_fdinfo (busy-idle-check-all)
[84.572785] Starting subtest: busy-idle-check-all
[84.573561] Starting dynamic subtest: rcs0
[84.601843] Dynamic subtest rcs0: SKIP (0.029s)
[84.610039] Starting dynamic subtest: bcs0
[84.612006] Dynamic subtest bcs0: SKIP (0.000s)
[84.620262] Starting dynamic subtest: vcs0
[84.622479] Dynamic subtest vcs0: SKIP (0.000s)
[84.630640] Starting dynamic subtest: vcs1
[84.632886] Dynamic subtest vcs1: SKIP (0.000s)
[84.641236] Starting dynamic subtest: vecs0
[84.643477] Dynamic subtest vecs0: SKIP (0.000s)
[84.651570] Starting dynamic subtest: vecs1
[84.653547] Dynamic subtest vecs1: SKIP (0.000s)
[84.661565] Starting dynamic subtest: ccs0
[84.663790] Dynamic subtest ccs0: SKIP (0.000s)
[84.665947] Subtest busy-idle-check-all: SKIP (0.033s)
[84.711128] [015/133] (938s left) kms_atomic_transition (modeset-transition)
[84.921928] Starting subtest: modeset-transition
[84.922770] Starting dynamic subtest: 1x-outputs
[87.541057] Dynamic subtest 1x-outputs: SUCCESS (2.617s)
[87.542775] Subtest modeset-transition: SUCCESS (2.618s)
[87.827144] [016/133] (935s left) i915_selftest (mock)
[88.981045] Starting subtest: mock
[88.982082] Starting dynamic subtest: sanitycheck
[89.826224] Dynamic subtest sanitycheck: SUCCESS (0.844s)
[89.838057] Starting dynamic subtest: shmem
[90.666939] Dynamic subtest shmem: SUCCESS (0.839s)
[90.695357] Starting dynamic subtest: fence
[99.010834] Dynamic subtest fence: SUCCESS (8.341s)
[99.021642] Starting dynamic subtest: scatterlist
[100.883396] Dynamic subtest scatterlist: SUCCESS (1.871s)
[100.894716] Starting dynamic subtest: syncmap
[103.815461] Dynamic subtest syncmap: SUCCESS (2.931s)
[103.824713] Starting dynamic subtest: uncore
[104.656590] Dynamic subtest uncore: SUCCESS (0.840s)
[104.668251] Starting dynamic subtest: ring
[105.522674] Dynamic subtest ring: SUCCESS (0.865s)
[105.550163] Starting dynamic subtest: engine
[106.383470] Dynamic subtest engine: SUCCESS (0.859s)
[106.394778] Starting dynamic subtest: timelines
[111.015059] Dynamic subtest timelines: SUCCESS (4.630s)
[111.024386] Starting dynamic subtest: requests
[113.814027] Dynamic subtest requests: SUCCESS (2.798s)
[113.822958] Starting dynamic subtest: objects
[114.812968] Dynamic subtest objects: SUCCESS (0.998s)
[114.821430] Starting dynamic subtest: phys
[115.821924] Dynamic subtest phys: SUCCESS (1.008s)
[115.830635] Starting dynamic subtest: dmabuf
[116.825016] Dynamic subtest dmabuf: SUCCESS (1.003s)
[116.834681] Starting dynamic subtest: vma
[125.041209] Dynamic subtest vma: SUCCESS (8.215s)
[125.050385] Starting dynamic subtest: evict
[126.902991] Dynamic subtest evict: SUCCESS (1.861s)
[126.911318] Starting dynamic subtest: gtt
[130.906947] Dynamic subtest gtt: SUCCESS (4.003s)
[130.916260] Starting dynamic subtest: hugepages
[132.051335] Dynamic subtest hugepages: SUCCESS (1.144s)
[132.064965] Starting dynamic subtest: memory_region
[135.483841] Dynamic subtest memory_region: SUCCESS (3.432s)
[135.484746] Subtest mock: SUCCESS (46.496s)
[135.513720] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[135.515377] [017/133] (888s left) gem_create (create-valid-nonaligned)
[137.130076] Starting subtest: create-valid-nonaligned
[137.130814] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[137.329059] [FACT gem_create (create-valid-nonaligned)] new: kernel.kmod_is_loaded.i915: true
[137.331436] [018/133] (886s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[137.515858] Starting subtest: plane-all-transition-nonblocking-fencing
[137.516743] Starting dynamic subtest: pipe-A-DP-3
[141.300730] Dynamic subtest pipe-A-DP-3: SUCCESS (3.783s)
[141.437527] Starting dynamic subtest: pipe-B-DP-3
[145.331112] Dynamic subtest pipe-B-DP-3: SUCCESS (3.903s)
[145.420917] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.905s)
[145.693152] [019/133] (878s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[145.872229] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[145.873051] Starting dynamic subtest: pipe-A-DP-3
[145.881468] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[145.889746] Starting dynamic subtest: pipe-B-DP-3
[145.897986] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[145.906254] Starting dynamic subtest: pipe-C-DP-3
[145.914364] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[145.922370] Starting dynamic subtest: pipe-D-DP-3
[145.932420] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[145.934357] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[146.359424] [020/133] (877s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[146.607639] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[146.666695] [021/133] (877s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[146.846053] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[146.847823] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[146.981887] [022/133] (877s left) gem_exec_fence (syncobj-timeline-chain-engines)
[147.693864] Starting subtest: syncobj-timeline-chain-engines
[147.844989] Subtest syncobj-timeline-chain-engines: SUCCESS (0.152s)
[148.187542] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[148.189723] [023/133] (876s left) gem_exec_whisper (basic-queues-forked)
[148.277299] Starting subtest: basic-queues-forked
[170.706408] Subtest basic-queues-forked: SUCCESS (22.424s)
[170.983443] [024/133] (853s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[171.168893] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[171.170522] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[171.290704] [025/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[171.479655] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[171.481293] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[171.668633] [026/133] (852s left) gem_exec_flush (basic-uc-rw-default)
[171.750217] Subtest basic-uc-rw-default: SKIP (0.000s)
[171.838998] [027/133] (852s left) gem_lmem_swapping (parallel-random-verify)
[174.477309] Starting subtest: parallel-random-verify
[174.478123] Starting dynamic subtest: lmem0
[231.571453] Dynamic subtest lmem0: SUCCESS (57.094s)
[231.572348] Subtest parallel-random-verify: SUCCESS (57.095s)
[232.653764] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[232.654736] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[232.656473] [028/133] (791s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[234.426175] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[234.497243] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[234.500144] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[234.502578] [029/133] (790s left) kms_busy (basic)
[234.701355] Starting subtest: basic
[234.703430] Starting dynamic subtest: flip
[235.278444] Dynamic subtest flip: SUCCESS (0.575s)
[235.299479] Starting dynamic subtest: modeset
[236.211664] Dynamic subtest modeset: SUCCESS (0.931s)
[236.212925] Subtest basic: SUCCESS (1.510s)
[236.531132] [030/133] (788s left) i915_fb_tiling (basic-x-tiling)
[236.605007] Subtest basic-x-tiling: SKIP (0.000s)
[236.673378] [031/133] (788s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[236.866261] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[236.867116] Starting dynamic subtest: pipe-A-DP-3
[236.875523] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[236.884446] Starting dynamic subtest: pipe-B-DP-3
[236.892811] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[236.901435] Starting dynamic subtest: pipe-C-DP-3
[236.909173] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[236.917733] Starting dynamic subtest: pipe-D-DP-3
[236.927481] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[236.929525] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[237.354994] [032/133] (787s left) sysfs_heartbeat_interval (idempotent)
[237.440578] Starting subtest: idempotent
[237.442772] Starting dynamic subtest: vecs0
[237.443562] Dynamic subtest vecs0: SUCCESS (0.001s)
[237.453199] Starting dynamic subtest: ccs0
[237.454151] Dynamic subtest ccs0: SUCCESS (0.001s)
[237.463134] Starting dynamic subtest: vcs0
[237.464054] Dynamic subtest vcs0: SUCCESS (0.001s)
[237.472727] Starting dynamic subtest: bcs0
[237.473783] Dynamic subtest bcs0: SUCCESS (0.001s)
[237.482651] Starting dynamic subtest: vecs1
[237.483745] Dynamic subtest vecs1: SUCCESS (0.001s)
[237.492611] Starting dynamic subtest: rcs0
[237.493469] Dynamic subtest rcs0: SUCCESS (0.001s)
[237.502500] Starting dynamic subtest: vcs1
[237.503586] Dynamic subtest vcs1: SUCCESS (0.001s)
[237.504640] Subtest idempotent: SUCCESS (0.013s)
[237.608442] [033/133] (787s left) gem_ctx_exec (basic-invalid-context)
[237.695159] Starting subtest: basic-invalid-context
[237.699959] Subtest basic-invalid-context: SUCCESS (0.005s)
[237.888397] [034/133] (787s left) kms_plane_scaling (2x-scaler-multi-pipe)
[238.080771] Starting subtest: 2x-scaler-multi-pipe
[238.083684] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[238.242736] [035/133] (786s left) perf (blocking)
[238.676877] Starting subtest: blocking
[238.677751] Starting dynamic subtest: 0-rcs0
[248.697131] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[248.698139] Subtest blocking: SUCCESS (10.020s)
[248.751870] [036/133] (776s left) gem_exec_reloc (basic-write-cpu)
[248.839535] Subtest basic-write-cpu: SKIP (0.000s)
[248.942471] [037/133] (776s left) gem_mmap_gtt (flink-race)
[249.020077] Subtest flink-race: SKIP (0.000s)
[249.105768] [038/133] (776s left) perf_pmu (busy-hang)
[249.175244] Starting subtest: busy-hang
[249.176142] Starting dynamic subtest: rcs0
[250.483572] Dynamic subtest rcs0: SUCCESS (1.306s)
[250.493877] Starting dynamic subtest: bcs0
[251.701485] Dynamic subtest bcs0: SUCCESS (1.215s)
[251.712120] Starting dynamic subtest: vcs0
[252.928176] Dynamic subtest vcs0: SUCCESS (1.224s)
[252.938676] Starting dynamic subtest: vcs1
[254.156146] Dynamic subtest vcs1: SUCCESS (1.225s)
[254.166640] Starting dynamic subtest: vecs0
[255.386661] Dynamic subtest vecs0: SUCCESS (1.227s)
[255.397220] Starting dynamic subtest: vecs1
[256.614596] Dynamic subtest vecs1: SUCCESS (1.225s)
[256.625221] Starting dynamic subtest: ccs0
[257.841252] Dynamic subtest ccs0: SUCCESS (1.223s)
[257.842194] Subtest busy-hang: SUCCESS (8.665s)
[257.992663] [039/133] (767s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[258.182135] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[258.197603] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.015s)
[258.357743] [040/133] (766s left) prime_self_import (basic-with_one_bo)
[258.403486] Starting subtest: basic-with_one_bo
[258.453059] Subtest basic-with_one_bo: SUCCESS (0.049s)
[258.626408] [041/133] (766s left) gem_tiled_fence_blits (basic)
[258.708438] Subtest basic: SKIP (0.000s)
[258.783814] [042/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[258.973792] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[258.975405] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[259.116348] [043/133] (766s left) syncobj_timeline (reset-unsignaled)
[259.196365] Starting subtest: reset-unsignaled
[259.197239] Subtest reset-unsignaled: SUCCESS (0.000s)
[259.375375] [044/133] (766s left) kms_fbcon_fbt (psr)
[259.456595] Starting subtest: psr
[259.458445] Subtest psr: SKIP (0.000s)
[259.674802] [045/133] (765s left) api_intel_bb (object-noreloc-purge-cache-simple)
[259.749495] Starting subtest: object-noreloc-purge-cache-simple
[259.782463] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.033s)
[260.004901] [046/133] (765s left) kms_chamelium_frames (dp-crc-fast)
[260.269418] Subtest dp-crc-fast: SKIP (0.000s)
[260.417870] [047/133] (765s left) gem_exec_reloc (basic-write-read-noreloc)
[260.502531] Subtest basic-write-read-noreloc: SKIP (0.000s)
[260.593951] [048/133] (765s left) kms_flip (2x-nonexisting-fb)
[260.779247] Starting subtest: 2x-nonexisting-fb
[260.794436] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[260.971604] [049/133] (764s left) gem_exec_balancer (parallel-ordering)
[261.365915] Starting subtest: parallel-ordering
[263.036787] Subtest parallel-ordering: SUCCESS (1.671s)
[263.228094] [050/133] (762s left) kms_cdclk (mode-transition)
[263.418758] Starting subtest: mode-transition
[263.419597] Starting dynamic subtest: pipe-A-DP-3
[263.511414] Dynamic subtest pipe-A-DP-3: SKIP (0.091s)
[263.526541] Starting dynamic subtest: pipe-B-DP-3
[263.528450] Dynamic subtest pipe-B-DP-3: SKIP (0.003s)
[263.540396] Starting dynamic subtest: pipe-C-DP-3
[263.542085] Dynamic subtest pipe-C-DP-3: SKIP (0.003s)
[263.552376] Starting dynamic subtest: pipe-D-DP-3
[263.554135] Dynamic subtest pipe-D-DP-3: SKIP (0.003s)
[263.555906] Subtest mode-transition: SKIP (0.106s)
[263.759895] [051/133] (762s left) gen9_exec_parse (basic-rejected-ctx-param)
[263.842467] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[263.925976] [052/133] (762s left) kms_cursor_legacy (single-bo)
[264.110223] Starting subtest: single-bo
[264.111130] Starting dynamic subtest: pipe-A
[269.491100] Dynamic subtest pipe-A: SUCCESS (5.380s)
[269.501953] Starting dynamic subtest: pipe-B
[274.871055] Dynamic subtest pipe-B: SUCCESS (5.379s)
[274.881404] Starting dynamic subtest: pipe-C
[280.249919] Dynamic subtest pipe-C: SUCCESS (5.378s)
[280.260356] Starting dynamic subtest: pipe-D
[285.629773] Dynamic subtest pipe-D: SUCCESS (5.379s)
[285.640208] Starting dynamic subtest: all-pipes
[291.009599] Dynamic subtest all-pipes: SUCCESS (5.379s)
[291.010469] Subtest single-bo: SUCCESS (26.900s)
[291.130569] [053/133] (735s left) gem_blits (basic)
[291.244704] Starting subtest: basic
[297.117320] Subtest basic: SUCCESS (5.872s)
[297.343054] [054/133] (728s left) kms_content_protection (content-type-change)
[297.593387] Starting subtest: content-type-change
[297.603153] Subtest content-type-change: SKIP (0.003s)
[297.793437] [055/133] (728s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[297.985765] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[298.040803] [056/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[298.238719] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[298.240307] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[298.428308] [057/133] (728s left) prime_udl
[298.542362] [058/133] (727s left) gem_exec_balancer (full-late)
[298.629164] Starting subtest: full-late
[300.645186] Subtest full-late: SUCCESS (2.016s)
[301.065353] [059/133] (725s left) drm_read (empty-block)
[301.331426] Starting subtest: empty-block
[302.332915] Subtest empty-block: SUCCESS (1.000s)
[302.581951] [060/133] (724s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[302.767209] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[302.767927] Starting dynamic subtest: pipe-A
[302.863975] Dynamic subtest pipe-A: SUCCESS (0.098s)
[302.882223] Starting dynamic subtest: pipe-B
[303.077065] Dynamic subtest pipe-B: SUCCESS (0.211s)
[303.099414] Starting dynamic subtest: pipe-C
[303.291284] Dynamic subtest pipe-C: SUCCESS (0.213s)
[303.312472] Starting dynamic subtest: pipe-D
[303.506225] Dynamic subtest pipe-D: SUCCESS (0.213s)
[303.507362] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.741s)
[303.869381] [061/133] (722s left) gem_ctx_persistence (legacy-engines-queued)
[303.964376] Starting subtest: legacy-engines-queued
[303.965304] Starting dynamic subtest: render
[304.080256] Dynamic subtest render: SUCCESS (0.115s)
[304.093388] Starting dynamic subtest: bsd1
[304.135556] Dynamic subtest bsd1: SUCCESS (0.054s)
[304.159231] Starting dynamic subtest: bsd2
[304.199439] Dynamic subtest bsd2: SUCCESS (0.062s)
[304.225631] Starting dynamic subtest: blt
[304.238373] Dynamic subtest blt: SUCCESS (0.037s)
[304.256704] Starting dynamic subtest: vebox
[304.287351] Dynamic subtest vebox: SUCCESS (0.047s)
[304.288372] Subtest legacy-engines-queued: SUCCESS (0.324s)
[304.504445] [062/133] (722s left) kms_flip (flip-vs-rmfb-interruptible)
[304.701508] Starting subtest: flip-vs-rmfb-interruptible
[304.706337] Starting dynamic subtest: A-DP3
[312.531639] Dynamic subtest A-DP3: SUCCESS (7.824s)
[312.573207] Starting dynamic subtest: B-DP3
[320.300705] Dynamic subtest B-DP3: SUCCESS (7.763s)
[320.336426] Starting dynamic subtest: C-DP3
[328.041941] Dynamic subtest C-DP3: SUCCESS (7.736s)
[328.075858] Starting dynamic subtest: D-DP3
[335.782787] Dynamic subtest D-DP3: SUCCESS (7.736s)
[335.788733] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.086s)
[336.163754] [063/133] (690s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[336.366067] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[336.367729] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[336.559430] [064/133] (690s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[336.981673] Starting subtest: cursor-rapid-movement-256x256
[336.987030] Starting dynamic subtest: pipe-A-DP-3
[337.411049] Dynamic subtest pipe-A-DP-3: SUCCESS (0.423s)
[337.463387] Starting dynamic subtest: pipe-D-DP-3
[337.859554] Dynamic subtest pipe-D-DP-3: SUCCESS (0.406s)
[337.860522] Subtest cursor-rapid-movement-256x256: SUCCESS (0.878s)
[338.308942] [065/133] (688s left) kms_cursor_crc (cursor-offscreen-256x256)
[338.720632] Starting subtest: cursor-offscreen-256x256
[338.725813] Starting dynamic subtest: pipe-A-DP-3
[341.280834] Dynamic subtest pipe-A-DP-3: SUCCESS (2.555s)
[341.331567] Starting dynamic subtest: pipe-D-DP-3
[343.812240] Dynamic subtest pipe-D-DP-3: SUCCESS (2.490s)
[343.813140] Subtest cursor-offscreen-256x256: SUCCESS (5.091s)
[344.207911] [066/133] (682s left) kms_joiner (basic-force-big-joiner)
[344.398466] Starting subtest: basic-force-big-joiner
[344.399251] Starting dynamic subtest: single
[345.178587] Dynamic subtest single: SUCCESS (0.782s)
[345.179583] Subtest basic-force-big-joiner: SUCCESS (0.783s)
[345.582141] [067/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[345.775920] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[345.777556] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[345.965290] [068/133] (681s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[348.066666] Starting subtest: gem-execbuf-stress-pc8
[348.200890] Subtest gem-execbuf-stress-pc8: SKIP (0.134s)
[348.515883] [069/133] (678s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[348.702368] Starting subtest: plane-downscale-factor-0-5-with-rotation
[348.703178] Starting dynamic subtest: pipe-A
[349.080220] Dynamic subtest pipe-A: SUCCESS (0.378s)
[349.102142] Starting dynamic subtest: pipe-B
[349.561800] Dynamic subtest pipe-B: SUCCESS (0.479s)
[349.582113] Starting dynamic subtest: pipe-C
[350.042613] Dynamic subtest pipe-C: SUCCESS (0.479s)
[350.057249] Starting dynamic subtest: pipe-D
[350.507703] Dynamic subtest pipe-D: SUCCESS (0.463s)
[350.509072] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.807s)
[350.874774] [070/133] (676s left) syncobj_basic (bad-destroy-pad)
[350.953662] Starting subtest: bad-destroy-pad
[350.954573] Subtest bad-destroy-pad: SUCCESS (0.000s)
[351.091181] [071/133] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[351.280901] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[351.282549] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[351.489286] [072/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[351.679320] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[354.606521] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.927s)
[354.820867] [073/133] (672s left) syncobj_timeline (wait-all-complex)
[354.896478] Starting subtest: wait-all-complex
[355.113096] Subtest wait-all-complex: SUCCESS (0.215s)
[355.231250] [074/133] (672s left) gem_exec_schedule (in-order)
[355.322167] Starting subtest: in-order
[355.323162] Starting dynamic subtest: rcs0
[355.618341] Dynamic subtest rcs0: SUCCESS (0.295s)
[355.629953] Starting dynamic subtest: bcs0
[355.826579] Dynamic subtest bcs0: SUCCESS (0.207s)
[355.838162] Starting dynamic subtest: vcs0
[356.043620] Dynamic subtest vcs0: SUCCESS (0.216s)
[356.055402] Starting dynamic subtest: vcs1
[356.262044] Dynamic subtest vcs1: SUCCESS (0.217s)
[356.273692] Starting dynamic subtest: vecs0
[356.480280] Dynamic subtest vecs0: SUCCESS (0.217s)
[356.491841] Starting dynamic subtest: vecs1
[356.697463] Dynamic subtest vecs1: SUCCESS (0.216s)
[356.709065] Starting dynamic subtest: ccs0
[356.972867] Dynamic subtest ccs0: SUCCESS (0.274s)
[356.973759] Subtest in-order: SUCCESS (1.651s)
[357.439372] [075/133] (670s left) kms_plane_alpha_blend (alpha-transparent-fb)
[357.622673] Starting subtest: alpha-transparent-fb
[357.880291] Starting dynamic subtest: pipe-A-DP-3
[358.395988] Dynamic subtest pipe-A-DP-3: SUCCESS (0.515s)
[358.408878] Starting dynamic subtest: pipe-D-DP-3
[358.969945] Dynamic subtest pipe-D-DP-3: SUCCESS (0.572s)
[358.970891] Subtest alpha-transparent-fb: SUCCESS (1.347s)
[359.279587] [076/133] (668s left) sw_sync (sync_merge_invalid)
[359.328035] Starting subtest: sync_merge_invalid
[359.372356] Subtest sync_merge_invalid: SUCCESS (0.045s)
[359.457261] [077/133] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[359.649914] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[359.651613] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[359.818127] [078/133] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[360.009882] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[360.011567] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[360.213199] [079/133] (667s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[360.401397] Starting subtest: fbc-2p-pri-indfb-multidraw
[360.402994] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[360.597189] [080/133] (667s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[360.792737] Starting subtest: x-tiled-8bpp-rotate-180
[362.413585] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.620s)
[362.665036] [081/133] (665s left) core_setmaster (master-drop-set-shared-fd)
[362.814379] Starting subtest: master-drop-set-shared-fd
[362.845437] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[362.894232] [082/133] (665s left) tools_test (sysfs_l3_parity)
[362.946687] Starting subtest: sysfs_l3_parity
[363.013560] Subtest sysfs_l3_parity: SKIP (0.071s)
[363.151076] [083/133] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[363.348140] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[363.349871] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[363.563739] [084/133] (665s left) kms_vblank (ts-continuation-modeset-rpm)
[363.749579] Starting subtest: ts-continuation-modeset-rpm
[363.751920] Starting dynamic subtest: pipe-A-DP-3
[365.693580] Dynamic subtest pipe-A-DP-3: SUCCESS (1.942s)
[365.719184] Starting dynamic subtest: pipe-D-DP-3
[366.576679] Dynamic subtest pipe-D-DP-3: SUCCESS (0.875s)
[366.577579] Subtest ts-continuation-modeset-rpm: SUCCESS (2.827s)
[366.853780] [085/133] (661s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[366.947845] Starting subtest: multi-wait-all-for-submit-available-signaled
[366.951401] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[367.122644] [086/133] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[367.314849] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[367.317175] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[367.470353] [087/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[367.669206] Starting subtest: psr-2p-primscrn-spr-indfb-move
[367.670930] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[367.869547] [088/133] (661s left) gem_exec_params (secure-non-master)
[367.953883] Starting subtest: secure-non-master
[367.955650] Subtest secure-non-master: SKIP (0.000s)
[368.139756] [089/133] (660s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[368.331447] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[369.587222] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.256s)
[369.841102] [090/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[370.030053] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[370.031782] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[370.194460] [091/133] (658s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[370.387917] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[370.389626] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.567585] [092/133] (658s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[370.753053] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[370.815138] [093/133] (658s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[370.892429] Starting subtest: etime-single-wait-for-submit-unsubmitted
[370.996964] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[371.189532] [094/133] (658s left) perf (non-sampling-read-error)
[371.422430] Starting subtest: non-sampling-read-error
[371.438513] Subtest non-sampling-read-error: SUCCESS (0.016s)
[371.501021] [095/133] (657s left) kms_plane_lowres (tiling-4)
[371.687745] Starting subtest: tiling-4
[371.690259] Starting dynamic subtest: pipe-A-DP-3
[382.695103] Dynamic subtest pipe-A-DP-3: SUCCESS (11.005s)
[382.813328] Starting dynamic subtest: pipe-B-DP-3
[393.180895] Dynamic subtest pipe-B-DP-3: SUCCESS (10.376s)
[393.297243] Starting dynamic subtest: pipe-C-DP-3
[403.706098] Dynamic subtest pipe-C-DP-3: SUCCESS (10.419s)
[403.824394] Starting dynamic subtest: pipe-D-DP-3
[414.213917] Dynamic subtest pipe-D-DP-3: SUCCESS (10.397s)
[414.300278] Subtest tiling-4: SUCCESS (42.611s)
[414.614054] [096/133] (614s left) perf_pmu (init-wait)
[414.687370] Starting subtest: init-wait
[414.688251] Starting dynamic subtest: rcs0
[414.689194] Dynamic subtest rcs0: SUCCESS (0.003s)
[414.702209] Starting dynamic subtest: bcs0
[414.703153] Dynamic subtest bcs0: SUCCESS (0.001s)
[414.714382] Starting dynamic subtest: vcs0
[414.715251] Dynamic subtest vcs0: SUCCESS (0.000s)
[414.726839] Starting dynamic subtest: vcs1
[414.728087] Dynamic subtest vcs1: SUCCESS (0.000s)
[414.739585] Starting dynamic subtest: vecs0
[414.740779] Dynamic subtest vecs0: SUCCESS (0.000s)
[414.752176] Starting dynamic subtest: vecs1
[414.753406] Dynamic subtest vecs1: SUCCESS (0.000s)
[414.764788] Starting dynamic subtest: ccs0
[414.765634] Dynamic subtest ccs0: SUCCESS (0.000s)
[414.766824] Subtest init-wait: SUCCESS (0.013s)
[414.852128] [097/133] (614s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[415.037713] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[415.116555] [098/133] (614s left) api_intel_allocator (reloc-allocator)
[415.193376] Starting subtest: reloc-allocator
[415.194291] Starting dynamic subtest: basic
[415.221976] Dynamic subtest basic: SUCCESS (0.028s)
[415.235305] Starting dynamic subtest: parallel-one
[415.236206] Dynamic subtest parallel-one: SUCCESS (0.005s)
[415.247528] Starting dynamic subtest: print
[415.248398] Dynamic subtest print: SUCCESS (0.000s)
[415.259542] Starting dynamic subtest: reuse
[415.260446] Dynamic subtest reuse: SUCCESS (0.000s)
[415.271815] Starting dynamic subtest: fork-reopen-allocator
[415.273069] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[415.274159] Subtest reloc-allocator: SUCCESS (0.052s)
[415.451781] [099/133] (614s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[415.639986] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[415.641752] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[415.832048] [100/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[416.023162] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[418.700541] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.678s)
[418.948489] [101/133] (610s left) gem_exec_flush (basic-uc-pro-default)
[419.033190] Subtest basic-uc-pro-default: SKIP (0.000s)
[419.138408] [102/133] (610s left) kms_big_fb (y-tiled-addfb)
[419.331017] Starting subtest: y-tiled-addfb
[419.332825] Subtest y-tiled-addfb: SKIP (0.000s)
[419.516351] [103/133] (610s left) kms_color (gamma)
[419.702896] Starting subtest: gamma
[419.703805] Starting dynamic subtest: pipe-A-DP-3
[420.385336] Dynamic subtest pipe-A-DP-3: SUCCESS (0.680s)
[420.411990] Starting dynamic subtest: pipe-B-DP-3
[420.989146] Dynamic subtest pipe-B-DP-3: SUCCESS (0.602s)
[421.008229] Starting dynamic subtest: pipe-C-DP-3
[421.571223] Dynamic subtest pipe-C-DP-3: SUCCESS (0.581s)
[421.586940] Starting dynamic subtest: pipe-D-DP-3
[422.154666] Dynamic subtest pipe-D-DP-3: SUCCESS (0.580s)
[422.155720] Subtest gamma: SUCCESS (2.451s)
[422.497173] [104/133] (607s left) kms_cursor_crc (cursor-size-change)
[422.685292] Starting subtest: cursor-size-change
[422.686210] Starting dynamic subtest: pipe-A-DP-3
[423.615772] Dynamic subtest pipe-A-DP-3: SUCCESS (0.928s)
[423.644292] Starting dynamic subtest: pipe-D-DP-3
[424.446459] Dynamic subtest pipe-D-DP-3: SUCCESS (0.825s)
[424.447440] Subtest cursor-size-change: SUCCESS (1.761s)
[425.128603] [105/133] (605s left) perf (polling-parameterized)
[425.333466] Starting subtest: polling-parameterized
[445.362564] Subtest polling-parameterized: SUCCESS (20.030s)
[445.421350] [106/133] (584s left) gem_ctx_param (invalid-get-engines)
[445.497855] Starting subtest: invalid-get-engines
[445.500168] Subtest invalid-get-engines: SUCCESS (0.001s)
[445.684667] [107/133] (584s left) syncobj_wait (wait-all-for-submit-complex)
[445.761558] Starting subtest: wait-all-for-submit-complex
[445.979173] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[446.152501] [108/133] (584s left) gem_exec_schedule (deep)
[446.359495] Starting subtest: deep
[446.360454] Starting dynamic subtest: rcs0
[461.493696] Dynamic subtest rcs0: SUCCESS (15.133s)
[461.506480] Starting dynamic subtest: bcs0
[476.825238] Dynamic subtest bcs0: SUCCESS (15.330s)
[476.837628] Starting dynamic subtest: vcs0
[492.303692] Dynamic subtest vcs0: SUCCESS (15.476s)
[492.319459] Starting dynamic subtest: vcs1
[507.708025] Dynamic subtest vcs1: SUCCESS (15.399s)
[507.720120] Starting dynamic subtest: vecs0
[523.029187] Dynamic subtest vecs0: SUCCESS (15.318s)
[523.041163] Starting dynamic subtest: vecs1
[538.537955] Dynamic subtest vecs1: SUCCESS (15.508s)
[538.550222] Starting dynamic subtest: ccs0
[553.912555] Dynamic subtest ccs0: SUCCESS (15.373s)
[553.913444] Subtest deep: SUCCESS (107.551s)
[554.826786] [109/133] (475s left) kms_big_fb (linear-16bpp-rotate-90)
[555.020813] Starting subtest: linear-16bpp-rotate-90
[555.081613] Subtest linear-16bpp-rotate-90: SKIP (0.060s)
[555.295328] [110/133] (475s left) gem_exec_schedule (preempt-queue-contexts-chain)
[555.387146] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[555.776511] [111/133] (474s left) gem_exec_reloc (basic-wc-read-noreloc)
[555.865728] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[555.967824] [112/133] (474s left) kms_scaling_modes (scaling-mode-none)
[556.162578] Starting subtest: scaling-mode-none
[556.167700] Subtest scaling-mode-none: SKIP (0.001s)
[556.339166] [113/133] (474s left) gem_ctx_param (invalid-param-set)
[556.415789] Starting subtest: invalid-param-set
[556.416645] Subtest invalid-param-set: SUCCESS (0.000s)
[556.580268] [114/133] (474s left) gem_vm_create (create-ext)
[556.665460] Starting subtest: create-ext
[556.671591] Subtest create-ext: SUCCESS (0.006s)
[556.894887] [115/133] (474s left) gem_pwrite (basic-random)
[556.970319] Subtest basic-random: SKIP (0.000s)
[557.103982] [116/133] (474s left) gem_render_copy (y-tiled)
[557.188661] Starting subtest: y-tiled
[557.190995] Subtest y-tiled: SKIP (0.000s)
[557.475180] [117/133] (473s left) gem_mmap_gtt (medium-copy)
[557.551240] Subtest medium-copy: SKIP (0.000s)
[557.629678] [118/133] (473s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[557.823215] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[559.080537] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.257s)
[559.350920] [119/133] (472s left) kms_getfb (getfb2-handle-zero)
[559.538307] Starting subtest: getfb2-handle-zero
[559.539183] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[559.745778] [120/133] (471s left) kms_hdmi_inject (inject-audio)
[559.912298] Starting subtest: inject-audio
[560.043703] Subtest inject-audio: SUCCESS (0.132s)
[560.461790] [121/133] (471s left) gem_exec_alignment (pi)
[560.557271] Starting subtest: pi
[578.184956] Subtest pi: SUCCESS (17.628s)
[578.705254] [122/133] (452s left) kms_psr (psr2-cursor-plane-move)
[578.944234] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[579.005746] [123/133] (452s left) kms_draw_crc (draw-method-pwrite)
[579.194277] Starting subtest: draw-method-pwrite
[579.195200] Starting dynamic subtest: xrgb8888-untiled
[579.627055] Dynamic subtest xrgb8888-untiled: SUCCESS (0.432s)
[579.642340] Starting dynamic subtest: rgb565-untiled
[580.044611] Dynamic subtest rgb565-untiled: SUCCESS (0.415s)
[580.086460] Starting dynamic subtest: xrgb2101010-untiled
[580.428034] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.379s)
[580.470641] Starting dynamic subtest: xbgr16161616f-untiled
[580.876924] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.445s)
[580.892916] Starting dynamic subtest: xrgb8888-xtiled
[581.410380] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.532s)
[581.426744] Starting dynamic subtest: rgb565-xtiled
[581.994029] Dynamic subtest rgb565-xtiled: SUCCESS (0.582s)
[582.009295] Starting dynamic subtest: xrgb2101010-xtiled
[582.510386] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s)
[582.525284] Starting dynamic subtest: xbgr16161616f-xtiled
[583.128322] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.616s)
[583.145036] Starting dynamic subtest: xrgb8888-4tiled
[583.560508] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.428s)
[583.575739] Starting dynamic subtest: rgb565-4tiled
[583.878236] Dynamic subtest rgb565-4tiled: SUCCESS (0.316s)
[583.898389] Starting dynamic subtest: xrgb2101010-4tiled
[584.293746] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.412s)
[584.309100] Starting dynamic subtest: xbgr16161616f-4tiled
[584.928355] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.633s)
[584.934394] Subtest draw-method-pwrite: SUCCESS (5.736s)
[585.083192] [124/133] (446s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[585.166609] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[585.269264] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[585.412977] [125/133] (446s left) gem_tiled_wc
[585.574236] [126/133] (446s left) gem_mmap_wc (fault-concurrent)
[585.654217] Subtest fault-concurrent: SKIP (0.000s)
[585.723776] [127/133] (446s left) kms_cursor_edge_walk (128x128-left-edge)
[585.911596] Starting subtest: 128x128-left-edge
[585.913862] Starting dynamic subtest: pipe-A-DP-3
[589.394193] Dynamic subtest pipe-A-DP-3: SUCCESS (3.480s)
[589.413559] Starting dynamic subtest: pipe-D-DP-3
[592.724179] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[592.725155] Subtest 128x128-left-edge: SUCCESS (6.813s)
[593.060421] [128/133] (438s left) kms_flip (2x-absolute-wf_vblank)
[593.246464] Starting subtest: 2x-absolute-wf_vblank
[593.261169] Subtest 2x-absolute-wf_vblank: SKIP (0.014s)
[593.399252] [129/133] (438s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[593.581191] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[593.637811] [130/133] (438s left) gem_exec_store (cachelines)
[593.732585] Starting subtest: cachelines
[593.733431] Starting dynamic subtest: rcs0
[593.862627] Dynamic subtest rcs0: SUCCESS (0.129s)
[593.892700] Starting dynamic subtest: bcs0
[593.931156] Dynamic subtest bcs0: SUCCESS (0.066s)
[593.977065] Starting dynamic subtest: vcs0
[594.004766] Dynamic subtest vcs0: SUCCESS (0.070s)
[594.024279] Starting dynamic subtest: vcs1
[594.061036] Dynamic subtest vcs1: SUCCESS (0.055s)
[594.088926] Starting dynamic subtest: vecs0
[594.124140] Dynamic subtest vecs0: SUCCESS (0.061s)
[594.142926] Starting dynamic subtest: vecs1
[594.176664] Dynamic subtest vecs1: SUCCESS (0.050s)
[594.198073] Starting dynamic subtest: ccs0
[594.230127] Dynamic subtest ccs0: SUCCESS (0.052s)
[594.231437] Subtest cachelines: SUCCESS (0.498s)
[594.533373] [131/133] (437s left) kms_pm_backlight (fade-with-suspend)
[594.726315] Subtest fade-with-suspend: SKIP (0.000s)
[594.788099] [132/133] (437s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[594.872368] Starting subtest: yf-tiled-to-vebox-yf-tiled
[594.874822] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[595.134684] [133/133] (437s left) kms_vblank (crtc-id)
[595.326343] Starting subtest: crtc-id
[595.327252] Starting dynamic subtest: pipe-A-DP-3
[595.703352] Dynamic subtest pipe-A-DP-3: SUCCESS (0.375s)
[595.726376] Starting dynamic subtest: pipe-D-DP-3
[596.011577] Dynamic subtest pipe-D-DP-3: SUCCESS (0.302s)
[596.012629] Subtest crtc-id: SUCCESS (0.686s)
[596.303457] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: i915_selftest
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_tiled_display
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_joiner
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_flush
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: i915_fb_tiling
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: sysfs_heartbeat_interval
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: gem_tiled_fence_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_fbcon_fbt
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_cdclk
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_blits
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_udl
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: drm_read
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_joiner
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: i915_pm_rpm
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: core_setmaster
results: parsing output: 81/ for test: tools_test
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_plane_lowres
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_color
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_scaling_modes
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: gem_vm_create
results: parsing output: 114/ for test: gem_pwrite
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_getfb
results: parsing output: 119/ for test: kms_hdmi_inject
results: parsing output: 120/ for test: gem_exec_alignment
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_draw_crc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_tiled_wc
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_store
results: parsing output: 130/ for test: kms_pm_backlight
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: kms_vblank
Done.