[67.373609] Initializing watchdogs
[67.373691]   /dev/watchdog0
[67.405843] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.421253] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.426248] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.429414] [001/156] (960s left) gem_render_copy (y-tiled-to-vebox-linear)
[67.494371] Starting subtest: y-tiled-to-vebox-linear
[67.495968] Starting dynamic subtest: smem
[67.580191] Dynamic subtest smem: SUCCESS (0.087s)
[67.589367] Starting dynamic subtest: lmem0
[67.715959] Dynamic subtest lmem0: SUCCESS (0.132s)
[67.717856] Subtest y-tiled-to-vebox-linear: SUCCESS (0.220s)
[67.990817] [002/156] (960s left) gem_exec_flush (basic-uc-pro-default)
[68.050336] Subtest basic-uc-pro-default: SKIP (0.000s)
[68.155992] [003/156] (959s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[69.647762] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[69.651227] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[69.861125] [004/156] (958s left) syncobj_timeline (single-wait-all-signaled)
[69.911352] Starting subtest: single-wait-all-signaled
[69.913074] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[70.031237] [005/156] (958s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[71.533484] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[71.536753] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[71.915244] [006/156] (956s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[73.443579] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[73.447226] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.630567] [007/156] (954s left) gem_mmap_gtt (fault-concurrent-y)
[73.681134] Subtest fault-concurrent-Y: SKIP (0.000s)
[73.748162] [008/156] (954s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[75.246138] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[75.249666] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[75.427284] [009/156] (953s left) vgem_basic (dmabuf-fence-before)
[75.541763] Starting subtest: dmabuf-fence-before
[75.543459] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[75.639234] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[75.642969] [010/156] (953s left) kms_async_flips (test-time-stamp-atomic)
[77.133477] Starting subtest: test-time-stamp-atomic
[77.371677] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.785938] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.413s)
[77.991043] Starting dynamic subtest: pipe-B-HDMI-A-1
[78.099292] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.115s)
[78.284400] Starting dynamic subtest: pipe-C-HDMI-A-1
[78.405034] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.127s)
[78.583926] Starting dynamic subtest: pipe-D-HDMI-A-1
[78.697670] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.120s)
[78.699319] Subtest test-time-stamp-atomic: SUCCESS (1.563s)
[79.081037] [011/156] (949s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[80.575644] Starting subtest: basic-busy-flip-before-cursor-varying-size
[80.578811] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[80.705495] [012/156] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[82.211765] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[82.214990] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[82.400810] [013/156] (946s left) syncobj_wait (invalid-signal-illegal-handle)
[82.453278] Starting subtest: invalid-signal-illegal-handle
[82.454847] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[82.575652] [014/156] (946s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[84.069475] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[84.147084] [015/156] (945s left) kms_scaling_modes (scaling-mode-center)
[85.640292] Starting subtest: scaling-mode-center
[85.649177] Subtest scaling-mode-center: SKIP (0.001s)
[85.780130] [016/156] (943s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[87.326713] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[87.464232] [017/156] (941s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[88.955977] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[88.958919] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[89.110796] [018/156] (940s left) i915_pm_rpm (gem-execbuf)
[93.055959] Starting subtest: gem-execbuf
[93.057933] Starting dynamic subtest: lmem0
[96.329078] Dynamic subtest lmem0: SUCCESS (3.272s)
[96.383361] Starting dynamic subtest: smem0
[99.417517] Dynamic subtest smem0: SUCCESS (3.091s)
[99.420226] Subtest gem-execbuf: SUCCESS (6.366s)
[100.407993] [019/156] (929s left) kms_cursor_legacy (forked-move)
[101.901544] Starting subtest: forked-move
[101.902960] Starting dynamic subtest: pipe-A
[107.343248] Dynamic subtest pipe-A: SUCCESS (5.436s)
[107.356131] Starting dynamic subtest: pipe-B
[112.774844] Dynamic subtest pipe-B: SUCCESS (5.431s)
[112.794549] Starting dynamic subtest: pipe-C
[118.213146] Dynamic subtest pipe-C: SUCCESS (5.439s)
[118.230869] Starting dynamic subtest: pipe-D
[123.662730] Dynamic subtest pipe-D: SUCCESS (5.449s)
[123.683635] Starting dynamic subtest: all-pipes
[129.107956] Dynamic subtest all-pipes: SUCCESS (5.445s)
[129.109509] Subtest forked-move: SUCCESS (27.203s)
[129.250142] [020/156] (900s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[130.740445] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[130.741844] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.757206] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[130.766905] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.782575] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[130.792325] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.808504] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[130.818272] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.836318] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[130.839488] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[131.008153] [021/156] (898s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[132.497993] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[132.499661] Starting dynamic subtest: pipe-A
[135.045328] Dynamic subtest pipe-A: SUCCESS (2.547s)
[135.058114] Starting dynamic subtest: pipe-B
[137.685434] Dynamic subtest pipe-B: SUCCESS (2.639s)
[137.698108] Starting dynamic subtest: pipe-C
[137.991817] Dynamic subtest pipe-C: SUCCESS (0.305s)
[138.004850] Starting dynamic subtest: pipe-D
[138.299105] Dynamic subtest pipe-D: SUCCESS (0.306s)
[138.300737] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (5.802s)
[138.532599] [022/156] (891s left) i915_hangman (hangcheck-unterminated)
[138.630252] Starting subtest: hangcheck-unterminated
[148.056015] Subtest hangcheck-unterminated: SUCCESS (9.427s)
[148.244954] [023/156] (881s left) gem_exec_suspend (basic-s0)
[148.304149] Starting subtest: basic-S0
[148.305691] Starting dynamic subtest: smem
[168.165400] Dynamic subtest smem: SUCCESS (5.510s)
[168.178497] Starting dynamic subtest: lmem0
[188.146593] Dynamic subtest lmem0: SUCCESS (5.338s)
[188.148213] Subtest basic-S0: SUCCESS (10.850s)
[193.424873] [024/156] (841s left) gem_exec_gttfill (engines)
[193.488462] Starting subtest: engines
[193.489950] Starting dynamic subtest: rcs0
[221.097519] Dynamic subtest rcs0: SUCCESS (27.687s)
[221.110710] Starting dynamic subtest: bcs0
[248.868564] Dynamic subtest bcs0: SUCCESS (27.786s)
[248.881033] Starting dynamic subtest: vcs0
[276.611645] Dynamic subtest vcs0: SUCCESS (27.756s)
[276.624342] Starting dynamic subtest: vcs1
[304.412720] Dynamic subtest vcs1: SUCCESS (27.794s)
[304.425342] Starting dynamic subtest: vecs0
[332.232079] Dynamic subtest vecs0: SUCCESS (27.809s)
[332.233760] Subtest engines: SUCCESS (138.837s)
[332.502235] [025/156] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[334.065291] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[334.069348] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[334.262260] [026/156] (700s left) perf_pmu (render-node-busy)
[334.323724] Starting subtest: render-node-busy
[334.325054] Starting dynamic subtest: rcs0
[334.919848] Dynamic subtest rcs0: SUCCESS (0.596s)
[334.935680] Starting dynamic subtest: bcs0
[335.481362] Dynamic subtest bcs0: SUCCESS (0.559s)
[335.498757] Starting dynamic subtest: vcs0
[336.040427] Dynamic subtest vcs0: SUCCESS (0.555s)
[336.057895] Starting dynamic subtest: vcs1
[336.602630] Dynamic subtest vcs1: SUCCESS (0.558s)
[336.620110] Starting dynamic subtest: vecs0
[337.164426] Dynamic subtest vecs0: SUCCESS (0.558s)
[337.167232] Subtest render-node-busy: SUCCESS (2.842s)
[337.283017] [027/156] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[338.787590] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[338.790902] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[338.963617] [028/156] (696s left) gem_ctx_param (root-set)
[339.010987] Starting subtest: root-set
[339.012421] Subtest root-set: SUCCESS (0.001s)
[339.134452] [029/156] (696s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[340.635408] Starting subtest: fbchdr-rgb101010-draw-pwrite
[340.638424] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[340.844991] [030/156] (694s left) gem_readwrite (write-bad-handle)
[340.895589] Subtest write-bad-handle: SKIP (0.000s)
[340.993821] [031/156] (694s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[341.051565] Starting subtest: yf-tiled-ccs-to-x-tiled
[341.053017] Starting dynamic subtest: smem
[341.151626] Dynamic subtest smem: SUCCESS (0.101s)
[341.165325] Starting dynamic subtest: lmem0
[342.081077] Dynamic subtest lmem0: SUCCESS (0.926s)
[342.082591] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (1.028s)
[342.333336] [032/156] (693s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[343.827542] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[343.914067] [033/156] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[345.461176] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[345.464188] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[345.658390] [034/156] (690s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[347.148264] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[347.150182] Starting dynamic subtest: pipe-A
[347.278296] Dynamic subtest pipe-A: SUCCESS (0.130s)
[347.298054] Starting dynamic subtest: pipe-B
[347.451273] Dynamic subtest pipe-B: SUCCESS (0.172s)
[347.465147] Starting dynamic subtest: pipe-C
[347.609273] Dynamic subtest pipe-C: SUCCESS (0.157s)
[347.623883] Starting dynamic subtest: pipe-D
[347.765917] Dynamic subtest pipe-D: SUCCESS (0.156s)
[347.767248] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.619s)
[347.985454] [035/156] (688s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[349.494766] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[349.497930] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[349.706355] [036/156] (686s left) gem_partial_pwrite_pread (reads-snoop)
[349.760300] Subtest reads-snoop: SKIP (0.000s)
[349.859400] [037/156] (686s left) gem_userptr_blits (map-fixed-invalidate)
[349.924520] Starting subtest: map-fixed-invalidate
[349.927864] Subtest map-fixed-invalidate: SKIP (0.000s)
[350.137867] [038/156] (686s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[351.629583] Starting subtest: nonblocking-crc-frame-sequence
[351.631097] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.414229] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.783s)
[352.429571] Starting dynamic subtest: pipe-B-HDMI-A-1
[352.958083] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.542s)
[352.983129] Starting dynamic subtest: pipe-C-HDMI-A-1
[353.534437] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.575s)
[353.550354] Starting dynamic subtest: pipe-D-HDMI-A-1
[354.115520] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.579s)
[354.117247] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.487s)
[354.313013] [039/156] (682s left) gen3_render_tiledx_blits
[354.457058] [040/156] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[355.959335] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[355.965198] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[356.173666] [041/156] (680s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[357.673357] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[357.676876] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[357.876365] [042/156] (678s left) kms_psr (psr-cursor-plane-move)
[359.371037] Subtest psr-cursor-plane-move: SKIP (0.000s)
[359.467832] [043/156] (677s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[360.993123] Starting subtest: 4-tiled-addfb-size-offset-overflow
[360.996581] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[361.177052] [044/156] (675s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[362.678164] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[362.681592] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.876115] [045/156] (674s left) dumb_buffer (map-invalid-size)
[362.927837] Starting subtest: map-invalid-size
[362.929608] Subtest map-invalid-size: SUCCESS (0.000s)
[363.093149] [046/156] (674s left) kms_chamelium_frames (dp-frame-dump)
[364.633971] Subtest dp-frame-dump: SKIP (0.000s)
[364.767470] [047/156] (672s left) syncobj_wait (single-wait-all-signaled)
[364.828681] Starting subtest: single-wait-all-signaled
[364.830471] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[364.943551] [048/156] (672s left) kms_big_fb (linear-8bpp-rotate-270)
[366.452611] Starting subtest: linear-8bpp-rotate-270
[366.551354] Subtest linear-8bpp-rotate-270: SKIP (0.097s)
[366.705161] [049/156] (670s left) kms_flip (plain-flip-interruptible)
[368.201991] Starting subtest: plain-flip-interruptible
[368.207270] Starting dynamic subtest: A-HDMI-A1
[369.093146] Dynamic subtest A-HDMI-A1: SUCCESS (0.886s)
[369.115169] Starting dynamic subtest: B-HDMI-A1
[369.787847] Dynamic subtest B-HDMI-A1: SUCCESS (0.693s)
[369.804301] Starting dynamic subtest: C-HDMI-A1
[370.482881] Dynamic subtest C-HDMI-A1: SUCCESS (0.692s)
[370.501349] Starting dynamic subtest: D-HDMI-A1
[371.176032] Dynamic subtest D-HDMI-A1: SUCCESS (0.689s)
[371.180058] Subtest plain-flip-interruptible: SUCCESS (2.978s)
[371.442689] [050/156] (666s left) gen9_exec_parse (unaligned-jump)
[371.498610] Subtest unaligned-jump: SKIP (0.000s)
[371.579159] [051/156] (666s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[371.633181] Starting subtest: saturated-hostile-nopreempt
[371.634573] Starting dynamic subtest: rcs0
[372.438105] Dynamic subtest rcs0: SUCCESS (0.805s)
[372.455546] Starting dynamic subtest: bcs0
[373.222083] Dynamic subtest bcs0: SUCCESS (0.783s)
[373.237870] Starting dynamic subtest: vcs0
[374.014920] Dynamic subtest vcs0: SUCCESS (0.789s)
[374.029231] Starting dynamic subtest: vcs1
[374.804861] Dynamic subtest vcs1: SUCCESS (0.788s)
[374.818898] Starting dynamic subtest: vecs0
[375.580722] Dynamic subtest vecs0: SUCCESS (0.776s)
[375.582447] Subtest saturated-hostile-nopreempt: SUCCESS (3.949s)
[375.735462] [052/156] (661s left) gem_gpgpu_fill (offset-16x16)
[375.787348] Starting subtest: offset-16x16
[375.806567] Subtest offset-16x16: SUCCESS (0.020s)
[375.985581] [053/156] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[377.483481] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[380.230953] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.750s)
[380.494012] [054/156] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[381.991880] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[381.995005] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.159795] [055/156] (655s left) kms_pm_rpm (package-g7)
[385.971396] Starting subtest: package-g7
[385.975052] Subtest package-g7: SKIP (0.000s)
[386.927937] [056/156] (651s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[388.447593] Starting subtest: yf-tiled-16bpp-rotate-270
[388.450736] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[388.620787] [057/156] (649s left) gem_exec_reloc (basic-write-wc-active)
[388.676557] Subtest basic-write-wc-active: SKIP (0.000s)
[388.787014] [058/156] (649s left) gem_exec_fence (submit3)
[389.010262] Starting subtest: submit3
[389.014190] Subtest submit3: SKIP (0.000s)
[389.664625] [059/156] (648s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[391.164669] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[391.168334] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[391.407071] [060/156] (647s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[392.907303] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[392.910698] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[393.092083] [061/156] (645s left) gem_pread (display)
[393.142408] Subtest display: SKIP (0.000s)
[393.238491] [062/156] (645s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[394.757585] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[394.760904] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[394.981419] [063/156] (643s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[396.479242] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[396.482561] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[396.658715] [064/156] (642s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[398.175466] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[398.178559] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[398.353433] [065/156] (640s left) kms_flip (absolute-wf_vblank)
[399.843400] Starting subtest: absolute-wf_vblank
[399.848188] Starting dynamic subtest: A-HDMI-A1
[407.757187] Dynamic subtest A-HDMI-A1: SUCCESS (7.911s)
[407.774156] Starting dynamic subtest: B-HDMI-A1
[415.615221] Dynamic subtest B-HDMI-A1: SUCCESS (7.858s)
[415.630214] Starting dynamic subtest: C-HDMI-A1
[423.309871] Dynamic subtest C-HDMI-A1: SUCCESS (7.692s)
[423.326704] Starting dynamic subtest: D-HDMI-A1
[431.006010] Dynamic subtest D-HDMI-A1: SUCCESS (7.692s)
[431.009381] Subtest absolute-wf_vblank: SUCCESS (31.167s)
[431.238295] [066/156] (607s left) gem_mmap (pf-nonblock)
[431.289774] Subtest pf-nonblock: SKIP (0.000s)
[431.380617] [067/156] (607s left) kms_vblank (query-busy-hang)
[432.871556] Starting subtest: query-busy-hang
[432.874943] Starting dynamic subtest: pipe-A-HDMI-A-1
[459.506256] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.627s)
[459.523490] Starting dynamic subtest: pipe-D-HDMI-A-1
[484.428871] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (24.917s)
[484.430531] Subtest query-busy-hang: SUCCESS (51.552s)
[484.645836] [068/156] (554s left) gem_spin_batch (resubmit)
[484.706993] Starting subtest: resubmit
[484.708725] Starting dynamic subtest: rcs0
[484.727241] Dynamic subtest rcs0: SUCCESS (0.020s)
[484.742560] Starting dynamic subtest: bcs0
[484.744155] Dynamic subtest bcs0: SUCCESS (0.002s)
[484.758582] Starting dynamic subtest: vcs0
[484.760144] Dynamic subtest vcs0: SUCCESS (0.003s)
[484.774265] Starting dynamic subtest: vcs1
[484.775839] Dynamic subtest vcs1: SUCCESS (0.003s)
[484.789685] Starting dynamic subtest: vecs0
[484.791171] Dynamic subtest vecs0: SUCCESS (0.003s)
[484.792618] Subtest resubmit: SUCCESS (0.037s)
[485.103975] [069/156] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[486.603334] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[486.607118] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[486.806012] [070/156] (552s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[486.854510] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[486.856300] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[487.001036] [071/156] (552s left) kms_cursor_crc (cursor-offscreen-512x512)
[488.764328] Starting subtest: cursor-offscreen-512x512
[488.767251] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[489.047624] [072/156] (550s left) i915_suspend (sysfs-reader)
[489.097026] Starting subtest: sysfs-reader
[512.414783] Subtest sysfs-reader: SUCCESS (12.072s)
[516.572666] [073/156] (527s left) kms_properties (colorop-properties-legacy)
[518.067920] Starting subtest: colorop-properties-legacy
[518.069509] Starting dynamic subtest: pipe-A-HDMI-A-1
[518.195548] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.126s)
[518.216433] Starting dynamic subtest: pipe-B-HDMI-A-1
[518.323694] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.126s)
[518.342638] Starting dynamic subtest: pipe-C-HDMI-A-1
[518.454192] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.128s)
[518.470087] Starting dynamic subtest: pipe-D-HDMI-A-1
[518.578709] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.122s)
[518.580326] Subtest colorop-properties-legacy: SUCCESS (0.512s)
[518.785916] [074/156] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[520.300192] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[520.304106] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[520.505990] [075/156] (523s left) gem_exec_schedule (u-semaphore-user)
[520.571878] Starting subtest: u-semaphore-user
[520.601064] Subtest u-semaphore-user: SUCCESS (0.029s)
[521.050235] [076/156] (523s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[522.543030] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[522.544730] Starting dynamic subtest: pipe-A-HDMI-A-1
[522.561977] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[522.578641] Starting dynamic subtest: pipe-B-HDMI-A-1
[522.603032] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[522.618892] Starting dynamic subtest: pipe-C-HDMI-A-1
[522.634012] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[522.649280] Starting dynamic subtest: pipe-D-HDMI-A-1
[522.664188] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[522.667318] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[522.878793] [077/156] (521s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[524.378531] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[524.381740] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.561571] [078/156] (519s left) kms_content_protection (legacy)
[526.106486] Starting subtest: legacy
[526.113050] Subtest legacy: SKIP (0.002s)
[526.357849] [079/156] (518s left) kms_plane_multiple (tiling-y)
[527.851437] Starting subtest: tiling-y
[527.852835] Starting dynamic subtest: pipe-A-HDMI-A-1
[528.775392] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.924s)
[528.793393] Starting dynamic subtest: pipe-B-HDMI-A-1
[529.609618] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.832s)
[529.629094] Starting dynamic subtest: pipe-C-HDMI-A-1
[530.445374] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.832s)
[530.464130] Starting dynamic subtest: pipe-D-HDMI-A-1
[531.292827] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.844s)
[531.294372] Subtest tiling-y: SUCCESS (3.442s)
[531.509198] [080/156] (513s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[533.032780] Starting subtest: y-tiled-16bpp-rotate-0
[534.913066] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.880s)
[535.184771] [081/156] (509s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[536.677491] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[536.763898] [082/156] (508s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[538.265036] Starting subtest: psrhdr-1p-rte
[538.268608] Subtest psrhdr-1p-rte: SKIP (0.000s)
[538.464473] [083/156] (506s left) syncobj_wait (signal)
[538.516094] Starting subtest: signal
[538.517958] Subtest signal: SUCCESS (0.000s)
[538.658819] [084/156] (506s left) gem_vm_create (invalid-create)
[538.713252] Starting subtest: invalid-create
[538.717353] Subtest invalid-create: SUCCESS (0.002s)
[538.926962] [085/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[540.427051] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[540.430710] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[540.645387] [086/156] (504s left) gem_exec_params (rel-constants-invalid-ring)
[540.698914] Starting subtest: rel-constants-invalid-ring
[540.700840] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[540.883717] [087/156] (504s left) api_intel_allocator (fork-simple-once)
[540.944663] Starting subtest: fork-simple-once
[540.963846] Subtest fork-simple-once: SUCCESS (0.033s)
[541.140527] [088/156] (504s left) gem_eio (wait-wedge-immediate)
[541.334195] Starting subtest: wait-wedge-immediate
[543.118024] Subtest wait-wedge-immediate: SUCCESS (1.784s)
[544.811083] [089/156] (500s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[546.312096] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[546.316107] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[546.525382] [090/156] (499s left) kms_flip (2x-flip-vs-panning)
[548.016248] Starting subtest: 2x-flip-vs-panning
[548.038795] Subtest 2x-flip-vs-panning: SKIP (0.021s)
[548.190201] [091/156] (497s left) kms_feature_discovery (display-3x)
[549.682997] Starting subtest: display-3x
[549.686384] Subtest display-3x: SKIP (0.000s)
[549.834025] [092/156] (496s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[551.345002] Starting subtest: disable-crc-after-crtc
[551.346738] Starting dynamic subtest: pipe-A-HDMI-A-1
[552.021304] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.675s)
[552.039704] Starting dynamic subtest: pipe-B-HDMI-A-1
[552.527728] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.502s)
[552.546833] Starting dynamic subtest: pipe-C-HDMI-A-1
[553.017703] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.488s)
[553.039028] Starting dynamic subtest: pipe-D-HDMI-A-1
[553.523777] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.504s)
[553.525400] Subtest disable-crc-after-crtc: SUCCESS (2.182s)
[553.737852] [093/156] (492s left) gem_eio (kms)
[555.371896] Starting subtest: kms
[576.618429] Subtest kms: SUCCESS (21.249s)
[576.902630] [094/156] (469s left) gem_set_tiling_vs_pwrite
[577.057817] [095/156] (469s left) kms_pm_rpm (legacy-planes-dpms)
[581.308703] Starting subtest: legacy-planes-dpms
[581.325586] Starting dynamic subtest: plane-65
[589.194752] Dynamic subtest plane-65: SUCCESS (7.908s)
[589.279795] Starting dynamic subtest: plane-95
[596.766673] Dynamic subtest plane-95: SUCCESS (7.562s)
[596.853544] Starting dynamic subtest: plane-125
[603.638327] Dynamic subtest plane-125: SUCCESS (6.868s)
[603.724146] Starting dynamic subtest: plane-135
[610.528978] Dynamic subtest plane-135: SUCCESS (6.885s)
[610.616091] Starting dynamic subtest: plane-145
[619.213271] Dynamic subtest plane-145: SUCCESS (8.678s)
[619.298902] Starting dynamic subtest: plane-155
[626.087651] Dynamic subtest plane-155: SUCCESS (6.866s)
[626.090700] Subtest legacy-planes-dpms: SUCCESS (44.810s)
[627.126301] [096/156] (419s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[628.627015] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[628.630375] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[628.828232] [097/156] (417s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[630.318204] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[630.399095] [098/156] (416s left) gen9_exec_parse (basic-rejected)
[630.453523] Subtest basic-rejected: SKIP (0.000s)
[630.533762] [099/156] (416s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[632.045721] Starting subtest: x-tiled-64bpp-rotate-90
[632.120071] Subtest x-tiled-64bpp-rotate-90: SKIP (0.072s)
[632.291728] [100/156] (414s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[633.792018] Starting subtest: hdr-modesetfrombusy
[633.795378] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[633.960811] [101/156] (413s left) syncobj_wait (invalid-reset-one-illegal-handle)
[634.011850] Starting subtest: invalid-reset-one-illegal-handle
[634.013407] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[634.151846] [102/156] (412s left) gem_exec_schedule (out-order)
[634.215398] Starting subtest: out-order
[634.217092] Starting dynamic subtest: rcs0
[634.412258] Dynamic subtest rcs0: SUCCESS (0.193s)
[634.428699] Starting dynamic subtest: bcs0
[634.545085] Dynamic subtest bcs0: SUCCESS (0.135s)
[634.562947] Starting dynamic subtest: vcs0
[634.680105] Dynamic subtest vcs0: SUCCESS (0.134s)
[634.696779] Starting dynamic subtest: vcs1
[634.817786] Dynamic subtest vcs1: SUCCESS (0.136s)
[634.833767] Starting dynamic subtest: vecs0
[634.965841] Dynamic subtest vecs0: SUCCESS (0.147s)
[634.967363] Subtest out-order: SUCCESS (0.752s)
[635.423598] [103/156] (411s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[637.090116] Starting subtest: cursor-rapid-movement-128x128
[637.097385] Starting dynamic subtest: pipe-A-HDMI-A-1
[637.518688] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.421s)
[637.556135] Starting dynamic subtest: pipe-D-HDMI-A-1
[637.874102] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.333s)
[637.875564] Subtest cursor-rapid-movement-128x128: SUCCESS (0.785s)
[638.340024] [104/156] (408s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[638.391092] Starting subtest: etime-multi-wait-available-unsubmitted
[638.498042] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[638.669365] [105/156] (408s left) gem_ppgtt (blt-vs-render-ctx0)
[638.722326] Starting subtest: blt-vs-render-ctx0
[671.396353] Subtest blt-vs-render-ctx0: SUCCESS (32.667s)
[671.642755] [106/156] (375s left) kms_vblank (wait-forked-busy-hang)
[673.210246] Starting subtest: wait-forked-busy-hang
[673.212399] Starting dynamic subtest: pipe-A-HDMI-A-1
[699.730973] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.522s)
[699.749842] Starting dynamic subtest: pipe-D-HDMI-A-1
[724.666599] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (24.935s)
[724.668174] Subtest wait-forked-busy-hang: SUCCESS (51.464s)
[724.849360] [107/156] (322s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[726.352318] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[726.355763] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[726.544691] [108/156] (321s left) gem_exec_balancer (fairslice)
[726.607313] Starting subtest: fairslice
[730.667755] Subtest fairslice: SUCCESS (4.058s)
[731.153344] [109/156] (316s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[731.217810] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[731.219446] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[731.333985] [110/156] (316s left) perf_pmu (busy)
[731.387604] Starting subtest: busy
[731.389337] Starting dynamic subtest: rcs0
[731.969500] Dynamic subtest rcs0: SUCCESS (0.582s)
[731.991028] Starting dynamic subtest: bcs0
[732.530465] Dynamic subtest bcs0: SUCCESS (0.559s)
[732.551243] Starting dynamic subtest: vcs0
[733.092190] Dynamic subtest vcs0: SUCCESS (0.559s)
[733.113177] Starting dynamic subtest: vcs1
[733.653168] Dynamic subtest vcs1: SUCCESS (0.556s)
[733.671387] Starting dynamic subtest: vecs0
[734.227276] Dynamic subtest vecs0: SUCCESS (0.573s)
[734.228803] Subtest busy: SUCCESS (2.841s)
[734.380106] [111/156] (313s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[735.900893] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[735.904624] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[736.120008] [112/156] (312s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[737.651568] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[737.655340] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[737.860654] [113/156] (310s left) vgem_basic (setversion)
[737.926835] Starting subtest: setversion
[737.930763] Subtest setversion: SUCCESS (0.000s)
[738.048817] [114/156] (310s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[739.547218] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[739.569966] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.021s)
[739.723070] [115/156] (308s left) vgem_basic (bad-pad)
[739.774418] Starting subtest: bad-pad
[739.776143] Subtest bad-pad: SUCCESS (0.000s)
[739.896102] [116/156] (308s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[741.389970] Starting subtest: primary-yf-tiled-reflect-x-0
[741.491176] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.101s)
[741.708744] [117/156] (306s left) kms_psr (pr-sprite-plane-onoff)
[743.203394] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[743.293710] [118/156] (305s left) gem_create (create-clear)
[743.345970] Starting subtest: create-clear
[743.347675] Starting dynamic subtest: lmem0
[776.564970] Dynamic subtest lmem0: SUCCESS (33.216s)
[776.582410] Starting dynamic subtest: smem0
[812.661163] Dynamic subtest smem0: SUCCESS (36.092s)
[812.662919] Subtest create-clear: SUCCESS (69.311s)
[813.080509] [119/156] (235s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[814.571036] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[814.572724] Starting dynamic subtest: pipe-A-valid-mode
[815.976744] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.404s)
[815.978410] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.407s)
[816.234576] [120/156] (232s left) gem_exec_balancer (waits)
[816.310479] Starting subtest: waits
[823.970779] Subtest waits: SUCCESS (7.657s)
[824.388567] [121/156] (224s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[825.881077] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[825.918137] Starting dynamic subtest: pipe-A-plane-0
[826.468622] Dynamic subtest pipe-A-plane-0: SUCCESS (0.550s)
[826.523762] Starting dynamic subtest: pipe-A-plane-3
[826.801620] Dynamic subtest pipe-A-plane-3: SUCCESS (0.326s)
[826.823049] Starting dynamic subtest: pipe-A-plane-5
[827.134657] Dynamic subtest pipe-A-plane-5: SUCCESS (0.328s)
[827.167437] Starting dynamic subtest: pipe-A-plane-7
[827.170897] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[827.283168] Starting dynamic subtest: pipe-B-plane-0
[827.650903] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s)
[827.696713] Starting dynamic subtest: pipe-B-plane-3
[827.968432] Dynamic subtest pipe-B-plane-3: SUCCESS (0.314s)
[828.019097] Starting dynamic subtest: pipe-B-plane-5
[828.301383] Dynamic subtest pipe-B-plane-5: SUCCESS (0.328s)
[828.353389] Starting dynamic subtest: pipe-B-plane-7
[828.356319] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[828.357776] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SUCCESS (2.478s)
[828.545327] [122/156] (220s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[830.040093] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[830.041848] Starting dynamic subtest: pipe-A-HDMI-A-1
[851.140179] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (10.542s)
[851.156731] Starting dynamic subtest: pipe-B-HDMI-A-1
[873.094479] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (10.215s)
[873.111137] Starting dynamic subtest: pipe-C-HDMI-A-1
[895.092421] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (10.078s)
[895.109678] Starting dynamic subtest: pipe-D-HDMI-A-1
[917.111628] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (10.150s)
[917.113108] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (40.994s)
[922.360772] [123/156] (131s left) kms_invalid_mode (bad-vsync-start)
[923.852998] Starting subtest: bad-vsync-start
[923.854461] Starting dynamic subtest: pipe-A-HDMI-A-1
[923.888060] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.034s)
[923.907114] Starting dynamic subtest: pipe-B-HDMI-A-1
[923.908859] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[923.926496] Starting dynamic subtest: pipe-C-HDMI-A-1
[923.928062] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[923.946192] Starting dynamic subtest: pipe-D-HDMI-A-1
[923.947742] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[923.949257] Subtest bad-vsync-start: SUCCESS (0.046s)
[924.088067] [124/156] (130s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[925.590169] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[925.593521] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[925.791130] [125/156] (128s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[927.285407] Starting subtest: async-flip-with-page-flip-events-tiled
[927.526330] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs
[929.833412] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs: SUCCESS (2.303s)
[929.856585] Starting dynamic subtest: pipe-A-HDMI-A-1-y
[932.033397] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.192s)
[932.060816] Starting dynamic subtest: pipe-A-HDMI-A-1-y
[934.049629] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.009s)
[934.075304] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[936.276770] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.224s)
[936.458104] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs
[938.701224] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs: SUCCESS (2.255s)
[938.726185] Starting dynamic subtest: pipe-B-HDMI-A-1-y
[940.884603] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.179s)
[940.934401] Starting dynamic subtest: pipe-B-HDMI-A-1-y
[942.899718] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.009s)
[942.921161] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[945.098745] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.195s)
[945.284699] Starting dynamic subtest: pipe-C-HDMI-A-1-y-rc-ccs
[947.535585] Dynamic subtest pipe-C-HDMI-A-1-y-rc-ccs: SUCCESS (2.262s)
[947.562280] Starting dynamic subtest: pipe-C-HDMI-A-1-y
[949.732938] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.190s)
[949.759469] Starting dynamic subtest: pipe-C-HDMI-A-1-y
[951.748689] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.009s)
[951.769344] Starting dynamic subtest: pipe-C-HDMI-A-1-x
[953.947267] Dynamic subtest pipe-C-HDMI-A-1-x: SUCCESS (2.195s)
[954.127991] Starting dynamic subtest: pipe-D-HDMI-A-1-y-rc-ccs
[956.370016] Dynamic subtest pipe-D-HDMI-A-1-y-rc-ccs: SUCCESS (2.253s)
[956.396823] Starting dynamic subtest: pipe-D-HDMI-A-1-y
[958.569781] Dynamic subtest pipe-D-HDMI-A-1-y: SUCCESS (2.192s)
[958.589217] Starting dynamic subtest: pipe-D-HDMI-A-1-y
[960.585339] Dynamic subtest pipe-D-HDMI-A-1-y: SUCCESS (2.011s)
[960.614810] Starting dynamic subtest: pipe-D-HDMI-A-1-x
[962.784495] Dynamic subtest pipe-D-HDMI-A-1-x: SUCCESS (2.192s)
[962.786574] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.502s)
[963.183392] [126/156] ( 91s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[964.694235] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[964.700110] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[964.966854] [127/156] ( 89s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[966.467638] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[966.471634] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[966.658291] [128/156] ( 88s left) gem_exec_reloc (basic-write-cpu)
[966.712615] Subtest basic-write-cpu: SKIP (0.000s)
[966.818756] [129/156] ( 88s left) kms_color (ctm-0-50)
[968.312543] Starting subtest: ctm-0-50
[968.314526] Starting dynamic subtest: pipe-A-HDMI-A-1
[970.029874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.716s)
[970.047020] Starting dynamic subtest: pipe-B-HDMI-A-1
[971.457384] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.428s)
[971.475159] Starting dynamic subtest: pipe-C-HDMI-A-1
[972.917321] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.458s)
[972.933970] Starting dynamic subtest: pipe-D-HDMI-A-1
[974.382813] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.463s)
[974.384330] Subtest ctm-0-50: SUCCESS (6.071s)
[974.596614] [130/156] ( 80s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[976.103276] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[976.108752] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[976.359982] [131/156] ( 78s left) gem_eio (in-flight-external)
[976.554441] Starting subtest: in-flight-external
[978.184858] Subtest in-flight-external: SUCCESS (1.630s)
[979.811809] [132/156] ( 75s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[981.312214] Starting subtest: fbc-rgb565-draw-pwrite
[984.347692] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.039s)
[984.628281] [133/156] ( 70s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[986.137830] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[986.141041] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[986.351988] [134/156] ( 69s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[987.845550] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[987.848426] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[988.065916] [135/156] ( 67s left) prime_vgem (wait)
[988.153001] Starting subtest: wait
[988.154723] Starting dynamic subtest: rcs0
[988.233668] Dynamic subtest rcs0: SUCCESS (0.080s)
[988.250317] Starting dynamic subtest: bcs0
[988.283081] Dynamic subtest bcs0: SUCCESS (0.048s)
[988.300394] Starting dynamic subtest: vcs0
[988.318295] Dynamic subtest vcs0: SUCCESS (0.034s)
[988.335538] Starting dynamic subtest: vcs1
[988.356794] Dynamic subtest vcs1: SUCCESS (0.037s)
[988.374014] Starting dynamic subtest: vecs0
[988.395736] Dynamic subtest vecs0: SUCCESS (0.037s)
[988.397419] Subtest wait: SUCCESS (0.244s)
[988.603232] [136/156] ( 67s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[990.102569] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[990.106172] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[990.254343] [137/156] ( 65s left) gem_ctx_exec (basic-norecovery)
[990.306485] Starting subtest: basic-norecovery
[990.595369] Subtest basic-norecovery: SUCCESS (0.288s)
[990.852254] [138/156] ( 65s left) kms_getfb (getfb2-handle-zero)
[992.346374] Starting subtest: getfb2-handle-zero
[992.347926] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[992.550794] [139/156] ( 63s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[992.601792] Starting subtest: invalid-multi-wait-unsubmitted
[992.603381] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[992.725396] [140/156] ( 63s left) gem_mmap_gtt (ptrace)
[992.776526] Subtest ptrace: SKIP (0.000s)
[992.871851] [141/156] ( 63s left) kms_rotation_crc (primary-rotation-270)
[994.364277] Starting subtest: primary-rotation-270
[1004.957946] Subtest primary-rotation-270: SUCCESS (10.595s)
[1005.247521] [142/156] ( 51s left) kms_getfb (getfb-handle-zero)
[1006.740179] Starting subtest: getfb-handle-zero
[1006.741572] Subtest getfb-handle-zero: SUCCESS (0.000s)
[1006.943265] [143/156] ( 49s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[1008.442367] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[1008.445400] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[1008.641268] [144/156] ( 47s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[1010.148328] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[1010.151922] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[1010.355333] [145/156] ( 46s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[1011.865869] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[1011.869637] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[1012.059830] [146/156] ( 44s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[1013.555479] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[1013.557104] Starting dynamic subtest: pipe-A-HDMI-A-1
[1013.573323] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[1013.590564] Starting dynamic subtest: pipe-B-HDMI-A-1
[1013.607144] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[1013.623916] Starting dynamic subtest: pipe-C-HDMI-A-1
[1013.641500] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[1013.658146] Starting dynamic subtest: pipe-D-HDMI-A-1
[1013.683630] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[1013.686603] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.010s)
[1013.849227] [147/156] ( 43s left) gem_eio (suspend)
[1014.046572] Starting subtest: suspend
[1027.049789] Subtest suspend: SUCCESS (12.992s)
[1034.610110] [148/156] ( 28s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[1036.113495] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[1036.116852] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[1036.339999] [149/156] ( 26s left) gem_basic (multigpu-create-close)
[1036.409338] Starting subtest: multigpu-create-close
[1036.412450] Subtest multigpu-create-close: SKIP (0.000s)
[1036.605271] [150/156] ( 26s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[1038.105999] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[1041.273340] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.170s)
[1041.537340] [151/156] ( 21s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[1043.045115] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[1043.050427] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[1043.316577] [152/156] ( 20s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[1044.816017] Starting subtest: extended-pageflip-modeset-hang-oldfb
[1044.817384] Starting dynamic subtest: pipe-A
[1052.697432] Dynamic subtest pipe-A: SUCCESS (7.878s)
[1052.716353] Starting dynamic subtest: pipe-D
[1060.427218] Dynamic subtest pipe-D: SUCCESS (7.725s)
[1060.428821] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.611s)
[1060.669152] [153/156] (  2s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[1062.199597] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[1062.203149] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1062.380352] [154/156] (  1s left) kms_addfb_basic (unused-modifier)
[1062.430432] Starting subtest: unused-modifier
[1062.432036] Subtest unused-modifier: SUCCESS (0.000s)
[1064.069662] Overall timeout time exceeded, stopping.
[1064.121555] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: vgem_basic
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: gem_exec_suspend
results: parsing output: 23/ for test: gem_exec_gttfill
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_readwrite
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_pipe_crc_basic
results: parsing output: 38/ for test: gen3_render_tiledx_blits
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: dumb_buffer
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gem_gpgpu_fill
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_pread
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: i915_suspend
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: kms_plane_multiple
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_vm_create
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_feature_discovery
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_ppgtt
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: vgem_basic
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_color
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_ccs
results: parsing output: 134/ for test: prime_vgem
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_ctx_exec
results: parsing output: 137/ for test: kms_getfb
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: gem_mmap_gtt
results: parsing output: 140/ for test: kms_rotation_crc
results: parsing output: 141/ for test: kms_getfb
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: gem_eio
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_basic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_busy
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_addfb_basic
results: parsing output: 154/ for test: api_intel_bb
results: no output, setting notrun
results: parsing output: 155/ for test: syncobj_timeline
results: no output, setting notrun
Done.