[60.068662] Initializing watchdogs
[60.068735]   /dev/watchdog0
[60.088736] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.099397] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.103026] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.105399] [001/131] (960s left) kms_content_protection (type1)
[60.351720] Starting subtest: type1
[60.356992] Subtest type1: SKIP (0.003s)
[60.576869] [002/131] (960s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[60.757734] Starting subtest: basic-modeset-with-all-modifiers-formats
[60.976419] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[61.224066] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.249s)
[61.233170] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[61.256756] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.033s)
[61.268066] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[61.290293] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.033s)
[61.307710] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[61.323404] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.033s)
[61.340938] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[61.356845] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.033s)
[61.373968] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[61.389493] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[61.406420] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[61.422555] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.033s)
[61.434721] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[61.455680] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.033s)
[61.468141] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[61.488922] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.033s)
[61.506174] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[61.671050] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.183s)
[61.679186] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[61.704221] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.033s)
[61.713730] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[61.737363] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.033s)
[61.748823] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[61.770741] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.033s)
[61.786892] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[61.804117] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.033s)
[61.820417] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[61.837046] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.033s)
[61.855538] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[61.870164] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.033s)
[61.886367] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[61.903235] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.033s)
[61.917059] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[61.936566] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.033s)
[61.950420] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[62.119894] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.184s)
[62.128167] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[62.153856] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.034s)
[62.163664] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[62.187237] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.033s)
[62.205788] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[62.220575] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.033s)
[62.235943] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[62.253406] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.033s)
[62.268686] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[62.286780] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.033s)
[62.302385] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[62.319849] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.033s)
[62.335694] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[62.353060] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.033s)
[62.368453] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[62.386173] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.033s)
[62.654063] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.907s)
[62.998994] [003/131] (957s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[63.178905] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[63.179802] Starting dynamic subtest: pipe-A-DP-3
[63.187961] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[63.195838] Starting dynamic subtest: pipe-B-DP-3
[63.203970] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[63.211639] Starting dynamic subtest: pipe-C-DP-3
[63.219822] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[63.227440] Starting dynamic subtest: pipe-D-DP-3
[63.235834] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[63.237586] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[63.637932] [004/131] (957s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[63.707969] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[63.765394] [005/131] (957s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[63.954368] Starting subtest: 4-tiled-16bpp-rotate-0
[65.722687] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.774s)
[65.945047] [006/131] (954s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[66.131410] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[66.133046] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[66.327897] [007/131] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[66.519477] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[66.521401] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[66.701582] [008/131] (954s left) gem_mmap_gtt (basic-write-read-distinct)
[66.799896] Subtest basic-write-read-distinct: SKIP (0.000s)
[66.888583] [009/131] (954s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[67.310235] Starting subtest: yf-tiled-16bpp-rotate-90
[67.312434] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[67.823319] [010/131] (953s left) prime_vgem (shrink)
[68.029820] Starting subtest: shrink
[68.037165] Subtest shrink: SUCCESS (0.006s)
[68.189641] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[68.191259] [011/131] (953s left) kms_hdr (bpc-switch-suspend)
[68.372635] Starting subtest: bpc-switch-suspend
[71.504221] Starting dynamic subtest: pipe-A-DP-3
[91.698288] Dynamic subtest pipe-A-DP-3: SUCCESS (4.909s)
[91.699276] Subtest bpc-switch-suspend: SUCCESS (8.046s)
[92.054693] [012/131] (929s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[92.246760] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[92.247631] Starting dynamic subtest: pipe-A-valid-mode
[92.335128] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[92.337020] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.087s)
[92.588206] [013/131] (928s left) gem_ringfill (legacy-basic)
[93.002313] Starting subtest: legacy-basic
[93.003675] Starting dynamic subtest: default
[93.123606] Dynamic subtest default: SUCCESS (0.121s)
[93.136865] Starting dynamic subtest: render
[93.165416] Dynamic subtest render: SUCCESS (0.041s)
[93.183475] Starting dynamic subtest: bsd
[93.207793] Dynamic subtest bsd: SUCCESS (0.041s)
[93.237378] Starting dynamic subtest: bsd1
[93.253553] Dynamic subtest bsd1: SUCCESS (0.045s)
[93.272547] Starting dynamic subtest: bsd2
[93.295576] Dynamic subtest bsd2: SUCCESS (0.041s)
[93.311987] Starting dynamic subtest: blt
[93.337716] Dynamic subtest blt: SUCCESS (0.041s)
[93.356228] Starting dynamic subtest: vebox
[93.380568] Dynamic subtest vebox: SUCCESS (0.042s)
[93.381764] Subtest legacy-basic: SUCCESS (0.379s)
[93.568455] [014/131] (927s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[93.756521] Starting subtest: fbcpsr-tiling-4
[93.758212] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[93.926765] [015/131] (927s left) kms_scaling_modes (scaling-mode-full)
[94.107455] Starting subtest: scaling-mode-full
[94.112359] Subtest scaling-mode-full: SKIP (0.001s)
[94.274086] [016/131] (927s left) vgem_basic (bad-pad)
[94.338940] Starting subtest: bad-pad
[94.339913] Subtest bad-pad: SUCCESS (0.000s)
[94.503143] [017/131] (927s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[94.685396] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[94.686319] Starting dynamic subtest: pipe-A-DP-3
[94.694588] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[94.704592] Starting dynamic subtest: pipe-B-DP-3
[94.713000] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[94.722694] Starting dynamic subtest: pipe-C-DP-3
[94.730796] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[94.740280] Starting dynamic subtest: pipe-D-DP-3
[94.750943] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[94.752934] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[95.168556] [018/131] (926s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[95.251216] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[95.252179] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[95.453133] [019/131] (926s left) kms_psr (fbc-psr2-basic)
[95.639481] Subtest fbc-psr2-basic: SKIP (0.000s)
[95.697337] [020/131] (926s left) core_auth (getclient-simple)
[95.743436] Starting subtest: getclient-simple
[95.770986] Subtest getclient-simple: SUCCESS (0.028s)
[95.929853] [021/131] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[96.126476] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[96.128147] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[96.318598] [022/131] (925s left) drm_read (short-buffer-wakeup)
[96.571681] Starting subtest: short-buffer-wakeup
[128.785752] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[129.018270] [023/131] (893s left) perf_pmu (init-wait)
[129.088439] Starting subtest: init-wait
[129.089400] Starting dynamic subtest: rcs0
[129.091429] Dynamic subtest rcs0: SUCCESS (0.003s)
[129.102065] Starting dynamic subtest: bcs0
[129.102998] Dynamic subtest bcs0: SUCCESS (0.001s)
[129.113221] Starting dynamic subtest: vcs0
[129.114187] Dynamic subtest vcs0: SUCCESS (0.001s)
[129.124480] Starting dynamic subtest: vcs1
[129.125602] Dynamic subtest vcs1: SUCCESS (0.000s)
[129.135847] Starting dynamic subtest: vecs0
[129.136717] Dynamic subtest vecs0: SUCCESS (0.001s)
[129.146988] Starting dynamic subtest: vecs1
[129.148173] Dynamic subtest vecs1: SUCCESS (0.000s)
[129.158440] Starting dynamic subtest: ccs0
[129.159713] Dynamic subtest ccs0: SUCCESS (0.001s)
[129.160832] Subtest init-wait: SUCCESS (0.008s)
[129.272750] [024/131] (892s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[129.349031] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[129.350064] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[129.546688] [025/131] (892s left) kms_plane_alpha_blend (constant-alpha-max)
[129.737725] Starting subtest: constant-alpha-max
[129.997622] Starting dynamic subtest: pipe-A-DP-3
[130.896891] Dynamic subtest pipe-A-DP-3: SUCCESS (0.899s)
[130.907258] Starting dynamic subtest: pipe-D-DP-3
[131.835435] Dynamic subtest pipe-D-DP-3: SUCCESS (0.938s)
[131.836341] Subtest constant-alpha-max: SUCCESS (2.098s)
[132.114894] [026/131] (890s left) kms_psr (fbc-pr-primary-mmap-gtt)
[132.300303] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[132.393032] [027/131] (890s left) kms_flip (bo-too-big-interruptible)
[132.580975] Starting subtest: bo-too-big-interruptible
[132.584473] Starting dynamic subtest: A-DP3
[132.886812] Dynamic subtest A-DP3: SUCCESS (0.302s)
[132.918223] Starting dynamic subtest: B-DP3
[133.109536] Dynamic subtest B-DP3: SUCCESS (0.220s)
[133.152190] Starting dynamic subtest: C-DP3
[133.355668] Dynamic subtest C-DP3: SUCCESS (0.244s)
[133.385448] Starting dynamic subtest: D-DP3
[133.604023] Dynamic subtest D-DP3: SUCCESS (0.247s)
[133.607922] Subtest bo-too-big-interruptible: SUCCESS (1.027s)
[134.020097] [028/131] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[134.212384] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[134.214150] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[134.393694] [029/131] (888s left) kms_cdclk (mode-transition-all-outputs)
[134.578406] Starting subtest: mode-transition-all-outputs
[134.661804] Subtest mode-transition-all-outputs: SKIP (0.082s)
[134.910293] [030/131] (887s left) gem_exec_schedule (fairslice-all)
[135.007284] Starting subtest: fairslice-all
[137.129486] Subtest fairslice-all: SUCCESS (2.122s)
[137.532944] [031/131] (885s left) kms_lease (invalid-create-leases)
[137.715664] Starting subtest: invalid-create-leases
[137.725031] Subtest invalid-create-leases: SUCCESS (0.009s)
[137.929357] [032/131] (884s left) gem_eio (in-flight-1us)
[138.216075] Starting subtest: in-flight-1us
[143.368950] Subtest in-flight-1us: SUCCESS (5.152s)
[143.664090] [033/131] (879s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[143.845825] Starting subtest: cursorB-vs-flipB-atomic
[143.848806] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[144.028760] [034/131] (879s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[144.214990] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[144.215884] Starting dynamic subtest: pipe-A-DP-3
[144.223828] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[144.234830] Starting dynamic subtest: pipe-B-DP-3
[144.242788] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[144.253663] Starting dynamic subtest: pipe-C-DP-3
[144.261575] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[144.272465] Starting dynamic subtest: pipe-D-DP-3
[144.281973] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[144.284023] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[144.701871] [035/131] (878s left) gem_userptr_blits (huge-split)
[144.795606] Starting subtest: huge-split
[144.829889] Subtest huge-split: SUCCESS (0.034s)
[145.071196] [036/131] (878s left) kms_cursor_edge_walk (64x64-right-edge)
[145.253121] Starting subtest: 64x64-right-edge
[145.253949] Starting dynamic subtest: pipe-A-DP-3
[148.699262] Dynamic subtest pipe-A-DP-3: SUCCESS (3.446s)
[148.717192] Starting dynamic subtest: pipe-D-DP-3
[152.024645] Dynamic subtest pipe-D-DP-3: SUCCESS (3.323s)
[152.025629] Subtest 64x64-right-edge: SUCCESS (6.772s)
[152.353701] [037/131] (870s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[152.545202] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[152.595810] [038/131] (870s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[152.786361] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[152.801822] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.015s)
[152.975656] [039/131] (870s left) prime_self_import (basic-with_fd_dup)
[153.020230] Starting subtest: basic-with_fd_dup
[153.064940] Subtest basic-with_fd_dup: SUCCESS (0.045s)
[153.233671] [040/131] (870s left) syncobj_wait (invalid-signal-bad-pad)
[153.314219] Starting subtest: invalid-signal-bad-pad
[153.315192] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[153.515024] [041/131] (870s left) gem_ctx_shared (exec-single-timeline)
[153.612157] Starting subtest: exec-single-timeline
[153.613110] Starting dynamic subtest: rcs0
[154.704145] Dynamic subtest rcs0: SUCCESS (1.090s)
[154.718433] Starting dynamic subtest: bcs0
[155.728004] Dynamic subtest bcs0: SUCCESS (1.021s)
[155.742230] Starting dynamic subtest: vcs0
[156.752295] Dynamic subtest vcs0: SUCCESS (1.022s)
[156.766329] Starting dynamic subtest: vcs1
[157.776285] Dynamic subtest vcs1: SUCCESS (1.021s)
[157.790201] Starting dynamic subtest: vecs0
[158.799857] Dynamic subtest vecs0: SUCCESS (1.021s)
[158.813815] Starting dynamic subtest: vecs1
[159.824200] Dynamic subtest vecs1: SUCCESS (1.022s)
[159.839395] Starting dynamic subtest: ccs0
[160.848121] Dynamic subtest ccs0: SUCCESS (1.021s)
[160.849996] Subtest exec-single-timeline: SUCCESS (7.236s)
[161.135830] [042/131] (862s left) gem_tiled_fence_blits (basic)
[161.215162] Subtest basic: SKIP (0.000s)
[161.301738] [043/131] (862s left) kms_plane_scaling (planes-scaler-unity-scaling)
[161.486455] Starting subtest: planes-scaler-unity-scaling
[161.487346] Starting dynamic subtest: pipe-A
[161.569062] Dynamic subtest pipe-A: SUCCESS (0.082s)
[161.582614] Starting dynamic subtest: pipe-B
[161.765022] Dynamic subtest pipe-B: SUCCESS (0.195s)
[161.784428] Starting dynamic subtest: pipe-C
[161.978100] Dynamic subtest pipe-C: SUCCESS (0.212s)
[161.997478] Starting dynamic subtest: pipe-D
[162.192313] Dynamic subtest pipe-D: SUCCESS (0.213s)
[162.193372] Subtest planes-scaler-unity-scaling: SUCCESS (0.706s)
[162.533876] [044/131] (861s left) kms_big_fb (yf-tiled-addfb)
[162.729183] Starting subtest: yf-tiled-addfb
[162.731136] Subtest yf-tiled-addfb: SKIP (0.000s)
[162.934773] [045/131] (860s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[163.197614] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[163.342949] [046/131] (860s left) gem_create (create-size-update)
[163.417223] Starting subtest: create-size-update
[163.418200] Subtest create-size-update: SUCCESS (0.000s)
[163.688446] [047/131] (860s left) syncobj_timeline (invalid-transfer-non-existent-point)
[163.765222] Starting subtest: invalid-transfer-non-existent-point
[163.766258] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[163.970840] [048/131] (860s left) syncobj_wait (invalid-reset-one-illegal-handle)
[164.046165] Starting subtest: invalid-reset-one-illegal-handle
[164.047093] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[164.258984] [049/131] (859s left) gem_exec_fence (syncobj-import)
[164.824537] Starting subtest: syncobj-import
[164.854158] Subtest syncobj-import: SUCCESS (0.029s)
[165.306496] [050/131] (858s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[165.501613] Starting subtest: y-tiled-64bpp-rotate-90
[165.503286] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[165.715286] [051/131] (858s left) sw_sync (timeline_closed_signaled)
[165.761948] Starting subtest: timeline_closed_signaled
[165.762872] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[165.876234] [052/131] (858s left) kms_pm_rpm (legacy-planes-dpms)
[168.382736] Starting subtest: legacy-planes-dpms
[168.384659] Starting dynamic subtest: plane-63
[171.181739] Dynamic subtest plane-63: SUCCESS (2.800s)
[171.228205] Starting dynamic subtest: plane-93
[174.030575] Dynamic subtest plane-93: SUCCESS (2.846s)
[174.080170] Starting dynamic subtest: plane-123
[176.853560] Dynamic subtest plane-123: SUCCESS (2.820s)
[176.897656] Starting dynamic subtest: plane-133
[179.598595] Dynamic subtest plane-133: SUCCESS (2.742s)
[179.600541] Subtest legacy-planes-dpms: SUCCESS (11.220s)
[180.069340] [053/131] (844s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[180.256169] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[180.257909] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[180.421519] [054/131] (844s left) gem_exec_schedule (in-order)
[180.512234] Starting subtest: in-order
[180.513104] Starting dynamic subtest: rcs0
[180.797316] Dynamic subtest rcs0: SUCCESS (0.286s)
[180.809265] Starting dynamic subtest: bcs0
[181.002003] Dynamic subtest bcs0: SUCCESS (0.204s)
[181.013952] Starting dynamic subtest: vcs0
[181.211849] Dynamic subtest vcs0: SUCCESS (0.209s)
[181.224061] Starting dynamic subtest: vcs1
[181.424418] Dynamic subtest vcs1: SUCCESS (0.212s)
[181.435894] Starting dynamic subtest: vecs0
[181.633428] Dynamic subtest vecs0: SUCCESS (0.208s)
[181.645008] Starting dynamic subtest: vecs1
[181.845198] Dynamic subtest vecs1: SUCCESS (0.211s)
[181.857180] Starting dynamic subtest: ccs0
[182.060456] Dynamic subtest ccs0: SUCCESS (0.215s)
[182.061487] Subtest in-order: SUCCESS (1.550s)
[182.547273] [055/131] (842s left) kms_vblank (wait-forked-busy-hang)
[182.733962] Starting subtest: wait-forked-busy-hang
[182.736024] Starting dynamic subtest: pipe-A-DP-3
[208.893846] Dynamic subtest pipe-A-DP-3: SUCCESS (26.157s)
[208.908281] Starting dynamic subtest: pipe-D-DP-3
[233.847381] Dynamic subtest pipe-D-DP-3: SUCCESS (24.950s)
[233.848254] Subtest wait-forked-busy-hang: SUCCESS (51.113s)
[234.179090] [056/131] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[234.367590] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[234.369350] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[234.558345] [057/131] (790s left) gem_ctx_persistence (legacy-engines-queued)
[234.643271] Starting subtest: legacy-engines-queued
[234.644230] Starting dynamic subtest: render
[234.758412] Dynamic subtest render: SUCCESS (0.114s)
[234.774786] Starting dynamic subtest: bsd1
[234.821585] Dynamic subtest bsd1: SUCCESS (0.062s)
[234.838639] Starting dynamic subtest: bsd2
[234.874336] Dynamic subtest bsd2: SUCCESS (0.050s)
[234.890931] Starting dynamic subtest: blt
[234.941861] Dynamic subtest blt: SUCCESS (0.066s)
[234.980877] Starting dynamic subtest: vebox
[235.015438] Dynamic subtest vebox: SUCCESS (0.071s)
[235.016533] Subtest legacy-engines-queued: SUCCESS (0.373s)
[235.197575] [058/131] (789s left) kms_prop_blob (basic)
[235.272225] Starting subtest: basic
[235.273412] Subtest basic: SUCCESS (0.000s)
[235.477700] [059/131] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[235.668838] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[235.670435] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[235.876728] [060/131] (789s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[236.067960] Starting subtest: psr-rgb565-draw-render
[236.069596] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[236.260074] [061/131] (788s left) gen9_exec_parse (bb-oversize)
[236.341957] Subtest bb-oversize: SKIP (0.000s)
[236.452337] [062/131] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[236.638954] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[236.640675] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[236.843458] [063/131] (788s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[237.028962] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[237.044591] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[237.216819] [064/131] (788s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[237.407960] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[237.409732] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[237.610526] [065/131] (787s left) gem_exec_whisper (basic-sync)
[237.697387] Starting subtest: basic-sync
[244.006890] Subtest basic-sync: SUCCESS (6.308s)
[244.257496] [066/131] (781s left) kms_flip (2x-flip-vs-wf_vblank)
[244.443196] Starting subtest: 2x-flip-vs-wf_vblank
[244.458540] Subtest 2x-flip-vs-wf_vblank: SKIP (0.015s)
[244.634824] [067/131] (780s left) kms_psr (fbc-psr-basic)
[244.816460] Subtest fbc-psr-basic: SKIP (0.000s)
[244.871283] [068/131] (780s left) i915_hangman (engine-engine-error)
[244.963292] Starting subtest: engine-engine-error
[244.964194] Starting dynamic subtest: rcs0
[245.843816] Dynamic subtest rcs0: SUCCESS (0.880s)
[245.857913] Starting dynamic subtest: bcs0
[246.661017] Dynamic subtest bcs0: SUCCESS (0.816s)
[246.672816] Starting dynamic subtest: vcs0
[247.469403] Dynamic subtest vcs0: SUCCESS (0.808s)
[247.481836] Starting dynamic subtest: vcs1
[248.309595] Dynamic subtest vcs1: SUCCESS (0.839s)
[248.323377] Starting dynamic subtest: vecs0
[249.152660] Dynamic subtest vecs0: SUCCESS (0.842s)
[249.168379] Starting dynamic subtest: vecs1
[249.990632] Dynamic subtest vecs1: SUCCESS (0.837s)
[250.004046] Starting dynamic subtest: ccs0
[250.799420] Dynamic subtest ccs0: SUCCESS (0.808s)
[250.800345] Subtest engine-engine-error: SUCCESS (5.837s)
[250.992353] [069/131] (774s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[251.254044] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[251.396699] [070/131] (774s left) gem_workarounds (reset)
[251.490720] Starting subtest: reset
[251.708614] Subtest reset: SUCCESS (0.218s)
[251.927426] [071/131] (773s left) i915_pm_rpm (debugfs-forcewake-user)
[254.342917] Starting subtest: debugfs-forcewake-user
[264.992757] Subtest debugfs-forcewake-user: SUCCESS (10.654s)
[265.339364] [072/131] (760s left) gem_pxp (create-protected-buffer)
[267.948380] Starting subtest: create-protected-buffer
[267.950794] Subtest create-protected-buffer: SKIP (0.000s)
[268.087315] [073/131] (757s left) gem_exec_parallel (fds)
[268.175550] Starting subtest: fds
[268.176499] Starting dynamic subtest: rcs0
[271.650926] Dynamic subtest rcs0: SUCCESS (3.475s)
[271.663295] Starting dynamic subtest: bcs0
[275.409874] Dynamic subtest bcs0: SUCCESS (3.758s)
[275.422138] Starting dynamic subtest: vcs0
[280.416818] Dynamic subtest vcs0: SUCCESS (5.006s)
[280.429467] Starting dynamic subtest: vcs1
[285.190909] Dynamic subtest vcs1: SUCCESS (4.773s)
[285.203210] Starting dynamic subtest: vecs0
[289.018945] Dynamic subtest vecs0: SUCCESS (3.827s)
[289.031494] Starting dynamic subtest: vecs1
[292.547927] Dynamic subtest vecs1: SUCCESS (3.528s)
[292.559884] Starting dynamic subtest: ccs0
[297.196134] Dynamic subtest ccs0: SUCCESS (4.647s)
[297.197328] Subtest fds: SUCCESS (29.020s)
[297.498752] [074/131] (728s left) gem_exec_whisper (basic-contexts-all)
[297.587224] Starting subtest: basic-contexts-all
[319.648604] Subtest basic-contexts-all: SUCCESS (22.060s)
[319.881004] [075/131] (706s left) kms_cursor_crc (cursor-random-64x21)
[320.219238] Starting subtest: cursor-random-64x21
[320.222623] Starting dynamic subtest: pipe-A-DP-3
[324.804148] Dynamic subtest pipe-A-DP-3: SUCCESS (4.580s)
[324.847729] Starting dynamic subtest: pipe-D-DP-3
[329.237152] Dynamic subtest pipe-D-DP-3: SUCCESS (4.400s)
[329.238102] Subtest cursor-random-64x21: SUCCESS (9.019s)
[329.713862] [076/131] (696s left) gem_mmap_offset (open-flood)
[329.786680] Starting subtest: open-flood
[351.272700] Subtest open-flood: SUCCESS (21.484s)
[351.470561] [077/131] (674s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[351.671120] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[353.003286] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.321s)
[353.247307] [078/131] (673s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[353.341232] Subtest tiled-to-tiled: SKIP (0.000s)
[353.437245] [079/131] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[353.632130] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[353.633807] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[353.824765] [080/131] (672s left) gem_exec_capture (capture)
[353.910296] Starting subtest: capture
[353.911219] Starting dynamic subtest: rcs0-smem
[354.879392] Dynamic subtest rcs0-smem: SUCCESS (0.963s)
[354.891540] Starting dynamic subtest: rcs0-lmem0
[356.305466] Dynamic subtest rcs0-lmem0: SUCCESS (1.432s)
[356.318168] Starting dynamic subtest: bcs0-smem
[357.230358] Dynamic subtest bcs0-smem: SUCCESS (0.924s)
[357.242946] Starting dynamic subtest: bcs0-lmem0
[358.153290] Dynamic subtest bcs0-lmem0: SUCCESS (0.922s)
[358.165809] Starting dynamic subtest: vcs0-smem
[359.082307] Dynamic subtest vcs0-smem: SUCCESS (0.928s)
[359.094756] Starting dynamic subtest: vcs0-lmem0
[360.513473] Dynamic subtest vcs0-lmem0: SUCCESS (1.430s)
[360.525814] Starting dynamic subtest: vcs1-smem
[361.571386] Dynamic subtest vcs1-smem: SUCCESS (1.057s)
[361.583792] Starting dynamic subtest: vcs1-lmem0
[362.486258] Dynamic subtest vcs1-lmem0: SUCCESS (0.915s)
[362.498540] Starting dynamic subtest: vecs0-smem
[363.608542] Dynamic subtest vecs0-smem: FAIL (1.103s)
[363.620515] Starting dynamic subtest: vecs0-lmem0
[364.952173] Dynamic subtest vecs0-lmem0: FAIL (1.338s)
[364.963742] Starting dynamic subtest: vecs1-smem
[366.387924] Dynamic subtest vecs1-smem: FAIL (1.437s)
[366.399646] Starting dynamic subtest: vecs1-lmem0
[367.397699] Dynamic subtest vecs1-lmem0: FAIL (1.009s)
[367.409493] Starting dynamic subtest: ccs0-smem
[368.827265] Dynamic subtest ccs0-smem: SUCCESS (1.450s)
[368.839522] Starting dynamic subtest: ccs0-lmem0
[370.265269] Dynamic subtest ccs0-lmem0: SUCCESS (1.438s)
[370.266225] Subtest capture: FAIL (16.356s)
[370.456779] [081/131] (656s left) kms_psr (pr-primary-blt)
[370.648635] Subtest pr-primary-blt: SKIP (0.000s)
[370.724245] [082/131] (655s left) kms_universal_plane (disable-primary-vs-flip)
[370.919786] Starting subtest: disable-primary-vs-flip
[370.921996] Starting dynamic subtest: pipe-A-DP-3
[371.468991] Dynamic subtest pipe-A-DP-3: SUCCESS (0.547s)
[371.500982] Starting dynamic subtest: pipe-B-DP-3
[371.954369] Dynamic subtest pipe-B-DP-3: SUCCESS (0.480s)
[371.968020] Starting dynamic subtest: pipe-C-DP-3
[372.377724] Dynamic subtest pipe-C-DP-3: SUCCESS (0.421s)
[372.390481] Starting dynamic subtest: pipe-D-DP-3
[372.824554] Dynamic subtest pipe-D-DP-3: SUCCESS (0.445s)
[372.825492] Subtest disable-primary-vs-flip: SUCCESS (1.904s)
[373.119028] [083/131] (653s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[373.308035] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[373.308887] Starting dynamic subtest: pipe-A
[375.451725] Dynamic subtest pipe-A: SUCCESS (2.143s)
[375.484725] Starting dynamic subtest: pipe-B
[377.680108] Dynamic subtest pipe-B: SUCCESS (2.226s)
[377.710092] Starting dynamic subtest: pipe-C
[377.993107] Dynamic subtest pipe-C: SUCCESS (0.311s)
[378.022741] Starting dynamic subtest: pipe-D
[378.305097] Dynamic subtest pipe-D: SUCCESS (0.310s)
[378.306155] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.998s)
[378.653820] [084/131] (648s left) gem_spin_batch (resubmit)
[378.746230] Starting subtest: resubmit
[378.747171] Starting dynamic subtest: rcs0
[378.777497] Dynamic subtest rcs0: SUCCESS (0.031s)
[378.791464] Starting dynamic subtest: bcs0
[378.792394] Dynamic subtest bcs0: SUCCESS (0.005s)
[378.804871] Starting dynamic subtest: vcs0
[378.806075] Dynamic subtest vcs0: SUCCESS (0.002s)
[378.817728] Starting dynamic subtest: vcs1
[378.818582] Dynamic subtest vcs1: SUCCESS (0.002s)
[378.830258] Starting dynamic subtest: vecs0
[378.831191] Dynamic subtest vecs0: SUCCESS (0.002s)
[378.842433] Starting dynamic subtest: vecs1
[378.843543] Dynamic subtest vecs1: SUCCESS (0.002s)
[378.855235] Starting dynamic subtest: ccs0
[378.856505] Dynamic subtest ccs0: SUCCESS (0.002s)
[378.857668] Subtest resubmit: SUCCESS (0.054s)
[379.153993] [085/131] (647s left) kms_flip (nonexisting-fb)
[379.341374] Starting subtest: nonexisting-fb
[379.346195] Starting dynamic subtest: A-DP3
[379.672356] Dynamic subtest A-DP3: SUCCESS (0.325s)
[379.718884] Starting dynamic subtest: B-DP3
[379.969684] Dynamic subtest B-DP3: SUCCESS (0.292s)
[380.001359] Starting dynamic subtest: C-DP3
[380.252673] Dynamic subtest C-DP3: SUCCESS (0.280s)
[380.284392] Starting dynamic subtest: D-DP3
[380.534590] Dynamic subtest D-DP3: SUCCESS (0.279s)
[380.538831] Subtest nonexisting-fb: SUCCESS (1.197s)
[380.950949] [086/131] (646s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[381.026479] Starting subtest: etime-single-wait-all-for-submit-submitted
[381.142489] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[381.311452] [087/131] (645s left) kms_frontbuffer_tracking (psr-1p-rte)
[381.501148] Starting subtest: psr-1p-rte
[381.502862] Subtest psr-1p-rte: SKIP (0.000s)
[381.712592] [088/131] (645s left) gem_fenced_exec_thrash (no-spare-fences)
[381.795853] Subtest no-spare-fences: SKIP (0.000s)
[381.875662] [089/131] (645s left) perf_pmu (interrupts)
[381.943274] Starting subtest: interrupts
[383.074887] Subtest interrupts: SUCCESS (1.131s)
[383.262853] [090/131] (643s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[383.452877] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[383.454465] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[383.645994] [091/131] (643s left) kms_plane_lowres (tiling-x)
[383.833456] Starting subtest: tiling-x
[383.834360] Starting dynamic subtest: pipe-A-DP-3
[394.357364] Dynamic subtest pipe-A-DP-3: SUCCESS (10.523s)
[394.461546] Starting dynamic subtest: pipe-B-DP-3
[405.084352] Dynamic subtest pipe-B-DP-3: SUCCESS (10.636s)
[405.186172] Starting dynamic subtest: pipe-C-DP-3
[415.648003] Dynamic subtest pipe-C-DP-3: SUCCESS (10.474s)
[415.766636] Starting dynamic subtest: pipe-D-DP-3
[426.219140] Dynamic subtest pipe-D-DP-3: SUCCESS (10.464s)
[426.324438] Subtest tiling-x: SUCCESS (42.491s)
[426.684744] [092/131] (600s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[426.867795] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[426.883211] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.015s)
[427.072379] [093/131] (600s left) kms_flip (basic-flip-vs-wf_vblank)
[427.253130] Starting subtest: basic-flip-vs-wf_vblank
[427.257965] Starting dynamic subtest: A-DP3
[428.388701] Dynamic subtest A-DP3: SUCCESS (1.131s)
[428.405097] Starting dynamic subtest: B-DP3
[429.441644] Dynamic subtest B-DP3: SUCCESS (1.051s)
[429.456752] Starting dynamic subtest: C-DP3
[430.487660] Dynamic subtest C-DP3: SUCCESS (1.045s)
[430.502812] Starting dynamic subtest: D-DP3
[431.535773] Dynamic subtest D-DP3: SUCCESS (1.047s)
[431.538237] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.285s)
[431.901361] [094/131] (595s left) kms_cursor_crc (cursor-sliding-512x512)
[432.353996] Starting subtest: cursor-sliding-512x512
[432.355771] Subtest cursor-sliding-512x512: SKIP (0.001s)
[432.632554] [095/131] (595s left) prime_mmap (test_userptr)
[432.711946] Starting subtest: test_userptr
[432.712903] Starting dynamic subtest: test_userptr-smem
[432.713808] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[432.714618] Subtest test_userptr: SUCCESS (0.002s)
[432.865361] [096/131] (594s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[433.065253] Starting subtest: 4-tiled-8bpp-rotate-180
[434.716112] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.650s)
[434.935609] [097/131] (592s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[435.125469] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[435.130380] Starting dynamic subtest: A-DP3
[436.061760] Dynamic subtest A-DP3: SUCCESS (0.930s)
[436.077305] Starting dynamic subtest: B-DP3
[436.761620] Dynamic subtest B-DP3: SUCCESS (0.699s)
[436.774776] Starting dynamic subtest: C-DP3
[437.439574] Dynamic subtest C-DP3: SUCCESS (0.677s)
[437.453013] Starting dynamic subtest: D-DP3
[438.132900] Dynamic subtest D-DP3: SUCCESS (0.691s)
[438.133824] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.007s)
[438.429888] [098/131] (589s left) kms_big_fb (linear-32bpp-rotate-90)
[438.622735] Starting subtest: linear-32bpp-rotate-90
[438.678106] Subtest linear-32bpp-rotate-90: SKIP (0.055s)
[438.930827] [099/131] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[439.117997] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[439.119690] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[439.327554] [100/131] (588s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[439.405444] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[439.511853] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[439.658840] [101/131] (588s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[439.847213] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[439.848962] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[440.046509] [102/131] (588s left) gem_sync (basic-store-each)
[440.134460] Starting subtest: basic-store-each
[444.115298] Subtest basic-store-each: SUCCESS (3.980s)
[444.395810] [103/131] (583s left) gem_ctx_persistence (engines-hostile)
[444.480221] Starting subtest: engines-hostile
[444.481172] Starting dynamic subtest: rcs0
[444.633351] Dynamic subtest rcs0: SUCCESS (0.152s)
[444.650536] Starting dynamic subtest: bcs0
[444.687481] Dynamic subtest bcs0: SUCCESS (0.050s)
[444.713031] Starting dynamic subtest: vcs0
[444.733499] Dynamic subtest vcs0: SUCCESS (0.044s)
[444.758698] Starting dynamic subtest: vcs1
[444.774412] Dynamic subtest vcs1: SUCCESS (0.039s)
[444.793484] Starting dynamic subtest: vecs0
[444.872590] Dynamic subtest vecs0: SUCCESS (0.096s)
[444.920214] Starting dynamic subtest: vecs1
[444.921487] Dynamic subtest vecs1: SUCCESS (0.034s)
[444.938206] Starting dynamic subtest: ccs0
[445.023703] Dynamic subtest ccs0: SUCCESS (0.110s)
[445.027928] Subtest engines-hostile: SUCCESS (0.545s)
[445.247455] [104/131] (583s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[445.438276] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[445.490562] [105/131] (583s left) kms_addfb_basic (addfb25-modifier-no-flag)
[445.670869] Starting subtest: addfb25-modifier-no-flag
[445.671740] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[445.881025] [106/131] (582s left) kms_dp_linktrain_fallback (dsc-fallback)
[446.063787] Starting subtest: dsc-fallback
[446.066328] Subtest dsc-fallback: SKIP (0.000s)
[446.228615] [107/131] (582s left) syncobj_timeline (single-wait-available-signaled)
[446.303500] Starting subtest: single-wait-available-signaled
[446.304395] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[446.508501] [108/131] (582s left) kms_addfb_basic (bad-pitch-256)
[446.583680] Starting subtest: bad-pitch-256
[446.584570] Subtest bad-pitch-256: SUCCESS (0.000s)
[446.897695] [109/131] (581s left) perf (i915-ref-count)
[447.048033] Starting subtest: i915-ref-count
[447.329005] Subtest i915-ref-count: SUCCESS (0.280s)
[447.493499] [110/131] (581s left) i915_drm_fdinfo (idle)
[447.562044] Starting subtest: idle
[447.562989] Starting dynamic subtest: rcs0
[448.168371] Dynamic subtest rcs0: SUCCESS (0.606s)
[448.181876] Starting dynamic subtest: bcs0
[448.673262] Dynamic subtest bcs0: SUCCESS (0.502s)
[448.689550] Starting dynamic subtest: vcs0
[449.179965] Dynamic subtest vcs0: SUCCESS (0.503s)
[449.195900] Starting dynamic subtest: vcs1
[449.686409] Dynamic subtest vcs1: SUCCESS (0.503s)
[449.702437] Starting dynamic subtest: vecs0
[450.193139] Dynamic subtest vecs0: SUCCESS (0.503s)
[450.208689] Starting dynamic subtest: vecs1
[450.699280] Dynamic subtest vecs1: SUCCESS (0.503s)
[450.750112] Starting dynamic subtest: ccs0
[451.208718] Dynamic subtest ccs0: SUCCESS (0.505s)
[451.212374] Subtest idle: SUCCESS (3.648s)
[451.347413] [111/131] (577s left) gem_ccs (block-copy-uncompressed)
[451.429172] Starting subtest: block-copy-uncompressed
[451.431443] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[451.473200] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.043s)
[451.488487] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[451.489399] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[451.503344] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[451.605928] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s)
[451.620918] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[451.720604] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s)
[451.735809] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[451.737041] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[451.751720] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[451.752553] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[451.766078] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[451.868666] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.115s)
[451.884012] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[451.984574] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s)
[451.999134] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[452.001779] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[452.016403] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[452.017317] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[452.030539] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[452.136069] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.118s)
[452.149212] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[452.251167] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s)
[452.265976] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[452.267527] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[452.282263] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[452.283199] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[452.296503] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[452.382669] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.099s)
[452.397507] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[452.480672] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.097s)
[452.481519] Subtest block-copy-uncompressed: SUCCESS (1.052s)
[452.687169] [112/131] (576s left) gem_tiled_blits (normal)
[452.769861] Subtest normal: SKIP (0.000s)
[452.857921] [113/131] (576s left) api_intel_bb (blit-noreloc-keep-cache)
[452.933541] Starting subtest: blit-noreloc-keep-cache
[452.967004] Subtest blit-noreloc-keep-cache: SUCCESS (0.034s)
[453.166169] [114/131] (575s left) gem_exec_balancer (nohangcheck)
[453.509587] Starting subtest: nohangcheck
[455.014877] Subtest nohangcheck: SUCCESS (1.505s)
[455.180714] [115/131] (574s left) perf_pmu (busy-accuracy-50)
[455.249237] Starting subtest: busy-accuracy-50
[455.250168] Starting dynamic subtest: rcs0
[456.805670] Dynamic subtest rcs0: SUCCESS (1.555s)
[456.819020] Starting dynamic subtest: bcs0
[458.362201] Dynamic subtest bcs0: SUCCESS (1.554s)
[458.375491] Starting dynamic subtest: vcs0
[459.917557] Dynamic subtest vcs0: SUCCESS (1.555s)
[459.930696] Starting dynamic subtest: vcs1
[461.473011] Dynamic subtest vcs1: SUCCESS (1.554s)
[461.486542] Starting dynamic subtest: vecs0
[463.030236] Dynamic subtest vecs0: SUCCESS (1.556s)
[463.043550] Starting dynamic subtest: vecs1
[464.587630] Dynamic subtest vecs1: SUCCESS (1.556s)
[464.601161] Starting dynamic subtest: ccs0
[466.143509] Dynamic subtest ccs0: SUCCESS (1.555s)
[466.144437] Subtest busy-accuracy-50: SUCCESS (10.894s)
[466.346601] [116/131] (562s left) i915_pm_rps (thresholds-park)
[466.430116] Starting subtest: thresholds-park
[466.432033] Subtest thresholds-park: SKIP (0.000s)
[466.643185] [117/131] (562s left) gem_softpin (evict-active-interruptible)
[466.728499] Starting subtest: evict-active-interruptible
[466.743955] Subtest evict-active-interruptible: SUCCESS (0.015s)
[466.931086] [118/131] (562s left) kms_color (ctm-green-to-red)
[467.113605] Starting subtest: ctm-green-to-red
[467.114507] Starting dynamic subtest: pipe-A-DP-3
[467.804198] Dynamic subtest pipe-A-DP-3: SUCCESS (0.689s)
[467.817533] Starting dynamic subtest: pipe-B-DP-3
[468.383827] Dynamic subtest pipe-B-DP-3: SUCCESS (0.579s)
[468.401225] Starting dynamic subtest: pipe-C-DP-3
[468.988507] Dynamic subtest pipe-C-DP-3: SUCCESS (0.603s)
[469.004505] Starting dynamic subtest: pipe-D-DP-3
[469.561463] Dynamic subtest pipe-D-DP-3: SUCCESS (0.571s)
[469.562387] Subtest ctm-green-to-red: SUCCESS (2.448s)
[469.884506] [119/131] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[470.081034] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[470.082647] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[470.288975] [120/131] (559s left) kms_psr (psr2-primary-page-flip)
[470.468370] Subtest psr2-primary-page-flip: SKIP (0.000s)
[470.530952] [121/131] (559s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[470.712690] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[470.715211] Starting dynamic subtest: pipe-A-DP-3
[470.718508] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[470.731745] Starting dynamic subtest: pipe-B-DP-3
[470.735054] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[470.747931] Starting dynamic subtest: pipe-C-DP-3
[470.751204] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[470.763889] Starting dynamic subtest: pipe-D-DP-3
[470.767226] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[470.769549] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[471.188841] [122/131] (558s left) gem_exec_reloc (basic-cpu-read-active)
[471.269206] Subtest basic-cpu-read-active: SKIP (0.000s)
[471.361782] [123/131] (558s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[471.445547] Starting subtest: yf-tiled-ccs-to-x-tiled
[471.447636] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[471.732276] [124/131] (558s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[471.922136] Starting subtest: psr-rgb101010-draw-mmap-cpu
[471.923822] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[472.114476] [125/131] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[472.303177] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[472.304873] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[472.501071] [126/131] (557s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[472.686645] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[472.689122] Starting dynamic subtest: pipe-A-DP-3
[472.697230] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[472.710316] Starting dynamic subtest: pipe-B-DP-3
[472.718617] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[472.731485] Starting dynamic subtest: pipe-C-DP-3
[472.739548] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[472.752688] Starting dynamic subtest: pipe-D-DP-3
[472.762804] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[472.764813] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[473.154076] [127/131] (557s left) gem_exec_schedule (u-independent)
[473.247512] Starting subtest: u-independent
[473.248478] Starting dynamic subtest: rcs0
[473.716619] Dynamic subtest rcs0: SUCCESS (0.468s)
[473.739867] Starting dynamic subtest: bcs0
[474.114272] Dynamic subtest bcs0: SUCCESS (0.396s)
[474.130194] Starting dynamic subtest: vcs0
[474.518457] Dynamic subtest vcs0: SUCCESS (0.403s)
[474.535646] Starting dynamic subtest: vcs1
[474.911407] Dynamic subtest vcs1: SUCCESS (0.391s)
[474.931951] Starting dynamic subtest: vecs0
[475.307404] Dynamic subtest vecs0: SUCCESS (0.395s)
[475.326221] Starting dynamic subtest: vecs1
[475.724488] Dynamic subtest vecs1: SUCCESS (0.416s)
[475.742757] Starting dynamic subtest: ccs0
[476.108202] Dynamic subtest ccs0: SUCCESS (0.381s)
[476.113919] Subtest u-independent: SUCCESS (2.862s)
[476.540207] [128/131] (553s left) gem_exec_params (sol-reset-invalid)
[476.630231] Starting subtest: sol-reset-invalid
[476.632461] Subtest sol-reset-invalid: SUCCESS (0.002s)
[476.857954] [129/131] (553s left) kms_rotation_crc (bad-tiling)
[477.047481] Starting subtest: bad-tiling
[477.049257] Subtest bad-tiling: SKIP (0.001s)
[477.215130] [130/131] (553s left) perf (enable-disable)
[477.435979] Starting subtest: enable-disable
[477.436978] Starting dynamic subtest: 0-rcs0
[479.699814] Dynamic subtest 0-rcs0: SUCCESS (2.263s)
[479.700687] Subtest enable-disable: SUCCESS (2.264s)
[479.760428] [131/131] (550s left) gem_eio (throttle)
[480.052597] Starting subtest: throttle
[480.672091] Subtest throttle: SUCCESS (0.620s)
[480.955613] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_hdr
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_ringfill
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: core_auth
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_plane_alpha_blend
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cdclk
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: prime_self_import
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_ctx_shared
results: parsing output: 41/ for test: gem_tiled_fence_blits
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: gem_create
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: i915_hangman
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: gem_workarounds
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_set_tiling_vs_blt
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_capture
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_universal_plane
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_sync
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_dp_linktrain_fallback
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gem_ccs
results: parsing output: 111/ for test: gem_tiled_blits
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: gem_eio
Done.