[65.872297] Initializing watchdogs
[65.872364]   /dev/watchdog0
[65.892658] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.903574] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.907521] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.909902] [001/132] (960s left) kms_pm_dc (dc5-psr)
[68.425473] Starting subtest: dc5-psr
[68.427214] Subtest dc5-psr: SKIP (0.000s)
[68.535090] [002/132] (957s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[70.061401] Starting subtest: cursorA-vs-flipA-toggle
[81.004234] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.943s)
[81.212874] [003/132] (945s left) gem_exec_reloc (basic-gtt-read-noreloc)
[81.299878] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[81.380090] [004/132] (945s left) gem_exec_params (secure-non-root)
[81.461486] Starting subtest: secure-non-root
[81.463502] Subtest secure-non-root: SKIP (0.000s)
[81.615603] [005/132] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[83.120534] Starting subtest: fbcpsr-slowdraw
[83.122235] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[83.265745] [006/132] (943s left) gem_ccs (block-copy-uncompressed)
[83.376579] Starting subtest: block-copy-uncompressed
[83.377507] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[83.424569] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.047s)
[83.432195] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[83.440303] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[83.447558] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[83.543018] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.102s)
[83.550379] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[83.640477] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.097s)
[83.647815] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[83.655989] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[83.663436] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[83.671262] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[83.678596] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[83.777185] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.106s)
[83.784380] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[83.876079] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.099s)
[83.883398] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[83.892419] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[83.899766] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[83.907352] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[83.914748] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[84.013518] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.106s)
[84.020942] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[84.112031] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.098s)
[84.119357] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[84.127228] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[84.134560] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[84.142235] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[84.149541] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[84.241682] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.099s)
[84.249194] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[84.349453] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.108s)
[84.350396] Subtest block-copy-uncompressed: SUCCESS (0.973s)
[84.496585] [007/132] (942s left) kms_flip (2x-flip-vs-fences)
[86.001876] Starting subtest: 2x-flip-vs-fences
[86.003535] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[86.111852] [008/132] (940s left) syncobj_timeline (etime-single-wait-all-submitted)
[86.208363] Starting subtest: etime-single-wait-all-submitted
[86.312131] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[86.442828] [009/132] (940s left) kms_psr (pr-cursor-mmap-cpu)
[87.949742] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[87.995171] [010/132] (938s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[89.500984] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[89.501934] Starting dynamic subtest: pipe-A
[89.589944] Dynamic subtest pipe-A: SUCCESS (0.089s)
[89.598941] Starting dynamic subtest: pipe-B
[89.716279] Dynamic subtest pipe-B: SUCCESS (0.126s)
[89.726207] Starting dynamic subtest: pipe-C
[89.841636] Dynamic subtest pipe-C: SUCCESS (0.125s)
[89.849130] Starting dynamic subtest: pipe-D
[89.967340] Dynamic subtest pipe-D: SUCCESS (0.125s)
[89.968186] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.467s)
[90.143794] [011/132] (936s left) gem_ctx_isolation (clean)
[90.228585] Starting subtest: clean
[90.229480] Starting dynamic subtest: rcs0
[90.331398] Dynamic subtest rcs0: SUCCESS (0.103s)
[90.339309] Starting dynamic subtest: bcs0
[90.449053] Dynamic subtest bcs0: SUCCESS (0.117s)
[90.456595] Starting dynamic subtest: vcs0
[90.538746] Dynamic subtest vcs0: SUCCESS (0.089s)
[90.546689] Starting dynamic subtest: vcs1
[90.627234] Dynamic subtest vcs1: SUCCESS (0.088s)
[90.634755] Starting dynamic subtest: vecs0
[90.751720] Dynamic subtest vecs0: SUCCESS (0.124s)
[90.759257] Starting dynamic subtest: vecs1
[90.859557] Dynamic subtest vecs1: SUCCESS (0.108s)
[90.867254] Starting dynamic subtest: ccs0
[90.972295] Dynamic subtest ccs0: SUCCESS (0.112s)
[90.973231] Subtest clean: SUCCESS (0.744s)
[91.247955] [012/132] (935s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[92.750432] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[92.751332] Starting dynamic subtest: pipe-A-HDMI-A-3
[92.760886] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[92.768496] Starting dynamic subtest: pipe-B-HDMI-A-3
[92.778081] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[92.785520] Starting dynamic subtest: pipe-C-HDMI-A-3
[92.794571] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[92.808912] Starting dynamic subtest: pipe-D-HDMI-A-3
[92.819297] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[92.820948] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[93.006141] [013/132] (934s left) kms_color (ctm-0-50)
[94.510146] Starting subtest: ctm-0-50
[94.511047] Starting dynamic subtest: pipe-A-HDMI-A-3
[96.075028] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.564s)
[96.083619] Starting dynamic subtest: pipe-B-HDMI-A-3
[97.457399] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.382s)
[97.465233] Starting dynamic subtest: pipe-C-HDMI-A-3
[98.864261] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.407s)
[98.872128] Starting dynamic subtest: pipe-D-HDMI-A-3
[100.259316] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.394s)
[100.260348] Subtest ctm-0-50: SUCCESS (5.748s)
[100.431824] [014/132] (926s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[101.941065] Starting subtest: fbcpsr-modesetfrombusy
[101.942849] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[102.070507] [015/132] (925s left) gem_eio (create)
[102.389968] Starting subtest: create
[102.888935] Subtest create: SUCCESS (0.499s)
[104.424011] [016/132] (922s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[105.949436] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[105.951210] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[106.036259] [017/132] (921s left) gem_exec_balancer (smoke)
[106.143770] Starting subtest: smoke
[129.465050] Subtest smoke: SUCCESS (23.321s)
[130.337780] [018/132] (897s left) kms_lease (page-flip-implicit-plane)
[131.837162] Starting subtest: page-flip-implicit-plane
[131.838078] Starting dynamic subtest: pipe-A-HDMI-A-3
[132.212999] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.375s)
[132.221912] Starting dynamic subtest: pipe-B-HDMI-A-3
[132.458645] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.245s)
[132.469617] Starting dynamic subtest: pipe-C-HDMI-A-3
[132.710013] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.250s)
[132.718726] Starting dynamic subtest: pipe-D-HDMI-A-3
[132.950339] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.238s)
[132.952334] Subtest page-flip-implicit-plane: SUCCESS (1.113s)
[133.130092] [019/132] (894s left) gem_exec_params (rsvd2-dirt)
[133.208094] Starting subtest: rsvd2-dirt
[133.210205] Subtest rsvd2-dirt: SKIP (0.000s)
[133.370196] [020/132] (894s left) gem_exec_reloc (basic-write-wc-active)
[133.445588] Subtest basic-write-wc-active: SKIP (0.000s)
[133.536845] [021/132] (894s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[135.088591] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[135.188741] [022/132] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[136.703978] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[136.705784] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[136.855467] [023/132] (890s left) kms_plane_scaling (intel-max-src-size)
[138.392204] Starting subtest: intel-max-src-size
[138.397046] Subtest intel-max-src-size: SKIP (0.004s)
[138.532773] [024/132] (889s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[138.647115] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[138.713953] [025/132] (889s left) gem_ctx_exec (basic-close-race)
[138.788272] Starting subtest: basic-close-race
[144.403871] Subtest basic-close-race: SUCCESS (5.615s)
[144.561460] [026/132] (883s left) kms_properties (invalid-properties-atomic)
[146.068393] Starting subtest: invalid-properties-atomic
[146.571890] Subtest invalid-properties-atomic: SUCCESS (0.504s)
[146.687902] [027/132] (881s left) drm_read (short-buffer-nonblock)
[148.258545] Starting subtest: short-buffer-nonblock
[148.259463] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[148.499787] [028/132] (879s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[148.576441] Subtest untiled-to-tiled: SKIP (0.000s)
[148.652747] [029/132] (879s left) kms_cursor_crc (cursor-offscreen-256x85)
[150.413523] Starting subtest: cursor-offscreen-256x85
[150.417606] Starting dynamic subtest: pipe-A-HDMI-A-3
[152.898742] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.480s)
[152.931422] Starting dynamic subtest: pipe-D-HDMI-A-3
[155.323277] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.400s)
[155.324202] Subtest cursor-offscreen-256x85: SUCCESS (4.909s)
[155.639015] [030/132] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[157.145299] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[157.147030] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[157.266289] [031/132] (870s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[158.791402] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[158.792268] Starting dynamic subtest: pipe-A-HDMI-A-3
[158.800917] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[158.809553] Starting dynamic subtest: pipe-B-HDMI-A-3
[158.818373] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[158.826567] Starting dynamic subtest: pipe-C-HDMI-A-3
[158.834932] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[158.843044] Starting dynamic subtest: pipe-D-HDMI-A-3
[158.853472] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[158.855505] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[159.058340] [032/132] (869s left) kms_psr (fbc-psr-primary-blt)
[160.569207] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[160.628057] [033/132] (867s left) gem_spin_batch (legacy-resubmit-new)
[160.713386] Starting subtest: legacy-resubmit-new
[160.714376] Starting dynamic subtest: default
[160.747635] Dynamic subtest default: SUCCESS (0.034s)
[160.756217] Starting dynamic subtest: render
[160.757164] Dynamic subtest render: SUCCESS (0.005s)
[160.765561] Starting dynamic subtest: bsd
[160.766452] Dynamic subtest bsd: SUCCESS (0.004s)
[160.774957] Starting dynamic subtest: bsd1
[160.775896] Dynamic subtest bsd1: SUCCESS (0.004s)
[160.784549] Starting dynamic subtest: bsd2
[160.785721] Dynamic subtest bsd2: SUCCESS (0.004s)
[160.794334] Starting dynamic subtest: blt
[160.795525] Dynamic subtest blt: SUCCESS (0.004s)
[160.803686] Starting dynamic subtest: vebox
[160.804798] Dynamic subtest vebox: SUCCESS (0.007s)
[160.805890] Subtest legacy-resubmit-new: SUCCESS (0.067s)
[161.056743] [034/132] (867s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[161.133178] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[161.134092] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[161.272009] [035/132] (867s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[161.954225] Starting subtest: syncobj-timeline-invalid-wait
[161.955521] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[162.214362] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[162.216154] [036/132] (866s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[162.296169] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[162.365015] [037/132] (866s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[163.878882] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[163.931794] [038/132] (864s left) prime_vgem (wait)
[164.029566] Starting subtest: wait
[164.030734] Starting dynamic subtest: rcs0
[164.088101] Dynamic subtest rcs0: SUCCESS (0.060s)
[164.096739] Starting dynamic subtest: bcs0
[164.136966] Dynamic subtest bcs0: SUCCESS (0.049s)
[164.147258] Starting dynamic subtest: vcs0
[164.181094] Dynamic subtest vcs0: SUCCESS (0.043s)
[164.208351] Starting dynamic subtest: vcs1
[164.228090] Dynamic subtest vcs1: SUCCESS (0.045s)
[164.252559] Starting dynamic subtest: vecs0
[164.268451] Dynamic subtest vecs0: SUCCESS (0.039s)
[164.282533] Starting dynamic subtest: vecs1
[164.309136] Dynamic subtest vecs1: SUCCESS (0.040s)
[164.321532] Starting dynamic subtest: ccs0
[164.351054] Dynamic subtest ccs0: SUCCESS (0.041s)
[164.352263] Subtest wait: SUCCESS (0.323s)
[164.564385] [039/132] (864s left) kms_atomic_transition (plane-toggle-modeset-transition)
[166.077482] Starting subtest: plane-toggle-modeset-transition
[166.078413] Starting dynamic subtest: pipe-A-HDMI-A-3
[166.874493] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.796s)
[166.892560] Starting dynamic subtest: pipe-B-HDMI-A-3
[167.452525] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.571s)
[167.456325] Subtest plane-toggle-modeset-transition: SUCCESS (1.378s)
[167.631628] [040/132] (861s left) kms_getfb (getfb2-into-addfb2)
[169.146525] Starting subtest: getfb2-into-addfb2
[169.147391] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[169.293287] [041/132] (859s left) kms_dsc (dsc-with-output-formats-with-bpc)
[170.833184] Starting subtest: dsc-with-output-formats-with-bpc
[170.858157] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[170.923353] [042/132] (858s left) kms_dirtyfb (default-dirtyfb-ioctl)
[172.461515] Starting subtest: default-dirtyfb-ioctl
[172.462419] Starting dynamic subtest: A-HDMI-A-3
[173.885234] Dynamic subtest A-HDMI-A-3: SUCCESS (1.417s)
[173.886453] Subtest default-dirtyfb-ioctl: SUCCESS (1.418s)
[174.087150] [043/132] (854s left) gem_mmap_offset (partial-remap)
[174.170157] Starting subtest: partial-remap
[174.171274] Starting dynamic subtest: lmem0
[174.175438] Dynamic subtest lmem0: SUCCESS (0.005s)
[174.184462] Starting dynamic subtest: smem0
[174.186392] Dynamic subtest smem0: SUCCESS (0.004s)
[174.187233] Subtest partial-remap: SUCCESS (0.010s)
[174.335502] [044/132] (854s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[175.850455] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[175.851382] Starting dynamic subtest: pipe-A-HDMI-A-3
[175.861178] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[175.870182] Starting dynamic subtest: pipe-B-HDMI-A-3
[175.879891] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[175.888649] Starting dynamic subtest: pipe-C-HDMI-A-3
[175.897849] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[175.906603] Starting dynamic subtest: pipe-D-HDMI-A-3
[175.917391] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[175.919145] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[176.172735] [045/132] (852s left) kms_cursor_crc (cursor-random-512x512)
[177.968402] Starting subtest: cursor-random-512x512
[177.970321] Subtest cursor-random-512x512: SKIP (0.001s)
[178.186494] [046/132] (851s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[179.697474] Starting subtest: coverage-vs-premult-vs-constant
[179.952168] Starting dynamic subtest: pipe-A-HDMI-A-3
[180.372793] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.420s)
[180.382788] Starting dynamic subtest: pipe-D-HDMI-A-3
[180.776998] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.402s)
[180.778081] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.080s)
[180.987468] [047/132] (848s left) kms_concurrent (multi-plane-atomic-lowres)
[182.503855] Starting subtest: multi-plane-atomic-lowres
[182.504762] Starting dynamic subtest: pipe-A-HDMI-A-3
[182.842429] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.336s)
[182.855169] Starting dynamic subtest: pipe-B-HDMI-A-3
[183.162580] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.319s)
[183.172568] Starting dynamic subtest: pipe-C-HDMI-A-3
[183.460036] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.296s)
[183.470489] Starting dynamic subtest: pipe-D-HDMI-A-3
[183.726121] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.265s)
[183.727166] Subtest multi-plane-atomic-lowres: SUCCESS (1.223s)
[183.966674] [048/132] (845s left) gem_mmap_gtt (big-bo-tiledy)
[184.046055] Subtest big-bo-tiledY: SKIP (0.000s)
[184.121913] [049/132] (845s left) syncobj_eventfd (invalid-bad-pad)
[184.201220] Starting subtest: invalid-bad-pad
[184.202150] Subtest invalid-bad-pad: SUCCESS (0.000s)
[184.330549] [050/132] (845s left) gem_exec_schedule (implicit-read-write)
[184.424169] Starting subtest: implicit-read-write
[184.425129] Starting dynamic subtest: rcs0
[184.724680] Dynamic subtest rcs0: SUCCESS (0.290s)
[184.733483] Starting dynamic subtest: bcs0
[184.933186] Dynamic subtest bcs0: SUCCESS (0.209s)
[184.942109] Starting dynamic subtest: vcs0
[185.153072] Dynamic subtest vcs0: SUCCESS (0.222s)
[185.161926] Starting dynamic subtest: vcs1
[185.367333] Dynamic subtest vcs1: SUCCESS (0.220s)
[185.376113] Starting dynamic subtest: vecs0
[185.591377] Dynamic subtest vecs0: SUCCESS (0.223s)
[185.600188] Starting dynamic subtest: vecs1
[185.808509] Dynamic subtest vecs1: SUCCESS (0.216s)
[185.821605] Starting dynamic subtest: ccs0
[186.051878] Dynamic subtest ccs0: SUCCESS (0.242s)
[186.053065] Subtest implicit-read-write: SUCCESS (1.629s)
[186.486139] [051/132] (843s left) i915_drm_fdinfo (virtual-busy)
[186.559181] Starting subtest: virtual-busy
[186.560987] Subtest virtual-busy: SKIP (0.000s)
[186.658518] [052/132] (842s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[188.174349] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[188.176734] Starting dynamic subtest: pipe-A-valid-mode
[189.652361] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.477s)
[189.653240] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (1.478s)
[189.839828] [053/132] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[191.357545] Starting subtest: basic-busy-flip-before-cursor-varying-size
[191.359239] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[191.451086] [054/132] (838s left) kms_rotation_crc (primary-rotation-180)
[192.980652] Starting subtest: primary-rotation-180
[203.362320] Subtest primary-rotation-180: SUCCESS (10.381s)
[203.630432] [055/132] (826s left) gem_pxp (create-regular-context-2)
[206.235358] Starting subtest: create-regular-context-2
[206.237367] Subtest create-regular-context-2: SKIP (0.000s)
[206.377336] [056/132] (823s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[207.897973] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[210.515418] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.619s)
[210.725658] [057/132] (819s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[212.251919] Starting subtest: yf-tiled-64bpp-rotate-180
[212.253770] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[212.382924] [058/132] (817s left) perf_pmu (busy-start)
[212.476467] Starting subtest: busy-start
[212.477367] Starting dynamic subtest: rcs0
[215.053514] Dynamic subtest rcs0: SUCCESS (2.576s)
[215.068566] Starting dynamic subtest: bcs0
[217.603663] Dynamic subtest bcs0: SUCCESS (2.547s)
[217.619370] Starting dynamic subtest: vcs0
[220.152166] Dynamic subtest vcs0: SUCCESS (2.546s)
[220.164542] Starting dynamic subtest: vcs1
[222.699949] Dynamic subtest vcs1: SUCCESS (2.546s)
[222.713179] Starting dynamic subtest: vecs0
[225.250506] Dynamic subtest vecs0: SUCCESS (2.547s)
[225.265520] Starting dynamic subtest: vecs1
[227.800659] Dynamic subtest vecs1: SUCCESS (2.547s)
[227.813722] Starting dynamic subtest: ccs0
[230.351593] Dynamic subtest ccs0: SUCCESS (2.547s)
[230.353158] Subtest busy-start: SUCCESS (17.876s)
[230.484997] [059/132] (799s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[232.007363] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[232.009422] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[232.136511] [060/132] (797s left) kms_sequence (get-forked-busy)
[233.670415] Starting subtest: get-forked-busy
[233.671299] Starting dynamic subtest: pipe-A-HDMI-A-3
[236.268770] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.596s)
[236.305311] Starting dynamic subtest: pipe-B-HDMI-A-3
[238.786537] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.512s)
[238.809892] Starting dynamic subtest: pipe-C-HDMI-A-3
[241.279083] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.487s)
[241.309312] Starting dynamic subtest: pipe-D-HDMI-A-3
[243.757793] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.474s)
[243.759320] Subtest get-forked-busy: SUCCESS (10.087s)
[243.949859] [061/132] (786s left) syncobj_wait (invalid-reset-bad-pad)
[244.031257] Starting subtest: invalid-reset-bad-pad
[244.032169] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[244.150028] [062/132] (786s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[245.668982] Starting subtest: extended-pageflip-modeset-hang-oldfb
[245.669947] Starting dynamic subtest: pipe-A
[253.457497] Dynamic subtest pipe-A: SUCCESS (7.788s)
[253.470164] Starting dynamic subtest: pipe-D
[261.208538] Dynamic subtest pipe-D: SUCCESS (7.747s)
[261.209420] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.541s)
[261.385409] [063/132] (768s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[262.896991] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[262.897962] Starting dynamic subtest: pipe-A-HDMI-A-3
[262.906875] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[262.916975] Starting dynamic subtest: pipe-B-HDMI-A-3
[262.925724] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[262.935484] Starting dynamic subtest: pipe-C-HDMI-A-3
[262.943493] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[262.953196] Starting dynamic subtest: pipe-D-HDMI-A-3
[262.963085] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[262.964777] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[263.266543] [064/132] (767s left) i915_pm_rpm (system-suspend)
[267.014818] Starting subtest: system-suspend
[287.916599] Subtest system-suspend: SUCCESS (5.558s)
[297.853051] [065/132] (741s left) gem_ctx_persistence (legacy-engines-mixed)
[297.949288] Starting subtest: legacy-engines-mixed
[297.950270] Starting dynamic subtest: render
[298.054681] Dynamic subtest render: SUCCESS (0.104s)
[298.068830] Starting dynamic subtest: bsd1
[298.101800] Dynamic subtest bsd1: SUCCESS (0.046s)
[298.120737] Starting dynamic subtest: bsd2
[298.157059] Dynamic subtest bsd2: SUCCESS (0.053s)
[298.192570] Starting dynamic subtest: blt
[298.221846] Dynamic subtest blt: SUCCESS (0.062s)
[298.245324] Starting dynamic subtest: vebox
[298.278155] Dynamic subtest vebox: SUCCESS (0.054s)
[298.279443] Subtest legacy-engines-mixed: SUCCESS (0.330s)
[298.468805] [066/132] (741s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[298.552634] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[298.632721] [067/132] (740s left) gem_flink_basic (basic)
[298.709633] Starting subtest: basic
[298.710538] Subtest basic: SUCCESS (0.000s)
[298.866877] [068/132] (740s left) kms_vblank (ts-continuation-idle)
[300.380786] Starting subtest: ts-continuation-idle
[300.383349] Starting dynamic subtest: pipe-A-HDMI-A-3
[300.674701] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.292s)
[300.720451] Starting dynamic subtest: pipe-D-HDMI-A-3
[300.888623] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.201s)
[300.889797] Subtest ts-continuation-idle: SUCCESS (0.507s)
[301.051679] [069/132] (738s left) kms_addfb_basic (unused-modifier)
[301.129926] Starting subtest: unused-modifier
[301.130800] Subtest unused-modifier: SUCCESS (0.000s)
[302.702190] [070/132] (737s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[304.250673] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[304.320118] [071/132] (735s left) vgem_basic (bad-pad)
[304.374875] Starting subtest: bad-pad
[304.375745] Subtest bad-pad: SUCCESS (0.000s)
[304.459219] [072/132] (735s left) i915_pm_freq_api (freq-basic-api)
[304.549335] Starting subtest: freq-basic-api
[304.550264] Starting dynamic subtest: gt0
[304.554093] Dynamic subtest gt0: SUCCESS (0.004s)
[304.554943] Subtest freq-basic-api: SUCCESS (0.005s)
[304.700652] [073/132] (735s left) gem_exec_params (invalid-bsd2-flag-on-render)
[304.782959] Starting subtest: invalid-bsd2-flag-on-render
[304.783830] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[304.967350] [074/132] (735s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[306.498540] Starting subtest: 4-tiled-64bpp-rotate-180
[308.457650] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.959s)
[308.651698] [075/132] (731s left) kms_plane_cursor (viewport)
[310.164521] Starting subtest: viewport
[310.166284] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[313.408459] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.243s)
[313.490671] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[316.741951] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.266s)
[316.823412] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[320.042126] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.233s)
[320.146288] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[323.378267] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.244s)
[323.458509] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[326.744675] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.316s)
[326.806119] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[330.061808] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.267s)
[330.148584] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[333.464962] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.328s)
[333.545720] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[336.799244] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.283s)
[336.861304] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[340.132711] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.283s)
[340.243032] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[343.526890] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.297s)
[343.590052] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[346.743843] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.167s)
[346.806057] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[349.960832] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.167s)
[350.035664] Subtest viewport: SUCCESS (39.869s)
[350.222821] [076/132] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[351.737660] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[354.831029] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.093s)
[355.079110] [077/132] (685s left) prime_vgem (basic-write)
[355.191557] Starting subtest: basic-write
[355.211421] Subtest basic-write: SKIP (0.019s)
[355.365901] [078/132] (685s left) gem_exec_flush (basic-batch-kernel-default-uc)
[355.455664] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[355.547757] [079/132] (684s left) gem_exec_schedule (fifo)
[355.641302] Starting subtest: fifo
[355.642228] Starting dynamic subtest: rcs0
[355.931326] Dynamic subtest rcs0: SUCCESS (0.289s)
[355.945350] Starting dynamic subtest: bcs0
[356.131980] Dynamic subtest bcs0: SUCCESS (0.199s)
[356.145440] Starting dynamic subtest: vcs0
[356.342876] Dynamic subtest vcs0: SUCCESS (0.209s)
[356.354971] Starting dynamic subtest: vcs1
[356.554905] Dynamic subtest vcs1: SUCCESS (0.211s)
[356.567059] Starting dynamic subtest: vecs0
[356.766484] Dynamic subtest vecs0: SUCCESS (0.210s)
[356.780441] Starting dynamic subtest: vecs1
[356.980171] Dynamic subtest vecs1: SUCCESS (0.212s)
[356.991883] Starting dynamic subtest: ccs0
[357.190048] Dynamic subtest ccs0: SUCCESS (0.209s)
[357.191027] Subtest fifo: SUCCESS (1.549s)
[357.586986] [080/132] (682s left) perf (global-sseu-config-invalid)
[357.950440] Starting subtest: global-sseu-config-invalid
[357.952173] Subtest global-sseu-config-invalid: SKIP (0.000s)
[358.014461] [081/132] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[359.531642] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[359.533551] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[359.756695] [082/132] (680s left) kms_flip (2x-modeset-vs-vblank-race)
[361.273724] Starting subtest: 2x-modeset-vs-vblank-race
[361.286944] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[361.421377] [083/132] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[362.960712] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[362.962369] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[363.108997] [084/132] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[364.654461] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[364.656313] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[364.865278] [085/132] (676s left) kms_big_fb (linear-32bpp-rotate-90)
[366.389934] Starting subtest: linear-32bpp-rotate-90
[366.449958] Subtest linear-32bpp-rotate-90: SKIP (0.058s)
[366.649986] [086/132] (674s left) gem_exec_flush (basic-wb-ro-default)
[366.735640] Subtest basic-wb-ro-default: SKIP (0.000s)
[366.813391] [087/132] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[368.334706] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[368.336530] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[368.483290] [088/132] (672s left) kms_frontbuffer_tracking (fbc-tiling-y)
[370.022299] Starting subtest: fbc-tiling-y
[370.024041] Subtest fbc-tiling-y: SKIP (0.000s)
[370.206208] [089/132] (671s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[371.735470] Starting subtest: fbc-rgb565-draw-mmap-gtt
[371.737259] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[371.882912] [090/132] (669s left) api_intel_allocator (simple-allocator)
[371.984301] Starting subtest: simple-allocator
[371.985224] Starting dynamic subtest: basic
[372.014703] Dynamic subtest basic: SUCCESS (0.030s)
[372.028257] Starting dynamic subtest: parallel-one
[372.205410] Dynamic subtest parallel-one: SUCCESS (0.181s)
[372.217808] Starting dynamic subtest: print
[372.218749] Dynamic subtest print: SUCCESS (0.000s)
[372.232113] Starting dynamic subtest: reuse
[372.232978] Dynamic subtest reuse: SUCCESS (0.000s)
[372.245219] Starting dynamic subtest: reserve
[372.246361] Dynamic subtest reserve: SUCCESS (0.000s)
[372.258587] Starting dynamic subtest: fork-reopen-allocator
[372.259773] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[372.260967] Subtest simple-allocator: SUCCESS (0.232s)
[372.357547] [091/132] (669s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[373.869573] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[374.096803] Starting dynamic subtest: pipe-A-HDMI-A-3
[376.370026] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.273s)
[376.569892] Starting dynamic subtest: pipe-B-HDMI-A-3
[378.614334] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.055s)
[378.795618] Starting dynamic subtest: pipe-C-HDMI-A-3
[380.847936] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.063s)
[381.041763] Starting dynamic subtest: pipe-D-HDMI-A-3
[383.094746] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.063s)
[383.096235] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.227s)
[383.452331] [092/132] (658s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[384.967584] Starting subtest: basic-flip-after-cursor-legacy
[385.967225] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.000s)
[386.145449] [093/132] (655s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[386.234364] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[386.236591] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[386.483714] [094/132] (655s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[388.000070] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[388.055441] [095/132] (653s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[389.579966] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[389.581914] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[389.790327] [096/132] (652s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[389.879488] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[389.955962] [097/132] (651s left) gen9_exec_parse (allowed-single)
[390.049682] Subtest allowed-single: SKIP (0.000s)
[390.141587] [098/132] (651s left) gem_exec_schedule (u-submit-late-slice)
[390.234600] Starting subtest: u-submit-late-slice
[390.235522] Starting dynamic subtest: rcs0
[390.313883] Dynamic subtest rcs0: SUCCESS (0.079s)
[390.327703] Starting dynamic subtest: bcs0
[390.367953] Dynamic subtest bcs0: SUCCESS (0.053s)
[390.382147] Starting dynamic subtest: vcs0
[390.419335] Dynamic subtest vcs0: SUCCESS (0.050s)
[390.433529] Starting dynamic subtest: vcs1
[390.472572] Dynamic subtest vcs1: SUCCESS (0.052s)
[390.486013] Starting dynamic subtest: vecs0
[390.523369] Dynamic subtest vecs0: SUCCESS (0.050s)
[390.537056] Starting dynamic subtest: vecs1
[390.574845] Dynamic subtest vecs1: SUCCESS (0.050s)
[390.588762] Starting dynamic subtest: ccs0
[390.627436] Dynamic subtest ccs0: SUCCESS (0.051s)
[390.628576] Subtest u-submit-late-slice: SUCCESS (0.393s)
[391.054786] [099/132] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[392.574359] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[392.576051] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[392.719265] [100/132] (649s left) i915_pm_rps (thresholds)
[392.837800] Starting subtest: thresholds
[392.839534] Subtest thresholds: SKIP (0.000s)
[392.926365] [101/132] (649s left) kms_addfb_basic (unused-pitches)
[393.007007] Starting subtest: unused-pitches
[393.007846] Subtest unused-pitches: SUCCESS (0.000s)
[394.591217] [102/132] (647s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[396.130503] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[396.131374] Starting dynamic subtest: pipe-A-HDMI-A-3
[396.134664] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[396.147164] Starting dynamic subtest: pipe-B-HDMI-A-3
[396.150665] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[396.162939] Starting dynamic subtest: pipe-C-HDMI-A-3
[396.166453] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[396.178582] Starting dynamic subtest: pipe-D-HDMI-A-3
[396.182605] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[396.184852] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[396.402418] [103/132] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[397.923431] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[400.757241] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.834s)
[400.969324] [104/132] (641s left) gem_exec_schedule (semaphore-user)
[401.063399] Starting subtest: semaphore-user
[401.146663] Subtest semaphore-user: SUCCESS (0.083s)
[401.555298] [105/132] (640s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[401.634228] Starting subtest: multi-wait-available-submitted-signaled
[401.635151] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[401.784818] [106/132] (640s left) syncobj_wait (wait-all-delayed-signal)
[401.868358] Starting subtest: wait-all-delayed-signal
[401.970785] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[402.098424] [107/132] (640s left) perf_pmu (interrupts-sync)
[402.171943] Starting subtest: interrupts-sync
[403.321490] Subtest interrupts-sync: SUCCESS (1.148s)
[403.467661] [108/132] (639s left) kms_flip (2x-flip-vs-suspend-interruptible)
[404.988363] Starting subtest: 2x-flip-vs-suspend-interruptible
[405.001828] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.013s)
[405.130193] [109/132] (637s left) dmabuf_sync_file (export-wait-after-attach)
[405.207064] Starting subtest: export-wait-after-attach
[405.207950] Subtest export-wait-after-attach: SUCCESS (0.001s)
[405.355325] [110/132] (637s left) gem_partial_pwrite_pread (write-snoop)
[405.440786] Subtest write-snoop: SKIP (0.000s)
[405.521694] [111/132] (637s left) kms_async_flips (test-cursor)
[407.038644] Starting subtest: test-cursor
[407.277369] Starting dynamic subtest: pipe-A-HDMI-A-3
[407.544651] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.268s)
[407.748264] Starting dynamic subtest: pipe-B-HDMI-A-3
[407.830543] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.094s)
[407.999207] Starting dynamic subtest: pipe-C-HDMI-A-3
[408.056920] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.069s)
[408.237562] Starting dynamic subtest: pipe-D-HDMI-A-3
[408.303818] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.078s)
[408.304721] Subtest test-cursor: SUCCESS (1.267s)
[408.661870] [112/132] (634s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[410.220922] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[410.322004] [113/132] (632s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[411.850942] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[413.187261] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.336s)
[413.379510] [114/132] (629s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[413.464654] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[413.551704] [115/132] (629s left) gem_exec_reloc (basic-gtt-wc)
[413.639963] Subtest basic-gtt-wc: SKIP (0.000s)
[413.735312] [116/132] (629s left) api_intel_bb (simple-bb-ctx)
[413.814879] Starting subtest: simple-bb-ctx
[413.849809] Subtest simple-bb-ctx: SUCCESS (0.035s)
[414.063427] [117/132] (629s left) kms_psr2_su (frontbuffer-xrgb8888)
[414.144437] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[414.217204] [118/132] (629s left) kms_psr (psr-sprite-plane-onoff)
[415.732966] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[415.800298] [119/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[417.316486] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[417.318278] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[417.484529] [120/132] (625s left) kms_psr (psr-cursor-plane-onoff)
[419.011392] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[419.066677] [121/132] (624s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[420.581655] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[421.610577] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.028s)
[421.850340] [122/132] (621s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[423.364595] Starting subtest: invalid-modeset-force-ultra-joiner
[423.366206] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[423.471466] [123/132] (620s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[425.003481] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[425.005317] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[425.134991] [124/132] (618s left) syncobj_timeline (signal-array)
[425.243725] Starting subtest: signal-array
[425.244961] Subtest signal-array: SUCCESS (0.000s)
[425.402054] [125/132] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[426.919330] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[426.921036] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[427.165070] [126/132] (616s left) gem_lmem_swapping (massive)
[431.682505] Starting subtest: massive
[431.685301] Starting dynamic subtest: lmem0
[437.723464] Dynamic subtest lmem0: SUCCESS (6.041s)
[437.724468] Subtest massive: SUCCESS (6.042s)
[439.402449] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[439.403420] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[439.405297] [127/132] (604s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[442.905073] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[442.908274] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[442.969873] [FACT syncobj_wait (invalid-multi-wait-unsubmitted-submitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[442.972254] [FACT syncobj_wait (invalid-multi-wait-unsubmitted-submitted)] new: kernel.kmod_is_loaded.i915: true
[442.975301] [128/132] (601s left) gen7_exec_parse (basic-allocation)
[443.066739] Subtest basic-allocation: SKIP (0.000s)
[443.153976] [129/132] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[444.674427] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[444.676158] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[444.815247] [130/132] (599s left) gem_exec_balancer (hang)
[445.235168] Starting subtest: hang
[448.667792] Subtest hang: SUCCESS (3.434s)
[448.819241] [131/132] (595s left) kms_pm_rpm (system-suspend-idle)
[452.483679] Starting subtest: system-suspend-idle
[473.805886] Subtest system-suspend-idle: SUCCESS (7.094s)
[480.699073] [132/132] (569s left) gem_pxp (hw-rejects-pxp-context)
[483.310329] Starting subtest: hw-rejects-pxp-context
[483.312600] Subtest hw-rejects-pxp-context: SUCCESS (0.003s)
[483.437516] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: gem_ctx_isolation
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_ctx_exec
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: drm_read
results: parsing output: 27/ for test: gem_set_tiling_vs_blt
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_spin_batch
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_pipe_b_c_ivb
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_dirtyfb
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_concurrent
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: gem_flink_basic
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: vgem_basic
results: parsing output: 71/ for test: i915_pm_freq_api
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_plane_cursor
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_chamelium_frames
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_fenced_exec_thrash
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_joiner
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gen7_exec_parse
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: gem_pxp
Done.