[65.668997] Initializing watchdogs
[65.669047]   /dev/watchdog0
[65.684347] [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]
[65.689304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.691574] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.693975] [001/132] (960s left) kms_lease (lease-revoke)
[65.801360] Starting subtest: lease-revoke
[65.802355] Starting dynamic subtest: pipe-A-eDP-1
[65.836201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.035s)
[65.844861] Starting dynamic subtest: pipe-B-eDP-1
[65.864871] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[65.871181] Starting dynamic subtest: pipe-C-eDP-1
[65.892365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[65.898546] Starting dynamic subtest: pipe-D-eDP-1
[65.918580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[65.919435] Subtest lease-revoke: SUCCESS (0.119s)
[66.033216] [002/132] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[66.137961] Starting subtest: fbc-tiling-linear
[69.851372] Subtest fbc-tiling-linear: SUCCESS (3.718s)
[71.012473] [003/132] (955s left) kms_plane_scaling (planes-upscale-factor-0-25)
[71.101345] Starting subtest: planes-upscale-factor-0-25
[71.102246] Starting dynamic subtest: pipe-A
[71.162884] Dynamic subtest pipe-A: SUCCESS (0.062s)
[71.170813] Starting dynamic subtest: pipe-B
[72.342828] Dynamic subtest pipe-B: SUCCESS (1.180s)
[72.351051] Starting dynamic subtest: pipe-C
[73.445979] Dynamic subtest pipe-C: SUCCESS (1.103s)
[73.452061] Starting dynamic subtest: pipe-D
[74.580957] Dynamic subtest pipe-D: SUCCESS (1.135s)
[74.581922] Subtest planes-upscale-factor-0-25: SUCCESS (3.483s)
[75.721989] [004/132] (950s left) perf_pmu (most-busy-idle-check-all)
[75.764904] Starting subtest: most-busy-idle-check-all
[75.765826] Starting dynamic subtest: rcs0
[76.893819] Dynamic subtest rcs0: SUCCESS (1.120s)
[76.902309] Starting dynamic subtest: bcs0
[78.940652] Dynamic subtest bcs0: SUCCESS (2.046s)
[78.949208] Starting dynamic subtest: vcs0
[80.926178] Dynamic subtest vcs0: SUCCESS (1.984s)
[80.935073] Starting dynamic subtest: vcs1
[82.909644] Dynamic subtest vcs1: SUCCESS (1.982s)
[82.917493] Starting dynamic subtest: vecs0
[84.892346] Dynamic subtest vecs0: SUCCESS (1.981s)
[84.900522] Starting dynamic subtest: ccs0
[86.941038] Dynamic subtest ccs0: SUCCESS (2.047s)
[86.942261] Subtest most-busy-idle-check-all: SUCCESS (11.167s)
[87.021485] [005/132] (939s left) kms_content_protection (dp-mst-type-0-hdcp14)
[87.167295] Starting subtest: dp-mst-type-0-hdcp14
[87.169145] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[87.284697] [006/132] (939s left) gem_exec_fence (syncobj-timeline-signal)
[87.845796] Starting subtest: syncobj-timeline-signal
[87.847053] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[88.990480] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[88.992501] [007/132] (937s left) gem_ctx_exec (basic)
[89.051850] Starting subtest: basic
[89.059962] Subtest basic: SUCCESS (0.008s)
[89.170676] [008/132] (937s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[89.254900] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[89.256734] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[89.345700] [009/132] (937s left) kms_flip (dpms-vs-vblank-race)
[89.438739] Starting subtest: dpms-vs-vblank-race
[89.441182] Starting dynamic subtest: A-eDP1
[93.325455] Dynamic subtest A-eDP1: SUCCESS (3.883s)
[93.331998] Starting dynamic subtest: B-eDP1
[96.835701] Dynamic subtest B-eDP1: SUCCESS (3.509s)
[96.843364] Starting dynamic subtest: C-eDP1
[100.360811] Dynamic subtest C-eDP1: SUCCESS (3.524s)
[100.368026] Starting dynamic subtest: D-eDP1
[105.005724] Dynamic subtest D-eDP1: SUCCESS (4.642s)
[105.008160] Subtest dpms-vs-vblank-race: SUCCESS (15.567s)
[105.885757] [010/132] (920s left) kms_psr2_su (page_flip-p010)
[105.941147] Subtest page_flip-P010: SKIP (0.000s)
[106.004265] [011/132] (920s left) prime_mmap (test_forked_cpu_write)
[106.065838] Starting subtest: test_forked_cpu_write
[106.066991] Starting dynamic subtest: test_forked_cpu_write-smem
[106.074689] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.010s)
[106.075765] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[106.168551] [012/132] (920s left) kms_universal_plane (universal-plane-pageflip-windowed)
[106.251977] Starting subtest: universal-plane-pageflip-windowed
[106.252868] Starting dynamic subtest: pipe-A-eDP-1
[106.868055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[106.876152] Starting dynamic subtest: pipe-B-eDP-1
[108.139809] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[108.147324] Starting dynamic subtest: pipe-C-eDP-1
[109.339503] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[109.347301] Starting dynamic subtest: pipe-D-eDP-1
[110.573698] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[110.574485] Subtest universal-plane-pageflip-windowed: SUCCESS (4.321s)
[111.413889] [013/132] (915s left) kms_async_flips (invalid-async-flip-atomic)
[111.510163] Starting subtest: invalid-async-flip-atomic
[111.882980] Starting dynamic subtest: pipe-A-eDP-1
[112.748149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[113.104741] Starting dynamic subtest: pipe-B-eDP-1
[113.890518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s)
[114.262041] Starting dynamic subtest: pipe-C-eDP-1
[115.120653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.864s)
[115.472273] Starting dynamic subtest: pipe-D-eDP-1
[116.243980] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[116.244923] Subtest invalid-async-flip-atomic: SUCCESS (4.734s)
[117.391870] [014/132] (909s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[117.478893] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[117.479805] Starting dynamic subtest: pipe-A-default-mode
[120.231224] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[120.232116] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.751s)
[121.094152] [015/132] (905s left) kms_psr (pr-primary-mmap-cpu)
[121.183113] Starting subtest: pr-primary-mmap-cpu
[121.185024] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[121.255201] [016/132] (905s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[121.347058] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[121.423016] [017/132] (905s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[121.523689] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[121.524627] Starting dynamic subtest: pipe-A-eDP-1
[121.624362] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[121.631030] Starting dynamic subtest: pipe-B-eDP-1
[122.775607] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s)
[122.777509] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.252s)
[123.947508] [018/132] (902s left) gem_exec_suspend (basic-s4-devices)
[124.003255] Starting subtest: basic-S4-devices
[124.004169] Starting dynamic subtest: smem
[135.900857] Dynamic subtest smem: SUCCESS (11.887s)
[135.911218] Subtest basic-S4-devices: SUCCESS (11.889s)
[142.108401] [019/132] (890s left) kms_plane_cursor (primary)
[142.224913] Starting subtest: primary
[142.226504] Starting dynamic subtest: pipe-A-eDP-1-size-64
[144.767949] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[144.793781] Starting dynamic subtest: pipe-A-eDP-1-size-128
[147.346842] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[147.372582] Starting dynamic subtest: pipe-A-eDP-1-size-256
[149.902863] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.539s)
[150.220941] Starting dynamic subtest: pipe-B-eDP-1-size-64
[153.529329] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.316s)
[153.554455] Starting dynamic subtest: pipe-B-eDP-1-size-128
[156.121105] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.574s)
[156.144437] Starting dynamic subtest: pipe-B-eDP-1-size-256
[158.720219] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[159.032693] Starting dynamic subtest: pipe-C-eDP-1-size-64
[161.929453] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.904s)
[161.955683] Starting dynamic subtest: pipe-C-eDP-1-size-128
[164.129860] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[164.156525] Starting dynamic subtest: pipe-C-eDP-1-size-256
[166.385063] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[166.705635] Starting dynamic subtest: pipe-D-eDP-1-size-64
[169.652557] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.956s)
[169.679318] Starting dynamic subtest: pipe-D-eDP-1-size-128
[171.852643] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[171.879849] Starting dynamic subtest: pipe-D-eDP-1-size-256
[174.052994] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[174.361775] Subtest primary: SUCCESS (32.137s)
[175.192933] [020/132] (857s left) gem_softpin (evict-single-offset)
[175.261227] Starting subtest: evict-single-offset
[202.909887] Subtest evict-single-offset: SUCCESS (27.638s)
[202.987712] [021/132] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[203.122823] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[203.124637] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[203.215260] [022/132] (829s left) kms_getfb (getfb2-into-addfb2)
[203.297565] Starting subtest: getfb2-into-addfb2
[203.298519] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[203.402750] [023/132] (829s left) syncobj_timeline (wait-zero-handles)
[203.456539] Starting subtest: wait-zero-handles
[203.457457] Subtest wait-zero-handles: SUCCESS (0.000s)
[203.550234] [024/132] (829s left) gem_exec_whisper (basic-sync-all)
[203.617247] Starting subtest: basic-sync-all
[210.082386] Subtest basic-sync-all: SUCCESS (6.463s)
[210.263944] [025/132] (822s left) gem_mmap_wc (bad-size)
[210.320688] Subtest bad-size: SKIP (0.000s)
[210.390403] [026/132] (822s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[210.521568] Starting subtest: cursor-tearing-framebuffer-change
[210.522680] Starting dynamic subtest: pipe-A-eDP-1
[211.105992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[211.114497] Starting dynamic subtest: pipe-D-eDP-1
[212.310520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[212.311410] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.789s)
[213.146095] [027/132] (819s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[213.240216] Starting subtest: random-ccs-data-y-tiled-ccs
[213.241042] Starting dynamic subtest: pipe-A-eDP-1
[213.250384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.258840] Starting dynamic subtest: pipe-B-eDP-1
[213.268460] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.276495] Starting dynamic subtest: pipe-C-eDP-1
[213.285378] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.293526] Starting dynamic subtest: pipe-D-eDP-1
[213.302580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.304203] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[215.528434] [028/132] (817s left) dumb_buffer (map-invalid-size)
[215.572847] Starting subtest: map-invalid-size
[215.573783] Subtest map-invalid-size: SUCCESS (0.000s)
[215.673913] [029/132] (817s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[215.768874] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[216.814437] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.046s)
[216.920025] [030/132] (816s left) syncobj_wait (multi-wait-signaled)
[216.974843] Starting subtest: multi-wait-signaled
[216.975879] Subtest multi-wait-signaled: SUCCESS (0.000s)
[217.086370] [031/132] (816s left) kms_setmode (invalid-clone-single-crtc-stealing)
[217.142471] Starting subtest: invalid-clone-single-crtc-stealing
[217.145166] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[217.249160] [032/132] (816s left) gem_fence_thrash (bo-write-verify-y)
[217.277697] Starting subtest: bo-write-verify-y
[217.295933] Subtest bo-write-verify-y: SKIP (0.019s)
[217.345824] [033/132] (815s left) i915_drm_fdinfo (idle)
[217.388658] Starting subtest: idle
[217.389543] Starting dynamic subtest: rcs0
[217.940626] Dynamic subtest rcs0: SUCCESS (0.551s)
[217.952412] Starting dynamic subtest: bcs0
[218.457066] Dynamic subtest bcs0: SUCCESS (0.503s)
[218.466506] Starting dynamic subtest: vcs0
[218.963991] Dynamic subtest vcs0: SUCCESS (0.504s)
[218.974675] Starting dynamic subtest: vcs1
[219.460417] Dynamic subtest vcs1: SUCCESS (0.504s)
[219.473337] Starting dynamic subtest: vecs0
[219.977847] Dynamic subtest vecs0: SUCCESS (0.504s)
[219.988558] Starting dynamic subtest: ccs0
[220.484735] Dynamic subtest ccs0: SUCCESS (0.504s)
[220.486222] Subtest idle: SUCCESS (3.087s)
[220.547575] [034/132] (812s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[220.600680] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[220.657923] [035/132] (812s left) kms_vrr (seamless-rr-switch-drrs)
[220.749567] Starting subtest: seamless-rr-switch-drrs
[220.752271] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[220.815024] [036/132] (812s left) gem_mmap_gtt (basic-small-copy-odd)
[220.864779] Subtest basic-small-copy-odd: SKIP (0.000s)
[220.923288] [037/132] (812s left) gem_userptr_blits (input-checking)
[220.988255] Starting subtest: input-checking
[220.989082] Subtest input-checking: SUCCESS (0.000s)
[221.116077] [038/132] (812s left) api_intel_bb (simple-bb)
[221.167483] Starting subtest: simple-bb
[221.173093] Subtest simple-bb: SUCCESS (0.006s)
[221.278625] [039/132] (812s left) api_intel_allocator (fork-simple-stress-signal)
[221.322042] Starting subtest: fork-simple-stress-signal
[226.775382] Subtest fork-simple-stress-signal: SUCCESS (5.408s)
[226.873703] [040/132] (806s left) prime_vgem (basic-gtt)
[226.977504] Starting subtest: basic-gtt
[226.979468] Subtest basic-gtt: SKIP (0.000s)
[227.069077] [041/132] (806s left) kms_flip (nonexisting-fb-interruptible)
[227.165435] Starting subtest: nonexisting-fb-interruptible
[227.167628] Starting dynamic subtest: A-eDP1
[228.304114] Dynamic subtest A-eDP1: SUCCESS (1.136s)
[228.314407] Starting dynamic subtest: B-eDP1
[229.442365] Dynamic subtest B-eDP1: SUCCESS (1.136s)
[229.453792] Starting dynamic subtest: C-eDP1
[230.579554] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[230.588920] Starting dynamic subtest: D-eDP1
[231.720293] Dynamic subtest D-eDP1: SUCCESS (1.140s)
[231.723420] Subtest nonexisting-fb-interruptible: SUCCESS (4.558s)
[232.902274] [042/132] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[232.997873] Starting subtest: psr-1p-primscrn-spr-indfb-move
[240.609225] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.612s)
[240.752128] [043/132] (792s left) i915_drm_fdinfo (virtual-busy-idle-all)
[240.789532] Starting subtest: virtual-busy-idle-all
[240.791193] Subtest virtual-busy-idle-all: SKIP (0.000s)
[240.862161] [044/132] (792s left) kms_vblank (query-forked-hang)
[240.955505] Starting subtest: query-forked-hang
[240.956421] Starting dynamic subtest: pipe-A-eDP-1
[267.668502] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.712s)
[267.680203] Starting dynamic subtest: pipe-D-eDP-1
[292.685389] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.010s)
[292.686242] Subtest query-forked-hang: SUCCESS (51.729s)
[293.483118] [045/132] (740s left) gem_mmap_gtt (ptrace)
[293.528890] Subtest ptrace: SKIP (0.000s)
[293.581042] [046/132] (740s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[293.773208] Starting subtest: cursor-rapid-movement-128x128
[293.775376] Starting dynamic subtest: pipe-A-eDP-1
[294.306920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[294.336059] Starting dynamic subtest: pipe-D-eDP-1
[295.512693] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s)
[295.513688] Subtest cursor-rapid-movement-128x128: SUCCESS (1.740s)
[296.354597] [047/132] (737s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[296.446398] Starting subtest: 4-tiled-16bpp-rotate-90
[296.466214] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[296.570412] [048/132] (737s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[296.653842] Starting subtest: crc-primary-suspend-y-tiled-ccs
[296.654760] Starting dynamic subtest: pipe-A-eDP-1
[296.658407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.667199] Starting dynamic subtest: pipe-B-eDP-1
[296.670624] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.679103] Starting dynamic subtest: pipe-C-eDP-1
[296.682780] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.691044] Starting dynamic subtest: pipe-D-eDP-1
[296.694458] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.696303] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[298.910191] [049/132] (734s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[298.954036] Starting subtest: etime-single-wait-available-unsubmitted
[299.056942] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[299.142535] [050/132] (734s left) gem_exec_whisper (basic-fds-forked-all)
[299.202648] Starting subtest: basic-fds-forked-all
[319.866433] Subtest basic-fds-forked-all: SUCCESS (20.660s)
[320.047705] [051/132] (713s left) gem_userptr_blits (sync-unmap)
[320.105776] Starting subtest: sync-unmap
[320.129154] Subtest sync-unmap: SUCCESS (0.024s)
[320.260826] [052/132] (713s left) syncobj_wait (invalid-reset-illegal-handle)
[320.308210] Starting subtest: invalid-reset-illegal-handle
[320.309496] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[320.414334] [053/132] (713s left) gem_exec_reloc (basic-write-read)
[320.460053] Subtest basic-write-read: SKIP (0.000s)
[320.531532] [054/132] (713s left) fbdev (read)
[320.567887] Starting subtest: read
[321.247230] Subtest read: SUCCESS (0.670s)
[321.303855] [055/132] (712s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[321.401253] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[322.425472] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.024s)
[322.546437] [056/132] (711s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[322.633808] Starting subtest: read-crc-frame-sequence
[322.634748] Starting dynamic subtest: pipe-A-eDP-1
[323.379621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[323.391308] Starting dynamic subtest: pipe-B-eDP-1
[324.801958] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[324.810472] Starting dynamic subtest: pipe-C-eDP-1
[326.192339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[326.201227] Starting dynamic subtest: pipe-D-eDP-1
[327.528935] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[327.530185] Subtest read-crc-frame-sequence: SUCCESS (4.895s)
[328.368475] [057/132] (705s left) gem_ringfill (basic-all)
[333.922367] Starting subtest: basic-all
[335.077121] Subtest basic-all: SUCCESS (1.154s)
[335.196140] [058/132] (698s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[335.280881] Starting subtest: fbc-2p-pri-indfb-multidraw
[335.282689] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[335.360858] [059/132] (698s left) gem_exec_create (legacy)
[335.414089] Starting subtest: legacy
[335.415040] Starting dynamic subtest: smem
[337.504239] Dynamic subtest smem: SUCCESS (2.089s)
[337.507589] Subtest legacy: SUCCESS (2.091s)
[337.686310] [060/132] (696s left) gem_render_copy_redux (flink)
[337.754741] Starting subtest: flink
[338.884828] Subtest flink: SUCCESS (1.130s)
[339.003290] [061/132] (695s left) gem_caching (writes)
[339.056918] Subtest writes: SKIP (0.000s)
[339.135155] [062/132] (695s left) i915_pm_rpm (reg-read-ioctl)
[341.067704] Starting subtest: reg-read-ioctl
[343.470978] Subtest reg-read-ioctl: SUCCESS (2.405s)
[343.866835] [063/132] (690s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[343.910899] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[343.913446] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[344.009531] [064/132] (690s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[344.062430] Starting subtest: multi-wait-all-for-submit-signaled
[344.063344] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[344.150805] [065/132] (690s left) syncobj_wait (single-wait-all-submitted)
[344.202074] Starting subtest: single-wait-all-submitted
[344.304747] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[344.379505] [066/132] (690s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[344.758709] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[345.565404] [067/132] (688s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[345.656797] Starting subtest: fbc-modesetfrombusy
[349.560460] Subtest fbc-modesetfrombusy: SUCCESS (3.904s)
[350.728331] [068/132] (683s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[350.861613] Starting subtest: basic-flip-after-cursor-atomic
[351.777572] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[352.651901] [069/132] (681s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[352.745199] Starting subtest: yf-tiled-addfb-size-offset-overflow
[352.747076] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[352.845683] [070/132] (681s left) kms_pm_dc (dc5-dpms-negative)
[353.932399] Starting subtest: dc5-dpms-negative
[353.933943] Subtest dc5-dpms-negative: SKIP (0.000s)
[354.001975] [071/132] (680s left) kms_flip (flip-vs-expired-vblank)
[354.081073] Starting subtest: flip-vs-expired-vblank
[354.083133] Starting dynamic subtest: A-eDP1
[362.796199] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[362.807591] Starting dynamic subtest: B-eDP1
[371.439328] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[371.450309] Starting dynamic subtest: C-eDP1
[380.068821] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[380.079587] Starting dynamic subtest: D-eDP1
[388.697587] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[388.698594] Subtest flip-vs-expired-vblank: SUCCESS (34.584s)
[389.837077] [072/132] (644s left) gem_exec_balancer (bonded-false-hang)
[390.100085] Starting subtest: bonded-false-hang
[390.102022] Subtest bonded-false-hang: SKIP (0.000s)
[390.216579] [073/132] (644s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[390.331881] Starting subtest: flip-vs-cursor-busy-crc-atomic
[391.146471] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.814s)
[391.955584] [074/132] (642s left) gem_ctx_persistence (heartbeat-hang)
[392.023276] Starting subtest: heartbeat-hang
[392.025057] Subtest heartbeat-hang: SKIP (0.000s)
[392.131171] [075/132] (642s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[392.246819] Starting subtest: cursorB-vs-flipA-varying-size
[392.249487] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[392.387173] [076/132] (642s left) gem_exec_reloc (basic-gtt-read)
[392.442937] Subtest basic-gtt-read: SKIP (0.000s)
[392.507895] [077/132] (642s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[392.592298] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[392.593184] Starting dynamic subtest: pipe-A-eDP-1
[393.494030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[393.503352] Starting dynamic subtest: pipe-B-eDP-1
[395.163241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.665s)
[395.183638] Starting dynamic subtest: pipe-C-eDP-1
[396.678411] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[396.686968] Starting dynamic subtest: pipe-D-eDP-1
[398.216923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[398.217882] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.622s)
[399.394983] [078/132] (635s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[399.477262] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[399.478896] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[399.545099] [079/132] (635s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[399.633192] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[399.634903] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[399.724708] [080/132] (635s left) gen9_exec_parse (basic-rejected-ctx-param)
[399.780624] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[399.849308] [081/132] (635s left) gem_ctx_shared (disjoint-timelines)
[399.912380] Starting subtest: disjoint-timelines
[399.949121] Subtest disjoint-timelines: SUCCESS (0.037s)
[400.165787] [082/132] (634s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[400.248878] Starting subtest: invalid-modeset-force-ultra-joiner
[400.250661] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[400.318484] [083/132] (634s left) kms_prime (basic-crc-hybrid)
[400.395436] Subtest basic-crc-hybrid: SKIP (0.000s)
[400.485477] [084/132] (634s left) gem_ctx_param (set-priority-invalid-size)
[400.538038] Starting subtest: set-priority-invalid-size
[400.539485] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[400.610671] [085/132] (634s left) kms_display_modes (extended-mode-basic)
[400.696318] Starting subtest: extended-mode-basic
[400.698107] Subtest extended-mode-basic: SKIP (0.000s)
[400.739026] [086/132] (634s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[400.783948] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[400.860752] [087/132] (634s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[400.948216] Starting subtest: primary-yf-tiled-reflect-x-270
[400.950019] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[401.020412] [088/132] (634s left) syncobj_eventfd (binary-wait-before-signal)
[401.065213] Starting subtest: binary-wait-before-signal
[401.095364] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[401.165521] [089/132] (634s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[401.249647] Starting subtest: y-tiled-16bpp-rotate-270
[401.251211] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[401.343059] [090/132] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[401.433300] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[408.828124] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.395s)
[408.948762] [091/132] (626s left) gem_pxp (reject-modify-context-protection-off-3)
[409.072301] Starting subtest: reject-modify-context-protection-off-3
[409.073555] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[409.174178] [092/132] (626s left) i915_pm_rps (thresholds-idle)
[409.234265] Starting subtest: thresholds-idle
[409.236069] Subtest thresholds-idle: SKIP (0.001s)
[409.349504] [093/132] (626s left) kms_cursor_crc (cursor-alpha-opaque)
[409.440620] Starting subtest: cursor-alpha-opaque
[409.441575] Starting dynamic subtest: pipe-A-eDP-1
[410.085446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[410.094087] Starting dynamic subtest: pipe-D-eDP-1
[411.369873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[411.370808] Subtest cursor-alpha-opaque: SUCCESS (1.929s)
[412.172368] [094/132] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[412.259374] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[412.260992] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[412.360315] [095/132] (623s left) gem_exec_fence (syncobj-timeline-repeat)
[412.908885] Starting subtest: syncobj-timeline-repeat
[413.169443] Subtest syncobj-timeline-repeat: SUCCESS (0.260s)
[413.988553] [096/132] (621s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[414.071868] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[414.073164] Starting dynamic subtest: pipe-A-eDP-1
[414.082934] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.097475] Starting dynamic subtest: pipe-B-eDP-1
[414.106994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.121601] Starting dynamic subtest: pipe-C-eDP-1
[414.131434] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.141564] Starting dynamic subtest: pipe-D-eDP-1
[414.151216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.152832] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[416.250690] [097/132] (619s left) gem_userptr_blits (set-cache-level)
[416.307821] Starting subtest: set-cache-level
[416.309666] Subtest set-cache-level: SKIP (0.000s)
[416.423299] [098/132] (619s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[416.506915] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[416.508717] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[416.598931] [099/132] (619s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[416.684141] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[424.052450] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.369s)
[424.161789] [100/132] (611s left) syncobj_timeline (multi-wait-available-signaled)
[424.208167] Starting subtest: multi-wait-available-signaled
[424.209067] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[424.312451] [101/132] (611s left) gem_ctx_persistence (engines-mixed-process)
[424.366125] Starting subtest: engines-mixed-process
[424.367039] Starting dynamic subtest: rcs0
[425.901933] Dynamic subtest rcs0: SUCCESS (1.535s)
[425.914594] Starting dynamic subtest: bcs0
[427.874455] Dynamic subtest bcs0: SUCCESS (1.971s)
[427.887267] Starting dynamic subtest: vcs0
[429.889835] Dynamic subtest vcs0: SUCCESS (2.014s)
[429.899927] Starting dynamic subtest: vcs1
[431.908929] Dynamic subtest vcs1: SUCCESS (2.017s)
[431.922269] Starting dynamic subtest: vecs0
[433.924387] Dynamic subtest vecs0: SUCCESS (2.013s)
[433.934030] Starting dynamic subtest: ccs0
[435.863713] Dynamic subtest ccs0: SUCCESS (1.939s)
[435.864750] Subtest engines-mixed-process: SUCCESS (11.497s)
[435.938878] [102/132] (599s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[436.035735] Starting subtest: yf-tiled-32bpp-rotate-270
[436.037522] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[436.124303] [103/132] (599s left) gem_ctx_exec (basic-invalid-context)
[436.177446] Starting subtest: basic-invalid-context
[436.182100] Subtest basic-invalid-context: SUCCESS (0.005s)
[436.292975] [104/132] (599s left) gem_readwrite (read-bad-handle)
[436.338172] Subtest read-bad-handle: SKIP (0.000s)
[436.404079] [105/132] (599s left) gem_eio (banned)
[436.626274] Starting subtest: banned
[437.233656] Subtest banned: SUCCESS (0.612s)
[437.400596] [106/132] (598s left) gem_exec_schedule (semaphore-codependency)
[437.456583] Starting subtest: semaphore-codependency
[437.468305] Subtest semaphore-codependency: SUCCESS (0.012s)
[437.799502] [107/132] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[437.898782] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[437.900811] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[438.007050] [108/132] (597s left) kms_psr (psr-primary-page-flip)
[438.096507] Starting subtest: psr-primary-page-flip
[438.097356] Starting dynamic subtest: eDP-1
[439.896825] Dynamic subtest eDP-1: SUCCESS (1.799s)
[439.897725] Subtest psr-primary-page-flip: SUCCESS (1.801s)
[440.741709] [109/132] (595s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[440.823496] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[440.825233] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[440.891449] [110/132] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[440.983313] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[440.984951] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[441.101237] [111/132] (594s left) prime_vgem (wait)
[441.163284] Starting subtest: wait
[441.164212] Starting dynamic subtest: rcs0
[441.212863] Dynamic subtest rcs0: SUCCESS (0.049s)
[441.221830] Starting dynamic subtest: bcs0
[441.268903] Dynamic subtest bcs0: SUCCESS (0.055s)
[441.278763] Starting dynamic subtest: vcs0
[441.313353] Dynamic subtest vcs0: SUCCESS (0.044s)
[441.323330] Starting dynamic subtest: vcs1
[441.361525] Dynamic subtest vcs1: SUCCESS (0.047s)
[441.370764] Starting dynamic subtest: vecs0
[441.405827] Dynamic subtest vecs0: SUCCESS (0.044s)
[441.415107] Starting dynamic subtest: ccs0
[441.454839] Dynamic subtest ccs0: SUCCESS (0.048s)
[441.455691] Subtest wait: SUCCESS (0.292s)
[441.588488] [112/132] (594s left) kms_flip (plain-flip-ts-check)
[441.699389] Starting subtest: plain-flip-ts-check
[441.700258] Starting dynamic subtest: A-eDP1
[450.551594] Dynamic subtest A-eDP1: SUCCESS (8.827s)
[450.562616] Starting dynamic subtest: B-eDP1
[459.378629] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[459.391421] Starting dynamic subtest: C-eDP1
[468.210845] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[468.225055] Starting dynamic subtest: D-eDP1
[477.041226] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[477.042230] Subtest plain-flip-ts-check: SUCCESS (35.309s)
[478.186235] [113/132] (557s left) kms_psr (psr2-sprite-render)
[478.278302] Starting subtest: psr2-sprite-render
[478.279138] Starting dynamic subtest: eDP-1
[479.999049] Dynamic subtest eDP-1: SUCCESS (1.721s)
[479.999873] Subtest psr2-sprite-render: SUCCESS (1.722s)
[480.854576] [114/132] (555s left) gem_tiled_swapping (non-threaded)
[480.912192] Subtest non-threaded: SKIP (0.000s)
[480.967292] [115/132] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[481.062421] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[481.064331] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[481.171828] [116/132] (555s left) kms_psr (fbc-psr-dpms)
[481.271515] Starting subtest: fbc-psr-dpms
[481.272278] Starting dynamic subtest: eDP-1
[481.273882] Dynamic subtest eDP-1: SKIP (0.000s)
[481.275471] Subtest fbc-psr-dpms: SKIP (0.001s)
[481.371044] [117/132] (554s left) kms_flip (2x-flip-vs-dpms-on-nop)
[481.459901] Starting subtest: 2x-flip-vs-dpms-on-nop
[481.470149] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[481.564997] [118/132] (554s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[481.666188] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[481.666969] Starting dynamic subtest: pipe-A-eDP-1
[481.674784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.684098] Starting dynamic subtest: pipe-B-eDP-1
[481.692161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.700809] Starting dynamic subtest: pipe-C-eDP-1
[481.708368] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.716779] Starting dynamic subtest: pipe-D-eDP-1
[481.724445] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.725984] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[483.916558] [119/132] (552s left) i915_query (query-topology-coherent-slice-mask)
[483.979882] Starting subtest: query-topology-coherent-slice-mask
[483.981562] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[484.082692] [120/132] (552s left) kms_color (deep-color)
[484.172786] Starting subtest: deep-color
[485.295425] Starting dynamic subtest: pipe-A-eDP-1-gamma
[486.005402] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.709s)
[486.014703] Starting dynamic subtest: pipe-A-eDP-1-degamma
[487.487109] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.480s)
[487.496353] Starting dynamic subtest: pipe-A-eDP-1-ctm
[488.918695] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.431s)
[489.690229] Starting dynamic subtest: pipe-B-eDP-1-gamma
[490.401607] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.721s)
[490.410649] Starting dynamic subtest: pipe-B-eDP-1-degamma
[491.887065] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.484s)
[491.896680] Starting dynamic subtest: pipe-B-eDP-1-ctm
[493.318954] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.431s)
[494.085048] Starting dynamic subtest: pipe-C-eDP-1-gamma
[494.769597] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.694s)
[494.778779] Starting dynamic subtest: pipe-C-eDP-1-degamma
[496.150608] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.379s)
[496.160070] Starting dynamic subtest: pipe-C-eDP-1-ctm
[497.582443] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.431s)
[498.388153] Starting dynamic subtest: pipe-D-eDP-1-gamma
[499.083365] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s)
[499.092842] Starting dynamic subtest: pipe-D-eDP-1-degamma
[500.558674] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.474s)
[500.567866] Starting dynamic subtest: pipe-D-eDP-1-ctm
[501.971811] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.413s)
[501.972748] Subtest deep-color: SUCCESS (17.798s)
[502.845193] [121/132] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[502.943776] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[502.945726] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[503.038175] [122/132] (533s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[503.124612] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[507.369517] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.245s)
[508.532454] [123/132] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[508.615671] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[516.148912] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.534s)
[516.268509] [124/132] (520s left) kms_psr (fbc-psr2-cursor-blt)
[516.356760] Starting subtest: fbc-psr2-cursor-blt
[516.357831] Starting dynamic subtest: eDP-1
[516.359704] Dynamic subtest eDP-1: SKIP (0.000s)
[516.361539] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[516.426296] [125/132] (520s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[516.511824] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[516.513566] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[516.582122] [126/132] (520s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[516.627239] Starting subtest: wait-all-for-submit-delayed-submit
[516.731384] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[516.807733] [127/132] (519s left) gem_exec_reloc (basic-gtt-active)
[516.856839] Subtest basic-gtt-active: SKIP (0.000s)
[516.943053] [128/132] (519s left) kms_busy (extended-modeset-hang-oldfb)
[517.038434] Starting subtest: extended-modeset-hang-oldfb
[517.039484] Starting dynamic subtest: pipe-A
[528.851954] Dynamic subtest pipe-A: SUCCESS (11.811s)
[528.862506] Starting dynamic subtest: pipe-D
[541.148054] Dynamic subtest pipe-D: SUCCESS (12.290s)
[541.149161] Subtest extended-modeset-hang-oldfb: SUCCESS (24.105s)
[541.937436] [129/132] (494s left) gem_exec_schedule (pi-distinct-iova)
[542.123885] Starting subtest: pi-distinct-iova
[542.124903] Starting dynamic subtest: rcs0
[542.201670] Dynamic subtest rcs0: SUCCESS (0.084s)
[542.211745] Starting dynamic subtest: vcs0
[542.267027] Dynamic subtest vcs0: SUCCESS (0.065s)
[542.276722] Starting dynamic subtest: vcs1
[542.323276] Dynamic subtest vcs1: SUCCESS (0.055s)
[542.336547] Starting dynamic subtest: vecs0
[542.383433] Dynamic subtest vecs0: SUCCESS (0.059s)
[542.398368] Starting dynamic subtest: ccs0
[542.462454] Dynamic subtest ccs0: SUCCESS (0.077s)
[542.463285] Subtest pi-distinct-iova: SUCCESS (0.346s)
[543.992947] [130/132] (492s left) kms_chamelium_frames (hdmi-aspect-ratio)
[544.367571] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[545.144033] [131/132] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[545.235699] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[545.237651] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[545.333208] [132/132] (491s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[545.463545] Starting subtest: multiplane-atomic-fence-wait
[545.784724] Subtest multiplane-atomic-fence-wait: SUCCESS (0.321s)
[546.902593] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_psr2_su
results: parsing output: 10/ for test: prime_mmap
results: parsing output: 11/ for test: kms_universal_plane
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_exec_suspend
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: gem_softpin
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: gem_mmap_wc
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_setmode
results: parsing output: 31/ for test: gem_fence_thrash
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_vrr
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: fbdev
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_pipe_crc_basic
results: parsing output: 56/ for test: gem_ringfill
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: gem_render_copy_redux
results: parsing output: 60/ for test: gem_caching
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_pm_dc
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: kms_joiner
results: parsing output: 82/ for test: kms_prime
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_display_modes
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_userptr_blits
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_ctx_exec
results: parsing output: 103/ for test: gem_readwrite
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: prime_vgem
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_tiled_swapping
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_busy
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_explicit_fence
Done.