[60.608664] Initializing watchdogs
[60.608708]   /dev/watchdog0
[60.622291] [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]
[60.626461] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.628531] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.631849] [001/131] (960s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[60.779250] Starting subtest: flip-vs-cursor-busy-crc-legacy
[61.623702] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.841s)
[62.440910] [002/131] (958s left) kms_color (ctm-0-75)
[62.537322] Starting subtest: ctm-0-75
[62.539657] Starting dynamic subtest: pipe-A-eDP-1
[67.395974] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.844s)
[67.406440] Starting dynamic subtest: pipe-B-eDP-1
[72.907877] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.503s)
[72.916977] Starting dynamic subtest: pipe-C-eDP-1
[78.286743] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.373s)
[78.295833] Starting dynamic subtest: pipe-D-eDP-1
[83.633867] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.344s)
[83.635897] Subtest ctm-0-75: SUCCESS (21.065s)
[84.488593] [003/131] (936s left) prime_mmap (test_dup)
[84.541245] Starting subtest: test_dup
[84.543216] Starting dynamic subtest: test_dup-smem
[84.569408] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[84.571840] Subtest test_dup: SUCCESS (0.031s)
[84.663798] [004/131] (936s left) kms_cursor_crc (cursor-offscreen-256x85)
[84.912919] Starting subtest: cursor-offscreen-256x85
[84.961290] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[85.154707] [005/131] (936s left) gem_softpin (reverse)
[85.221763] Starting subtest: reverse
[85.225831] Subtest reverse: SUCCESS (0.007s)
[85.373939] [006/131] (935s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[85.481965] Starting subtest: flip-vs-cursor-crc-legacy
[86.128814] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.646s)
[87.004418] [007/131] (934s left) gem_readwrite (beyond-eob)
[87.074257] Subtest beyond-EOB: SKIP (0.000s)
[87.141909] [008/131] (934s left) sysfs_timeslice_duration (duration)
[87.219272] Starting subtest: duration
[87.221722] Starting dynamic subtest: vecs0
[100.853313] Dynamic subtest vecs0: SUCCESS (13.627s)
[100.862090] Starting dynamic subtest: ccs0
[114.030843] Dynamic subtest ccs0: SUCCESS (13.175s)
[114.040662] Starting dynamic subtest: vcs0
[127.795784] Dynamic subtest vcs0: SUCCESS (13.760s)
[127.805517] Starting dynamic subtest: bcs0
[140.952160] Dynamic subtest bcs0: SUCCESS (13.154s)
[140.962297] Starting dynamic subtest: rcs0
[154.112568] Dynamic subtest rcs0: SUCCESS (13.158s)
[154.122669] Starting dynamic subtest: vcs1
[168.820590] Dynamic subtest vcs1: SUCCESS (14.705s)
[168.823257] Subtest duration: SUCCESS (81.590s)
[168.915037] [009/131] (852s left) kms_psr (fbc-pr-cursor-blt)
[169.021620] Starting subtest: fbc-pr-cursor-blt
[169.025563] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[169.115827] [010/131] (852s left) gem_exec_fence (syncobj-import)
[169.572061] Starting subtest: syncobj-import
[169.577018] Subtest syncobj-import: SUCCESS (0.005s)
[170.996803] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[171.000199] [011/131] (850s left) gem_tiled_blits (normal)
[171.051978] Subtest normal: SKIP (0.000s)
[171.118464] [012/131] (850s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[171.213134] Starting subtest: addfb25-y-tiled-small-legacy
[171.217585] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[171.338728] [013/131] (850s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[171.444803] Starting subtest: yf-tiled-8bpp-rotate-90
[171.449333] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[171.571783] [014/131] (850s left) kms_color (invalid-ctm-matrix-sizes)
[171.665988] Starting subtest: invalid-ctm-matrix-sizes
[171.668325] Starting dynamic subtest: pipe-A
[171.670674] Dynamic subtest pipe-A: SUCCESS (0.002s)
[171.679314] Starting dynamic subtest: pipe-B
[171.681209] Dynamic subtest pipe-B: SUCCESS (0.002s)
[171.688133] Starting dynamic subtest: pipe-C
[171.690485] Dynamic subtest pipe-C: SUCCESS (0.003s)
[171.697678] Starting dynamic subtest: pipe-D
[171.699944] Dynamic subtest pipe-D: SUCCESS (0.003s)
[171.702187] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[171.772077] [015/131] (849s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[171.869496] Starting subtest: fbc-psr2-primary-mmap-cpu
[171.871766] Starting dynamic subtest: eDP-1
[171.876161] Dynamic subtest eDP-1: SKIP (0.000s)
[171.880498] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[171.962549] [016/131] (849s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[172.027181] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[172.029162] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[172.147746] [017/131] (849s left) perf_pmu (busy-double-start)
[172.183905] Starting subtest: busy-double-start
[172.185939] Starting dynamic subtest: rcs0
[175.827660] Dynamic subtest rcs0: FAIL (3.592s)
[175.835673] Starting dynamic subtest: bcs0
[179.345136] Dynamic subtest bcs0: SUCCESS (3.569s)
[179.357728] Starting dynamic subtest: vcs0
[183.416888] Dynamic subtest vcs0: SUCCESS (4.070s)
[183.427507] Starting dynamic subtest: vcs1
[187.436678] Dynamic subtest vcs1: SUCCESS (4.018s)
[187.446888] Starting dynamic subtest: vecs0
[191.493907] Dynamic subtest vecs0: SUCCESS (4.056s)
[191.504828] Starting dynamic subtest: ccs0
[195.130072] Dynamic subtest ccs0: FAIL (3.566s)
[195.132139] Subtest busy-double-start: FAIL (22.877s)
[195.205632] [018/131] (826s left) kms_psr (psr-sprite-plane-move)
[195.314814] Starting subtest: psr-sprite-plane-move
[195.317070] Starting dynamic subtest: eDP-1
[197.113313] Dynamic subtest eDP-1: SUCCESS (1.798s)
[197.115552] Subtest psr-sprite-plane-move: SUCCESS (1.799s)
[197.956787] [019/131] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[198.053292] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[198.057548] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.170537] [020/131] (823s left) i915_pm_rpm (gem-execbuf-stress)
[200.104731] Starting subtest: gem-execbuf-stress
[200.106842] Starting dynamic subtest: smem0
[213.070329] Dynamic subtest smem0: SUCCESS (12.968s)
[213.081181] Starting dynamic subtest: extra-wait-smem0
[275.075849] Dynamic subtest extra-wait-smem0: SUCCESS (61.999s)
[275.079031] Subtest gem-execbuf-stress: SUCCESS (74.972s)
[275.481536] [021/131] (746s left) gem_ctx_param (set-priority-range)
[275.536588] Starting subtest: set-priority-range
[275.550190] Subtest set-priority-range: SUCCESS (0.014s)
[275.691260] [022/131] (746s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[275.787289] Starting subtest: primary-x-tiled-reflect-x-0
[282.873263] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.085s)
[284.123105] [023/131] (737s left) gem_exec_alignment (pi)
[284.193811] Starting subtest: pi
[332.591581] Subtest pi: SUCCESS (48.393s)
[333.748242] [024/131] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[333.893472] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[333.897902] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[334.040762] [025/131] (688s left) kms_hdmi_inject (inject-4k)
[334.379698] Starting subtest: inject-4k
[334.693749] Subtest inject-4k: SUCCESS (0.315s)
[335.285240] [026/131] (686s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[335.390786] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[342.773431] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.385s)
[342.956931] [027/131] (679s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[343.073483] Starting subtest: x-tiled-addfb-size-offset-overflow
[343.075716] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[343.201311] [028/131] (678s left) kms_pm_backlight (basic-brightness)
[343.312867] Starting subtest: basic-brightness
[343.392174] Starting dynamic subtest: eDP-1
[343.917034] Dynamic subtest eDP-1: SUCCESS (0.522s)
[343.919190] Subtest basic-brightness: SUCCESS (0.604s)
[344.743902] [029/131] (677s left) syncobj_timeline (invalid-query-bad-pad)
[344.803565] Starting subtest: invalid-query-bad-pad
[344.805804] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[344.901397] [030/131] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[345.005954] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[352.302962] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.299s)
[352.472833] [031/131] (669s left) perf (invalid-oa-format-id)
[352.631843] Starting subtest: invalid-oa-format-id
[352.640637] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[352.681994] [032/131] (669s left) gem_busy (parallel)
[352.863618] Starting subtest: parallel
[352.865795] Starting dynamic subtest: rcs0
[354.904251] Dynamic subtest rcs0: SUCCESS (2.041s)
[354.915778] Starting dynamic subtest: bcs0
[356.886521] Dynamic subtest bcs0: SUCCESS (1.979s)
[356.898721] Starting dynamic subtest: vcs0
[358.994432] Dynamic subtest vcs0: SUCCESS (2.044s)
[359.005376] Starting dynamic subtest: vcs1
[360.917431] Dynamic subtest vcs1: SUCCESS (1.982s)
[360.928986] Starting dynamic subtest: vecs0
[362.902430] Dynamic subtest vecs0: SUCCESS (1.983s)
[362.913794] Starting dynamic subtest: ccs0
[364.886564] Dynamic subtest ccs0: SUCCESS (1.981s)
[364.889211] Subtest parallel: SUCCESS (12.025s)
[365.151068] [033/131] (657s left) kms_atomic_transition (modeset-transition)
[365.251772] Starting subtest: modeset-transition
[365.253922] Starting dynamic subtest: 1x-outputs
[376.083592] Dynamic subtest 1x-outputs: SUCCESS (10.832s)
[376.086072] Subtest modeset-transition: SUCCESS (10.833s)
[376.942640] [034/131] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[377.042638] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[383.639832] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.599s)
[383.794635] [035/131] (638s left) gem_render_copy (y-tiled)
[383.873042] Starting subtest: y-tiled
[383.877677] Subtest y-tiled: SKIP (0.000s)
[384.080310] [036/131] (638s left) i915_query (query-regions-garbage-items)
[384.139987] Starting subtest: query-regions-garbage-items
[384.141911] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[384.273740] [037/131] (638s left) gem_exec_params (invalid-ring2)
[384.331248] Starting subtest: invalid-ring2
[384.333480] Subtest invalid-ring2: SUCCESS (0.000s)
[384.454112] [038/131] (638s left) kms_feature_discovery (psr1)
[384.558985] Starting subtest: psr1
[384.561296] Subtest psr1: SUCCESS (0.000s)
[384.657632] [039/131] (637s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[384.756671] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[384.759053] Starting dynamic subtest: A-eDP1
[388.363072] Dynamic subtest A-eDP1: SUCCESS (3.605s)
[388.373856] Starting dynamic subtest: B-eDP1
[391.634899] Dynamic subtest B-eDP1: SUCCESS (3.271s)
[391.644746] Starting dynamic subtest: C-eDP1
[394.943515] Dynamic subtest C-eDP1: SUCCESS (3.304s)
[394.953260] Starting dynamic subtest: D-eDP1
[398.238369] Dynamic subtest D-eDP1: SUCCESS (3.297s)
[398.240954] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.484s)
[399.143404] [040/131] (623s left) kms_cursor_legacy (single-move)
[399.287054] Starting subtest: single-move
[399.289326] Starting dynamic subtest: pipe-A
[404.722562] Dynamic subtest pipe-A: SUCCESS (5.378s)
[404.733464] Starting dynamic subtest: pipe-B
[410.102922] Dynamic subtest pipe-B: SUCCESS (5.380s)
[410.114192] Starting dynamic subtest: pipe-C
[415.485743] Dynamic subtest pipe-C: SUCCESS (5.380s)
[415.496645] Starting dynamic subtest: pipe-D
[420.868037] Dynamic subtest pipe-D: SUCCESS (5.378s)
[420.879247] Starting dynamic subtest: all-pipes
[426.256080] Dynamic subtest all-pipes: SUCCESS (5.386s)
[426.258530] Subtest single-move: SUCCESS (26.915s)
[426.376130] [041/131] (596s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[426.488398] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[426.490671] Starting dynamic subtest: pipe-A-default-mode
[426.781889] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[426.786568] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.292s)
[427.642727] [042/131] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[427.747674] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[427.752024] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[427.884160] [043/131] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[427.982735] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[427.987100] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[428.106510] [044/131] (594s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[428.198600] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[428.200470] Starting dynamic subtest: pipe-A-eDP-1
[429.526436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.327s)
[429.818287] Starting dynamic subtest: pipe-B-eDP-1
[430.836641] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.028s)
[431.109623] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.912s)
[431.940321] [045/131] (590s left) gem_eio (in-flight-contexts-immediate)
[432.175137] Starting subtest: in-flight-contexts-immediate
[443.937709] Subtest in-flight-contexts-immediate: SUCCESS (11.761s)
[444.130252] [046/131] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[444.231833] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[444.236278] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[444.366327] [047/131] (578s left) syncobj_eventfd (timeline-wait-signaled)
[444.434975] Starting subtest: timeline-wait-signaled
[444.437373] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[444.558892] [048/131] (578s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[444.653254] Starting subtest: crc-primary-basic-y-tiled-ccs
[444.655505] Starting dynamic subtest: pipe-A-eDP-1
[444.677868] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[444.688842] Starting dynamic subtest: pipe-B-eDP-1
[444.710277] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[444.718512] Starting dynamic subtest: pipe-C-eDP-1
[444.739792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[444.747932] Starting dynamic subtest: pipe-D-eDP-1
[444.769315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[444.773604] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[446.939114] [049/131] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[447.043715] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[447.048321] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[447.200033] [050/131] (575s left) syncobj_timeline (wait-delayed-signal)
[447.257850] Starting subtest: wait-delayed-signal
[447.361404] Subtest wait-delayed-signal: SUCCESS (0.104s)
[447.464778] [051/131] (575s left) kms_plane_alpha_blend (alpha-7efc)
[447.561391] Starting subtest: alpha-7efc
[447.848601] Starting dynamic subtest: pipe-A-eDP-1
[448.456648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[448.486186] Starting dynamic subtest: pipe-D-eDP-1
[449.791334] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[449.793705] Subtest alpha-7efc: SUCCESS (2.232s)
[450.643387] [052/131] (572s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[450.740331] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[450.742712] Starting dynamic subtest: pipe-A-eDP-1
[450.766081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[450.776741] Starting dynamic subtest: pipe-B-eDP-1
[450.800229] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[450.808228] Starting dynamic subtest: pipe-C-eDP-1
[450.829665] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[450.837803] Starting dynamic subtest: pipe-D-eDP-1
[450.859101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[450.863150] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[453.034904] [053/131] (570s left) kms_sequence (get-forked)
[453.130251] Starting subtest: get-forked
[453.132418] Starting dynamic subtest: pipe-A-eDP-1
[454.985974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.856s)
[454.995060] Starting dynamic subtest: pipe-B-eDP-1
[457.573407] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.584s)
[457.582144] Starting dynamic subtest: pipe-C-eDP-1
[460.128401] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.554s)
[460.138677] Starting dynamic subtest: pipe-D-eDP-1
[462.625792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[462.628073] Subtest get-forked: SUCCESS (9.496s)
[463.443368] [054/131] (559s left) gem_gpgpu_fill (offset-16x16)
[463.503153] Starting subtest: offset-16x16
[463.508655] Subtest offset-16x16: SUCCESS (0.007s)
[463.665250] [055/131] (559s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[463.734382] Starting subtest: basic-batch-kernel-default-cmd
[463.738904] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[463.944406] [056/131] (559s left) gem_exec_reloc (basic-write-cpu)
[464.000884] Subtest basic-write-cpu: SKIP (0.000s)
[464.086170] [057/131] (559s left) gem_exec_reloc (basic-gtt-read-active)
[464.136129] Subtest basic-gtt-read-active: SKIP (0.000s)
[464.212855] [058/131] (559s left) kms_psr (psr2-cursor-mmap-gtt)
[464.320540] Starting subtest: psr2-cursor-mmap-gtt
[464.322834] Starting dynamic subtest: eDP-1
[466.065450] Dynamic subtest eDP-1: SUCCESS (1.745s)
[466.067762] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.746s)
[466.930548] [059/131] (556s left) gem_userptr_blits (sync-unmap)
[467.000399] Starting subtest: sync-unmap
[467.010941] Subtest sync-unmap: SUCCESS (0.012s)
[467.184229] [060/131] (556s left) syncobj_wait (multi-wait-submitted-signaled)
[467.241760] Starting subtest: multi-wait-submitted-signaled
[467.243766] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[467.354246] [061/131] (556s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[472.397648] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[472.402098] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[473.244389] [062/131] (550s left) perf_pmu (init-wait)
[473.289068] Starting subtest: init-wait
[473.291427] Starting dynamic subtest: rcs0
[473.293679] Dynamic subtest rcs0: SUCCESS (0.002s)
[473.304996] Starting dynamic subtest: bcs0
[473.307660] Dynamic subtest bcs0: SUCCESS (0.000s)
[473.318702] Starting dynamic subtest: vcs0
[473.320822] Dynamic subtest vcs0: SUCCESS (0.001s)
[473.330428] Starting dynamic subtest: vcs1
[473.332531] Dynamic subtest vcs1: SUCCESS (0.001s)
[473.341177] Starting dynamic subtest: vecs0
[473.342993] Dynamic subtest vecs0: SUCCESS (0.001s)
[473.354090] Starting dynamic subtest: ccs0
[473.356199] Dynamic subtest ccs0: SUCCESS (0.000s)
[473.358267] Subtest init-wait: SUCCESS (0.008s)
[473.416909] [063/131] (550s left) syncobj_timeline (invalid-signal-illegal-handle)
[473.483531] Starting subtest: invalid-signal-illegal-handle
[473.485892] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[473.629023] [064/131] (550s left) syncobj_wait (invalid-reset-one-illegal-handle)
[473.684371] Starting subtest: invalid-reset-one-illegal-handle
[473.686300] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[473.825789] [065/131] (549s left) kms_properties (plane-properties-legacy)
[473.937665] Starting subtest: plane-properties-legacy
[473.940143] Starting dynamic subtest: pipe-A-eDP-1
[474.493257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[474.503142] Starting dynamic subtest: pipe-B-eDP-1
[475.754034] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[475.764659] Starting dynamic subtest: pipe-C-eDP-1
[477.046688] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[477.056300] Starting dynamic subtest: pipe-D-eDP-1
[478.362672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[478.364596] Subtest plane-properties-legacy: SUCCESS (4.426s)
[479.233679] [066/131] (544s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[479.334319] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[479.338639] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[479.479327] [067/131] (544s left) kms_plane (plane-position-hole)
[479.574797] Starting subtest: plane-position-hole
[480.077345] Starting dynamic subtest: pipe-A-plane-1
[481.352134] Dynamic subtest pipe-A-plane-1: SUCCESS (1.278s)
[481.362073] Starting dynamic subtest: pipe-A-plane-2
[482.642577] Dynamic subtest pipe-A-plane-2: SUCCESS (1.287s)
[482.652543] Starting dynamic subtest: pipe-A-plane-3
[483.943838] Dynamic subtest pipe-A-plane-3: SUCCESS (1.301s)
[483.955569] Starting dynamic subtest: pipe-A-plane-4
[485.252291] Dynamic subtest pipe-A-plane-4: SUCCESS (1.306s)
[485.262232] Starting dynamic subtest: pipe-A-plane-5
[485.276772] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[486.455767] Starting dynamic subtest: pipe-B-plane-1
[487.765979] Dynamic subtest pipe-B-plane-1: SUCCESS (1.318s)
[487.776720] Starting dynamic subtest: pipe-B-plane-2
[489.042290] Dynamic subtest pipe-B-plane-2: SUCCESS (1.273s)
[489.052315] Starting dynamic subtest: pipe-B-plane-3
[490.367677] Dynamic subtest pipe-B-plane-3: SUCCESS (1.327s)
[490.378679] Starting dynamic subtest: pipe-B-plane-4
[491.634995] Dynamic subtest pipe-B-plane-4: SUCCESS (1.266s)
[491.644869] Starting dynamic subtest: pipe-B-plane-5
[491.661619] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[491.663852] Subtest plane-position-hole: SUCCESS (12.086s)
[492.536672] [068/131] (531s left) kms_pm_rpm (modeset-stress-extra-wait)
[494.068089] Starting subtest: modeset-stress-extra-wait
[548.360266] Subtest modeset-stress-extra-wait: SUCCESS (54.241s)
[548.421377] [069/131] (475s left) gen7_exec_parse (bitmasks)
[548.484845] Subtest bitmasks: SKIP (0.000s)
[548.572569] [070/131] (475s left) gem_exec_schedule (u-semaphore-noskip)
[548.643668] Starting subtest: u-semaphore-noskip
[549.044074] Subtest u-semaphore-noskip: SUCCESS (0.400s)
[549.412076] [071/131] (474s left) gem_userptr_blits (vma-merge)
[549.492023] Starting subtest: vma-merge
[549.529315] Subtest vma-merge: SUCCESS (0.037s)
[549.674653] [072/131] (474s left) gem_exec_await (wide-all)
[549.890772] Starting subtest: wide-all
[572.705138] Subtest wide-all: SUCCESS (22.801s)
[572.910495] [073/131] (451s left) kms_flip (2x-flip-vs-panning)
[573.077159] Starting subtest: 2x-flip-vs-panning
[573.088392] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[573.194276] [074/131] (450s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[573.310573] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[573.315043] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[573.478086] [075/131] (450s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[578.502750] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[578.507254] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[579.331753] [076/131] (444s left) kms_lease (empty-lease)
[579.422220] Starting subtest: empty-lease
[579.424635] Starting dynamic subtest: pipe-A-eDP-1
[579.426939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[579.436369] Starting dynamic subtest: pipe-B-eDP-1
[579.438623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[579.447485] Starting dynamic subtest: pipe-C-eDP-1
[579.449715] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[579.458620] Starting dynamic subtest: pipe-D-eDP-1
[579.460880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[579.463203] Subtest empty-lease: SUCCESS (0.009s)
[579.598777] [077/131] (444s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[579.707093] Starting subtest: extended-modeset-hang-newfb-with-reset
[579.709241] Starting dynamic subtest: pipe-A
[594.918917] Dynamic subtest pipe-A: SUCCESS (15.210s)
[594.928373] Starting dynamic subtest: pipe-D
[611.050436] Dynamic subtest pipe-D: SUCCESS (16.126s)
[611.052779] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.340s)
[611.927404] [078/131] (412s left) gem_ctx_persistence (legacy-engines-hostile)
[611.998057] Starting subtest: legacy-engines-hostile
[612.000275] Starting dynamic subtest: render
[612.116567] Dynamic subtest render: SUCCESS (0.118s)
[612.128313] Starting dynamic subtest: bsd1
[612.258755] Dynamic subtest bsd1: SUCCESS (0.139s)
[612.273516] Starting dynamic subtest: bsd2
[612.341593] Dynamic subtest bsd2: SUCCESS (0.080s)
[612.353099] Starting dynamic subtest: blt
[612.501477] Dynamic subtest blt: SUCCESS (0.157s)
[612.514205] Starting dynamic subtest: vebox
[612.609886] Dynamic subtest vebox: SUCCESS (0.106s)
[612.612436] Subtest legacy-engines-hostile: SUCCESS (0.613s)
[612.718868] [079/131] (411s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[613.113839] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[613.905084] [080/131] (410s left) kms_big_fb (linear-addfb)
[614.000466] Starting subtest: linear-addfb
[614.002416] Subtest linear-addfb: SUCCESS (0.000s)
[614.122087] [081/131] (410s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[614.220112] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[614.231113] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[614.364534] [082/131] (410s left) i915_drm_fdinfo (busy-idle-check-all)
[614.407411] Starting subtest: busy-idle-check-all
[614.409515] Starting dynamic subtest: rcs0
[614.413954] Dynamic subtest rcs0: SKIP (0.003s)
[614.427078] Starting dynamic subtest: bcs0
[614.431714] Dynamic subtest bcs0: SKIP (0.000s)
[614.442420] Starting dynamic subtest: vcs0
[614.446358] Dynamic subtest vcs0: SKIP (0.000s)
[614.455437] Starting dynamic subtest: vcs1
[614.460047] Dynamic subtest vcs1: SKIP (0.000s)
[614.470613] Starting dynamic subtest: vecs0
[614.474713] Dynamic subtest vecs0: SKIP (0.000s)
[614.483067] Starting dynamic subtest: ccs0
[614.487053] Dynamic subtest ccs0: SKIP (0.000s)
[614.491055] Subtest busy-idle-check-all: SKIP (0.008s)
[614.526110] [083/131] (410s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[614.640077] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[614.644358] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[614.850762] [084/131] (409s left) gem_ctx_isolation (dirty-switch)
[614.920530] Starting subtest: dirty-switch
[614.922903] Starting dynamic subtest: rcs0
[615.121061] Dynamic subtest rcs0: SUCCESS (0.200s)
[615.132479] Starting dynamic subtest: bcs0
[615.349143] Dynamic subtest bcs0: SUCCESS (0.227s)
[615.361077] Starting dynamic subtest: vcs0
[615.581782] Dynamic subtest vcs0: SUCCESS (0.232s)
[615.591434] Starting dynamic subtest: vcs1
[617.122761] Dynamic subtest vcs1: SUCCESS (1.540s)
[617.134613] Starting dynamic subtest: vecs0
[619.137540] Dynamic subtest vecs0: SUCCESS (2.014s)
[619.149566] Starting dynamic subtest: ccs0
[621.114603] Dynamic subtest ccs0: SUCCESS (1.976s)
[621.117102] Subtest dirty-switch: SUCCESS (6.194s)
[621.387822] [085/131] (403s left) kms_vblank (wait-forked-busy)
[621.490634] Starting subtest: wait-forked-busy
[621.492839] Starting dynamic subtest: pipe-A-eDP-1
[623.366758] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[623.381841] Starting dynamic subtest: pipe-D-eDP-1
[625.934169] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[625.936436] Subtest wait-forked-busy: SUCCESS (4.445s)
[626.827669] [086/131] (397s left) gem_pipe_control_store_loop (fresh-buffer)
[626.893709] Starting subtest: fresh-buffer
[629.100435] Subtest fresh-buffer: SUCCESS (2.151s)
[629.213990] [087/131] (395s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[629.314991] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[629.319334] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[630.427447] [088/131] (394s left) gem_mmap (big-bo)
[630.504838] Subtest big-bo: SKIP (0.000s)
[630.574421] [089/131] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[630.674228] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[637.374309] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.701s)
[637.535607] [090/131] (387s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[637.923499] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[638.780988] [091/131] (386s left) kms_cursor_crc (cursor-sliding-max-size)
[639.081639] Starting subtest: cursor-sliding-max-size
[639.088207] Subtest cursor-sliding-max-size: SKIP (0.000s)
[639.256706] [092/131] (385s left) gem_pxp (verify-pxp-stale-ctx-execution)
[639.391705] Starting subtest: verify-pxp-stale-ctx-execution
[640.449893] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[640.617998] [093/131] (384s left) gem_exec_balancer (full)
[640.682197] Starting subtest: full
[645.779719] Subtest full: SUCCESS (5.097s)
[646.125912] [094/131] (378s left) gem_create (create-ext-placement-all)
[646.297052] Starting subtest: create-ext-placement-all
[646.299752] Subtest create-ext-placement-all: SUCCESS (0.000s)
[646.435152] [095/131] (378s left) gem_sync (basic-store-each)
[646.512412] Starting subtest: basic-store-each
[649.193947] Subtest basic-store-each: SUCCESS (2.691s)
[649.404790] [096/131] (375s left) gem_exec_fence (basic-wait)
[649.604351] Starting subtest: basic-wait
[649.607055] Starting dynamic subtest: rcs0
[649.690085] Dynamic subtest rcs0: SUCCESS (0.086s)
[649.700977] Starting dynamic subtest: bcs0
[649.761098] Dynamic subtest bcs0: SUCCESS (0.069s)
[649.770891] Starting dynamic subtest: vcs0
[649.821572] Dynamic subtest vcs0: SUCCESS (0.058s)
[649.835679] Starting dynamic subtest: vcs1
[649.883374] Dynamic subtest vcs1: SUCCESS (0.060s)
[649.898907] Starting dynamic subtest: vecs0
[649.950939] Dynamic subtest vecs0: SUCCESS (0.065s)
[649.962943] Starting dynamic subtest: ccs0
[650.017753] Dynamic subtest ccs0: SUCCESS (0.065s)
[650.020105] Subtest basic-wait: SUCCESS (0.415s)
[652.058636] [097/131] (373s left) kms_addfb_basic (bad-pitch-999)
[652.121921] Starting subtest: bad-pitch-999
[652.124124] Subtest bad-pitch-999: SUCCESS (0.000s)
[652.296809] [098/131] (372s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[652.401880] Starting subtest: 4-tiled-addfb-size-offset-overflow
[652.404111] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[652.540555] [099/131] (372s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[652.625273] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[652.629395] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[652.743970] [100/131] (372s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[652.847605] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[657.211292] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.367s)
[658.425821] [101/131] (366s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[658.527764] Starting subtest: y-tiled-32bpp-rotate-0
[658.532467] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[658.644780] [102/131] (366s left) gem_exec_whisper (basic-fds)
[658.712612] Starting subtest: basic-fds
[665.936600] Subtest basic-fds: SUCCESS (7.222s)
[666.145795] [103/131] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[666.261041] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[666.265171] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[666.379309] [104/131] (359s left) gem_mmap_offset (close-race)
[666.445028] Starting subtest: close-race
[686.606408] Subtest close-race: SUCCESS (20.108s)
[686.683190] [105/131] (338s left) prime_vgem (shrink)
[686.776880] Starting subtest: shrink
[686.801372] Subtest shrink: SUCCESS (0.024s)
[686.951876] [106/131] (338s left) gem_mmap_gtt (cpuset-basic-small-copy)
[687.006274] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[687.081539] [107/131] (338s left) dmabuf_sync_file (export-multiwait)
[687.121116] Starting subtest: export-multiwait
[687.123506] Subtest export-multiwait: SUCCESS (0.001s)
[687.202772] [108/131] (338s left) kms_dsc (dsc-fractional-bpp)
[687.298102] Starting subtest: dsc-fractional-bpp
[687.310653] Subtest dsc-fractional-bpp: SKIP (0.000s)
[687.393974] [109/131] (338s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[687.498339] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[691.861436] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.366s)
[693.025358] [110/131] (332s left) kms_pm_rpm (cursor-dpms)
[695.045671] Starting subtest: cursor-dpms
[695.050523] Subtest cursor-dpms: SKIP (0.000s)
[695.452501] [111/131] (330s left) kms_psr (fbc-psr-dpms)
[695.553356] Starting subtest: fbc-psr-dpms
[695.555599] Starting dynamic subtest: eDP-1
[695.559959] Dynamic subtest eDP-1: SKIP (0.000s)
[695.564338] Subtest fbc-psr-dpms: SKIP (0.001s)
[695.650429] [112/131] (330s left) gem_mmap_wc (bad-size)
[695.718406] Subtest bad-size: SKIP (0.000s)
[695.787560] [113/131] (329s left) i915_hangman (engine-error-state-capture)
[695.859435] Starting subtest: engine-error-state-capture
[695.861383] Starting dynamic subtest: rcs0
[699.892603] Dynamic subtest rcs0: SUCCESS (4.032s)
[699.906806] Starting dynamic subtest: bcs0
[705.844845] Dynamic subtest bcs0: SUCCESS (5.949s)
[705.857271] Starting dynamic subtest: vcs0
[711.795189] Dynamic subtest vcs0: SUCCESS (5.947s)
[711.807483] Starting dynamic subtest: vcs1
[716.852803] Dynamic subtest vcs1: SUCCESS (5.055s)
[716.865671] Starting dynamic subtest: vecs0
[722.804553] Dynamic subtest vecs0: SUCCESS (5.949s)
[722.817026] Starting dynamic subtest: ccs0
[727.860677] Dynamic subtest ccs0: SUCCESS (5.053s)
[727.863866] Subtest engine-error-state-capture: SUCCESS (32.001s)
[727.967345] [114/131] (297s left) perf (sysctl-defaults)
[728.077940] Starting subtest: sysctl-defaults
[728.080424] Subtest sysctl-defaults: SUCCESS (0.000s)
[728.138058] [115/131] (297s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[728.251346] Starting subtest: psr-rgb101010-draw-mmap-wc
[735.223799] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.975s)
[735.385475] [116/131] (290s left) kms_psr (psr2-sprite-render)
[735.480072] Starting subtest: psr2-sprite-render
[735.482277] Starting dynamic subtest: eDP-1
[737.252571] Dynamic subtest eDP-1: SUCCESS (1.772s)
[737.254938] Subtest psr2-sprite-render: SUCCESS (1.774s)
[738.109305] [117/131] (287s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[738.392652] Starting subtest: cursor-rapid-movement-512x512
[738.397203] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[738.595082] [118/131] (287s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[738.692314] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[738.694540] Starting dynamic subtest: pipe-A-eDP-1
[738.703666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[738.715026] Starting dynamic subtest: pipe-B-eDP-1
[738.724768] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[738.739286] Starting dynamic subtest: pipe-C-eDP-1
[738.747701] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[738.760587] Starting dynamic subtest: pipe-D-eDP-1
[738.768954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[738.773653] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[740.907851] [119/131] (285s left) gem_partial_pwrite_pread (writes-after-reads)
[740.979780] Subtest writes-after-reads: SKIP (0.000s)
[741.068381] [120/131] (284s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[741.184489] Starting subtest: 2x-cursor-vs-flip-legacy
[741.188939] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[741.357698] [121/131] (284s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[741.459520] Starting subtest: yf-tiled-32bpp-rotate-270
[741.463638] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[741.604141] [122/131] (284s left) gem_render_copy_redux (normal)
[741.656386] Starting subtest: normal
[741.932234] Subtest normal: SUCCESS (0.276s)
[742.053861] [123/131] (284s left) gem_exec_schedule (implicit-read-write)
[742.133131] Starting subtest: implicit-read-write
[742.134743] Starting dynamic subtest: rcs0
[742.229522] Dynamic subtest rcs0: SUCCESS (0.104s)
[742.242052] Starting dynamic subtest: vcs0
[742.309445] Dynamic subtest vcs0: SUCCESS (0.079s)
[742.321689] Starting dynamic subtest: vcs1
[742.384552] Dynamic subtest vcs1: SUCCESS (0.075s)
[742.395355] Starting dynamic subtest: vecs0
[742.460502] Dynamic subtest vecs0: SUCCESS (0.076s)
[742.471511] Starting dynamic subtest: ccs0
[742.550782] Dynamic subtest ccs0: SUCCESS (0.089s)
[742.553046] Subtest implicit-read-write: SUCCESS (0.426s)
[744.033137] [124/131] (282s left) api_intel_allocator (reserve-simple)
[744.099767] Starting subtest: reserve-simple
[744.102252] Subtest reserve-simple: SUCCESS (0.005s)
[744.268080] [125/131] (281s left) syncobj_wait (invalid-signal-illegal-handle)
[744.319444] Starting subtest: invalid-signal-illegal-handle
[744.321722] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[744.469437] [126/131] (281s left) gem_exec_parallel (engines)
[744.532171] Starting subtest: engines
[744.534477] Starting dynamic subtest: basic
[747.925849] Dynamic subtest basic: SUCCESS (3.392s)
[747.936164] Starting dynamic subtest: contexts
[752.425222] Dynamic subtest contexts: SUCCESS (4.496s)
[752.434397] Starting dynamic subtest: fds
[756.167452] Dynamic subtest fds: SUCCESS (3.741s)
[756.179904] Starting dynamic subtest: userptr
[757.879345] Dynamic subtest userptr: SUCCESS (1.709s)
[757.881871] Subtest engines: SUCCESS (13.346s)
[758.097402] [127/131] (268s left) kms_plane_multiple (tiling-4)
[758.198463] Starting subtest: tiling-4
[758.200380] Starting dynamic subtest: pipe-A-eDP-1
[762.032957] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.834s)
[762.043422] Starting dynamic subtest: pipe-B-eDP-1
[766.629031] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.594s)
[766.639194] Starting dynamic subtest: pipe-C-eDP-1
[771.219967] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.589s)
[771.230287] Starting dynamic subtest: pipe-D-eDP-1
[775.821595] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.600s)
[775.823988] Subtest tiling-4: SUCCESS (17.623s)
[776.706522] [128/131] (249s left) kms_invalid_mode (zero-vdisplay)
[776.793445] Starting subtest: zero-vdisplay
[776.795714] Starting dynamic subtest: pipe-A-eDP-1
[777.078215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[777.088728] Starting dynamic subtest: pipe-B-eDP-1
[777.090977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[777.099667] Starting dynamic subtest: pipe-C-eDP-1
[777.101936] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[777.115283] Starting dynamic subtest: pipe-D-eDP-1
[777.118018] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[777.127092] Subtest zero-vdisplay: SUCCESS (0.293s)
[777.907355] [129/131] (248s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[778.008829] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[778.013243] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[778.132499] [130/131] (248s left) api_intel_bb (object-reloc-purge-cache)
[778.187092] Starting subtest: object-reloc-purge-cache
[778.191563] Subtest object-reloc-purge-cache: SKIP (0.002s)
[778.335207] [131/131] (248s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[778.438233] Starting subtest: fbcpsr-1p-rte
[785.409062] Subtest fbcpsr-1p-rte: SUCCESS (6.974s)
[785.577460] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_readwrite
results: parsing output: 7/ for test: sysfs_timeslice_duration
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_tiled_blits
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_pm_rpm
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: gem_exec_alignment
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_hdmi_inject
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_pm_backlight
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_feature_discovery
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_plane_alpha_blend
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: gem_gpgpu_fill
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: gem_exec_await
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_ctx_isolation
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: gem_pipe_control_store_loop
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_mmap
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_chamelium_edid
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: gem_create
results: parsing output: 94/ for test: gem_sync
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_offset
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: kms_dsc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_mmap_wc
results: parsing output: 112/ for test: i915_hangman
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_render_copy_redux
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_exec_parallel
results: parsing output: 126/ for test: kms_plane_multiple
results: parsing output: 127/ for test: kms_invalid_mode
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.