[56.783426] Initializing watchdogs
[56.783473]   /dev/watchdog0
[56.798255] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.802709] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.805169] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.808384] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[56.944591] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[56.948699] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[57.045753] [002/156] (960s left) gem_exec_reloc (basic-cpu-wc-active)
[57.117879] Subtest basic-cpu-wc-active: SKIP (0.000s)
[57.173480] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[57.269561] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[57.273572] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[57.382801] [004/156] (960s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[57.486259] Starting subtest: plane-scaler-unity-scaling-with-rotation
[57.488550] Starting dynamic subtest: pipe-A
[57.728324] Dynamic subtest pipe-A: SUCCESS (0.252s)
[57.736416] Starting dynamic subtest: pipe-B
[58.999953] Dynamic subtest pipe-B: SUCCESS (1.305s)
[59.008275] Starting dynamic subtest: pipe-C
[60.279304] Dynamic subtest pipe-C: SUCCESS (1.308s)
[60.288553] Starting dynamic subtest: pipe-D
[61.596888] Dynamic subtest pipe-D: SUCCESS (1.343s)
[61.599422] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.209s)
[62.978717] [005/156] (954s left) kms_cursor_crc (cursor-random-32x10)
[63.168931] Starting subtest: cursor-random-32x10
[63.221480] Subtest cursor-random-32x10: SKIP (0.050s)
[63.477244] [006/156] (954s left) perf_pmu (busy-idle-no-semaphores)
[63.518920] Starting subtest: busy-idle-no-semaphores
[63.521796] Starting dynamic subtest: rcs0
[64.178060] Dynamic subtest rcs0: SUCCESS (0.669s)
[64.189075] Starting dynamic subtest: bcs0
[64.826074] Dynamic subtest bcs0: SUCCESS (0.653s)
[64.836894] Starting dynamic subtest: vcs0
[65.476638] Dynamic subtest vcs0: SUCCESS (0.657s)
[65.489623] Starting dynamic subtest: vcs1
[66.922499] Dynamic subtest vcs1: SUCCESS (1.456s)
[66.933321] Starting dynamic subtest: vecs0
[68.904081] Dynamic subtest vecs0: SUCCESS (1.995s)
[68.913199] Starting dynamic subtest: ccs0
[70.886681] Dynamic subtest ccs0: SUCCESS (1.990s)
[70.889684] Subtest busy-idle-no-semaphores: SUCCESS (7.431s)
[71.001868] [007/156] (946s left) kms_cursor_edge_walk (64x64-top-bottom)
[71.105016] Starting subtest: 64x64-top-bottom
[71.107350] Starting dynamic subtest: pipe-A-eDP-1
[74.556993] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[74.567074] Starting dynamic subtest: pipe-D-eDP-1
[77.758332] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.209s)
[77.760253] Subtest 64x64-top-bottom: SUCCESS (6.675s)
[78.565115] [008/156] (939s left) gem_spin_batch (engines)
[78.632701] Starting subtest: engines
[78.635141] Starting dynamic subtest: rcs0
[81.873380] Dynamic subtest rcs0: SUCCESS (3.240s)
[81.883855] Starting dynamic subtest: bcs0
[85.107792] Dynamic subtest bcs0: SUCCESS (3.236s)
[85.116659] Starting dynamic subtest: vcs0
[88.344592] Dynamic subtest vcs0: SUCCESS (3.235s)
[88.355153] Starting dynamic subtest: vcs1
[91.579115] Dynamic subtest vcs1: SUCCESS (3.233s)
[91.589823] Starting dynamic subtest: vecs0
[94.814353] Dynamic subtest vecs0: SUCCESS (3.233s)
[94.824866] Starting dynamic subtest: ccs0
[98.050642] Dynamic subtest ccs0: SUCCESS (3.234s)
[98.052836] Subtest engines: SUCCESS (19.419s)
[98.289908] [009/156] (919s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[98.390315] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[98.392647] Starting dynamic subtest: pipe-A-eDP-1
[104.254318] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.866s)
[104.266605] Starting dynamic subtest: pipe-B-eDP-1
[110.903313] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[110.905697] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.516s)
[111.786949] [010/156] (905s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite)
[111.900742] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite
[111.904982] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[111.998581] [011/156] (905s left) kms_plane_lowres (tiling-y)
[112.088199] Starting subtest: tiling-y
[112.092703] Subtest tiling-y: SKIP (0.000s)
[112.160253] [012/156] (905s left) vgem_basic (bad-fence)
[112.237466] Starting subtest: bad-fence
[112.239500] Subtest bad-fence: SUCCESS (0.000s)
[112.292738] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true
[112.296250] [013/156] (905s left) sw_sync (sync_multi_consumer)
[112.329910] Starting subtest: sync_multi_consumer
[112.759878] Subtest sync_multi_consumer: SUCCESS (0.430s)
[112.819170] [014/156] (904s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[112.921666] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[112.925946] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[113.010812] [015/156] (904s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[113.121594] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[113.125597] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[113.233083] [016/156] (904s left) kms_flip (flip-vs-panning-interruptible)
[113.335573] Starting subtest: flip-vs-panning-interruptible
[113.337832] Starting dynamic subtest: A-eDP1
[122.100017] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[122.111758] Starting dynamic subtest: B-eDP1
[130.821910] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[130.832133] Starting dynamic subtest: C-eDP1
[139.550818] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[139.561897] Starting dynamic subtest: D-eDP1
[148.286874] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[148.291079] Subtest flip-vs-panning-interruptible: SUCCESS (34.953s)
[149.450340] [017/156] (868s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[149.553873] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[149.558055] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[149.655523] [018/156] (868s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[149.755281] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[149.759081] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[149.855998] [019/156] (868s left) syncobj_eventfd (binary-wait-before-signal)
[149.905991] Starting subtest: binary-wait-before-signal
[149.935470] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[150.023401] [020/156] (868s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[150.126758] Starting subtest: fbchdr-rgb565-draw-pwrite
[150.131155] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[150.221816] [021/156] (867s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[150.312864] Starting subtest: coverage-vs-premult-vs-constant
[150.600202] Starting dynamic subtest: pipe-A-eDP-1
[151.246593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[151.255444] Starting dynamic subtest: pipe-D-eDP-1
[152.586405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[152.588690] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.274s)
[153.427390] [022/156] (864s left) gem_exec_fence (syncobj-signal)
[153.846709] Starting subtest: syncobj-signal
[153.852443] Subtest syncobj-signal: SUCCESS (0.007s)
[155.400602] [023/156] (862s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[155.502755] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[155.507153] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[155.597023] [024/156] (862s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[155.712466] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[155.717227] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[155.835938] [025/156] (862s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[155.962803] Starting subtest: cursorB-vs-flipB-atomic
[155.967337] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[156.103840] [026/156] (862s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[156.192926] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[156.197381] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[156.266369] [027/156] (862s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[156.363434] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[156.365249] Starting dynamic subtest: pipe-A-eDP-1
[162.308702] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.947s)
[162.317858] Starting dynamic subtest: pipe-B-eDP-1
[168.971218] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s)
[168.973520] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.610s)
[169.831160] [028/156] (848s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[169.886985] Starting subtest: multi-wait-available-unsubmitted-submitted
[169.889282] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[169.988248] [029/156] (848s left) gem_ctx_persistence (heartbeat-hostile)
[170.052364] Starting subtest: heartbeat-hostile
[170.057062] Subtest heartbeat-hostile: SKIP (0.000s)
[170.162878] [030/156] (848s left) kms_psr (pr-cursor-mmap-gtt)
[170.257862] Starting subtest: pr-cursor-mmap-gtt
[170.262271] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[170.328510] [031/156] (848s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[170.433402] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[170.437699] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[170.560299] [032/156] (848s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[170.666623] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[170.670826] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[170.780104] [033/156] (847s left) gem_exec_schedule (timeslicing)
[170.852983] Starting subtest: timeslicing
[170.854821] Starting dynamic subtest: rcs0
[170.866401] Dynamic subtest rcs0: SUCCESS (0.021s)
[170.876670] Starting dynamic subtest: bcs0
[170.889145] Dynamic subtest bcs0: SUCCESS (0.022s)
[170.899195] Starting dynamic subtest: vcs0
[170.910524] Dynamic subtest vcs0: SUCCESS (0.021s)
[170.919180] Starting dynamic subtest: vcs1
[170.931901] Dynamic subtest vcs1: SUCCESS (0.021s)
[170.940068] Starting dynamic subtest: vecs0
[170.951617] Dynamic subtest vecs0: SUCCESS (0.019s)
[170.960126] Starting dynamic subtest: ccs0
[170.971301] Dynamic subtest ccs0: SUCCESS (0.019s)
[170.973166] Subtest timeslicing: SUCCESS (0.127s)
[172.329568] [034/156] (846s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[172.427346] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[172.429619] Starting dynamic subtest: pipe-A-eDP-1
[172.438199] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.447268] Starting dynamic subtest: pipe-B-eDP-1
[172.456051] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.464789] Starting dynamic subtest: pipe-C-eDP-1
[172.473186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.481282] Starting dynamic subtest: pipe-D-eDP-1
[172.489287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.493130] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[174.699186] [035/156] (843s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[175.088579] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[175.912612] [036/156] (842s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[175.961480] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[176.026009] [037/156] (842s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[176.140573] Starting subtest: cursor-vs-flip-toggle
[207.360499] Subtest cursor-vs-flip-toggle: SUCCESS (31.216s)
[208.180246] [038/156] (810s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[208.278193] Starting subtest: primary-4-tiled-reflect-x-0
[215.260118] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.983s)
[216.523557] [039/156] (802s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[216.617939] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[216.620130] Starting dynamic subtest: pipe-A-default-mode
[219.374748] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s)
[219.377145] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.759s)
[220.213454] [040/156] (798s left) gem_mmap_offset (bad-flags)
[220.273319] Starting subtest: bad-flags
[220.275220] Subtest bad-flags: SUCCESS (0.000s)
[220.385138] [041/156] (798s left) kms_invalid_mode (bad-hsync-start)
[220.478079] Starting subtest: bad-hsync-start
[220.480363] Starting dynamic subtest: pipe-A-eDP-1
[220.760715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[220.771083] Starting dynamic subtest: pipe-B-eDP-1
[220.772945] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[220.781722] Starting dynamic subtest: pipe-C-eDP-1
[220.784053] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[220.793229] Starting dynamic subtest: pipe-D-eDP-1
[220.795699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[220.798038] Subtest bad-hsync-start: SUCCESS (0.290s)
[221.630121] [042/156] (797s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[221.742052] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[221.746413] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.850831] [043/156] (797s left) kms_content_protection (legacy)
[221.999636] Starting subtest: legacy
[222.004082] Subtest legacy: SKIP (0.000s)
[222.125427] [044/156] (796s left) gem_ctx_engines (execute-allforone)
[222.178960] Starting subtest: execute-allforone
[222.190728] Subtest execute-allforone: SUCCESS (0.014s)
[223.342892] [045/156] (795s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[223.432464] Starting subtest: 2x-plain-flip-ts-check-interruptible
[223.444450] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[223.518750] [046/156] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[223.629964] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[231.264073] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.639s)
[231.421606] [047/156] (787s left) kms_psr (fbc-psr2-cursor-render)
[231.515039] Starting subtest: fbc-psr2-cursor-render
[231.517337] Starting dynamic subtest: eDP-1
[231.521726] Dynamic subtest eDP-1: SKIP (0.000s)
[231.526192] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[231.588465] [048/156] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[231.690628] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[231.695076] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[231.796629] [049/156] (787s left) gem_ctx_param (vm)
[231.852301] Starting subtest: vm
[231.899241] Subtest vm: SUCCESS (0.047s)
[232.034399] [050/156] (787s left) kms_psr (pr-primary-blt)
[232.129160] Starting subtest: pr-primary-blt
[232.133261] Subtest pr-primary-blt: SKIP (0.000s)
[232.200850] [051/156] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[232.307359] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[232.310664] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[232.407604] [052/156] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[232.505897] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[236.203922] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.703s)
[237.378828] [053/156] (782s left) kms_atomic_transition (plane-all-modeset-transition)
[237.473786] Starting subtest: plane-all-modeset-transition
[237.478220] Subtest plane-all-modeset-transition: SKIP (0.000s)
[237.547450] [054/156] (781s left) kms_setmode (invalid-clone-exclusive-crtc)
[237.598062] Starting subtest: invalid-clone-exclusive-crtc
[237.604654] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[237.687394] [055/156] (781s left) gem_exec_reloc (basic-cpu-gtt)
[237.751288] Subtest basic-cpu-gtt: SKIP (0.000s)
[237.813518] [056/156] (781s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[237.931241] Starting subtest: flip-vs-cursor-busy-crc-atomic
[238.659656] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.726s)
[239.507128] [057/156] (780s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[239.615262] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[239.619299] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[239.716457] [058/156] (779s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[239.818115] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[239.822650] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[239.909944] [059/156] (779s left) kms_flip (2x-nonexisting-fb)
[240.001729] Starting subtest: 2x-nonexisting-fb
[240.012182] Subtest 2x-nonexisting-fb: SKIP (0.012s)
[240.093083] [060/156] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[240.193387] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[240.197420] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[240.290497] [061/156] (779s left) kms_async_flips (async-flip-hang)
[240.378298] Starting subtest: async-flip-hang
[240.753854] Starting dynamic subtest: pipe-A-eDP-1
[255.773455] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.018s)
[256.157821] Starting dynamic subtest: pipe-B-eDP-1
[271.772481] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.621s)
[272.158777] Starting dynamic subtest: pipe-C-eDP-1
[287.768837] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.612s)
[288.154027] Starting dynamic subtest: pipe-D-eDP-1
[303.767744] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.616s)
[303.769907] Subtest async-flip-hang: SUCCESS (63.385s)
[304.947051] [062/156] (714s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[305.048565] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[305.052512] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[305.168378] [063/156] (714s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[305.266157] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[305.270225] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[305.368837] [064/156] (714s left) syncobj_basic (bad-handle-to-fd)
[305.430831] Starting subtest: bad-handle-to-fd
[305.433160] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[305.543843] [065/156] (714s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[305.649518] Starting subtest: 4-tiled-32bpp-rotate-90
[305.670241] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[305.776588] [066/156] (714s left) syncobj_wait (multi-wait-all-signaled)
[305.833635] Starting subtest: multi-wait-all-signaled
[305.836191] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[305.923515] [067/156] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[306.019046] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[306.022463] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[306.111034] [068/156] (713s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[306.192520] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[306.196208] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[306.265306] [069/156] (713s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[306.363901] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[306.367360] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[306.444895] [070/156] (713s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[306.534904] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[306.538344] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.628354] [071/156] (713s left) kms_chamelium_edid (vga-edid-read)
[307.005173] Subtest vga-edid-read: SKIP (0.000s)
[307.863241] [072/156] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[307.970518] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[307.974511] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[308.061660] [073/156] (712s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[308.159120] Starting subtest: yf-tiled-64bpp-rotate-0
[308.163545] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[308.254530] [074/156] (712s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[308.347548] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[308.351755] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[308.427325] [075/156] (711s left) kms_big_fb (linear-addfb)
[308.524197] Starting subtest: linear-addfb
[308.526398] Subtest linear-addfb: SUCCESS (0.000s)
[308.622236] [076/156] (711s left) gem_pwrite (basic-self)
[308.674956] Subtest basic-self: SKIP (0.000s)
[308.738283] [077/156] (711s left) drm_read (empty-nonblock)
[308.884581] Starting subtest: empty-nonblock
[308.886625] Subtest empty-nonblock: SUCCESS (0.000s)
[309.026540] [078/156] (711s left) syncobj_wait (wait-all-for-submit-snapshot)
[309.078441] Starting subtest: wait-all-for-submit-snapshot
[309.159662] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[309.235921] [079/156] (711s left) gem_mmap_gtt (big-bo-tiledx)
[309.289575] Subtest big-bo-tiledX: SKIP (0.000s)
[309.354323] [080/156] (711s left) kms_vblank (wait-forked-busy-hang)
[309.454283] Starting subtest: wait-forked-busy-hang
[309.456298] Starting dynamic subtest: pipe-A-eDP-1
[336.060596] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.606s)
[336.074350] Starting dynamic subtest: pipe-D-eDP-1
[362.064420] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.999s)
[362.066742] Subtest wait-forked-busy-hang: SUCCESS (52.610s)
[362.941549] [081/156] (657s left) gem_exec_schedule (deep)
[363.121975] Starting subtest: deep
[363.123837] Starting dynamic subtest: rcs0
[368.396017] Dynamic subtest rcs0: SKIP (5.271s)
[368.408768] Starting dynamic subtest: vcs0
[378.465818] Dynamic subtest vcs0: SUCCESS (10.073s)
[378.479600] Starting dynamic subtest: vcs1
[389.136193] Dynamic subtest vcs1: SUCCESS (10.668s)
[389.150332] Starting dynamic subtest: vecs0
[399.750721] Dynamic subtest vecs0: SUCCESS (10.613s)
[399.762729] Starting dynamic subtest: ccs0
[411.807076] Dynamic subtest ccs0: SUCCESS (12.054s)
[411.809793] Subtest deep: SUCCESS (48.684s)
[413.103713] [082/156] (607s left) prime_mmap_coherency (write)
[413.167963] Starting subtest: write
[418.552131] Subtest write: SUCCESS (5.383s)
[418.682297] [083/156] (602s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[418.782787] Starting subtest: psr-rgb565-draw-mmap-wc
[425.658015] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.882s)
[425.783694] [084/156] (594s left) kms_psr (psr2-primary-page-flip)
[425.875129] Starting subtest: psr2-primary-page-flip
[425.877416] Starting dynamic subtest: eDP-1
[427.663194] Dynamic subtest eDP-1: SUCCESS (1.786s)
[427.665481] Subtest psr2-primary-page-flip: SUCCESS (1.787s)
[428.538919] [085/156] (592s left) kms_getfb (getfb-addfb-different-handles)
[428.633955] Starting subtest: getfb-addfb-different-handles
[428.636181] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[428.748288] [086/156] (592s left) gem_exec_balancer (full-pulse)
[428.812469] Starting subtest: full-pulse
[433.227496] Subtest full-pulse: SUCCESS (4.418s)
[433.581239] [087/156] (587s left) i915_drm_fdinfo (memory-info-idle)
[433.622987] Starting subtest: memory-info-idle
[433.625245] Starting dynamic subtest: smem0
[433.675801] Dynamic subtest smem0: SUCCESS (0.055s)
[433.678556] Subtest memory-info-idle: SUCCESS (0.055s)
[433.752358] [088/156] (587s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[433.809081] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[433.811521] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[433.903076] [089/156] (587s left) kms_prop_blob (invalid-get-prop)
[433.958529] Starting subtest: invalid-get-prop
[433.960713] Subtest invalid-get-prop: SUCCESS (0.000s)
[434.064761] [090/156] (586s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[434.165027] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[434.167374] Starting dynamic subtest: pipe-A
[434.229550] Dynamic subtest pipe-A: SUCCESS (0.066s)
[434.240205] Starting dynamic subtest: pipe-B
[435.358476] Dynamic subtest pipe-B: SUCCESS (1.127s)
[435.369672] Starting dynamic subtest: pipe-C
[436.483899] Dynamic subtest pipe-C: SUCCESS (1.125s)
[436.492987] Starting dynamic subtest: pipe-D
[437.607298] Dynamic subtest pipe-D: SUCCESS (1.123s)
[437.609555] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.445s)
[438.767207] [091/156] (582s left) kms_fbcon_fbt (psr-suspend)
[438.815351] Starting subtest: psr-suspend
[489.296388] Subtest psr-suspend: FAIL (20.756s)
[489.336284] [092/156] (531s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[489.438318] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[489.440556] Starting dynamic subtest: pipe-A-eDP-1
[489.462491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.472773] Starting dynamic subtest: pipe-B-eDP-1
[489.493096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.502357] Starting dynamic subtest: pipe-C-eDP-1
[489.522244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.531210] Starting dynamic subtest: pipe-D-eDP-1
[489.551767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.555871] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[491.704406] [093/156] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[491.805326] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[491.809544] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[491.910336] [094/156] (529s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[492.004279] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[492.008663] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[492.092617] [095/156] (529s left) api_intel_allocator (alloc-simple)
[492.145215] Starting subtest: alloc-simple
[492.147453] Subtest alloc-simple: SUCCESS (0.003s)
[492.266102] [096/156] (528s left) gem_partial_pwrite_pread (write)
[492.329689] Subtest write: SKIP (0.000s)
[492.401375] [097/156] (528s left) gen9_exec_parse (bb-start-param)
[492.460324] Subtest bb-start-param: SKIP (0.000s)
[492.530290] [098/156] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[492.625744] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[496.864041] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.289s)
[498.045874] [099/156] (523s left) kms_async_flips (test-time-stamp-atomic)
[498.145146] Starting subtest: test-time-stamp-atomic
[498.528825] Starting dynamic subtest: pipe-A-eDP-1
[499.336682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[499.725825] Starting dynamic subtest: pipe-B-eDP-1
[500.557988] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.843s)
[500.936003] Starting dynamic subtest: pipe-C-eDP-1
[501.703037] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.780s)
[502.067519] Starting dynamic subtest: pipe-D-eDP-1
[502.841804] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[502.844265] Subtest test-time-stamp-atomic: SUCCESS (4.721s)
[504.005736] [100/156] (517s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[504.099704] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[504.104148] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[504.193674] [101/156] (517s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[504.298260] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[504.302404] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[504.412597] [102/156] (517s left) kms_universal_plane (disable-primary-vs-flip)
[504.499255] Starting subtest: disable-primary-vs-flip
[504.501068] Starting dynamic subtest: pipe-A-eDP-1
[506.076230] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.582s)
[506.086131] Starting dynamic subtest: pipe-B-eDP-1
[508.280636] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.207s)
[508.291848] Starting dynamic subtest: pipe-C-eDP-1
[510.520229] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s)
[510.532397] Starting dynamic subtest: pipe-D-eDP-1
[512.783359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.265s)
[512.785661] Subtest disable-primary-vs-flip: SUCCESS (8.303s)
[513.662039] [103/156] (507s left) kms_cursor_legacy (forked-move)
[513.777463] Starting subtest: forked-move
[513.779653] Starting dynamic subtest: pipe-A
[519.244230] Dynamic subtest pipe-A: SUCCESS (5.464s)
[519.256597] Starting dynamic subtest: pipe-B
[524.716319] Dynamic subtest pipe-B: SUCCESS (5.465s)
[524.729354] Starting dynamic subtest: pipe-C
[530.196230] Dynamic subtest pipe-C: SUCCESS (5.473s)
[530.209291] Starting dynamic subtest: pipe-D
[535.681591] Dynamic subtest pipe-D: SUCCESS (5.481s)
[535.692347] Starting dynamic subtest: all-pipes
[541.184697] Dynamic subtest all-pipes: SUCCESS (5.501s)
[541.187224] Subtest forked-move: SUCCESS (27.396s)
[541.387456] [104/156] (480s left) kms_joiner (basic-max-non-joiner)
[541.478017] Starting subtest: basic-max-non-joiner
[541.482217] Subtest basic-max-non-joiner: SKIP (0.000s)
[541.562644] [105/156] (480s left) i915_pm_rc6_residency (rc6-idle)
[541.609926] Starting subtest: rc6-idle
[541.624769] Starting dynamic subtest: gt0-rcs0
[565.912641] Dynamic subtest gt0-rcs0: SUCCESS (24.291s)
[565.922779] Starting dynamic subtest: gt0-bcs0
[590.264416] Dynamic subtest gt0-bcs0: SUCCESS (24.350s)
[590.274740] Starting dynamic subtest: gt0-ccs0
[614.558084] Dynamic subtest gt0-ccs0: SUCCESS (24.287s)
[614.568276] Starting dynamic subtest: gt1-vcs0
[620.732972] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[620.745133] Starting dynamic subtest: gt1-vecs0
[626.903776] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[626.906620] Subtest rc6-idle: SUCCESS (85.298s)
[626.998849] [106/156] (394s left) api_intel_bb (simple-bb-ctx)
[627.051304] Starting subtest: simple-bb-ctx
[627.065382] Subtest simple-bb-ctx: SUCCESS (0.017s)
[627.198827] [107/156] (394s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[627.269344] Starting subtest: yf-tiled-ccs-to-x-tiled
[627.273453] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[627.454295] [108/156] (394s left) kms_concurrent (multi-plane-atomic-lowres)
[627.547895] Starting subtest: multi-plane-atomic-lowres
[627.550158] Starting dynamic subtest: pipe-A-eDP-1
[628.049865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[628.061191] Starting dynamic subtest: pipe-B-eDP-1
[629.277418] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[629.287700] Starting dynamic subtest: pipe-C-eDP-1
[630.492577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[630.503925] Starting dynamic subtest: pipe-D-eDP-1
[631.740372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[631.742678] Subtest multi-plane-atomic-lowres: SUCCESS (4.194s)
[632.578681] [109/156] (389s left) kms_chamelium_audio (dp-audio)
[632.951988] Subtest dp-audio: SKIP (0.000s)
[633.780853] [110/156] (388s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[633.887474] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[641.305277] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.423s)
[641.430900] [111/156] (380s left) kms_pm_dc (dc5-dpms-negative)
[642.530434] Starting subtest: dc5-dpms-negative
[642.534971] Subtest dc5-dpms-negative: SKIP (0.000s)
[642.603970] [112/156] (379s left) gem_sync (basic-all)
[642.683095] Starting subtest: basic-all
[647.879280] Subtest basic-all: SUCCESS (5.205s)
[648.068478] [113/156] (373s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[648.186496] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[652.680396] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.502s)
[653.832898] [114/156] (368s left) i915_module_load (resize-bar)
[653.867441] Starting subtest: resize-bar
[653.873974] Subtest resize-bar: SKIP (0.007s)
[653.918909] [115/156] (368s left) fbdev (pan)
[653.952968] Starting subtest: pan
[653.981898] Subtest pan: SUCCESS (0.033s)
[654.053465] [116/156] (368s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[654.142902] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[654.145032] Starting dynamic subtest: pipe-A-eDP-1
[654.167790] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[654.178890] Starting dynamic subtest: pipe-B-eDP-1
[654.200295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[654.210578] Starting dynamic subtest: pipe-C-eDP-1
[654.232896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[654.242956] Starting dynamic subtest: pipe-D-eDP-1
[654.265335] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[654.269356] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[656.378814] [117/156] (365s left) perf_pmu (busy-start)
[656.420106] Starting subtest: busy-start
[656.422342] Starting dynamic subtest: rcs0
[658.968673] Dynamic subtest rcs0: SUCCESS (2.550s)
[658.981011] Starting dynamic subtest: bcs0
[661.516413] Dynamic subtest bcs0: SUCCESS (2.546s)
[661.529255] Starting dynamic subtest: vcs0
[664.902403] Dynamic subtest vcs0: SUCCESS (3.383s)
[664.914031] Starting dynamic subtest: vcs1
[668.870414] Dynamic subtest vcs1: SUCCESS (3.966s)
[668.881475] Starting dynamic subtest: vecs0
[672.902607] Dynamic subtest vecs0: SUCCESS (4.030s)
[672.913802] Starting dynamic subtest: ccs0
[675.451924] Dynamic subtest ccs0: SUCCESS (2.548s)
[675.455212] Subtest busy-start: SUCCESS (19.038s)
[675.559777] [118/156] (346s left) syncobj_timeline (invalid-signal-zero-handles)
[675.618053] Starting subtest: invalid-signal-zero-handles
[675.620319] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[675.735724] [119/156] (346s left) prime_self_import (basic-llseek-size)
[675.769538] Starting subtest: basic-llseek-size
[675.787121] Subtest basic-llseek-size: SUCCESS (0.019s)
[675.885522] [120/156] (346s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[675.951333] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[675.955750] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[676.144444] [121/156] (346s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[676.250685] Starting subtest: x-tiled-addfb-size-offset-overflow
[676.252640] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[676.350346] [122/156] (346s left) kms_cursor_crc (cursor-random-128x128)
[676.554791] Starting subtest: cursor-random-128x128
[676.559847] Starting dynamic subtest: pipe-A-eDP-1
[679.904147] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.346s)
[679.938116] Starting dynamic subtest: pipe-D-eDP-1
[683.895729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[683.897824] Subtest cursor-random-128x128: SUCCESS (7.340s)
[684.754062] [123/156] (337s left) prime_vgem (basic-fence-mmap)
[684.829322] Starting subtest: basic-fence-mmap
[684.834110] Subtest basic-fence-mmap: SKIP (0.000s)
[684.932626] [124/156] (337s left) kms_feature_discovery (chamelium)
[685.016896] Starting subtest: chamelium
[685.021221] Subtest chamelium: SKIP (0.000s)
[685.093976] [125/156] (337s left) gem_wait (wait)
[685.157841] Starting subtest: wait
[685.160141] Starting dynamic subtest: all-engines
[686.854961] Dynamic subtest all-engines: SUCCESS (1.695s)
[686.866004] Starting dynamic subtest: rcs0
[687.899642] Dynamic subtest rcs0: SUCCESS (1.044s)
[687.912264] Starting dynamic subtest: bcs0
[688.947804] Dynamic subtest bcs0: SUCCESS (1.045s)
[688.959012] Starting dynamic subtest: vcs0
[689.994510] Dynamic subtest vcs0: SUCCESS (1.045s)
[690.008826] Starting dynamic subtest: vcs1
[691.039508] Dynamic subtest vcs1: SUCCESS (1.043s)
[691.052127] Starting dynamic subtest: vecs0
[692.085015] Dynamic subtest vecs0: SUCCESS (1.043s)
[692.097350] Starting dynamic subtest: ccs0
[693.132252] Dynamic subtest ccs0: SUCCESS (1.046s)
[693.134801] Subtest wait: SUCCESS (7.977s)
[693.344716] [126/156] (329s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[693.445819] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[693.449969] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[693.545818] [127/156] (329s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[693.635751] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[693.638012] Starting dynamic subtest: pipe-A-eDP-1
[693.659781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[693.670320] Starting dynamic subtest: pipe-B-eDP-1
[693.690994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[693.701116] Starting dynamic subtest: pipe-C-eDP-1
[693.721672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[693.731633] Starting dynamic subtest: pipe-D-eDP-1
[693.753332] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[693.757402] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[695.910006] [128/156] (326s left) gem_exercise_blt (fast-copy-emit)
[695.962666] Starting subtest: fast-copy-emit
[695.964887] Starting dynamic subtest: linear-smem-smem-emit
[695.983942] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[695.996640] Starting dynamic subtest: xmajor-smem-smem-emit
[696.001854] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[696.012186] Starting dynamic subtest: tile4-smem-smem-emit
[696.016912] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[696.026414] Starting dynamic subtest: tile64-smem-smem-emit
[696.033167] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[696.035549] Subtest fast-copy-emit: SUCCESS (0.071s)
[696.162915] [129/156] (326s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[696.272957] Starting subtest: hdr-modesetfrombusy
[696.277280] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[696.372846] [130/156] (326s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[696.475910] Starting subtest: fbcpsrhdr-slowdraw
[696.479889] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[696.573658] [131/156] (326s left) i915_suspend (fence-restore-tiled2untiled)
[696.629224] Starting subtest: fence-restore-tiled2untiled
[696.633678] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[696.748369] [132/156] (326s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[696.802725] Starting subtest: single-wait-for-submit-available-submitted
[696.804631] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[696.908017] [133/156] (325s left) dumb_buffer (create-clear)
[696.956461] Starting subtest: create-clear
[730.905519] Subtest create-clear: SUCCESS (33.941s)
[731.005566] [134/156] (291s left) syncobj_timeline (etime-multi-wait-all-submitted)
[731.066124] Starting subtest: etime-multi-wait-all-submitted
[731.171681] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[731.256693] [135/156] (291s left) gem_eio (create)
[731.497851] Starting subtest: create
[731.848858] Subtest create: SUCCESS (0.352s)
[731.970920] [136/156] (291s left) gem_exec_reloc (basic-cpu-read)
[732.020983] Subtest basic-cpu-read: SKIP (0.000s)
[732.096998] [137/156] (290s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[732.198916] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[732.202632] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[732.305433] [138/156] (290s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[732.362898] Subtest writes-after-reads-snoop: SKIP (0.000s)
[732.434630] [139/156] (290s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[732.519632] Starting subtest: primary-yf-tiled-reflect-x-180
[732.590804] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s)
[732.695961] [140/156] (290s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[732.788974] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[732.792336] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[732.888161] [141/156] (290s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[732.993600] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[733.663148] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[733.837755] [142/156] (289s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[733.925946] Starting subtest: compare-crc-sanitycheck-nv12
[733.928268] Starting dynamic subtest: pipe-A-eDP-1
[734.639644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[734.650222] Starting dynamic subtest: pipe-B-eDP-1
[735.930069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[735.942994] Starting dynamic subtest: pipe-C-eDP-1
[737.209796] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[737.220975] Starting dynamic subtest: pipe-D-eDP-1
[738.441256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[738.443472] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.515s)
[739.249452] [143/156] (284s left) prime_mmap (test_map_unmap)
[739.310925] Starting subtest: test_map_unmap
[739.313263] Starting dynamic subtest: test_map_unmap-smem
[739.341439] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[739.343882] Subtest test_map_unmap: SUCCESS (0.034s)
[739.446384] [144/156] (283s left) gem_exec_basic (basic)
[739.496028] Starting subtest: basic
[739.498456] Starting dynamic subtest: rcs0-smem
[739.500737] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[739.512425] Starting dynamic subtest: bcs0-smem
[739.514685] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[739.525302] Starting dynamic subtest: vcs0-smem
[739.527150] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[739.536916] Starting dynamic subtest: vcs1-smem
[739.538772] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[739.548576] Starting dynamic subtest: vecs0-smem
[739.550464] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[739.560127] Starting dynamic subtest: ccs0-smem
[739.562044] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[739.563921] Subtest basic: SUCCESS (0.020s)
[740.926405] [145/156] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[741.035663] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[741.040034] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[741.161676] [146/156] (282s left) gem_exec_whisper (basic-fds-all)
[741.218647] Starting subtest: basic-fds-all
[752.664288] Subtest basic-fds-all: SUCCESS (11.444s)
[752.866912] [147/156] (270s left) prime_self_import (basic-with_two_bos)
[752.898222] Starting subtest: basic-with_two_bos
[752.925195] Subtest basic-with_two_bos: SUCCESS (0.027s)
[753.039779] [148/156] (270s left) gem_exec_schedule (preempt-queue)
[753.109603] Subtest preempt-queue: SKIP (0.000s)
[753.417760] [149/156] (270s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[753.480811] Starting subtest: invalid-single-wait-all-unsubmitted
[753.483233] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[753.619240] [150/156] (269s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[753.727800] Starting subtest: extended-modeset-hang-newfb-with-reset
[753.729705] Starting dynamic subtest: pipe-A
[769.322785] Dynamic subtest pipe-A: SUCCESS (15.595s)
[769.336068] Starting dynamic subtest: pipe-D
[784.902625] Dynamic subtest pipe-D: SUCCESS (15.575s)
[784.904949] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.174s)
[785.714272] [151/156] (237s left) kms_flip (flip-vs-wf_vblank-interruptible)
[785.818810] Starting subtest: flip-vs-wf_vblank-interruptible
[785.823767] Starting dynamic subtest: A-eDP1
[787.755016] Dynamic subtest A-eDP1: SUCCESS (1.933s)
[787.773669] Starting dynamic subtest: B-eDP1
[789.689308] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[789.702023] Starting dynamic subtest: C-eDP1
[791.615272] Dynamic subtest C-eDP1: SUCCESS (1.924s)
[791.626031] Starting dynamic subtest: D-eDP1
[793.549881] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[793.556163] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.735s)
[794.775311] [152/156] (228s left) gem_readwrite (read-write)
[794.830364] Subtest read-write: SKIP (0.000s)
[794.898292] [153/156] (228s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[795.008721] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[795.010876] Starting dynamic subtest: pipe-A-eDP-1
[795.095719] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[795.106935] Starting dynamic subtest: pipe-B-eDP-1
[796.245052] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[796.249764] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.240s)
[797.438576] [154/156] (226s left) gem_exec_flush (basic-uc-prw-default)
[797.508626] Starting subtest: basic-uc-prw-default
[802.973742] Subtest basic-uc-prw-default: SUCCESS (5.466s)
[803.175690] [155/156] (220s left) gem_eio (in-flight-immediate)
[803.429422] Starting subtest: in-flight-immediate
[811.813895] Subtest in-flight-immediate: SUCCESS (8.383s)
[811.936814] [156/156] (211s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[812.030070] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[812.034457] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[812.134932] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: gem_spin_batch
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_lowres
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_eventfd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: gem_ctx_engines
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_setmode
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_edid
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_pwrite
results: parsing output: 76/ for test: drm_read
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: prime_mmap_coherency
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_fbcon_fbt
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: gem_partial_pwrite_pread
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_universal_plane
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: i915_pm_rc6_residency
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_concurrent
results: parsing output: 108/ for test: kms_chamelium_audio
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: gem_sync
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_module_load
results: parsing output: 114/ for test: fbdev
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: gem_wait
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_exercise_blt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_suspend
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: dumb_buffer
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: gem_exec_reloc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_partial_pwrite_pread
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: kms_pipe_crc_basic
results: parsing output: 142/ for test: prime_mmap
results: parsing output: 143/ for test: gem_exec_basic
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_whisper
results: parsing output: 146/ for test: prime_self_import
results: parsing output: 147/ for test: gem_exec_schedule
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: kms_busy
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: gem_readwrite
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: gem_exec_flush
results: parsing output: 154/ for test: gem_eio
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.