[59.280039] Initializing watchdogs
[59.280090]   /dev/watchdog0
[59.294338] [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]
[59.299115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.301672] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.305275] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[59.433787] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[59.438250] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[59.523826] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[59.622349] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[59.626794] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.709712] [003/133] (960s left) kms_joiner (invalid-modeset-big-joiner)
[59.802262] Starting subtest: invalid-modeset-big-joiner
[59.806742] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[59.863527] [004/133] (960s left) i915_pm_rc6_residency (media-rc6-accuracy)
[59.915638] Starting subtest: media-rc6-accuracy
[59.919965] Subtest media-rc6-accuracy: SKIP (0.000s)
[60.027014] [005/133] (959s left) kms_cursor_legacy (torture-bo)
[60.147823] Starting subtest: torture-bo
[60.150133] Starting dynamic subtest: pipe-A
[65.923721] Dynamic subtest pipe-A: SUCCESS (5.787s)
[65.937037] Starting dynamic subtest: pipe-B
[73.988421] Dynamic subtest pipe-B: SUCCESS (8.072s)
[73.997585] Starting dynamic subtest: pipe-C
[81.540756] Dynamic subtest pipe-C: SUCCESS (7.556s)
[81.547352] Starting dynamic subtest: pipe-D
[88.997136] Dynamic subtest pipe-D: SUCCESS (7.455s)
[89.004649] Starting dynamic subtest: all-pipes
[96.533714] Dynamic subtest all-pipes: SUCCESS (7.534s)
[96.536755] Subtest torture-bo: SUCCESS (36.406s)
[96.696682] [006/133] (923s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[96.797175] Starting subtest: fbcpsr-rgb565-draw-blt
[103.802912] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.008s)
[103.934757] [007/133] (916s left) kms_big_fb (linear-8bpp-rotate-270)
[104.037626] Starting subtest: linear-8bpp-rotate-270
[104.057649] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[104.184773] [008/133] (915s left) gem_exec_schedule (preempt-queue-contexts)
[104.253762] Subtest preempt-queue-contexts: SKIP (0.000s)
[104.555628] [009/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[104.661706] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[104.665821] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[104.759662] [010/133] (915s left) syncobj_wait (single-wait-all-signaled)
[104.816802] Starting subtest: single-wait-all-signaled
[104.819102] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[104.901095] [011/133] (915s left) kms_psr (psr-primary-mmap-gtt)
[104.994411] Starting subtest: psr-primary-mmap-gtt
[104.996732] Starting dynamic subtest: eDP-1
[106.411203] Dynamic subtest eDP-1: SKIP (1.413s)
[106.415817] Subtest psr-primary-mmap-gtt: SKIP (1.414s)
[106.589339] [012/133] (913s left) gem_ctx_bad_destroy (double-destroy)
[106.658773] Starting subtest: double-destroy
[106.661743] Subtest double-destroy: SUCCESS (0.000s)
[106.730427] [013/133] (913s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[106.787889] Starting subtest: multi-wait-for-submit-submitted-signaled
[106.790262] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[106.887211] [014/133] (913s left) gem_flink_race (flink_close)
[106.920216] Starting subtest: flink_close
[112.002801] Subtest flink_close: SUCCESS (5.081s)
[112.094311] [015/133] (908s left) kms_color (invalid-ctm-matrix-sizes)
[112.222970] Starting subtest: invalid-ctm-matrix-sizes
[112.225425] Starting dynamic subtest: pipe-A
[112.227802] Dynamic subtest pipe-A: SUCCESS (0.002s)
[112.236483] Starting dynamic subtest: pipe-B
[112.238411] Dynamic subtest pipe-B: SUCCESS (0.003s)
[112.245318] Starting dynamic subtest: pipe-C
[112.247198] Dynamic subtest pipe-C: SUCCESS (0.004s)
[112.254326] Starting dynamic subtest: pipe-D
[112.256562] Dynamic subtest pipe-D: SUCCESS (0.004s)
[112.258770] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[112.304461] [016/133] (908s left) gem_mmap_gtt (cpuset-medium-copy)
[112.376997] Subtest cpuset-medium-copy: SKIP (0.000s)
[112.445125] [017/133] (907s left) perf_pmu (busy-idle-check-all)
[112.501839] Starting subtest: busy-idle-check-all
[112.504243] Starting dynamic subtest: rcs0
[113.159088] Dynamic subtest rcs0: SUCCESS (0.657s)
[113.169168] Starting dynamic subtest: bcs0
[113.812560] Dynamic subtest bcs0: SUCCESS (0.652s)
[113.823088] Starting dynamic subtest: vcs0
[114.903321] Dynamic subtest vcs0: SUCCESS (1.088s)
[114.914095] Starting dynamic subtest: vcs1
[116.886477] Dynamic subtest vcs1: SUCCESS (1.982s)
[116.897077] Starting dynamic subtest: vecs0
[118.933645] Dynamic subtest vecs0: SUCCESS (2.046s)
[118.944721] Starting dynamic subtest: ccs0
[119.590190] Dynamic subtest ccs0: SUCCESS (0.657s)
[119.592682] Subtest busy-idle-check-all: SUCCESS (7.089s)
[119.691097] [018/133] (900s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[119.802614] Starting subtest: y-tiled-16bpp-rotate-270
[119.806795] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[119.917179] [019/133] (900s left) kms_frontbuffer_tracking (psr-2p-rte)
[120.009859] Starting subtest: psr-2p-rte
[120.014136] Subtest psr-2p-rte: SKIP (0.000s)
[120.095139] [020/133] (900s left) gem_exec_schedule (u-fairslice-all)
[120.177489] Starting subtest: u-fairslice-all
[122.235782] Subtest u-fairslice-all: SUCCESS (2.056s)
[123.928540] [021/133] (896s left) perf (blocking-parameterized)
[124.057644] Starting subtest: blocking-parameterized
[144.080387] Subtest blocking-parameterized: SUCCESS (20.021s)
[144.126403] [022/133] (876s left) kms_chamelium_color (ctm-0-75)
[144.226780] Subtest ctm-0-75: SKIP (0.000s)
[144.269892] [023/133] (876s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[144.367967] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[145.191540] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[145.349803] [024/133] (875s left) kms_plane_scaling (planes-downscale-factor-0-75)
[145.435798] Starting subtest: planes-downscale-factor-0-75
[145.438062] Starting dynamic subtest: pipe-A
[145.462654] Dynamic subtest pipe-A: SKIP (0.019s)
[145.471853] Starting dynamic subtest: pipe-B
[145.498641] Dynamic subtest pipe-B: SKIP (0.037s)
[145.506523] Starting dynamic subtest: pipe-C
[145.535063] Dynamic subtest pipe-C: SKIP (0.038s)
[145.542773] Starting dynamic subtest: pipe-D
[145.572821] Dynamic subtest pipe-D: SKIP (0.037s)
[145.576450] Subtest planes-downscale-factor-0-75: SKIP (0.132s)
[145.664129] [025/133] (875s left) perf (gen8-unprivileged-single-ctx-counters)
[145.763867] Starting subtest: gen8-unprivileged-single-ctx-counters
[145.768596] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[145.807812] [026/133] (874s left) kms_plane_alpha_blend (alpha-7efc)
[145.891802] Starting subtest: alpha-7efc
[146.199505] Starting dynamic subtest: pipe-A-eDP-1
[146.840711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[146.874937] Starting dynamic subtest: pipe-D-eDP-1
[148.147054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[148.149518] Subtest alpha-7efc: SUCCESS (2.253s)
[149.008356] [027/133] (871s left) gem_request_retire (retire-vma-not-inactive)
[149.075760] Starting subtest: retire-vma-not-inactive
[149.135698] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[149.251856] [028/133] (871s left) vgem_basic (create)
[149.338642] Starting subtest: create
[149.340485] Subtest create: SUCCESS (0.000s)
[149.417385] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[149.420938] [029/133] (871s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[149.506443] Starting subtest: plane-scaler-unity-scaling-with-rotation
[149.508780] Starting dynamic subtest: pipe-A
[149.734299] Dynamic subtest pipe-A: SUCCESS (0.229s)
[149.744860] Starting dynamic subtest: pipe-B
[150.993655] Dynamic subtest pipe-B: SUCCESS (1.259s)
[151.003123] Starting dynamic subtest: pipe-C
[152.331111] Dynamic subtest pipe-C: SUCCESS (1.337s)
[152.340737] Starting dynamic subtest: pipe-D
[153.657985] Dynamic subtest pipe-D: SUCCESS (1.326s)
[153.660337] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.152s)
[154.851392] [030/133] (866s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[154.950777] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[154.953157] Starting dynamic subtest: pipe-A-eDP-1
[154.976697] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.986919] Starting dynamic subtest: pipe-B-eDP-1
[155.009235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.016976] Starting dynamic subtest: pipe-C-eDP-1
[155.039501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.047097] Starting dynamic subtest: pipe-D-eDP-1
[155.069234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.073238] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[157.220600] [031/133] (863s left) gem_exec_async (concurrent-writes)
[157.275022] Starting subtest: concurrent-writes
[157.277677] Starting dynamic subtest: rcs0
[157.290985] Dynamic subtest rcs0: SUCCESS (0.016s)
[157.301393] Starting dynamic subtest: bcs0
[157.303719] Dynamic subtest bcs0: SUCCESS (0.006s)
[157.311595] Starting dynamic subtest: vcs0
[157.314046] Dynamic subtest vcs0: SUCCESS (0.004s)
[157.321767] Starting dynamic subtest: vcs1
[157.323671] Dynamic subtest vcs1: SUCCESS (0.006s)
[157.331067] Starting dynamic subtest: vecs0
[157.332979] Dynamic subtest vecs0: SUCCESS (0.005s)
[157.340369] Starting dynamic subtest: ccs0
[157.342284] Dynamic subtest ccs0: SUCCESS (0.006s)
[157.344183] Subtest concurrent-writes: SUCCESS (0.045s)
[157.553573] [032/133] (863s left) kms_psr (fbc-pr-basic)
[157.649124] Starting subtest: fbc-pr-basic
[157.653213] Subtest fbc-pr-basic: SKIP (0.000s)
[157.735877] [033/133] (863s left) gem_exec_suspend (basic-s3-devices)
[157.797097] Starting subtest: basic-S3-devices
[157.799406] Starting dynamic subtest: smem
[169.942702] Dynamic subtest smem: SUCCESS (12.142s)
[169.945571] Subtest basic-S3-devices: SUCCESS (12.144s)
[170.144510] [034/133] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[170.268784] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[177.191161] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.925s)
[177.306892] [035/133] (843s left) kms_flip (2x-flip-vs-suspend)
[177.401086] Starting subtest: 2x-flip-vs-suspend
[177.412804] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[177.522861] [036/133] (843s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[177.625714] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[177.630082] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[177.732071] [037/133] (843s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[177.775823] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[177.881652] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[177.969306] [038/133] (843s left) kms_pm_rpm (dpms-lpsp)
[180.106745] Starting subtest: dpms-lpsp
[180.412055] Subtest dpms-lpsp: SUCCESS (0.307s)
[180.500994] [039/133] (840s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[180.614918] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[187.285775] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.672s)
[187.411243] [040/133] (833s left) gem_exec_whisper (basic-fds-priority)
[187.476714] Starting subtest: basic-fds-priority
[211.506644] Subtest basic-fds-priority: SUCCESS (24.028s)
[211.695498] [041/133] (809s left) vgem_basic (dmabuf-fence)
[211.755619] Starting subtest: dmabuf-fence
[211.757807] Subtest dmabuf-fence: SUCCESS (0.001s)
[211.828017] [042/133] (809s left) prime_vgem (basic-gtt)
[211.908724] Starting subtest: basic-gtt
[211.913401] Subtest basic-gtt: SKIP (0.000s)
[212.018362] [043/133] (809s left) kms_cursor_edge_walk (256x256-top-edge)
[212.120863] Starting subtest: 256x256-top-edge
[212.123213] Starting dynamic subtest: pipe-A-eDP-1
[215.553075] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[215.566347] Starting dynamic subtest: pipe-D-eDP-1
[218.679401] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[218.681715] Subtest 256x256-top-edge: SUCCESS (6.560s)
[219.472862] [044/133] (802s left) kms_vblank (query-forked-busy-hang)
[219.572760] Starting subtest: query-forked-busy-hang
[219.574628] Starting dynamic subtest: pipe-A-eDP-1
[245.658851] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.084s)
[245.673797] Starting dynamic subtest: pipe-D-eDP-1
[270.680340] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[270.682611] Subtest query-forked-busy-hang: SUCCESS (51.107s)
[271.534331] [045/133] (750s left) gem_eio (execbuf)
[271.748457] Starting subtest: execbuf
[272.015447] Subtest execbuf: SUCCESS (0.270s)
[272.134133] [046/133] (749s left) gem_exec_await (wide-contexts)
[272.362070] Starting subtest: wide-contexts
[295.846703] Subtest wide-contexts: SUCCESS (23.483s)
[296.048804] [047/133] (725s left) kms_frontbuffer_tracking (fbc-2p-rte)
[296.185337] Starting subtest: fbc-2p-rte
[296.189166] Subtest fbc-2p-rte: SKIP (0.000s)
[296.280911] [048/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[296.370278] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[300.634338] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.267s)
[301.840933] [049/133] (719s left) kms_flip (absolute-wf_vblank-interruptible)
[301.945654] Starting subtest: absolute-wf_vblank-interruptible
[301.948052] Starting dynamic subtest: A-eDP1
[310.680068] Dynamic subtest A-eDP1: SUCCESS (8.734s)
[310.695487] Starting dynamic subtest: B-eDP1
[319.415923] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[319.428184] Starting dynamic subtest: C-eDP1
[328.136056] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[328.148476] Starting dynamic subtest: D-eDP1
[336.866730] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[336.871693] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.927s)
[338.087299] [050/133] (683s left) i915_drm_fdinfo (virtual-busy-hang-all)
[338.132354] Starting subtest: virtual-busy-hang-all
[338.136884] Subtest virtual-busy-hang-all: SKIP (0.000s)
[338.207931] [051/133] (683s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[338.306597] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[338.310703] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[338.381147] [052/133] (683s left) i915_suspend (fence-restore-untiled)
[338.447411] Starting subtest: fence-restore-untiled
[338.452048] Subtest fence-restore-untiled: SKIP (0.000s)
[338.548243] [053/133] (683s left) gem_partial_pwrite_pread (write-display)
[338.617113] Subtest write-display: SKIP (0.000s)
[338.691235] [054/133] (683s left) syncobj_timeline (etime-multi-wait-all-submitted)
[338.751548] Starting subtest: etime-multi-wait-all-submitted
[338.857813] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[338.932769] [055/133] (683s left) gem_mmap_gtt (flink-race)
[338.981962] Subtest flink-race: SKIP (0.000s)
[339.047738] [056/133] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[339.137372] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[339.141387] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[339.234361] [057/133] (682s left) prime_vgem (basic-blt)
[339.291827] Starting subtest: basic-blt
[339.322036] Subtest basic-blt: SUCCESS (0.033s)
[339.444537] [058/133] (682s left) gem_exec_reloc (basic-softpin)
[339.501126] Subtest basic-softpin: SKIP (0.000s)
[339.581319] [059/133] (682s left) kms_cursor_crc (cursor-random-64x64)
[339.761613] Starting subtest: cursor-random-64x64
[339.766621] Starting dynamic subtest: pipe-A-eDP-1
[343.141170] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.376s)
[343.170823] Starting dynamic subtest: pipe-D-eDP-1
[347.251523] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.088s)
[347.253855] Subtest cursor-random-64x64: SUCCESS (7.490s)
[348.063574] [060/133] (674s left) kms_flip (flip-vs-modeset-vs-hang)
[348.148560] Starting subtest: flip-vs-modeset-vs-hang
[348.150954] Starting dynamic subtest: A-eDP1
[399.344613] Dynamic subtest A-eDP1: SUCCESS (51.192s)
[399.356482] Starting dynamic subtest: D-eDP1
[449.390676] Dynamic subtest D-eDP1: SUCCESS (50.044s)
[449.393143] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.240s)
[449.769161] [061/133] (572s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[449.864924] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[449.867174] Starting dynamic subtest: pipe-A-eDP-1
[449.890532] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.902834] Starting dynamic subtest: pipe-B-eDP-1
[449.924077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.933494] Starting dynamic subtest: pipe-C-eDP-1
[449.954256] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.963608] Starting dynamic subtest: pipe-D-eDP-1
[449.984660] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.988610] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[452.123917] [062/133] (570s left) gem_exec_balancer (parallel-contexts)
[452.400032] Starting subtest: parallel-contexts
[456.017871] Subtest parallel-contexts: SUCCESS (3.618s)
[456.217554] [063/133] (566s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[456.280888] Subtest tiled-to-tiled: SKIP (0.000s)
[456.362456] [064/133] (566s left) gem_lmem_swapping (massive)
[456.409901] Subtest massive: SKIP (0.000s)
[456.452010] [065/133] (565s left) gem_close_race (basic-threads)
[456.526309] Starting subtest: basic-threads
[457.887770] Subtest basic-threads: SUCCESS (1.361s)
[458.077625] [066/133] (564s left) kms_flip (2x-nonexisting-fb-interruptible)
[458.176550] Starting subtest: 2x-nonexisting-fb-interruptible
[458.186305] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[458.265764] [067/133] (564s left) api_intel_bb (simple-bb)
[458.313341] Starting subtest: simple-bb
[458.316096] Subtest simple-bb: SUCCESS (0.006s)
[458.439770] [068/133] (564s left) gem_exec_params (no-vebox)
[458.493804] Starting subtest: no-vebox
[458.496043] Subtest no-vebox: SUCCESS (0.002s)
[459.999396] [069/133] (562s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[460.096958] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[460.099263] Starting dynamic subtest: pipe-A-eDP-1
[460.121564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.133828] Starting dynamic subtest: pipe-B-eDP-1
[460.155138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.164426] Starting dynamic subtest: pipe-C-eDP-1
[460.185813] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.195355] Starting dynamic subtest: pipe-D-eDP-1
[460.217114] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.221379] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[462.282688] [070/133] (560s left) gem_busy (extended)
[462.474953] Starting subtest: extended
[462.477671] Starting dynamic subtest: rcs0
[462.557828] Dynamic subtest rcs0: SUCCESS (0.082s)
[462.570879] Starting dynamic subtest: bcs0
[462.599525] Dynamic subtest bcs0: SUCCESS (0.040s)
[462.610840] Starting dynamic subtest: vcs0
[463.894663] Dynamic subtest vcs0: SUCCESS (1.291s)
[463.908054] Starting dynamic subtest: vcs1
[465.879729] Dynamic subtest vcs1: SUCCESS (1.982s)
[465.892667] Starting dynamic subtest: vecs0
[467.927932] Dynamic subtest vecs0: SUCCESS (2.046s)
[467.940606] Starting dynamic subtest: ccs0
[467.972805] Dynamic subtest ccs0: SUCCESS (0.044s)
[467.975237] Subtest extended: SUCCESS (5.499s)
[468.213861] [071/133] (554s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[468.314732] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[468.319130] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[469.416975] [072/133] (553s left) kms_properties (colorop-properties-atomic)
[469.510828] Starting subtest: colorop-properties-atomic
[469.513219] Starting dynamic subtest: pipe-A-eDP-1
[469.876720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[469.890285] Starting dynamic subtest: pipe-B-eDP-1
[470.987458] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.110s)
[470.998285] Starting dynamic subtest: pipe-C-eDP-1
[472.017272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s)
[472.027559] Starting dynamic subtest: pipe-D-eDP-1
[473.072488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.054s)
[473.074787] Subtest colorop-properties-atomic: SUCCESS (3.565s)
[473.874702] [073/133] (548s left) gem_ctx_param (invalid-ctx-get)
[473.934991] Starting subtest: invalid-ctx-get
[473.937291] Subtest invalid-ctx-get: SUCCESS (0.000s)
[474.016611] [074/133] (548s left) gem_pread (bench)
[474.087806] Subtest bench: SKIP (0.000s)
[474.149376] [075/133] (548s left) gem_exec_balancer (bonded-semaphore)
[474.211116] Starting subtest: bonded-semaphore
[474.215755] Subtest bonded-semaphore: SKIP (0.000s)
[474.513455] [076/133] (548s left) kms_feature_discovery (display)
[474.613396] Starting subtest: display
[474.615386] Subtest display: SUCCESS (0.000s)
[474.720794] [077/133] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[474.816977] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[482.492460] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.678s)
[482.608104] [078/133] (540s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[482.674434] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[482.679069] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[482.873652] [079/133] (540s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[482.969585] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[482.971981] Starting dynamic subtest: pipe-A-eDP-1
[483.058080] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[483.068476] Starting dynamic subtest: pipe-B-eDP-1
[484.200040] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[484.204539] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.232s)
[485.392146] [080/133] (537s left) kms_flip_tiling (flip-change-tiling)
[485.485083] Starting subtest: flip-change-tiling
[485.487366] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[485.660739] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.176s)
[485.674582] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[485.806110] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[485.819037] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[485.950767] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.963642] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[486.106405] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.153s)
[486.118959] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[486.248890] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[486.261493] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[486.394051] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[486.406692] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[486.528063] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[486.539297] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[486.638198] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[486.650750] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[486.772565] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[486.785975] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[486.916373] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[486.929733] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[487.060128] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[487.072869] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[487.193305] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[487.206226] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[487.326826] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[487.339934] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[487.461708] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[487.475202] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[487.571840] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[487.584813] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[487.716201] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[487.729055] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[487.860029] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[487.873087] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[488.004168] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[488.020116] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[488.149046] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[488.161888] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[488.295066] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[488.308296] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[488.438065] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[488.451258] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[488.560257] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[488.573435] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[488.704124] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[488.719098] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[488.848519] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[488.863751] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[488.993063] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[489.007241] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[489.137214] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[489.153064] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[489.281766] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[489.297162] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[489.426542] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[489.441500] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[489.548978] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[489.561574] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[489.704708] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.154s)
[489.717685] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[489.848496] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[489.863661] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[489.992904] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[490.007077] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[490.138288] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[490.150589] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[490.282197] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[490.294076] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[490.426447] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[490.439022] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[490.548891] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[490.602642] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[491.854824] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.259s)
[491.870860] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[491.989437] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[492.002563] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[492.122470] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[492.134475] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[492.265802] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[492.278803] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[492.409408] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[492.422529] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[492.554274] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[492.566822] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[492.688263] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[492.699668] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[492.798682] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[492.810713] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[492.933312] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[492.945295] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[493.077038] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[493.090064] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[493.232027] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.153s)
[493.244664] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[493.376317] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[493.389304] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[493.510426] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[493.522507] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[493.644828] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[493.663051] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[493.754955] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[493.766376] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[493.899340] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[493.911816] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[494.042827] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[494.056842] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[494.187997] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[494.200898] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[494.332443] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[494.344669] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[494.477068] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[494.490606] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[494.621597] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[494.637298] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[494.743342] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.119s)
[494.756576] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[494.887137] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[494.901900] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[495.058901] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.170s)
[495.075045] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[495.203675] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[495.219594] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[495.347809] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[495.362198] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[495.492875] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[495.511971] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[495.636896] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[495.649204] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[495.759309] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[495.771429] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[495.904385] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[495.919840] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[496.048069] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.141s)
[496.065075] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[496.193074] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.141s)
[496.208573] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[496.337212] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.141s)
[496.356234] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[496.481458] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[496.496941] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[496.626675] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[496.639418] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[496.748605] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[496.802703] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[497.989267] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.194s)
[498.004724] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[498.100799] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[498.112969] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[498.200718] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[498.212331] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[498.312195] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[498.324824] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[498.422476] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[498.436652] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[498.533555] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[498.546038] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[498.633531] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[498.648288] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[498.733875] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[498.747025] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[498.833783] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[498.846041] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[498.944706] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[498.959868] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[499.055479] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.108s)
[499.066295] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[499.166591] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[499.178545] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[499.266904] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[499.279337] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[499.377915] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[499.390067] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[499.478037] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[499.490221] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[499.589447] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[499.601499] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[499.700056] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[499.711471] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[499.811013] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[499.822545] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[499.911464] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[499.923123] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[500.011830] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[500.024098] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[500.122798] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[500.138761] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[500.244475] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.118s)
[500.258809] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[500.355483] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[500.367433] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[500.477756] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.120s)
[500.490083] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[500.588917] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[500.600135] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[500.689029] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[500.700437] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[500.789030] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[500.799554] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[500.900058] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[500.912381] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[501.011097] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[501.022417] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[501.122320] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[501.136062] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[501.244167] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.119s)
[501.258219] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[501.355267] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.108s)
[501.367509] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[501.466687] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[501.478973] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[501.577830] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[501.595202] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[501.689230] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[501.699776] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[501.800222] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[501.842102] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[503.020145] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.185s)
[503.033288] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[503.119823] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[503.131347] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[503.219869] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[503.231633] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[503.342617] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.120s)
[503.354639] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[503.453274] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[503.465931] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[503.564421] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[503.576596] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[503.664994] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[503.677714] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[503.764950] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[503.776787] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[503.864701] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[503.880206] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[503.964372] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[503.975664] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[504.074853] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[504.087289] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[504.186013] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[504.198436] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[504.286617] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[504.299074] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[504.386567] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[504.398842] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[504.486723] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[504.500091] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[504.597616] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[504.610068] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[504.708425] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[504.720623] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[504.819852] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[504.830752] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[504.919966] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[504.931295] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[505.019745] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[505.032041] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[505.130893] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[505.143489] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[505.242340] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[505.254461] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[505.352837] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[505.363652] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[505.502614] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.148s)
[505.514996] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[505.613720] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[505.626035] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[505.724809] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[505.737505] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[505.824898] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[505.837407] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[505.935991] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[505.952116] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[506.047572] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[506.060239] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[506.169914] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.120s)
[506.182685] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[506.280402] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[506.292649] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[506.392168] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[506.405725] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[506.502809] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[506.513821] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[506.613499] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[506.625879] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[506.725307] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[506.738042] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[506.836563] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[506.869300] Subtest flip-change-tiling: SUCCESS (21.386s)
[508.024046] [081/133] (515s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[508.146698] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[509.592765] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.446s)
[510.404357] [082/133] (512s left) drm_mm (drm_mm)
[510.445601] Starting subtest: drm_mm
[510.493047] Starting dynamic subtest: drm_test_mm_init
[510.579254] Dynamic subtest drm_test_mm_init: SUCCESS (0.084s)
[510.590131] Starting dynamic subtest: drm_test_mm_debug
[510.676471] Dynamic subtest drm_test_mm_debug: SUCCESS (0.096s)
[510.697473] Starting dynamic subtest: drm_test_mm_align32
[510.769681] Dynamic subtest drm_test_mm_align32: SUCCESS (0.093s)
[510.780812] Starting dynamic subtest: drm_test_mm_align64
[510.866117] Dynamic subtest drm_test_mm_align64: SUCCESS (0.095s)
[510.875819] Starting dynamic subtest: drm_test_mm_lowest
[510.970967] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.103s)
[510.980769] Starting dynamic subtest: drm_test_mm_highest
[511.075025] Dynamic subtest drm_test_mm_highest: SUCCESS (0.102s)
[511.077336] Subtest drm_mm: SUCCESS (0.628s)
[511.237687] [083/133] (511s left) gem_exec_fence (invalid-fence-array)
[511.653220] Starting subtest: invalid-fence-array
[511.659118] Subtest invalid-fence-array: SUCCESS (0.003s)
[513.003803] [084/133] (510s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[513.109303] Starting subtest: psr-rgb565-draw-mmap-gtt
[513.113283] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[513.206996] [085/133] (510s left) gem_fence_thrash (bo-copy)
[513.249997] Starting subtest: bo-copy
[513.277910] Subtest bo-copy: SKIP (0.024s)
[513.343079] [086/133] (510s left) sysfs_preempt_timeout (timeout)
[513.403840] Starting subtest: timeout
[513.406365] Starting dynamic subtest: vecs0
[522.898091] Dynamic subtest vecs0: SUCCESS (9.490s)
[522.910068] Starting dynamic subtest: ccs0
[524.207364] Dynamic subtest ccs0: SUCCESS (1.308s)
[524.220977] Starting dynamic subtest: vcs0
[533.902205] Dynamic subtest vcs0: SUCCESS (9.692s)
[533.914745] Starting dynamic subtest: bcs0
[535.195140] Dynamic subtest bcs0: SUCCESS (1.292s)
[535.207193] Starting dynamic subtest: rcs0
[536.439427] Dynamic subtest rcs0: SUCCESS (1.241s)
[536.451720] Starting dynamic subtest: vcs1
[545.874633] Dynamic subtest vcs1: SUCCESS (9.433s)
[545.877241] Subtest timeout: SUCCESS (32.468s)
[545.962975] [087/133] (477s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[546.074499] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[555.552493] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.480s)
[555.699919] [088/133] (467s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[555.806940] Starting subtest: fbc-pr-sprite-mmap-cpu
[555.811467] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[555.880506] [089/133] (467s left) gem_exec_flush (basic-wb-set-default)
[555.933778] Starting subtest: basic-wb-set-default
[561.388711] Subtest basic-wb-set-default: SUCCESS (5.455s)
[561.579511] [090/133] (461s left) kms_properties (get_properties-sanity-atomic)
[561.678507] Starting subtest: get_properties-sanity-atomic
[561.680798] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[561.754011] [091/133] (461s left) kms_psr (fbc-psr-cursor-plane-onoff)
[561.836176] Starting subtest: fbc-psr-cursor-plane-onoff
[561.838461] Starting dynamic subtest: eDP-1
[561.842843] Dynamic subtest eDP-1: SKIP (0.000s)
[561.847130] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[561.910708] [092/133] (461s left) syncobj_timeline (single-wait-signaled)
[561.961462] Starting subtest: single-wait-signaled
[561.963421] Subtest single-wait-signaled: SUCCESS (0.000s)
[562.056120] [093/133] (461s left) gen9_exec_parse (bb-start-param)
[562.111487] Subtest bb-start-param: SKIP (0.000s)
[562.182438] [094/133] (461s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[562.282159] Starting subtest: x-tiled-64bpp-rotate-180
[563.961510] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.679s)
[564.139196] [095/133] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[564.244158] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[571.597908] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.356s)
[571.727358] [096/133] (452s left) gem_eio (wait-1us)
[571.943794] Starting subtest: wait-1us
[572.289206] Subtest wait-1us: SUCCESS (0.345s)
[572.410827] [097/133] (451s left) syncobj_timeline (invalid-query-zero-handles)
[572.460755] Starting subtest: invalid-query-zero-handles
[572.463010] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[572.543452] [098/133] (451s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[572.586031] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[572.641996] [099/133] (451s left) gem_ctx_engines (independent)
[572.699269] Starting subtest: independent
[572.701245] Starting dynamic subtest: rcs0
[572.849235] Dynamic subtest rcs0: SUCCESS (0.148s)
[572.859389] Starting dynamic subtest: bcs0
[573.029208] Dynamic subtest bcs0: SUCCESS (0.179s)
[573.039949] Starting dynamic subtest: vcs0
[573.196985] Dynamic subtest vcs0: SUCCESS (0.166s)
[573.207467] Starting dynamic subtest: vcs1
[573.372136] Dynamic subtest vcs1: SUCCESS (0.176s)
[573.381975] Starting dynamic subtest: vecs0
[573.521696] Dynamic subtest vecs0: SUCCESS (0.146s)
[573.533974] Starting dynamic subtest: ccs0
[573.700964] Dynamic subtest ccs0: SUCCESS (0.179s)
[573.714823] Starting dynamic subtest: all-engines
[574.468253] Dynamic subtest all-engines: SUCCESS (0.767s)
[574.470843] Subtest independent: SUCCESS (1.768s)
[575.961888] [100/133] (447s left) gem_ctx_persistence (engines-queued)
[576.024263] Starting subtest: engines-queued
[576.026645] Starting dynamic subtest: rcs0
[576.068690] Dynamic subtest rcs0: SUCCESS (0.044s)
[576.079693] Starting dynamic subtest: bcs0
[576.123309] Dynamic subtest bcs0: SUCCESS (0.054s)
[576.135386] Starting dynamic subtest: vcs0
[577.843854] Dynamic subtest vcs0: SUCCESS (1.718s)
[577.856439] Starting dynamic subtest: vcs1
[579.891317] Dynamic subtest vcs1: SUCCESS (2.045s)
[579.906809] Starting dynamic subtest: vecs0
[581.875218] Dynamic subtest vecs0: SUCCESS (1.981s)
[581.887599] Starting dynamic subtest: ccs0
[582.058652] Dynamic subtest ccs0: SUCCESS (0.183s)
[582.061202] Subtest engines-queued: SUCCESS (6.035s)
[582.142085] [101/133] (441s left) kms_cursor_crc (cursor-onscreen-128x128)
[582.370287] Starting subtest: cursor-onscreen-128x128
[582.372608] Starting dynamic subtest: pipe-A-eDP-1
[584.457598] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.086s)
[584.489166] Starting dynamic subtest: pipe-D-eDP-1
[587.271407] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[587.273330] Subtest cursor-onscreen-128x128: SUCCESS (4.901s)
[588.073507] [102/133] (435s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[588.185676] Starting subtest: yf-tiled-addfb-size-offset-overflow
[588.190086] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[588.284556] [103/133] (435s left) api_intel_allocator (simple-allocator)
[588.347300] Starting subtest: simple-allocator
[588.349767] Starting dynamic subtest: basic
[588.351856] Dynamic subtest basic: SUCCESS (0.003s)
[588.367854] Starting dynamic subtest: parallel-one
[588.545492] Dynamic subtest parallel-one: SUCCESS (0.196s)
[588.555400] Starting dynamic subtest: print
[588.557253] Dynamic subtest print: SUCCESS (0.000s)
[588.567706] Starting dynamic subtest: reuse
[588.569863] Dynamic subtest reuse: SUCCESS (0.000s)
[588.579888] Starting dynamic subtest: reserve
[588.582067] Dynamic subtest reserve: SUCCESS (0.000s)
[588.591750] Starting dynamic subtest: fork-reopen-allocator
[588.593875] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[588.596081] Subtest simple-allocator: SUCCESS (0.217s)
[588.686787] [104/133] (435s left) kms_properties (invalid-properties-legacy)
[588.784576] Starting subtest: invalid-properties-legacy
[588.892266] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[588.968550] [105/133] (435s left) gem_exec_fence (syncobj-wait)
[589.510042] Starting subtest: syncobj-wait
[590.866087] Subtest syncobj-wait: SUCCESS (1.355s)
[591.207640] [106/133] (432s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[591.322614] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[591.326819] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[591.413859] [107/133] (432s left) gem_exec_flush (basic-wb-ro-before-default)
[591.477623] Starting subtest: basic-wb-ro-before-default
[596.940496] Subtest basic-wb-ro-before-default: SUCCESS (5.463s)
[597.133915] [108/133] (427s left) kms_prime (basic-modeset-hybrid)
[597.222529] Subtest basic-modeset-hybrid: SKIP (0.000s)
[597.328356] [109/133] (426s left) gem_userptr_blits (access-control)
[597.393028] Starting subtest: access-control
[597.397594] Subtest access-control: SKIP (0.000s)
[597.523446] [110/133] (426s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[597.892437] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[598.678911] [111/133] (425s left) gem_fence_thrash (bo-write-verify-none)
[598.721177] Starting subtest: bo-write-verify-none
[598.748868] Subtest bo-write-verify-none: SKIP (0.026s)
[598.819424] [112/133] (425s left) i915_drm_fdinfo (all-busy-idle-check-all)
[598.868245] Starting subtest: all-busy-idle-check-all
[598.875076] Subtest all-busy-idle-check-all: SKIP (0.005s)
[598.945697] [113/133] (425s left) gem_spin_batch (legacy-resubmit)
[599.035965] Starting subtest: legacy-resubmit
[599.038395] Starting dynamic subtest: default
[599.044839] Dynamic subtest default: SUCCESS (0.008s)
[599.056856] Starting dynamic subtest: render
[599.059229] Dynamic subtest render: SUCCESS (0.001s)
[599.069278] Starting dynamic subtest: bsd
[599.071437] Dynamic subtest bsd: SUCCESS (0.003s)
[599.081112] Starting dynamic subtest: bsd1
[599.083260] Dynamic subtest bsd1: SUCCESS (0.001s)
[599.092889] Starting dynamic subtest: bsd2
[599.095065] Dynamic subtest bsd2: SUCCESS (0.003s)
[599.104615] Starting dynamic subtest: blt
[599.106813] Dynamic subtest blt: SUCCESS (0.002s)
[599.116153] Starting dynamic subtest: vebox
[599.118313] Dynamic subtest vebox: SUCCESS (0.003s)
[599.120761] Subtest legacy-resubmit: SUCCESS (0.027s)
[599.281528] [114/133] (425s left) gem_exec_reloc (basic-cpu-gtt)
[599.344933] Subtest basic-cpu-gtt: SKIP (0.000s)
[599.416525] [115/133] (425s left) kms_psr (psr2-sprite-mmap-cpu)
[599.500172] Starting subtest: psr2-sprite-mmap-cpu
[599.502403] Starting dynamic subtest: eDP-1
[601.199163] Dynamic subtest eDP-1: SUCCESS (1.697s)
[601.201058] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.698s)
[602.063217] [116/133] (422s left) gem_ctx_persistence (legacy-engines-hostile)
[602.118245] Starting subtest: legacy-engines-hostile
[602.120505] Starting dynamic subtest: render
[602.242320] Dynamic subtest render: SUCCESS (0.123s)
[602.255251] Starting dynamic subtest: bsd1
[602.333342] Dynamic subtest bsd1: SUCCESS (0.088s)
[602.345506] Starting dynamic subtest: bsd2
[602.425804] Dynamic subtest bsd2: SUCCESS (0.090s)
[602.439454] Starting dynamic subtest: blt
[602.518069] Dynamic subtest blt: SUCCESS (0.089s)
[602.530687] Starting dynamic subtest: vebox
[602.610299] Dynamic subtest vebox: SUCCESS (0.089s)
[602.612784] Subtest legacy-engines-hostile: SUCCESS (0.493s)
[602.690991] [117/133] (421s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[602.793164] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[603.828727] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.037s)
[603.974742] [118/133] (420s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[604.072927] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[604.076381] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[604.172088] [119/133] (420s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[604.279368] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[604.282851] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[604.368578] [120/133] (420s left) kms_sequence (queue-busy)
[604.481017] Starting subtest: queue-busy
[604.482803] Starting dynamic subtest: pipe-A-eDP-1
[606.429385] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[606.439814] Starting dynamic subtest: pipe-B-eDP-1
[609.052782] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[609.067047] Starting dynamic subtest: pipe-C-eDP-1
[611.667766] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[611.678338] Starting dynamic subtest: pipe-D-eDP-1
[614.300295] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[614.302175] Subtest queue-busy: SUCCESS (9.818s)
[615.177348] [121/133] (409s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[615.274864] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[621.867224] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.597s)
[622.008132] [122/133] (402s left) gem_workarounds (reset-context)
[622.073910] Starting subtest: reset-context
[622.262730] Subtest reset-context: SUCCESS (0.189s)
[622.386335] [123/133] (402s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[622.437208] Starting subtest: x-tiled-to-vebox-y-tiled
[622.441598] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[622.635946] [124/133] (402s left) gem_vm_create (execbuf)
[622.699487] Starting subtest: execbuf
[622.707327] Subtest execbuf: SUCCESS (0.008s)
[622.831202] [125/133] (402s left) kms_async_flips (test-cursor)
[622.917255] Starting subtest: test-cursor
[623.304973] Starting dynamic subtest: pipe-A-eDP-1
[624.095918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s)
[624.481850] Starting dynamic subtest: pipe-B-eDP-1
[625.217543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.744s)
[625.606609] Starting dynamic subtest: pipe-C-eDP-1
[626.344283] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.748s)
[626.726364] Starting dynamic subtest: pipe-D-eDP-1
[627.481391] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[627.483724] Subtest test-cursor: SUCCESS (4.566s)
[628.642403] [126/133] (396s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[628.731268] Starting subtest: addfb25-y-tiled-small-legacy
[628.735507] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[628.823386] [127/133] (396s left) kms_psr (pr-primary-render)
[628.919144] Starting subtest: pr-primary-render
[628.923092] Subtest pr-primary-render: SKIP (0.000s)
[629.005905] [128/133] (396s left) kms_chamelium_frames (hdmi-crc-multiple)
[629.401211] Subtest hdmi-crc-multiple: SKIP (0.000s)
[630.252170] [129/133] (394s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[630.349833] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[630.376642] Starting dynamic subtest: pipe-A-plane-0
[630.665243] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[630.676174] Starting dynamic subtest: pipe-A-plane-3
[630.899726] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[630.909902] Starting dynamic subtest: pipe-A-plane-5
[630.914386] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[631.961903] Starting dynamic subtest: pipe-B-plane-0
[632.253223] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[632.263439] Starting dynamic subtest: pipe-B-plane-3
[632.487862] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[632.498424] Starting dynamic subtest: pipe-B-plane-5
[632.503125] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[632.795442] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.445s)
[633.629392] [130/133] (391s left) kms_lease (lease-invalid-crtc)
[633.725302] Starting subtest: lease-invalid-crtc
[633.727626] Starting dynamic subtest: pipe-A-eDP-1
[633.729962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[633.741234] Starting dynamic subtest: pipe-B-eDP-1
[633.743083] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[633.753409] Starting dynamic subtest: pipe-C-eDP-1
[633.755631] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[633.765474] Starting dynamic subtest: pipe-D-eDP-1
[633.767687] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[633.769890] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[633.808742] [131/133] (391s left) kms_content_protection (lic-type-1)
[633.942082] Starting subtest: lic-type-1
[633.946756] Subtest lic-type-1: SKIP (0.000s)
[634.075208] [132/133] (391s left) gem_exec_fence (basic-busy-all)
[634.133818] Starting subtest: basic-busy-all
[634.213976] Subtest basic-busy-all: SUCCESS (0.080s)
[636.007738] [133/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[636.111107] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[639.831688] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.724s)
[641.070273] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: i915_pm_rc6_residency
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_flink_race
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: gem_request_retire
results: parsing output: 27/ for test: vgem_basic
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_async
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_cursor_edge_walk
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: gem_exec_await
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: i915_suspend
results: parsing output: 52/ for test: gem_partial_pwrite_pread
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: gem_set_tiling_vs_blt
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_feature_discovery
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_flip_tiling
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: drm_mm
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_fence_thrash
results: parsing output: 85/ for test: sysfs_preempt_timeout
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_prime
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: gem_fence_thrash
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_workarounds
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_vm_create
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_chamelium_frames
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.