[63.104640] Initializing watchdogs
[63.104705]   /dev/watchdog0
[63.125931] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.136237] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.140411] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.142696] [001/133] (960s left) gem_mmap_wc (write-read-distinct)
[63.218040] Subtest write-read-distinct: SKIP (0.000s)
[63.292009] [002/133] (960s left) kms_properties (crtc-properties-legacy)
[63.468924] Starting subtest: crtc-properties-legacy
[63.469860] Starting dynamic subtest: pipe-A-DP-3
[63.824313] Dynamic subtest pipe-A-DP-3: SUCCESS (0.364s)
[63.833628] Starting dynamic subtest: pipe-B-DP-3
[64.169006] Dynamic subtest pipe-B-DP-3: SUCCESS (0.354s)
[64.177648] Starting dynamic subtest: pipe-C-DP-3
[64.513237] Dynamic subtest pipe-C-DP-3: SUCCESS (0.352s)
[64.522222] Starting dynamic subtest: pipe-D-DP-3
[64.860279] Dynamic subtest pipe-D-DP-3: SUCCESS (0.355s)
[64.861271] Subtest crtc-properties-legacy: SUCCESS (1.429s)
[65.133341] [003/133] (958s left) kms_rotation_crc (multiplane-rotation)
[65.308670] Starting subtest: multiplane-rotation
[94.035844] Subtest multiplane-rotation: SUCCESS (28.895s)
[94.226507] [004/133] (929s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[94.302404] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[94.403518] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[94.515546] [005/133] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[94.702109] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[94.703876] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.834336] [006/133] (929s left) prime_vgem (coherency-blt)
[94.971649] Starting subtest: coherency-blt
[97.284382] Subtest coherency-blt: SUCCESS (2.312s)
[97.442558] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[97.444637] [007/133] (926s left) prime_vgem (basic-fence-flip)
[97.537320] Starting subtest: basic-fence-flip
[97.666992] Subtest basic-fence-flip: SKIP (0.128s)
[97.806761] [008/133] (926s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[98.011727] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[98.014290] Starting dynamic subtest: pipe-A-DP-3
[98.023023] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s)
[98.032944] Starting dynamic subtest: pipe-B-DP-3
[98.040932] Dynamic subtest pipe-B-DP-3: SUCCESS (0.003s)
[98.049649] Starting dynamic subtest: pipe-C-DP-3
[98.057380] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s)
[98.066079] Starting dynamic subtest: pipe-D-DP-3
[98.073590] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[98.074432] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.019s)
[98.495250] [009/133] (925s left) kms_pm_rpm (dpms-non-lpsp)
[100.015816] Starting subtest: dpms-non-lpsp
[100.241573] Subtest dpms-non-lpsp: SUCCESS (0.226s)
[100.483688] [010/133] (923s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[100.568202] Starting subtest: invalid-single-wait-all-unsubmitted
[100.569255] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[100.734648] [011/133] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[100.929717] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[100.931485] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.121515] [012/133] (923s left) gem_mmap_gtt (basic-small-bo-tiledy)
[101.199126] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[101.287302] [013/133] (923s left) kms_flip (busy-flip)
[101.477274] Starting subtest: busy-flip
[101.481564] Starting dynamic subtest: A-DP3
[102.368098] Dynamic subtest A-DP3: SUCCESS (0.886s)
[102.379548] Starting dynamic subtest: B-DP3
[103.139465] Dynamic subtest B-DP3: SUCCESS (0.769s)
[103.152594] Starting dynamic subtest: C-DP3
[103.907516] Dynamic subtest C-DP3: SUCCESS (0.763s)
[103.920669] Starting dynamic subtest: D-DP3
[104.678743] Dynamic subtest D-DP3: SUCCESS (0.766s)
[104.683467] Subtest busy-flip: SUCCESS (3.206s)
[104.973984] [014/133] (919s left) kms_chamelium_edid (hdmi-mode-timings)
[105.250918] Subtest hdmi-mode-timings: SKIP (0.000s)
[105.402410] [015/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[105.599733] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[105.601431] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[105.735198] [016/133] (918s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[105.937147] Starting subtest: stress-xrgb8888-4tiled
[113.997423] Subtest stress-xrgb8888-4tiled: SUCCESS (8.065s)
[114.252364] [017/133] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[114.455032] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[114.456921] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[114.586229] [018/133] (910s left) gem_pxp (verify-pxp-stale-ctx-execution)
[117.196521] Starting subtest: verify-pxp-stale-ctx-execution
[117.198801] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[117.288285] [019/133] (907s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[117.484115] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[117.485917] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[117.641226] [020/133] (907s left) gem_busy (semaphore)
[117.928459] Subtest semaphore: SKIP (0.000s)
[118.184237] [021/133] (906s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[118.378188] Starting subtest: cursor-vs-flip-toggle
[151.779939] Subtest cursor-vs-flip-toggle: SUCCESS (33.401s)
[152.045362] [022/133] (873s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[152.239180] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[152.304270] [023/133] (872s left) gem_eio (wait-10ms)
[152.587180] Starting subtest: wait-10ms
[153.216928] Subtest wait-10ms: SUCCESS (0.630s)
[153.476305] [024/133] (871s left) vgem_basic (bad-handle)
[153.544447] Starting subtest: bad-handle
[153.545419] Subtest bad-handle: SUCCESS (0.000s)
[153.670808] [025/133] (871s left) kms_psr (pr-cursor-plane-move)
[153.865275] Subtest pr-cursor-plane-move: SKIP (0.000s)
[153.922779] [026/133] (871s left) i915_getparams_basic (basic-subslice-total)
[154.004236] Starting subtest: basic-subslice-total
[154.006135] Subtest basic-subslice-total: SUCCESS (0.000s)
[154.141764] [027/133] (871s left) kms_chamelium_hpd (dp-hpd-storm)
[154.403772] Subtest dp-hpd-storm: SKIP (0.000s)
[154.554183] [028/133] (870s left) syncobj_eventfd (timeline-wait)
[154.642741] Starting subtest: timeline-wait
[154.654067] Subtest timeline-wait: SUCCESS (0.011s)
[154.783333] [029/133] (870s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[154.985055] Starting subtest: fbc-2p-pri-indfb-multidraw
[154.986832] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[155.173939] [030/133] (870s left) kms_content_protection (suspend-resume)
[155.430641] Starting subtest: suspend-resume
[155.460025] Starting dynamic subtest: pipe-A-DP-3
[278.540160] Dynamic subtest pipe-A-DP-3: FAIL (122.908s)
[278.541805] Subtest suspend-resume: FAIL (123.039s)
[278.749294] [031/133] (747s left) gem_basic (create-close)
[278.825407] Starting subtest: create-close
[278.827247] Subtest create-close: SUCCESS (0.000s)
[279.026711] [032/133] (746s left) kms_3d (basic)
[279.107248] Starting subtest: basic
[281.071486] Subtest basic: SUCCESS (1.964s)
[281.441950] [033/133] (744s left) kms_dp_link_training (uhbr-mst)
[281.635053] Starting subtest: uhbr-mst
[281.636895] Subtest uhbr-mst: SKIP (0.000s)
[281.783989] [034/133] (744s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[281.986230] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[283.224117] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.237s)
[283.482588] [035/133] (742s left) syncobj_wait (invalid-wait-bad-flags)
[283.564365] Starting subtest: invalid-wait-bad-flags
[283.565450] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[283.776914] [036/133] (742s left) gem_ctx_param (get-priority-new-ctx)
[283.858966] Starting subtest: get-priority-new-ctx
[283.861251] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[284.000655] [037/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[284.200974] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[284.202757] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[284.324387] [038/133] (741s left) kms_setmode (clone-exclusive-crtc)
[284.407592] Starting subtest: clone-exclusive-crtc
[284.410381] Subtest clone-exclusive-crtc: SKIP (0.000s)
[284.575815] [039/133] (741s left) kms_psr (psr2-sprite-plane-onoff)
[284.768248] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[284.835833] [040/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[285.031110] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[288.074869] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.044s)
[288.259988] [041/133] (738s left) kms_flip (blocking-wf_vblank)
[288.451145] Starting subtest: blocking-wf_vblank
[288.454485] Starting dynamic subtest: A-DP3
[296.597688] Dynamic subtest A-DP3: SUCCESS (8.143s)
[296.610697] Starting dynamic subtest: B-DP3
[304.650878] Dynamic subtest B-DP3: SUCCESS (8.051s)
[304.663081] Starting dynamic subtest: C-DP3
[312.700778] Dynamic subtest C-DP3: SUCCESS (8.049s)
[312.713222] Starting dynamic subtest: D-DP3
[320.751775] Dynamic subtest D-DP3: SUCCESS (8.050s)
[320.754148] Subtest blocking-wf_vblank: SUCCESS (32.304s)
[321.087476] [042/133] (705s left) kms_vblank (query-busy-hang)
[321.276468] Starting subtest: query-busy-hang
[321.277428] Starting dynamic subtest: pipe-A-DP-3
[323.856064] Dynamic subtest pipe-A-DP-3: SUCCESS (2.576s)
[323.881797] Starting dynamic subtest: pipe-D-DP-3
[326.299676] Dynamic subtest pipe-D-DP-3: SUCCESS (2.434s)
[326.300636] Subtest query-busy-hang: SUCCESS (5.024s)
[326.538854] [043/133] (700s left) i915_query (query-regions-garbage-items)
[326.619270] Starting subtest: query-regions-garbage-items
[326.620220] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[326.785916] [044/133] (699s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[326.975387] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[326.976119] Starting dynamic subtest: pipe-A
[328.588728] Dynamic subtest pipe-A: SUCCESS (1.614s)
[328.610133] Starting dynamic subtest: pipe-B
[330.301807] Dynamic subtest pipe-B: SUCCESS (1.711s)
[330.318149] Starting dynamic subtest: pipe-C
[330.599982] Dynamic subtest pipe-C: SUCCESS (0.296s)
[330.624865] Starting dynamic subtest: pipe-D
[330.912860] Dynamic subtest pipe-D: SUCCESS (0.311s)
[330.913829] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.939s)
[331.227438] [045/133] (695s left) kms_atomic_transition (modeset-transition-fencing)
[331.418374] Starting subtest: modeset-transition-fencing
[331.419300] Starting dynamic subtest: 1x-outputs
[334.079777] Dynamic subtest 1x-outputs: SUCCESS (2.660s)
[334.084348] Subtest modeset-transition-fencing: SUCCESS (2.664s)
[334.337474] [046/133] (692s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[334.529588] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[334.531393] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[334.638485] [047/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[334.834428] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[334.836175] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[334.948390] [048/133] (692s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[335.147774] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[335.149953] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[335.374508] [049/133] (691s left) gem_exec_schedule (u-semaphore-noskip)
[335.469730] Starting subtest: u-semaphore-noskip
[336.232023] Subtest u-semaphore-noskip: SUCCESS (0.762s)
[336.600436] [050/133] (690s left) device_reset (unbind-reset-rebind)
[336.689502] Starting subtest: unbind-reset-rebind
[339.518435] Subtest unbind-reset-rebind: SUCCESS (2.829s)
[339.580831] [051/133] (687s left) kms_vblank (crtc-id)
[339.774607] Starting subtest: crtc-id
[339.777216] Starting dynamic subtest: pipe-A-DP-3
[340.174978] Dynamic subtest pipe-A-DP-3: SUCCESS (0.397s)
[340.195126] Starting dynamic subtest: pipe-D-DP-3
[340.488203] Dynamic subtest pipe-D-DP-3: SUCCESS (0.309s)
[340.489148] Subtest crtc-id: SUCCESS (0.714s)
[340.732099] [052/133] (686s left) gem_ctx_param (invalid-param-get)
[340.812900] Starting subtest: invalid-param-get
[340.815224] Subtest invalid-param-get: SUCCESS (0.002s)
[340.984112] [053/133] (686s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[341.176463] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[341.177426] Starting dynamic subtest: pipe-A-DP-3
[341.186158] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[341.197585] Starting dynamic subtest: pipe-B-DP-3
[341.206133] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[341.217336] Starting dynamic subtest: pipe-C-DP-3
[341.225741] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[341.237077] Starting dynamic subtest: pipe-D-DP-3
[341.246989] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[341.248977] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[341.604421] [054/133] (685s left) gem_exec_balancer (individual)
[341.697037] Starting subtest: individual
[343.809625] Subtest individual: SUCCESS (2.112s)
[344.235361] [055/133] (683s left) kms_cursor_edge_walk (64x64-top-bottom)
[344.429411] Starting subtest: 64x64-top-bottom
[344.430307] Starting dynamic subtest: pipe-A-DP-3
[347.902274] Dynamic subtest pipe-A-DP-3: SUCCESS (3.473s)
[347.920881] Starting dynamic subtest: pipe-D-DP-3
[351.230571] Dynamic subtest pipe-D-DP-3: SUCCESS (3.325s)
[351.231594] Subtest 64x64-top-bottom: SUCCESS (6.803s)
[351.475434] [056/133] (676s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[351.678484] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[352.960739] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.269s)
[353.173960] [057/133] (674s left) kms_cursor_crc (cursor-onscreen-max-size)
[353.689420] Starting subtest: cursor-onscreen-max-size
[353.692242] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[353.936625] [058/133] (673s left) perf (disabled-read-error)
[354.306574] Starting subtest: disabled-read-error
[354.343974] Subtest disabled-read-error: SUCCESS (0.037s)
[354.397617] [059/133] (673s left) gem_exec_reloc (basic-active)
[354.484424] Subtest basic-active: SKIP (0.000s)
[354.561087] [060/133] (673s left) kms_invalid_mode (bad-hsync-end)
[354.750205] Starting subtest: bad-hsync-end
[354.751158] Starting dynamic subtest: pipe-A-DP-3
[354.822917] Dynamic subtest pipe-A-DP-3: SUCCESS (0.070s)
[354.836607] Starting dynamic subtest: pipe-B-DP-3
[354.837768] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[354.850937] Starting dynamic subtest: pipe-C-DP-3
[354.852205] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[354.865039] Starting dynamic subtest: pipe-D-DP-3
[354.865980] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[354.866931] Subtest bad-hsync-end: SUCCESS (0.080s)
[355.065921] [061/133] (672s left) gem_pipe_control_store_loop (reused-buffer)
[355.157952] Starting subtest: reused-buffer
[357.337328] Subtest reused-buffer: SUCCESS (2.179s)
[357.520127] [062/133] (670s left) kms_chamelium_audio (hdmi-audio)
[357.782565] Subtest hdmi-audio: SKIP (0.000s)
[357.939155] [063/133] (670s left) perf_pmu (render-node-busy-idle)
[358.049853] Starting subtest: render-node-busy-idle
[358.050787] Starting dynamic subtest: rcs0
[358.760976] Dynamic subtest rcs0: SUCCESS (0.709s)
[358.780040] Starting dynamic subtest: bcs0
[359.422816] Dynamic subtest bcs0: SUCCESS (0.656s)
[359.441572] Starting dynamic subtest: vcs0
[360.089965] Dynamic subtest vcs0: SUCCESS (0.661s)
[360.112306] Starting dynamic subtest: vcs1
[360.757933] Dynamic subtest vcs1: SUCCESS (0.661s)
[360.776799] Starting dynamic subtest: vecs0
[361.422751] Dynamic subtest vecs0: SUCCESS (0.659s)
[361.441832] Starting dynamic subtest: vecs1
[362.087086] Dynamic subtest vecs1: SUCCESS (0.659s)
[362.136342] Starting dynamic subtest: ccs0
[362.767765] Dynamic subtest ccs0: SUCCESS (0.675s)
[362.775384] Subtest render-node-busy-idle: SUCCESS (4.720s)
[362.934744] [064/133] (665s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[363.138494] Starting subtest: basic-flip-after-cursor-atomic
[364.166609] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.029s)
[364.434411] [065/133] (663s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[364.520209] Subtest writes-after-reads: SKIP (0.000s)
[364.582582] [066/133] (663s left) kms_psr (fbc-pr-cursor-render)
[364.773241] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[364.833320] [067/133] (663s left) kms_psr (fbc-psr2-no-drrs)
[365.021584] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[365.082737] [068/133] (663s left) i915_drm_fdinfo (memory-info-resident)
[365.156787] Starting subtest: memory-info-resident
[365.157738] Starting dynamic subtest: lmem0
[368.675655] Dynamic subtest lmem0: SUCCESS (3.518s)
[368.690237] Starting dynamic subtest: smem0
[372.655992] Dynamic subtest smem0: SUCCESS (3.979s)
[372.657067] Subtest memory-info-resident: SUCCESS (7.499s)
[372.753519] [069/133] (655s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[372.944989] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[372.947484] Starting dynamic subtest: pipe-A-DP-3
[372.956084] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[372.968588] Starting dynamic subtest: pipe-B-DP-3
[372.977416] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[372.989712] Starting dynamic subtest: pipe-C-DP-3
[372.998100] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[373.010559] Starting dynamic subtest: pipe-D-DP-3
[373.021386] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[373.023430] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.010s)
[373.416929] [070/133] (655s left) kms_vblank (wait-busy)
[373.604526] Starting subtest: wait-busy
[373.606970] Starting dynamic subtest: pipe-A-DP-3
[376.127513] Dynamic subtest pipe-A-DP-3: SUCCESS (2.520s)
[376.148512] Starting dynamic subtest: pipe-D-DP-3
[378.557231] Dynamic subtest pipe-D-DP-3: SUCCESS (2.423s)
[378.558230] Subtest wait-busy: SUCCESS (4.953s)
[378.795535] [071/133] (649s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[378.990990] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[378.992750] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[379.142935] [072/133] (649s left) gem_exercise_blt (fast-copy-emit)
[379.228995] Starting subtest: fast-copy-emit
[379.229962] Starting dynamic subtest: linear-smem-smem-emit
[379.273821] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.044s)
[379.287791] Starting dynamic subtest: linear-smem-lmem0-emit
[379.289260] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.014s)
[379.303232] Starting dynamic subtest: linear-lmem0-smem-emit
[379.387133] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.097s)
[379.401281] Starting dynamic subtest: linear-lmem0-lmem0-emit
[379.486933] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.098s)
[379.501018] Starting dynamic subtest: xmajor-smem-smem-emit
[379.503187] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.015s)
[379.517148] Starting dynamic subtest: xmajor-smem-lmem0-emit
[379.518149] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.013s)
[379.530627] Starting dynamic subtest: xmajor-lmem0-smem-emit
[379.618977] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.100s)
[379.633207] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[379.717424] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.097s)
[379.731370] Starting dynamic subtest: tile4-smem-smem-emit
[379.734269] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[379.748420] Starting dynamic subtest: tile4-smem-lmem0-emit
[379.749448] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[379.763584] Starting dynamic subtest: tile4-lmem0-smem-emit
[379.857200] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.106s)
[379.870795] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[379.953902] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.096s)
[379.967776] Starting dynamic subtest: tile64-smem-smem-emit
[379.969152] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.014s)
[379.983138] Starting dynamic subtest: tile64-smem-lmem0-emit
[379.984364] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[379.998276] Starting dynamic subtest: tile64-lmem0-smem-emit
[380.084577] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.099s)
[380.098494] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[380.187711] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.102s)
[380.188593] Subtest fast-copy-emit: SUCCESS (0.960s)
[380.323973] [073/133] (648s left) gem_ringfill (engines-basic)
[380.799164] Starting subtest: engines-basic
[380.800975] Starting dynamic subtest: rcs0
[380.900233] Dynamic subtest rcs0: SUCCESS (0.104s)
[380.915151] Starting dynamic subtest: bcs0
[380.941352] Dynamic subtest bcs0: SUCCESS (0.040s)
[380.961169] Starting dynamic subtest: vcs0
[380.984584] Dynamic subtest vcs0: SUCCESS (0.042s)
[381.006676] Starting dynamic subtest: vcs1
[381.029699] Dynamic subtest vcs1: SUCCESS (0.043s)
[381.052434] Starting dynamic subtest: vecs0
[381.072754] Dynamic subtest vecs0: SUCCESS (0.041s)
[381.095234] Starting dynamic subtest: vecs1
[381.116297] Dynamic subtest vecs1: SUCCESS (0.042s)
[381.135767] Starting dynamic subtest: ccs0
[381.158302] Dynamic subtest ccs0: SUCCESS (0.040s)
[381.159349] Subtest engines-basic: SUCCESS (0.365s)
[381.267645] [074/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[381.467584] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[381.469281] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.640068] [075/133] (647s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[381.838486] Starting subtest: 2x-flip-vs-cursor-legacy
[381.840273] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[381.998433] [076/133] (647s left) perf (gen12-group-exclusive-stream-sample-oa)
[382.217591] Starting subtest: gen12-group-exclusive-stream-sample-oa
[382.240224] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[382.297669] [077/133] (646s left) api_intel_bb (lot-of-buffers)
[382.379560] Starting subtest: lot-of-buffers
[385.672570] Subtest lot-of-buffers: SUCCESS (3.292s)
[385.873525] [078/133] (643s left) gen9_exec_parse (bb-oversize)
[385.960304] Subtest bb-oversize: SKIP (0.000s)
[386.043954] [079/133] (643s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[386.233477] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[386.234397] Starting dynamic subtest: pipe-A-valid-mode
[388.679229] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.445s)
[388.684451] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.448s)
[388.944800] [080/133] (640s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[389.135499] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[389.136405] Starting dynamic subtest: pipe-A-DP-3
[392.618627] Dynamic subtest pipe-A-DP-3: SUCCESS (3.465s)
[392.647943] Starting dynamic subtest: pipe-B-DP-3
[393.216764] Dynamic subtest pipe-B-DP-3: SUCCESS (0.589s)
[393.245424] Starting dynamic subtest: pipe-C-DP-3
[393.816894] Dynamic subtest pipe-C-DP-3: SUCCESS (0.593s)
[393.846592] Starting dynamic subtest: pipe-D-DP-3
[394.412923] Dynamic subtest pipe-D-DP-3: SUCCESS (0.588s)
[394.414759] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.264s)
[394.722937] [081/133] (634s left) gem_lmem_swapping (verify-random-ccs)
[397.293829] Starting subtest: verify-random-ccs
[397.294858] Starting dynamic subtest: lmem0
[401.736150] Dynamic subtest lmem0: SUCCESS (4.441s)
[401.737238] Subtest verify-random-ccs: SUCCESS (4.443s)
[402.805934] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[402.807242] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[402.809404] [082/133] (626s left) api_intel_allocator (gem-pool)
[404.401352] Starting subtest: gem-pool
[404.455924] Subtest gem-pool: SUCCESS (0.055s)
[404.573022] [FACT api_intel_allocator (gem-pool)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[404.575705] [FACT api_intel_allocator (gem-pool)] new: kernel.kmod_is_loaded.i915: true
[404.578564] [083/133] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[404.775860] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[404.777576] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[404.932250] [084/133] (624s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[405.123581] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[405.192612] [085/133] (624s left) vgem_basic (second-client)
[405.247450] Starting subtest: second-client
[405.280598] Subtest second-client: SUCCESS (0.033s)
[405.401602] [086/133] (624s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[405.594772] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[405.610299] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.015s)
[405.799177] [087/133] (624s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[406.002139] Starting subtest: x-tiled-16bpp-rotate-180
[407.831023] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.828s)
[408.070136] [088/133] (621s left) gem_userptr_blits (invalid-null-pointer)
[408.167452] Starting subtest: invalid-null-pointer
[408.168361] Subtest invalid-null-pointer: SUCCESS (0.002s)
[408.337088] [089/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[408.532372] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[408.534180] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[408.675909] [090/133] (621s left) kms_draw_crc (draw-method-mmap-cpu)
[408.872464] Starting subtest: draw-method-mmap-cpu
[408.873419] Starting dynamic subtest: xrgb8888-untiled
[409.196552] Dynamic subtest xrgb8888-untiled: SUCCESS (0.324s)
[409.214434] Starting dynamic subtest: rgb565-untiled
[409.514332] Dynamic subtest rgb565-untiled: SUCCESS (0.315s)
[409.560028] Starting dynamic subtest: xrgb2101010-untiled
[409.831068] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.311s)
[409.877316] Starting dynamic subtest: xbgr16161616f-untiled
[410.146383] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.311s)
[410.160262] Starting dynamic subtest: xrgb8888-xtiled
[410.296908] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s)
[410.319497] Starting dynamic subtest: rgb565-xtiled
[410.465691] Dynamic subtest rgb565-xtiled: SUCCESS (0.165s)
[410.509229] Starting dynamic subtest: xrgb2101010-xtiled
[410.647023] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.176s)
[410.692620] Starting dynamic subtest: xbgr16161616f-xtiled
[410.829791] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[410.843344] Starting dynamic subtest: xrgb8888-4tiled
[410.997984] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[411.018202] Starting dynamic subtest: rgb565-4tiled
[411.164569] Dynamic subtest rgb565-4tiled: SUCCESS (0.161s)
[411.209122] Starting dynamic subtest: xrgb2101010-4tiled
[411.347072] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.177s)
[411.361774] Starting dynamic subtest: xbgr16161616f-4tiled
[411.496923] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.147s)
[411.500945] Subtest draw-method-mmap-cpu: SUCCESS (2.626s)
[411.687925] [091/133] (618s left) kms_lease (lease-invalid-crtc)
[411.877492] Starting subtest: lease-invalid-crtc
[411.878403] Starting dynamic subtest: pipe-A-DP-3
[411.879285] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[411.890366] Starting dynamic subtest: pipe-B-DP-3
[411.891495] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[411.902446] Starting dynamic subtest: pipe-C-DP-3
[411.903625] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[411.914505] Starting dynamic subtest: pipe-D-DP-3
[411.915752] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[411.916915] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[412.026918] [092/133] (618s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[412.216468] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[412.247172] Starting dynamic subtest: pipe-A-plane-0
[412.964484] Dynamic subtest pipe-A-plane-0: SUCCESS (0.716s)
[413.010748] Starting dynamic subtest: pipe-A-plane-3
[413.463490] Dynamic subtest pipe-A-plane-3: SUCCESS (0.494s)
[413.755574] Starting dynamic subtest: pipe-B-plane-0
[414.266222] Dynamic subtest pipe-B-plane-0: SUCCESS (0.533s)
[414.290716] Starting dynamic subtest: pipe-B-plane-3
[414.749401] Dynamic subtest pipe-B-plane-3: SUCCESS (0.481s)
[414.873389] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.657s)
[415.155945] [093/133] (615s left) gen7_exec_parse (basic-allowed)
[415.248406] Subtest basic-allowed: SKIP (0.000s)
[415.328624] [094/133] (615s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[415.433911] Starting subtest: multi-wait-available-unsubmitted-signaled
[415.441262] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.004s)
[415.603065] [095/133] (614s left) gem_workarounds (suspend-resume-context)
[415.703479] Starting subtest: suspend-resume-context
[434.669220] Subtest suspend-resume-context: SUCCESS (3.692s)
[454.839310] [096/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[455.034702] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[455.036439] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[455.174740] [097/133] (595s left) syncobj_timeline (wait-all-delayed-signal)
[455.254607] Starting subtest: wait-all-delayed-signal
[455.356658] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[455.487513] [098/133] (595s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[455.858382] Starting subtest: cursor-rapid-movement-128x128
[455.862612] Starting dynamic subtest: pipe-A-DP-3
[456.333389] Dynamic subtest pipe-A-DP-3: SUCCESS (0.473s)
[456.384036] Starting dynamic subtest: pipe-D-DP-3
[456.792371] Dynamic subtest pipe-D-DP-3: SUCCESS (0.423s)
[456.793350] Subtest cursor-rapid-movement-128x128: SUCCESS (0.940s)
[457.260226] [099/133] (593s left) prime_mmap_coherency (write)
[457.346629] Starting subtest: write
[462.746036] Subtest write: SUCCESS (5.422s)
[462.887950] [100/133] (587s left) gem_softpin (zero)
[462.973515] Starting subtest: zero
[462.979955] Subtest zero: SUCCESS (0.006s)
[463.120919] [101/133] (587s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[463.317552] Starting subtest: psr-farfromfence-mmap-gtt
[463.319278] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[463.463291] [102/133] (587s left) kms_psr (fbc-psr-cursor-plane-onoff)
[463.655959] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[463.716080] [103/133] (587s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[463.914680] Starting subtest: primary-yf-tiled-reflect-x-0
[464.018477] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.102s)
[464.186966] [104/133] (586s left) gem_mmap_gtt (zero-extend)
[464.266474] Subtest zero-extend: SKIP (0.000s)
[464.348898] [105/133] (586s left) gem_exec_fence (basic-busy)
[464.557830] Starting subtest: basic-busy
[464.559039] Starting dynamic subtest: rcs0
[464.682205] Dynamic subtest rcs0: SUCCESS (0.123s)
[464.701160] Starting dynamic subtest: bcs0
[464.730701] Dynamic subtest bcs0: SUCCESS (0.046s)
[464.752052] Starting dynamic subtest: vcs0
[464.786060] Dynamic subtest vcs0: SUCCESS (0.054s)
[464.819701] Starting dynamic subtest: vcs1
[464.842357] Dynamic subtest vcs1: SUCCESS (0.054s)
[464.866140] Starting dynamic subtest: vecs0
[464.895822] Dynamic subtest vecs0: SUCCESS (0.052s)
[464.918903] Starting dynamic subtest: vecs1
[464.949043] Dynamic subtest vecs1: SUCCESS (0.051s)
[464.978727] Starting dynamic subtest: ccs0
[465.003747] Dynamic subtest ccs0: SUCCESS (0.053s)
[465.004797] Subtest basic-busy: SUCCESS (0.448s)
[465.739314] [106/133] (585s left) gem_ctx_persistence (engines-mixed-process)
[465.828548] Starting subtest: engines-mixed-process
[465.829516] Starting dynamic subtest: rcs0
[467.180261] Dynamic subtest rcs0: SUCCESS (1.354s)
[467.199624] Starting dynamic subtest: bcs0
[469.165686] Dynamic subtest bcs0: SUCCESS (1.987s)
[469.182399] Starting dynamic subtest: vcs0
[471.146758] Dynamic subtest vcs0: SUCCESS (1.982s)
[471.163645] Starting dynamic subtest: vcs1
[473.130707] Dynamic subtest vcs1: SUCCESS (1.985s)
[473.146979] Starting dynamic subtest: vecs0
[475.175348] Dynamic subtest vecs0: SUCCESS (2.045s)
[475.191773] Starting dynamic subtest: vecs1
[477.163506] Dynamic subtest vecs1: SUCCESS (1.988s)
[477.179710] Starting dynamic subtest: ccs0
[479.146891] Dynamic subtest ccs0: SUCCESS (1.983s)
[479.148019] Subtest engines-mixed-process: SUCCESS (13.337s)
[479.322129] [107/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[479.516161] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[479.517897] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[479.657055] [108/133] (571s left) gem_exec_whisper (basic-normal-all)
[479.748447] Starting subtest: basic-normal-all
[482.168046] Subtest basic-normal-all: SUCCESS (2.420s)
[482.414466] [109/133] (569s left) syncobj_timeline (invalid-signal-illegal-handle)
[482.493626] Starting subtest: invalid-signal-illegal-handle
[482.494581] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[482.665657] [110/133] (568s left) gem_ctx_engines (execute-one)
[482.756770] Starting subtest: execute-one
[486.284120] Subtest execute-one: SUCCESS (3.530s)
[486.576047] [111/133] (565s left) gem_exec_fence (syncobj-invalid-flags)
[487.098568] Starting subtest: syncobj-invalid-flags
[487.099581] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[487.531946] [112/133] (564s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[487.728415] Starting subtest: psr-rgb101010-draw-mmap-cpu
[487.730116] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[487.865497] [113/133] (563s left) kms_plane_lowres (tiling-yf)
[488.051924] Starting subtest: tiling-yf
[488.053704] Subtest tiling-yf: SKIP (0.000s)
[488.146622] [114/133] (563s left) gem_exec_schedule (pi-shared-iova)
[488.385606] Starting subtest: pi-shared-iova
[488.389968] Starting dynamic subtest: rcs0
[488.660020] Dynamic subtest rcs0: SUCCESS (0.273s)
[488.674484] Starting dynamic subtest: bcs0
[488.840632] Dynamic subtest bcs0: SUCCESS (0.180s)
[488.855525] Starting dynamic subtest: vcs0
[489.030000] Dynamic subtest vcs0: SUCCESS (0.188s)
[489.044412] Starting dynamic subtest: vcs1
[489.219956] Dynamic subtest vcs1: SUCCESS (0.189s)
[489.234284] Starting dynamic subtest: vecs0
[489.412137] Dynamic subtest vecs0: SUCCESS (0.191s)
[489.426580] Starting dynamic subtest: vecs1
[489.602977] Dynamic subtest vecs1: SUCCESS (0.190s)
[489.617307] Starting dynamic subtest: ccs0
[489.790718] Dynamic subtest ccs0: SUCCESS (0.187s)
[489.791636] Subtest pi-shared-iova: SUCCESS (1.407s)
[490.161978] [115/133] (561s left) kms_color (ctm-0-50)
[490.352098] Starting subtest: ctm-0-50
[490.353030] Starting dynamic subtest: pipe-A-DP-3
[492.094211] Dynamic subtest pipe-A-DP-3: SUCCESS (1.741s)
[492.119326] Starting dynamic subtest: pipe-B-DP-3
[493.733735] Dynamic subtest pipe-B-DP-3: SUCCESS (1.639s)
[493.753800] Starting dynamic subtest: pipe-C-DP-3
[495.386321] Dynamic subtest pipe-C-DP-3: SUCCESS (1.652s)
[495.401696] Starting dynamic subtest: pipe-D-DP-3
[497.090268] Dynamic subtest pipe-D-DP-3: SUCCESS (1.704s)
[497.091340] Subtest ctm-0-50: SUCCESS (6.743s)
[497.377581] [116/133] (554s left) kms_big_fb (yf-tiled-addfb)
[497.581430] Starting subtest: yf-tiled-addfb
[497.583321] Subtest yf-tiled-addfb: SKIP (0.000s)
[497.779598] [117/133] (554s left) syncobj_wait (wait-any-snapshot)
[497.862641] Starting subtest: wait-any-snapshot
[497.945040] Subtest wait-any-snapshot: SUCCESS (0.082s)
[498.130242] [118/133] (554s left) gem_ctx_persistence (processes)
[498.218193] Starting subtest: processes
[500.202489] Subtest processes: SUCCESS (1.985s)
[500.309876] [119/133] (551s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[500.504611] Starting subtest: plane-all-modeset-transition-internal-panels
[500.506369] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[500.617579] [120/133] (551s left) kms_plane (pixel-format-y-tiled-modifier)
[500.816763] Starting subtest: pixel-format-y-tiled-modifier
[500.818483] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[500.910636] [121/133] (551s left) kms_addfb_basic (small-bo)
[501.107501] Starting subtest: small-bo
[501.108375] Subtest small-bo: SUCCESS (0.000s)
[501.313987] [122/133] (551s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[501.507242] Starting subtest: fbc-rgb101010-draw-mmap-wc
[501.509077] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[501.640181] [123/133] (550s left) sw_sync (alloc_merge_fence)
[501.691544] Starting subtest: alloc_merge_fence
[501.692494] Subtest alloc_merge_fence: SUCCESS (0.000s)
[501.774041] [124/133] (550s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[501.857919] Starting subtest: wait-all-for-submit-delayed-submit
[501.960209] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[502.066187] [125/133] (550s left) kms_big_fb (4-tiled-addfb-size-overflow)
[502.268738] Starting subtest: 4-tiled-addfb-size-overflow
[502.271302] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.002s)
[502.423596] [126/133] (550s left) kms_prime (basic-crc-vgem)
[502.620620] Subtest basic-crc-vgem: SKIP (0.000s)
[502.853563] [127/133] (549s left) perf (invalid-open-flags)
[503.226107] Starting subtest: invalid-open-flags
[503.227074] Subtest invalid-open-flags: SUCCESS (0.000s)
[503.292602] [128/133] (549s left) gem_close_race (basic-process)
[503.412845] Starting subtest: basic-process
[503.482730] Subtest basic-process: SUCCESS (0.070s)
[503.739477] [129/133] (549s left) gem_ctx_sseu (mmap-args)
[503.826651] Subtest mmap-args: SKIP (0.000s)
[503.907095] [130/133] (549s left) gem_ppgtt (shrink-vs-evict-pinned)
[503.996887] Starting subtest: shrink-vs-evict-pinned
[509.172676] Subtest shrink-vs-evict-pinned: SUCCESS (5.170s)
[509.318615] [131/133] (543s left) kms_busy (extended-modeset-hang-oldfb)
[509.516480] Starting subtest: extended-modeset-hang-oldfb
[509.517373] Starting dynamic subtest: pipe-A
[517.636740] Dynamic subtest pipe-A: SUCCESS (8.114s)
[517.666620] Starting dynamic subtest: pipe-D
[525.731252] Dynamic subtest pipe-D: SUCCESS (8.085s)
[525.735074] Subtest extended-modeset-hang-oldfb: SUCCESS (16.211s)
[526.020210] [132/133] (527s left) i915_pm_rc6_residency (rc6-accuracy)
[526.101888] Starting subtest: rc6-accuracy
[526.103091] Starting dynamic subtest: gt0
[529.304696] Dynamic subtest gt0: FAIL (3.181s)
[529.305804] Subtest rc6-accuracy: FAIL (3.182s)
[529.403093] [133/133] (523s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[529.594891] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[529.596654] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[529.687582] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: prime_vgem
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_chamelium_edid
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pipe_stress
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_busy
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: i915_getparams_basic
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: gem_basic
results: parsing output: 31/ for test: kms_3d
results: parsing output: 32/ for test: kms_dp_link_training
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_setmode
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: i915_query
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: device_reset
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: gem_pipe_control_store_loop
results: parsing output: 61/ for test: kms_chamelium_audio
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exercise_blt
results: parsing output: 72/ for test: gem_ringfill
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_draw_crc
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gen7_exec_parse
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: prime_mmap_coherency
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_ctx_engines
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_lowres
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_prime
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: gem_close_race
results: parsing output: 128/ for test: gem_ctx_sseu
results: parsing output: 129/ for test: gem_ppgtt
results: parsing output: 130/ for test: kms_busy
results: parsing output: 131/ for test: i915_pm_rc6_residency
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.