[63.365828] Initializing watchdogs
[63.365894]   /dev/watchdog0
[63.385196] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.395803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.400061] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.402531] [001/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[63.590619] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[63.591470] Starting dynamic subtest: pipe-A-DP-3
[63.600189] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[63.607400] Starting dynamic subtest: pipe-B-DP-3
[63.615150] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[63.622611] Starting dynamic subtest: pipe-C-DP-3
[63.631036] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[63.638073] Starting dynamic subtest: pipe-D-DP-3
[63.647529] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[63.649502] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[64.080607] [002/133] (959s left) kms_psr (pr-primary-render)
[64.259179] Subtest pr-primary-render: SKIP (0.000s)
[64.307715] [003/133] (959s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[64.487358] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[64.488260] Starting dynamic subtest: pipe-A-valid-mode
[66.389298] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.896s)
[66.390686] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.897s)
[66.703785] [004/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[66.969953] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[66.970908] Starting dynamic subtest: pipe-A-DP-3
[66.979530] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[66.987874] Starting dynamic subtest: pipe-B-DP-3
[67.001015] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[67.009389] Starting dynamic subtest: pipe-C-DP-3
[67.022056] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[67.030244] Starting dynamic subtest: pipe-D-DP-3
[67.044078] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[67.046735] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[67.406258] [005/133] (956s left) kms_pm_rpm (modeset-lpsp)
[68.993333] Starting subtest: modeset-lpsp
[69.453079] Subtest modeset-lpsp: SKIP (0.456s)
[69.899601] [006/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[70.155376] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[70.300431] [007/133] (953s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[72.899217] Starting subtest: verify-pxp-stale-buf-optout-execution
[72.902053] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[73.039942] [008/133] (951s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[73.220587] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[73.236127] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.015s)
[73.371206] [009/133] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[73.553601] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[73.555246] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[73.742407] [010/133] (950s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[73.919500] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[73.924571] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[74.083226] [011/133] (950s left) kms_async_flips (crc)
[74.259851] Starting subtest: crc
[74.488241] Starting dynamic subtest: pipe-A-DP-3
[76.902575] Dynamic subtest pipe-A-DP-3: SUCCESS (2.412s)
[77.129109] Starting dynamic subtest: pipe-B-DP-3
[79.352549] Dynamic subtest pipe-B-DP-3: SUCCESS (2.234s)
[79.535798] Starting dynamic subtest: pipe-C-DP-3
[81.750234] Dynamic subtest pipe-C-DP-3: SUCCESS (2.228s)
[81.934141] Starting dynamic subtest: pipe-D-DP-3
[84.148662] Dynamic subtest pipe-D-DP-3: SUCCESS (2.227s)
[84.149558] Subtest crc: SUCCESS (9.899s)
[84.633740] [012/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[84.814176] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[84.815896] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[85.021605] [013/133] (939s left) gem_softpin (allocator-nopin-reserve)
[85.094420] Starting subtest: allocator-nopin-reserve
[85.329915] Subtest allocator-nopin-reserve: SUCCESS (0.236s)
[85.555507] [014/133] (939s left) i915_drm_fdinfo (busy-idle-check-all)
[85.615719] Starting subtest: busy-idle-check-all
[85.616546] Starting dynamic subtest: rcs0
[85.648049] Dynamic subtest rcs0: SKIP (0.031s)
[85.656474] Starting dynamic subtest: bcs0
[85.658660] Dynamic subtest bcs0: SKIP (0.000s)
[85.666755] Starting dynamic subtest: vcs0
[85.668512] Dynamic subtest vcs0: SKIP (0.000s)
[85.676192] Starting dynamic subtest: vcs1
[85.678274] Dynamic subtest vcs1: SKIP (0.000s)
[85.686223] Starting dynamic subtest: vecs0
[85.688578] Dynamic subtest vecs0: SKIP (0.000s)
[85.696361] Starting dynamic subtest: vecs1
[85.698494] Dynamic subtest vecs1: SKIP (0.000s)
[85.706360] Starting dynamic subtest: ccs0
[85.708765] Dynamic subtest ccs0: SKIP (0.001s)
[85.711187] Subtest busy-idle-check-all: SKIP (0.036s)
[85.752541] [015/133] (939s left) kms_atomic_transition (modeset-transition)
[85.972960] Starting subtest: modeset-transition
[85.973901] Starting dynamic subtest: 1x-outputs
[88.583362] Dynamic subtest 1x-outputs: SUCCESS (2.613s)
[88.585119] Subtest modeset-transition: SUCCESS (2.614s)
[88.873699] [016/133] (936s left) i915_selftest (mock)
[90.006440] Starting subtest: mock
[90.007463] Starting dynamic subtest: sanitycheck
[90.828796] Dynamic subtest sanitycheck: SUCCESS (0.823s)
[90.836334] Starting dynamic subtest: shmem
[91.642875] Dynamic subtest shmem: SUCCESS (0.814s)
[91.669136] Starting dynamic subtest: fence
[100.056730] Dynamic subtest fence: SUCCESS (8.421s)
[100.067710] Starting dynamic subtest: scatterlist
[101.918789] Dynamic subtest scatterlist: SUCCESS (1.862s)
[101.930223] Starting dynamic subtest: syncmap
[104.830220] Dynamic subtest syncmap: SUCCESS (2.912s)
[104.841251] Starting dynamic subtest: uncore
[105.675522] Dynamic subtest uncore: SUCCESS (0.845s)
[105.702833] Starting dynamic subtest: ring
[106.568541] Dynamic subtest ring: SUCCESS (0.892s)
[106.595056] Starting dynamic subtest: engine
[107.447731] Dynamic subtest engine: SUCCESS (0.878s)
[107.473998] Starting dynamic subtest: timelines
[112.112124] Dynamic subtest timelines: SUCCESS (4.666s)
[112.121165] Starting dynamic subtest: requests
[114.875987] Dynamic subtest requests: SUCCESS (2.765s)
[114.883813] Starting dynamic subtest: objects
[115.896238] Dynamic subtest objects: SUCCESS (1.020s)
[115.905248] Starting dynamic subtest: phys
[116.905964] Dynamic subtest phys: SUCCESS (1.010s)
[116.915030] Starting dynamic subtest: dmabuf
[117.911249] Dynamic subtest dmabuf: SUCCESS (1.005s)
[117.919962] Starting dynamic subtest: vma
[126.076531] Dynamic subtest vma: SUCCESS (8.168s)
[126.096482] Starting dynamic subtest: evict
[127.926330] Dynamic subtest evict: SUCCESS (1.850s)
[127.935617] Starting dynamic subtest: gtt
[131.877906] Dynamic subtest gtt: SUCCESS (3.952s)
[131.885991] Starting dynamic subtest: hugepages
[132.989991] Dynamic subtest hugepages: SUCCESS (1.112s)
[132.998607] Starting dynamic subtest: memory_region
[136.342995] Dynamic subtest memory_region: SUCCESS (3.354s)
[136.343926] Subtest mock: SUCCESS (46.362s)
[136.381764] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[136.383699] [017/133] (888s left) gem_create (create-valid-nonaligned)
[138.000068] Starting subtest: create-valid-nonaligned
[138.000949] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[138.190680] [FACT gem_create (create-valid-nonaligned)] new: kernel.kmod_is_loaded.i915: true
[138.193353] [018/133] (886s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[138.374213] Starting subtest: plane-all-transition-nonblocking-fencing
[138.375120] Starting dynamic subtest: pipe-A-DP-3
[142.184782] Dynamic subtest pipe-A-DP-3: SUCCESS (3.810s)
[142.304390] Starting dynamic subtest: pipe-B-DP-3
[146.346541] Dynamic subtest pipe-B-DP-3: SUCCESS (4.037s)
[146.453161] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.065s)
[146.742249] [019/133] (878s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[146.916777] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[146.917633] Starting dynamic subtest: pipe-A-DP-3
[146.925987] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[146.934068] Starting dynamic subtest: pipe-B-DP-3
[146.942253] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[146.950185] Starting dynamic subtest: pipe-C-DP-3
[146.958290] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[146.966237] Starting dynamic subtest: pipe-D-DP-3
[146.974645] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[146.976236] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[147.385877] [020/133] (877s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[147.638144] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[147.697900] [021/133] (877s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[147.874560] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[147.876264] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[148.050926] [022/133] (877s left) gem_exec_fence (syncobj-timeline-chain-engines)
[148.732756] Starting subtest: syncobj-timeline-chain-engines
[148.894250] Subtest syncobj-timeline-chain-engines: SUCCESS (0.160s)
[149.296375] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[149.298319] [023/133] (876s left) gem_exec_whisper (basic-queues-forked)
[149.386423] Starting subtest: basic-queues-forked
[171.877170] Subtest basic-queues-forked: SUCCESS (22.457s)
[172.156722] [024/133] (853s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[172.352448] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[172.354189] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[172.551258] [025/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[172.742521] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[172.744128] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[172.924185] [026/133] (852s left) gem_exec_flush (basic-uc-rw-default)
[173.009008] Subtest basic-uc-rw-default: SKIP (0.000s)
[173.095124] [027/133] (852s left) gem_lmem_swapping (parallel-random-verify)
[175.833203] Starting subtest: parallel-random-verify
[175.835084] Starting dynamic subtest: lmem0
[232.722822] Dynamic subtest lmem0: SUCCESS (56.879s)
[232.723801] Subtest parallel-random-verify: SUCCESS (56.880s)
[233.704982] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[233.706085] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[233.707831] [028/133] (792s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[235.428644] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[235.519818] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[235.522388] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[235.525418] [029/133] (790s left) kms_busy (basic)
[235.721834] Starting subtest: basic
[235.723893] Starting dynamic subtest: flip
[236.371931] Dynamic subtest flip: SUCCESS (0.648s)
[236.382268] Starting dynamic subtest: modeset
[237.296196] Dynamic subtest modeset: SUCCESS (0.922s)
[237.297238] Subtest basic: SUCCESS (1.573s)
[237.623767] [030/133] (788s left) i915_fb_tiling (basic-x-tiling)
[237.697963] Subtest basic-x-tiling: SKIP (0.000s)
[237.764848] [031/133] (788s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[237.948256] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[237.949166] Starting dynamic subtest: pipe-A-DP-3
[237.957004] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[237.965768] Starting dynamic subtest: pipe-B-DP-3
[237.973941] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[237.982574] Starting dynamic subtest: pipe-C-DP-3
[237.990757] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[237.999335] Starting dynamic subtest: pipe-D-DP-3
[238.008587] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[238.010534] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[238.434496] [032/133] (787s left) sysfs_heartbeat_interval (idempotent)
[238.517686] Starting subtest: idempotent
[238.518582] Starting dynamic subtest: vecs0
[238.520738] Dynamic subtest vecs0: SUCCESS (0.001s)
[238.530178] Starting dynamic subtest: ccs0
[238.531095] Dynamic subtest ccs0: SUCCESS (0.001s)
[238.539753] Starting dynamic subtest: vcs0
[238.540761] Dynamic subtest vcs0: SUCCESS (0.001s)
[238.549305] Starting dynamic subtest: bcs0
[238.550216] Dynamic subtest bcs0: SUCCESS (0.001s)
[238.559127] Starting dynamic subtest: vecs1
[238.560770] Dynamic subtest vecs1: SUCCESS (0.001s)
[238.569402] Starting dynamic subtest: rcs0
[238.570687] Dynamic subtest rcs0: SUCCESS (0.001s)
[238.579465] Starting dynamic subtest: vcs1
[238.580557] Dynamic subtest vcs1: SUCCESS (0.001s)
[238.581605] Subtest idempotent: SUCCESS (0.013s)
[238.692055] [033/133] (787s left) gem_ctx_exec (basic-invalid-context)
[238.778233] Starting subtest: basic-invalid-context
[238.783043] Subtest basic-invalid-context: SUCCESS (0.005s)
[238.937080] [034/133] (787s left) kms_plane_scaling (2x-scaler-multi-pipe)
[239.130163] Starting subtest: 2x-scaler-multi-pipe
[239.133166] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[239.329938] [035/133] (786s left) perf (blocking)
[239.729887] Starting subtest: blocking
[239.730759] Starting dynamic subtest: 0-rcs0
[249.754014] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[249.755054] Subtest blocking: SUCCESS (10.024s)
[249.819874] [036/133] (776s left) gem_exec_reloc (basic-write-cpu)
[249.902256] Subtest basic-write-cpu: SKIP (0.000s)
[249.988384] [037/133] (776s left) gem_mmap_gtt (flink-race)
[250.065017] Subtest flink-race: SKIP (0.000s)
[250.153450] [038/133] (776s left) perf_pmu (busy-hang)
[250.222060] Starting subtest: busy-hang
[250.222972] Starting dynamic subtest: rcs0
[251.511223] Dynamic subtest rcs0: SUCCESS (1.288s)
[251.523639] Starting dynamic subtest: bcs0
[252.741565] Dynamic subtest bcs0: SUCCESS (1.226s)
[252.752147] Starting dynamic subtest: vcs0
[253.970441] Dynamic subtest vcs0: SUCCESS (1.225s)
[253.980889] Starting dynamic subtest: vcs1
[255.198727] Dynamic subtest vcs1: SUCCESS (1.225s)
[255.208845] Starting dynamic subtest: vecs0
[256.436375] Dynamic subtest vecs0: SUCCESS (1.234s)
[256.446830] Starting dynamic subtest: vecs1
[257.660448] Dynamic subtest vecs1: SUCCESS (1.221s)
[257.670936] Starting dynamic subtest: ccs0
[258.879931] Dynamic subtest ccs0: SUCCESS (1.217s)
[258.880798] Subtest busy-hang: SUCCESS (8.656s)
[259.018098] [039/133] (767s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[259.206080] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[259.220538] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.015s)
[259.357420] [040/133] (767s left) prime_self_import (basic-with_one_bo)
[259.404285] Starting subtest: basic-with_one_bo
[259.455452] Subtest basic-with_one_bo: SUCCESS (0.052s)
[259.618408] [041/133] (766s left) gem_tiled_fence_blits (basic)
[259.701965] Subtest basic: SKIP (0.000s)
[259.803474] [042/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[259.991841] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[259.993447] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[260.202509] [043/133] (766s left) syncobj_timeline (reset-unsignaled)
[260.284375] Starting subtest: reset-unsignaled
[260.285266] Subtest reset-unsignaled: SUCCESS (0.000s)
[260.467367] [044/133] (766s left) kms_fbcon_fbt (psr)
[260.550559] Starting subtest: psr
[260.552533] Subtest psr: SKIP (0.000s)
[260.738504] [045/133] (766s left) api_intel_bb (object-noreloc-purge-cache-simple)
[260.815288] Starting subtest: object-noreloc-purge-cache-simple
[260.845591] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.031s)
[261.026416] [046/133] (765s left) kms_chamelium_frames (dp-crc-fast)
[261.297950] Subtest dp-crc-fast: SKIP (0.000s)
[261.447783] [047/133] (765s left) gem_exec_reloc (basic-write-read-noreloc)
[261.529592] Subtest basic-write-read-noreloc: SKIP (0.000s)
[261.617521] [048/133] (765s left) kms_flip (2x-nonexisting-fb)
[261.805015] Starting subtest: 2x-nonexisting-fb
[261.820232] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[262.001196] [049/133] (765s left) gem_exec_balancer (parallel-ordering)
[262.342979] Starting subtest: parallel-ordering
[264.002982] Subtest parallel-ordering: SUCCESS (1.660s)
[264.171436] [050/133] (763s left) kms_cdclk (mode-transition)
[264.356641] Starting subtest: mode-transition
[264.357519] Starting dynamic subtest: pipe-A-DP-3
[264.435072] Dynamic subtest pipe-A-DP-3: SKIP (0.076s)
[264.446862] Starting dynamic subtest: pipe-B-DP-3
[264.448567] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[264.459255] Starting dynamic subtest: pipe-C-DP-3
[264.461013] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[264.471369] Starting dynamic subtest: pipe-D-DP-3
[264.473143] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[264.474908] Subtest mode-transition: SKIP (0.088s)
[264.683413] [051/133] (762s left) gen9_exec_parse (basic-rejected-ctx-param)
[264.768423] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[264.843380] [052/133] (762s left) kms_cursor_legacy (single-bo)
[265.030087] Starting subtest: single-bo
[265.031052] Starting dynamic subtest: pipe-A
[270.412443] Dynamic subtest pipe-A: SUCCESS (5.381s)
[270.423010] Starting dynamic subtest: pipe-B
[275.792849] Dynamic subtest pipe-B: SUCCESS (5.379s)
[275.802929] Starting dynamic subtest: pipe-C
[281.174422] Dynamic subtest pipe-C: SUCCESS (5.379s)
[281.184466] Starting dynamic subtest: pipe-D
[286.553771] Dynamic subtest pipe-D: SUCCESS (5.379s)
[286.564147] Starting dynamic subtest: all-pipes
[291.935081] Dynamic subtest all-pipes: SUCCESS (5.380s)
[291.936127] Subtest single-bo: SUCCESS (26.902s)
[292.053403] [053/133] (735s left) gem_blits (basic)
[292.166244] Starting subtest: basic
[298.054123] Subtest basic: SUCCESS (5.887s)
[298.215546] [054/133] (729s left) kms_content_protection (content-type-change)
[298.464817] Starting subtest: content-type-change
[298.470840] Subtest content-type-change: SKIP (0.003s)
[298.681436] [055/133] (728s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[298.872671] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[298.930354] [056/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[299.120915] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[299.122570] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[299.319258] [057/133] (728s left) prime_udl
[299.431239] [058/133] (728s left) gem_exec_balancer (full-late)
[299.514904] Starting subtest: full-late
[301.554253] Subtest full-late: SUCCESS (2.039s)
[302.033545] [059/133] (725s left) drm_read (empty-block)
[302.288932] Starting subtest: empty-block
[303.290258] Subtest empty-block: SUCCESS (1.000s)
[303.519751] [060/133] (724s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[303.705259] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[303.705982] Starting dynamic subtest: pipe-A
[303.788552] Dynamic subtest pipe-A: SUCCESS (0.084s)
[303.811247] Starting dynamic subtest: pipe-B
[304.002066] Dynamic subtest pipe-B: SUCCESS (0.212s)
[304.022421] Starting dynamic subtest: pipe-C
[304.216839] Dynamic subtest pipe-C: SUCCESS (0.213s)
[304.238467] Starting dynamic subtest: pipe-D
[304.448370] Dynamic subtest pipe-D: SUCCESS (0.230s)
[304.449302] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.745s)
[304.817716] [061/133] (723s left) gem_ctx_persistence (legacy-engines-queued)
[304.903254] Starting subtest: legacy-engines-queued
[304.904238] Starting dynamic subtest: render
[305.005379] Dynamic subtest render: SUCCESS (0.101s)
[305.018028] Starting dynamic subtest: bsd1
[305.048214] Dynamic subtest bsd1: SUCCESS (0.042s)
[305.062180] Starting dynamic subtest: bsd2
[305.106579] Dynamic subtest bsd2: SUCCESS (0.057s)
[305.130309] Starting dynamic subtest: blt
[305.174052] Dynamic subtest blt: SUCCESS (0.065s)
[305.213780] Starting dynamic subtest: vebox
[305.258506] Dynamic subtest vebox: SUCCESS (0.080s)
[305.259563] Subtest legacy-engines-queued: SUCCESS (0.356s)
[305.483434] [062/133] (722s left) kms_flip (flip-vs-rmfb-interruptible)
[305.680298] Starting subtest: flip-vs-rmfb-interruptible
[305.685068] Starting dynamic subtest: A-DP3
[313.512530] Dynamic subtest A-DP3: SUCCESS (7.825s)
[313.550534] Starting dynamic subtest: B-DP3
[321.289451] Dynamic subtest B-DP3: SUCCESS (7.770s)
[321.325412] Starting dynamic subtest: C-DP3
[329.031918] Dynamic subtest C-DP3: SUCCESS (7.735s)
[329.064403] Starting dynamic subtest: D-DP3
[336.775118] Dynamic subtest D-DP3: SUCCESS (7.739s)
[336.783724] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.098s)
[337.189353] [063/133] (690s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[337.389459] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[337.391238] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[337.589065] [064/133] (690s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[338.005610] Starting subtest: cursor-rapid-movement-256x256
[338.010831] Starting dynamic subtest: pipe-A-DP-3
[338.487283] Dynamic subtest pipe-A-DP-3: SUCCESS (0.475s)
[338.535286] Starting dynamic subtest: pipe-D-DP-3
[338.897420] Dynamic subtest pipe-D-DP-3: SUCCESS (0.372s)
[338.898292] Subtest cursor-rapid-movement-256x256: SUCCESS (0.892s)
[339.307403] [065/133] (688s left) kms_cursor_crc (cursor-offscreen-256x256)
[339.720372] Starting subtest: cursor-offscreen-256x256
[339.725656] Starting dynamic subtest: pipe-A-DP-3
[342.211978] Dynamic subtest pipe-A-DP-3: SUCCESS (2.487s)
[342.262598] Starting dynamic subtest: pipe-D-DP-3
[344.748367] Dynamic subtest pipe-D-DP-3: SUCCESS (2.496s)
[344.749477] Subtest cursor-offscreen-256x256: SUCCESS (5.029s)
[345.161053] [066/133] (683s left) kms_joiner (basic-force-big-joiner)
[345.352494] Starting subtest: basic-force-big-joiner
[345.353223] Starting dynamic subtest: single
[346.091567] Dynamic subtest single: SUCCESS (0.740s)
[346.092593] Subtest basic-force-big-joiner: SUCCESS (0.742s)
[346.485692] [067/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[346.677905] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[346.679593] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[346.886127] [068/133] (681s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[348.996327] Starting subtest: gem-execbuf-stress-pc8
[349.139435] Subtest gem-execbuf-stress-pc8: SKIP (0.141s)
[349.435693] [069/133] (679s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[349.622758] Starting subtest: plane-downscale-factor-0-5-with-rotation
[349.623537] Starting dynamic subtest: pipe-A
[350.000560] Dynamic subtest pipe-A: SUCCESS (0.377s)
[350.024638] Starting dynamic subtest: pipe-B
[350.480377] Dynamic subtest pipe-B: SUCCESS (0.478s)
[350.498501] Starting dynamic subtest: pipe-C
[350.943388] Dynamic subtest pipe-C: SUCCESS (0.461s)
[350.963481] Starting dynamic subtest: pipe-D
[351.423571] Dynamic subtest pipe-D: SUCCESS (0.479s)
[351.427092] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.802s)
[351.801515] [070/133] (676s left) syncobj_basic (bad-destroy-pad)
[351.882476] Starting subtest: bad-destroy-pad
[351.883314] Subtest bad-destroy-pad: SUCCESS (0.000s)
[352.027518] [071/133] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[352.217176] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[352.218847] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[352.417908] [072/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[352.615185] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[355.403467] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.789s)
[355.664924] [073/133] (673s left) syncobj_timeline (wait-all-complex)
[355.747366] Starting subtest: wait-all-complex
[355.964693] Subtest wait-all-complex: SUCCESS (0.216s)
[356.103481] [074/133] (672s left) gem_exec_schedule (in-order)
[356.189798] Starting subtest: in-order
[356.190729] Starting dynamic subtest: rcs0
[356.486155] Dynamic subtest rcs0: SUCCESS (0.296s)
[356.497668] Starting dynamic subtest: bcs0
[356.695780] Dynamic subtest bcs0: SUCCESS (0.208s)
[356.707143] Starting dynamic subtest: vcs0
[356.918027] Dynamic subtest vcs0: SUCCESS (0.221s)
[356.929099] Starting dynamic subtest: vcs1
[357.139564] Dynamic subtest vcs1: SUCCESS (0.220s)
[357.150395] Starting dynamic subtest: vecs0
[357.361787] Dynamic subtest vecs0: SUCCESS (0.221s)
[357.373126] Starting dynamic subtest: vecs1
[357.581398] Dynamic subtest vecs1: SUCCESS (0.218s)
[357.592266] Starting dynamic subtest: ccs0
[357.800301] Dynamic subtest ccs0: SUCCESS (0.218s)
[357.801437] Subtest in-order: SUCCESS (1.611s)
[358.234976] [075/133] (670s left) kms_plane_alpha_blend (alpha-transparent-fb)
[358.426403] Starting subtest: alpha-transparent-fb
[358.680042] Starting dynamic subtest: pipe-A-DP-3
[359.192806] Dynamic subtest pipe-A-DP-3: SUCCESS (0.512s)
[359.205430] Starting dynamic subtest: pipe-D-DP-3
[359.784616] Dynamic subtest pipe-D-DP-3: SUCCESS (0.590s)
[359.785462] Subtest alpha-transparent-fb: SUCCESS (1.360s)
[360.148894] [076/133] (669s left) sw_sync (sync_merge_invalid)
[360.197051] Starting subtest: sync_merge_invalid
[360.245272] Subtest sync_merge_invalid: SUCCESS (0.048s)
[360.323612] [077/133] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[360.516011] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[360.517751] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.662597] [078/133] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[360.854169] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[360.855882] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[361.021741] [079/133] (668s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[361.213057] Starting subtest: fbc-2p-pri-indfb-multidraw
[361.214752] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[361.414180] [080/133] (668s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[361.614061] Starting subtest: x-tiled-8bpp-rotate-180
[363.214923] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.600s)
[363.464172] [081/133] (666s left) core_setmaster (master-drop-set-shared-fd)
[363.613783] Starting subtest: master-drop-set-shared-fd
[363.646595] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[363.695499] [082/133] (665s left) tools_test (sysfs_l3_parity)
[363.747232] Starting subtest: sysfs_l3_parity
[363.814828] Subtest sysfs_l3_parity: SKIP (0.072s)
[363.965073] [083/133] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[364.154255] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[364.155958] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[364.319378] [084/133] (665s left) kms_vblank (ts-continuation-modeset-rpm)
[364.506348] Starting subtest: ts-continuation-modeset-rpm
[364.507255] Starting dynamic subtest: pipe-A-DP-3
[366.427547] Dynamic subtest pipe-A-DP-3: SUCCESS (1.920s)
[366.455557] Starting dynamic subtest: pipe-D-DP-3
[367.298473] Dynamic subtest pipe-D-DP-3: SUCCESS (0.863s)
[367.299406] Subtest ts-continuation-modeset-rpm: SUCCESS (2.793s)
[367.575635] [085/133] (662s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[367.653491] Starting subtest: multi-wait-all-for-submit-available-signaled
[367.654375] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[367.821435] [086/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[368.017146] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[368.018888] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[368.173387] [087/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[368.360129] Starting subtest: psr-2p-primscrn-spr-indfb-move
[368.361803] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[368.560950] [088/133] (661s left) gem_exec_params (secure-non-master)
[368.644605] Starting subtest: secure-non-master
[368.646465] Subtest secure-non-master: SKIP (0.000s)
[368.775976] [089/133] (661s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[368.969244] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[370.260175] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.291s)
[370.514902] [090/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[370.712863] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[370.714471] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[370.887107] [091/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[371.078908] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[371.080528] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[371.254770] [092/133] (659s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[371.441675] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[371.505976] [093/133] (658s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[371.584439] Starting subtest: etime-single-wait-for-submit-unsubmitted
[371.694113] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[371.813439] [094/133] (658s left) perf (non-sampling-read-error)
[372.049818] Starting subtest: non-sampling-read-error
[372.066467] Subtest non-sampling-read-error: SUCCESS (0.017s)
[372.124377] [095/133] (658s left) kms_plane_lowres (tiling-4)
[372.311538] Starting subtest: tiling-4
[372.313807] Starting dynamic subtest: pipe-A-DP-3
[383.165964] Dynamic subtest pipe-A-DP-3: SUCCESS (10.852s)
[383.283730] Starting dynamic subtest: pipe-B-DP-3
[393.842896] Dynamic subtest pipe-B-DP-3: SUCCESS (10.569s)
[393.960787] Starting dynamic subtest: pipe-C-DP-3
[404.893946] Dynamic subtest pipe-C-DP-3: SUCCESS (10.943s)
[404.996565] Starting dynamic subtest: pipe-D-DP-3
[415.540829] Dynamic subtest pipe-D-DP-3: SUCCESS (10.554s)
[415.647245] Subtest tiling-4: SUCCESS (43.334s)
[415.987789] [096/133] (614s left) perf_pmu (init-wait)
[416.058742] Starting subtest: init-wait
[416.059586] Starting dynamic subtest: rcs0
[416.061942] Dynamic subtest rcs0: SUCCESS (0.003s)
[416.073492] Starting dynamic subtest: bcs0
[416.074407] Dynamic subtest bcs0: SUCCESS (0.001s)
[416.085432] Starting dynamic subtest: vcs0
[416.086354] Dynamic subtest vcs0: SUCCESS (0.001s)
[416.097702] Starting dynamic subtest: vcs1
[416.098843] Dynamic subtest vcs1: SUCCESS (0.000s)
[416.110026] Starting dynamic subtest: vecs0
[416.111153] Dynamic subtest vecs0: SUCCESS (0.000s)
[416.122649] Starting dynamic subtest: vecs1
[416.123835] Dynamic subtest vecs1: SUCCESS (0.001s)
[416.135389] Starting dynamic subtest: ccs0
[416.136445] Dynamic subtest ccs0: SUCCESS (0.001s)
[416.137541] Subtest init-wait: SUCCESS (0.014s)
[416.228069] [097/133] (614s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[416.414612] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[416.512455] [098/133] (614s left) api_intel_allocator (reloc-allocator)
[416.590580] Starting subtest: reloc-allocator
[416.591427] Starting dynamic subtest: basic
[416.618887] Dynamic subtest basic: SUCCESS (0.029s)
[416.632279] Starting dynamic subtest: parallel-one
[416.633177] Dynamic subtest parallel-one: SUCCESS (0.005s)
[416.644541] Starting dynamic subtest: print
[416.645422] Dynamic subtest print: SUCCESS (0.000s)
[416.656549] Starting dynamic subtest: reuse
[416.657627] Dynamic subtest reuse: SUCCESS (0.000s)
[416.668936] Starting dynamic subtest: fork-reopen-allocator
[416.670247] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[416.671565] Subtest reloc-allocator: SUCCESS (0.053s)
[416.869699] [099/133] (613s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[417.061755] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[417.063337] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.252931] [100/133] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[417.442223] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[420.188255] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.747s)
[420.438888] [101/133] (610s left) gem_exec_flush (basic-uc-pro-default)
[420.524434] Subtest basic-uc-pro-default: SKIP (0.000s)
[420.598583] [102/133] (610s left) kms_big_fb (y-tiled-addfb)
[420.793558] Starting subtest: y-tiled-addfb
[420.795290] Subtest y-tiled-addfb: SKIP (0.000s)
[421.002688] [103/133] (610s left) kms_color (gamma)
[421.190302] Starting subtest: gamma
[421.191193] Starting dynamic subtest: pipe-A-DP-3
[421.832279] Dynamic subtest pipe-A-DP-3: SUCCESS (0.641s)
[421.844131] Starting dynamic subtest: pipe-B-DP-3
[422.421792] Dynamic subtest pipe-B-DP-3: SUCCESS (0.589s)
[422.441386] Starting dynamic subtest: pipe-C-DP-3
[422.988029] Dynamic subtest pipe-C-DP-3: SUCCESS (0.564s)
[423.001653] Starting dynamic subtest: pipe-D-DP-3
[423.594207] Dynamic subtest pipe-D-DP-3: SUCCESS (0.605s)
[423.595257] Subtest gamma: SUCCESS (2.404s)
[423.878210] [104/133] (607s left) kms_cursor_crc (cursor-size-change)
[424.066570] Starting subtest: cursor-size-change
[424.067743] Starting dynamic subtest: pipe-A-DP-3
[424.993680] Dynamic subtest pipe-A-DP-3: SUCCESS (0.926s)
[425.018019] Starting dynamic subtest: pipe-D-DP-3
[425.818984] Dynamic subtest pipe-D-DP-3: SUCCESS (0.821s)
[425.819965] Subtest cursor-size-change: SUCCESS (1.754s)
[426.467259] [105/133] (604s left) perf (polling-parameterized)
[426.687895] Starting subtest: polling-parameterized
[446.718872] Subtest polling-parameterized: SUCCESS (20.029s)
[446.770547] [106/133] (584s left) gem_ctx_param (invalid-get-engines)
[446.846776] Starting subtest: invalid-get-engines
[446.849127] Subtest invalid-get-engines: SUCCESS (0.001s)
[447.028777] [107/133] (584s left) syncobj_wait (wait-all-for-submit-complex)
[447.108476] Starting subtest: wait-all-for-submit-complex
[447.325736] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[447.452591] [108/133] (584s left) gem_exec_schedule (deep)
[447.658411] Starting subtest: deep
[447.659378] Starting dynamic subtest: rcs0
[462.816105] Dynamic subtest rcs0: SUCCESS (15.155s)
[462.828812] Starting dynamic subtest: bcs0
[478.161916] Dynamic subtest bcs0: SUCCESS (15.343s)
[478.173921] Starting dynamic subtest: vcs0
[493.695223] Dynamic subtest vcs0: SUCCESS (15.531s)
[493.707798] Starting dynamic subtest: vcs1
[509.481439] Dynamic subtest vcs1: SUCCESS (15.783s)
[509.494754] Starting dynamic subtest: vecs0
[525.036965] Dynamic subtest vecs0: SUCCESS (15.552s)
[525.048881] Starting dynamic subtest: vecs1
[540.309506] Dynamic subtest vecs1: SUCCESS (15.269s)
[540.324165] Starting dynamic subtest: ccs0
[555.949653] Dynamic subtest ccs0: SUCCESS (15.638s)
[555.950573] Subtest deep: SUCCESS (108.281s)
[556.893949] [109/133] (474s left) kms_big_fb (linear-16bpp-rotate-90)
[557.087251] Starting subtest: linear-16bpp-rotate-90
[557.139676] Subtest linear-16bpp-rotate-90: SKIP (0.052s)
[557.358057] [110/133] (474s left) gem_exec_schedule (preempt-queue-contexts-chain)
[557.451138] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[557.837415] [111/133] (473s left) gem_exec_reloc (basic-wc-read-noreloc)
[557.924440] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[558.022032] [112/133] (473s left) kms_scaling_modes (scaling-mode-none)
[558.211385] Starting subtest: scaling-mode-none
[558.216263] Subtest scaling-mode-none: SKIP (0.001s)
[558.409339] [113/133] (473s left) gem_ctx_param (invalid-param-set)
[558.492930] Starting subtest: invalid-param-set
[558.493905] Subtest invalid-param-set: SUCCESS (0.000s)
[558.638624] [114/133] (473s left) gem_vm_create (create-ext)
[558.720846] Starting subtest: create-ext
[558.724962] Subtest create-ext: SUCCESS (0.004s)
[558.950526] [115/133] (473s left) gem_pwrite (basic-random)
[559.035234] Subtest basic-random: SKIP (0.000s)
[559.136992] [116/133] (472s left) gem_render_copy (y-tiled)
[559.224539] Starting subtest: y-tiled
[559.226431] Subtest y-tiled: SKIP (0.000s)
[559.488253] [117/133] (472s left) gem_mmap_gtt (medium-copy)
[559.562433] Subtest medium-copy: SKIP (0.000s)
[559.669663] [118/133] (472s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[559.865281] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[561.140394] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.274s)
[561.390397] [119/133] (470s left) kms_getfb (getfb2-handle-zero)
[561.577298] Starting subtest: getfb2-handle-zero
[561.578177] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[561.790264] [120/133] (470s left) kms_hdmi_inject (inject-audio)
[561.947233] Starting subtest: inject-audio
[562.068065] Subtest inject-audio: SUCCESS (0.121s)
[562.448708] [121/133] (470s left) gem_exec_alignment (pi)
[562.532474] Starting subtest: pi
[580.081719] Subtest pi: SUCCESS (17.544s)
[580.617458] [122/133] (452s left) kms_psr (psr2-cursor-plane-move)
[580.851309] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[580.917387] [123/133] (451s left) kms_draw_crc (draw-method-pwrite)
[581.106303] Starting subtest: draw-method-pwrite
[581.107206] Starting dynamic subtest: xrgb8888-untiled
[581.538424] Dynamic subtest xrgb8888-untiled: SUCCESS (0.432s)
[581.561936] Starting dynamic subtest: rgb565-untiled
[581.972400] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[581.988835] Starting dynamic subtest: xrgb2101010-untiled
[582.339451] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.365s)
[582.380434] Starting dynamic subtest: xbgr16161616f-untiled
[582.771948] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.429s)
[582.786482] Starting dynamic subtest: xrgb8888-xtiled
[583.305423] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.532s)
[583.320409] Starting dynamic subtest: rgb565-xtiled
[583.855686] Dynamic subtest rgb565-xtiled: SUCCESS (0.549s)
[583.870792] Starting dynamic subtest: xrgb2101010-xtiled
[584.372197] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s)
[584.386584] Starting dynamic subtest: xbgr16161616f-xtiled
[584.972360] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.599s)
[584.987071] Starting dynamic subtest: xrgb8888-4tiled
[585.390160] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.416s)
[585.431712] Starting dynamic subtest: rgb565-4tiled
[585.741432] Dynamic subtest rgb565-4tiled: SUCCESS (0.347s)
[585.757162] Starting dynamic subtest: xrgb2101010-4tiled
[586.139155] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.394s)
[586.153636] Starting dynamic subtest: xbgr16161616f-4tiled
[586.756188] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.616s)
[586.757242] Subtest draw-method-pwrite: SUCCESS (5.650s)
[586.938546] [124/133] (445s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[587.020595] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[587.127723] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[587.306059] [125/133] (445s left) gem_tiled_wc
[587.452666] [126/133] (445s left) gem_mmap_wc (fault-concurrent)
[587.529180] Subtest fault-concurrent: SKIP (0.000s)
[587.603806] [127/133] (445s left) kms_cursor_edge_walk (128x128-left-edge)
[587.803239] Starting subtest: 128x128-left-edge
[587.804362] Starting dynamic subtest: pipe-A-DP-3
[591.290953] Dynamic subtest pipe-A-DP-3: SUCCESS (3.494s)
[591.308819] Starting dynamic subtest: pipe-D-DP-3
[594.600018] Dynamic subtest pipe-D-DP-3: SUCCESS (3.310s)
[594.600991] Subtest 128x128-left-edge: SUCCESS (6.808s)
[594.903966] [128/133] (438s left) kms_flip (2x-absolute-wf_vblank)
[595.091397] Starting subtest: 2x-absolute-wf_vblank
[595.106674] Subtest 2x-absolute-wf_vblank: SKIP (0.014s)
[595.244747] [129/133] (437s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[595.430171] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[595.485104] [130/133] (437s left) gem_exec_store (cachelines)
[595.572384] Starting subtest: cachelines
[595.573346] Starting dynamic subtest: rcs0
[595.697541] Dynamic subtest rcs0: SUCCESS (0.125s)
[595.727411] Starting dynamic subtest: bcs0
[595.755582] Dynamic subtest bcs0: SUCCESS (0.056s)
[595.790556] Starting dynamic subtest: vcs0
[595.821711] Dynamic subtest vcs0: SUCCESS (0.063s)
[595.842566] Starting dynamic subtest: vcs1
[595.877934] Dynamic subtest vcs1: SUCCESS (0.055s)
[595.908175] Starting dynamic subtest: vecs0
[595.936059] Dynamic subtest vecs0: SUCCESS (0.056s)
[595.960552] Starting dynamic subtest: vecs1
[595.989778] Dynamic subtest vecs1: SUCCESS (0.052s)
[596.016373] Starting dynamic subtest: ccs0
[596.053216] Dynamic subtest ccs0: SUCCESS (0.062s)
[596.054410] Subtest cachelines: SUCCESS (0.482s)
[596.373714] [131/133] (436s left) kms_pm_backlight (fade-with-suspend)
[596.559567] Subtest fade-with-suspend: SKIP (0.000s)
[596.617251] [132/133] (436s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[596.700490] Starting subtest: yf-tiled-to-vebox-yf-tiled
[596.702389] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[596.993456] [133/133] (436s left) kms_vblank (crtc-id)
[597.180317] Starting subtest: crtc-id
[597.181218] Starting dynamic subtest: pipe-A-DP-3
[597.566019] Dynamic subtest pipe-A-DP-3: SUCCESS (0.384s)
[597.589119] Starting dynamic subtest: pipe-D-DP-3
[597.871600] Dynamic subtest pipe-D-DP-3: SUCCESS (0.300s)
[597.872567] Subtest crtc-id: SUCCESS (0.693s)
[598.153857] 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.