[67.538425] Initializing watchdogs
[67.538502]   /dev/watchdog0
[67.571977] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[67.592674] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.600134] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.603103] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[67.756464] Starting subtest: wait-for-submit-snapshot
[67.838154] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[67.957263] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[69.458970] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[69.459879] Starting dynamic subtest: pipe-A-HDMI-A-3
[69.481773] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[69.489299] Starting dynamic subtest: pipe-B-HDMI-A-3
[69.510842] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[69.518110] Starting dynamic subtest: pipe-C-HDMI-A-3
[69.542997] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[69.550390] Starting dynamic subtest: pipe-D-HDMI-A-3
[69.572230] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[69.574021] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s)
[69.780079] [003/132] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[71.296575] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[73.666262] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.369s)
[73.861887] [004/132] (954s left) kms_big_fb (linear-8bpp-rotate-270)
[75.379421] Starting subtest: linear-8bpp-rotate-270
[75.446044] Subtest linear-8bpp-rotate-270: SKIP (0.066s)
[75.691555] [005/132] (952s left) kms_busy (extended-modeset-hang-newfb)
[77.205046] Starting subtest: extended-modeset-hang-newfb
[77.207394] Starting dynamic subtest: pipe-A
[92.836177] Dynamic subtest pipe-A: SUCCESS (15.627s)
[92.844960] Starting dynamic subtest: pipe-D
[108.344022] Dynamic subtest pipe-D: SUCCESS (15.504s)
[108.344873] Subtest extended-modeset-hang-newfb: SUCCESS (31.137s)
[108.623604] [006/132] (919s left) perf (oa-exponents)
[109.056664] Starting subtest: oa-exponents
[109.057463] Starting dynamic subtest: 0-rcs0
[111.285997] Dynamic subtest 0-rcs0: SUCCESS (2.229s)
[111.286967] Subtest oa-exponents: SUCCESS (2.229s)
[111.335018] [007/132] (917s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[112.858907] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[114.160054] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.300s)
[114.386162] [008/132] (914s left) kms_pipe_crc_basic (suspend-read-crc)
[115.884136] Starting subtest: suspend-read-crc
[115.886265] Starting dynamic subtest: pipe-A-HDMI-A-3
[136.161426] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.850s)
[136.171040] Starting dynamic subtest: pipe-B-HDMI-A-3
[156.121138] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (4.269s)
[156.131294] Starting dynamic subtest: pipe-C-HDMI-A-3
[176.113668] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (4.227s)
[176.123830] Starting dynamic subtest: pipe-D-HDMI-A-3
[196.120972] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.289s)
[196.121902] Subtest suspend-read-crc: SUCCESS (17.641s)
[202.368177] [009/132] (832s left) perf_pmu (interrupts-sync)
[202.436609] Starting subtest: interrupts-sync
[203.609145] Subtest interrupts-sync: SUCCESS (1.124s)
[203.783179] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[203.785187] [010/132] (830s left) gem_exec_reloc (basic-gtt-active)
[203.876698] Subtest basic-gtt-active: SKIP (0.000s)
[203.949329] [011/132] (830s left) kms_flip (modeset-vs-vblank-race)
[205.519870] Starting subtest: modeset-vs-vblank-race
[205.524168] Starting dynamic subtest: A-HDMI-A3
[208.578367] Dynamic subtest A-HDMI-A3: SUCCESS (2.977s)
[208.617619] Starting dynamic subtest: B-HDMI-A3
[211.669756] Dynamic subtest B-HDMI-A3: SUCCESS (3.038s)
[211.682865] Starting dynamic subtest: C-HDMI-A3
[214.724777] Dynamic subtest C-HDMI-A3: SUCCESS (3.018s)
[214.737167] Starting dynamic subtest: D-HDMI-A3
[217.753374] Dynamic subtest D-HDMI-A3: SUCCESS (3.004s)
[217.754423] Subtest modeset-vs-vblank-race: SUCCESS (12.049s)
[218.101202] [012/132] (816s left) gem_sync (basic-each)
[218.203123] Starting subtest: basic-each
[220.362195] Subtest basic-each: SUCCESS (2.147s)
[220.661169] [013/132] (814s left) gem_ctx_persistence (legacy-engines-mixed)
[220.745842] Starting subtest: legacy-engines-mixed
[220.746796] Starting dynamic subtest: render
[220.860963] Dynamic subtest render: SUCCESS (0.114s)
[220.875691] Starting dynamic subtest: bsd1
[220.903851] Dynamic subtest bsd1: SUCCESS (0.041s)
[220.922771] Starting dynamic subtest: bsd2
[220.976756] Dynamic subtest bsd2: SUCCESS (0.070s)
[220.989373] Starting dynamic subtest: blt
[221.038936] Dynamic subtest blt: SUCCESS (0.060s)
[221.055768] Starting dynamic subtest: vebox
[221.088933] Dynamic subtest vebox: SUCCESS (0.048s)
[221.090154] Subtest legacy-engines-mixed: SUCCESS (0.343s)
[221.316941] [014/132] (813s left) kms_plane (plane-panning-bottom-right)
[222.834837] Starting subtest: plane-panning-bottom-right
[222.835791] Starting dynamic subtest: pipe-A
[223.499379] Dynamic subtest pipe-A: SUCCESS (0.661s)
[223.510255] Starting dynamic subtest: pipe-B
[223.999021] Dynamic subtest pipe-B: SUCCESS (0.497s)
[223.999878] Subtest plane-panning-bottom-right: SUCCESS (1.162s)
[224.290890] [015/132] (810s left) prime_vgem (wait)
[224.393984] Starting subtest: wait
[224.395048] Starting dynamic subtest: rcs0
[224.488018] Dynamic subtest rcs0: SUCCESS (0.095s)
[224.500388] Starting dynamic subtest: bcs0
[224.551551] Dynamic subtest bcs0: SUCCESS (0.062s)
[224.571689] Starting dynamic subtest: vcs0
[224.594248] Dynamic subtest vcs0: SUCCESS (0.041s)
[224.618755] Starting dynamic subtest: vcs1
[224.635562] Dynamic subtest vcs1: SUCCESS (0.039s)
[224.655999] Starting dynamic subtest: vecs0
[224.675093] Dynamic subtest vecs0: SUCCESS (0.038s)
[224.691155] Starting dynamic subtest: vecs1
[224.714999] Dynamic subtest vecs1: SUCCESS (0.038s)
[224.728978] Starting dynamic subtest: ccs0
[224.756334] Dynamic subtest ccs0: SUCCESS (0.040s)
[224.757336] Subtest wait: SUCCESS (0.364s)
[224.986297] [016/132] (810s left) i915_query (query-topology-matches-eu-total)
[225.070149] Starting subtest: query-topology-matches-eu-total
[225.071065] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[225.226175] [017/132] (810s left) syncobj_timeline (reset-signaled)
[225.309152] Starting subtest: reset-signaled
[225.310024] Subtest reset-signaled: SUCCESS (0.000s)
[225.467129] [018/132] (809s left) syncobj_timeline (multi-wait-all-available-signaled)
[225.550160] Starting subtest: multi-wait-all-available-signaled
[225.551074] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[225.752650] [019/132] (809s left) kms_cursor_crc (cursor-random-256x256)
[227.505840] Starting subtest: cursor-random-256x256
[227.510993] Starting dynamic subtest: pipe-A-HDMI-A-3
[232.138153] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.619s)
[232.174861] Starting dynamic subtest: pipe-D-HDMI-A-3
[236.533184] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.365s)
[236.534029] Subtest cursor-random-256x256: SUCCESS (9.017s)
[236.918665] [020/132] (798s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[237.010364] Starting subtest: mixed-tiled-to-y-tiled-ccs
[237.012326] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[237.299525] [021/132] (798s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[238.809749] Starting subtest: primary-y-tiled-reflect-x-180
[238.911843] Subtest primary-y-tiled-reflect-x-180: SKIP (0.102s)
[239.148492] [022/132] (796s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[239.234547] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[239.236753] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[239.493538] [023/132] (796s left) gem_exec_schedule (reorder-wide)
[239.705515] Subtest reorder-wide: SKIP (0.000s)
[239.952023] [024/132] (795s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[241.467615] Starting subtest: fbc-indfb-scaledprimary
[243.047264] Subtest fbc-indfb-scaledprimary: SUCCESS (1.579s)
[243.278617] [025/132] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[244.796677] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[244.798421] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[245.053387] [026/132] (790s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[246.568792] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[246.569714] Starting dynamic subtest: pipe-A-HDMI-A-3
[246.573310] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[246.584361] Starting dynamic subtest: pipe-B-HDMI-A-3
[246.587732] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[246.598704] Starting dynamic subtest: pipe-C-HDMI-A-3
[246.602176] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[246.612756] Starting dynamic subtest: pipe-D-HDMI-A-3
[246.616303] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[246.618008] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[246.940834] [027/132] (789s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[248.462124] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[248.526394] [028/132] (787s left) kms_cursor_crc (cursor-random-64x21)
[250.205736] Starting subtest: cursor-random-64x21
[250.211007] Starting dynamic subtest: pipe-A-HDMI-A-3
[254.791142] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.578s)
[254.827739] Starting dynamic subtest: pipe-D-HDMI-A-3
[259.202008] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.382s)
[259.202903] Subtest cursor-random-64x21: SUCCESS (8.993s)
[259.653065] [029/132] (776s left) prime_mmap (test_dup)
[259.734486] Starting subtest: test_dup
[259.735450] Starting dynamic subtest: test_dup-smem
[259.780478] Dynamic subtest test_dup-smem: SUCCESS (0.045s)
[259.792742] Starting dynamic subtest: test_dup-lmem0
[259.974827] Dynamic subtest test_dup-lmem0: SUCCESS (0.193s)
[259.975797] Subtest test_dup: SUCCESS (0.241s)
[260.155980] [030/132] (776s left) gem_exec_schedule (u-submit-late-slice)
[260.248952] Starting subtest: u-submit-late-slice
[260.249858] Starting dynamic subtest: rcs0
[260.324470] Dynamic subtest rcs0: SUCCESS (0.075s)
[260.337429] Starting dynamic subtest: bcs0
[260.372837] Dynamic subtest bcs0: SUCCESS (0.047s)
[260.385137] Starting dynamic subtest: vcs0
[260.425708] Dynamic subtest vcs0: SUCCESS (0.052s)
[260.438736] Starting dynamic subtest: vcs1
[260.473228] Dynamic subtest vcs1: SUCCESS (0.046s)
[260.485741] Starting dynamic subtest: vecs0
[260.523474] Dynamic subtest vecs0: SUCCESS (0.049s)
[260.535787] Starting dynamic subtest: vecs1
[260.571799] Dynamic subtest vecs1: SUCCESS (0.047s)
[260.584331] Starting dynamic subtest: ccs0
[260.624818] Dynamic subtest ccs0: SUCCESS (0.052s)
[260.625835] Subtest u-submit-late-slice: SUCCESS (0.376s)
[261.117362] [031/132] (775s left) syncobj_timeline (etime-multi-wait-all-submitted)
[261.195934] Starting subtest: etime-multi-wait-all-submitted
[261.297390] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s)
[261.447268] [032/132] (775s left) fbdev (write)
[261.513075] Starting subtest: write
[262.693351] Subtest write: SUCCESS (1.180s)
[262.814350] [033/132] (773s left) syncobj_wait (invalid-signal-zero-handles)
[262.893013] Starting subtest: invalid-signal-zero-handles
[262.893977] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[263.031061] [034/132] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[264.548414] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[264.549976] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[264.779025] [035/132] (771s left) gem_exec_balancer (sliced)
[264.871360] Starting subtest: sliced
[264.873147] Subtest sliced: SKIP (0.000s)
[265.313244] [036/132] (771s left) gem_ccs (large-ctrl-surf-copy)
[265.411052] Starting subtest: large-ctrl-surf-copy
[266.061394] Subtest large-ctrl-surf-copy: SUCCESS (0.650s)
[266.265558] [037/132] (770s left) gem_fenced_exec_thrash (2-spare-fences)
[266.359021] Subtest 2-spare-fences: SKIP (0.000s)
[266.451824] [038/132] (770s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[267.963732] Starting subtest: basic-busy-flip-before-cursor-varying-size
[267.965715] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[268.171655] [039/132] (768s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[269.713542] Starting subtest: 4-tiled-8bpp-rotate-0
[271.284484] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.569s)
[271.547812] [040/132] (765s left) gem_mmap_wc (copy)
[271.627813] Subtest copy: SKIP (0.000s)
[271.717955] [041/132] (765s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[273.231719] Starting subtest: cursor-vs-flip-toggle
[306.483609] Subtest cursor-vs-flip-toggle: SUCCESS (33.243s)
[306.724673] [042/132] (730s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[308.250731] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[308.252620] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[308.481524] [043/132] (728s left) kms_addfb_basic (unused-handle)
[308.560249] Starting subtest: unused-handle
[308.561117] Subtest unused-handle: SUCCESS (0.000s)
[310.229557] [044/132] (727s left) gem_ctx_shared (q-smoketest-all)
[310.324836] Starting subtest: Q-smoketest-all
[342.625304] Subtest Q-smoketest-all: SUCCESS (32.296s)
[342.981640] [045/132] (694s left) kms_flip (2x-flip-vs-expired-vblank)
[344.492605] Starting subtest: 2x-flip-vs-expired-vblank
[344.504938] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[344.690108] [046/132] (693s left) kms_force_connector_basic (force-edid)
[344.858875] Starting subtest: force-edid
[344.879957] Subtest force-edid: SUCCESS (0.022s)
[346.592404] [047/132] (691s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[348.141485] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[349.421068] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.278s)
[349.656016] [048/132] (688s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[351.168721] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[351.169607] Starting dynamic subtest: pipe-A
[351.253558] Dynamic subtest pipe-A: SUCCESS (0.085s)
[351.269728] Starting dynamic subtest: pipe-B
[351.397586] Dynamic subtest pipe-B: SUCCESS (0.143s)
[351.415372] Starting dynamic subtest: pipe-C
[351.539952] Dynamic subtest pipe-C: SUCCESS (0.141s)
[351.554052] Starting dynamic subtest: pipe-D
[351.663887] Dynamic subtest pipe-D: SUCCESS (0.123s)
[351.664822] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.497s)
[351.946491] [049/132] (686s left) kms_chamelium_audio (hdmi-audio)
[353.513197] Subtest hdmi-audio: SKIP (0.000s)
[353.612689] [050/132] (684s left) gem_set_tiling_vs_gtt
[353.781383] [051/132] (684s left) gem_lmem_swapping (massive)
[358.412371] Starting subtest: massive
[358.414310] Starting dynamic subtest: lmem0
[365.723426] Dynamic subtest lmem0: SUCCESS (7.308s)
[365.724233] Subtest massive: SUCCESS (7.310s)
[367.380082] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[367.381035] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[367.382875] [052/132] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[372.268760] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[372.270475] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[372.495644] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[372.499830] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[372.503705] [053/132] (665s left) prime_busy (after)
[372.596864] Starting subtest: after
[372.600410] Starting dynamic subtest: rcs0
[372.670405] Dynamic subtest rcs0: SUCCESS (0.070s)
[372.683176] Starting dynamic subtest: bcs0
[372.725622] Dynamic subtest bcs0: SUCCESS (0.054s)
[372.743229] Starting dynamic subtest: vcs0
[372.769174] Dynamic subtest vcs0: SUCCESS (0.042s)
[372.796526] Starting dynamic subtest: vcs1
[372.811485] Dynamic subtest vcs1: SUCCESS (0.040s)
[372.834541] Starting dynamic subtest: vecs0
[372.853639] Dynamic subtest vecs0: SUCCESS (0.040s)
[372.876181] Starting dynamic subtest: vecs1
[372.897523] Dynamic subtest vecs1: SUCCESS (0.042s)
[372.911559] Starting dynamic subtest: ccs0
[372.938880] Dynamic subtest ccs0: SUCCESS (0.040s)
[373.054249] Subtest after: SUCCESS (0.456s)
[373.283583] [054/132] (665s left) syncobj_wait (invalid-signal-illegal-handle)
[373.361143] Starting subtest: invalid-signal-illegal-handle
[373.362249] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[373.522964] [055/132] (664s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[375.034949] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[375.035843] Starting dynamic subtest: pipe-A-valid-mode
[375.079737] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[375.081500] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.045s)
[375.298208] [056/132] (663s left) gem_gtt_cpu_tlb
[375.454182] [057/132] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[376.973656] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[376.975535] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[377.211686] [058/132] (661s left) gen9_exec_parse (batch-zero-length)
[377.300659] Subtest batch-zero-length: SKIP (0.000s)
[377.371945] [059/132] (661s left) gem_softpin (evict-snoop-interruptible)
[377.458115] Starting subtest: evict-snoop-interruptible
[377.460012] Subtest evict-snoop-interruptible: SKIP (0.000s)
[377.643479] [060/132] (661s left) dmabuf_sync_file (export-basic)
[377.709803] Starting subtest: export-basic
[377.710724] Subtest export-basic: SUCCESS (0.001s)
[377.881953] [061/132] (661s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[379.391747] Starting subtest: fb-8bpc-vs-panel-6bpc
[379.394351] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.001s)
[379.581438] [062/132] (659s left) syncobj_timeline (host-signal-ordered)
[379.671052] Starting subtest: host-signal-ordered
[379.672181] Subtest host-signal-ordered: SUCCESS (0.000s)
[379.877653] [063/132] (659s left) kms_chamelium_hpd (common-hpd-after-suspend)
[381.434810] Subtest common-hpd-after-suspend: SKIP (0.000s)
[381.537860] [064/132] (657s left) kms_flip (2x-flip-vs-fences)
[383.058700] Starting subtest: 2x-flip-vs-fences
[383.060483] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[383.221551] [065/132] (656s left) perf (mi-rpc)
[383.679683] Starting subtest: mi-rpc
[383.681335] Subtest mi-rpc: SKIP (0.000s)
[383.735717] [066/132] (655s left) sw_sync (sync_random_merge)
[383.785137] Starting subtest: sync_random_merge
[383.848825] Subtest sync_random_merge: SUCCESS (0.064s)
[383.973509] [067/132] (655s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[385.498455] Starting subtest: psr-rgb101010-draw-pwrite
[385.500055] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[385.756379] [068/132] (653s left) kms_getfb (getfb2-handle-closed)
[387.269754] Starting subtest: getfb2-handle-closed
[387.270652] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[387.521321] [069/132] (652s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[389.040773] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[389.042487] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.280744] [070/132] (650s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[389.361501] Starting subtest: invalid-smem-bo-on-discrete
[389.362441] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[391.026052] [071/132] (648s left) perf (gen12-invalid-class-instance)
[391.289779] Starting subtest: gen12-invalid-class-instance
[391.310068] Subtest gen12-invalid-class-instance: SUCCESS (0.020s)
[391.370672] [072/132] (648s left) gem_exec_schedule (implicit-read-write)
[391.467096] Starting subtest: implicit-read-write
[391.467994] Starting dynamic subtest: rcs0
[391.765284] Dynamic subtest rcs0: SUCCESS (0.297s)
[391.776160] Starting dynamic subtest: bcs0
[391.969501] Dynamic subtest bcs0: SUCCESS (0.203s)
[391.980597] Starting dynamic subtest: vcs0
[392.190341] Dynamic subtest vcs0: SUCCESS (0.220s)
[392.201186] Starting dynamic subtest: vcs1
[392.403741] Dynamic subtest vcs1: SUCCESS (0.212s)
[392.414873] Starting dynamic subtest: vecs0
[392.621120] Dynamic subtest vecs0: SUCCESS (0.216s)
[392.632176] Starting dynamic subtest: vecs1
[392.836366] Dynamic subtest vecs1: SUCCESS (0.214s)
[392.847515] Starting dynamic subtest: ccs0
[393.052067] Dynamic subtest ccs0: SUCCESS (0.215s)
[393.053050] Subtest implicit-read-write: SUCCESS (1.585s)
[393.587326] [073/132] (646s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[395.100612] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[395.345802] [074/132] (644s left) kms_atomic (plane-cursor-legacy)
[396.858619] Starting subtest: plane-cursor-legacy
[396.859470] Starting dynamic subtest: pipe-A-HDMI-A-3
[397.313467] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.454s)
[397.314368] Subtest plane-cursor-legacy: SUCCESS (0.456s)
[397.585258] [075/132] (642s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[399.097728] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[399.098656] Starting dynamic subtest: pipe-A-HDMI-A-3
[399.106855] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[399.118037] Starting dynamic subtest: pipe-B-HDMI-A-3
[399.126708] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[399.137716] Starting dynamic subtest: pipe-C-HDMI-A-3
[399.145968] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[399.156950] Starting dynamic subtest: pipe-D-HDMI-A-3
[399.166453] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[399.168007] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[399.424174] [076/132] (640s left) gem_exec_balancer (bonded-pair)
[399.526279] Starting subtest: bonded-pair
[399.528462] Subtest bonded-pair: SKIP (0.000s)
[399.959082] [077/132] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[401.474861] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[401.476692] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.712639] [078/132] (638s left) gem_ctx_exec (basic-invalid-context)
[401.797993] Starting subtest: basic-invalid-context
[401.804079] Subtest basic-invalid-context: SUCCESS (0.006s)
[402.028024] [079/132] (638s left) kms_content_protection (lic-type-0-hdcp14)
[403.609173] Starting subtest: lic-type-0-hdcp14
[403.619402] Subtest lic-type-0-hdcp14: SKIP (0.006s)
[403.849534] [080/132] (636s left) gem_eio (wait-immediate)
[404.146959] Starting subtest: wait-immediate
[404.742962] Subtest wait-immediate: SUCCESS (0.596s)
[406.361344] [081/132] (634s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[407.892470] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[407.905995] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.013s)
[408.072471] [082/132] (632s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[409.596617] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[409.597504] Starting dynamic subtest: pipe-A-valid-mode
[411.292541] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.694s)
[411.293521] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.696s)
[411.547484] [083/132] (629s left) kms_psr (psr2-basic)
[413.061806] Subtest psr2-basic: SKIP (0.000s)
[413.134064] [084/132] (627s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[414.655716] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[414.656650] Starting dynamic subtest: pipe-A-HDMI-A-3
[414.665048] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[414.677060] Starting dynamic subtest: pipe-B-HDMI-A-3
[414.685700] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[414.697500] Starting dynamic subtest: pipe-C-HDMI-A-3
[414.713124] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[414.724771] Starting dynamic subtest: pipe-D-HDMI-A-3
[414.735169] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[414.737168] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[414.983837] [085/132] (626s left) kms_vblank (query-forked-busy)
[416.494730] Starting subtest: query-forked-busy
[416.495606] Starting dynamic subtest: pipe-A-HDMI-A-3
[418.950049] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.452s)
[418.998500] Starting dynamic subtest: pipe-D-HDMI-A-3
[421.453318] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.493s)
[421.454969] Subtest query-forked-busy: SUCCESS (4.958s)
[421.736590] [086/132] (619s left) kms_pm_dc (dc9-dpms)
[424.259990] Starting subtest: dc9-dpms
[424.612637] Subtest dc9-dpms: SUCCESS (0.351s)
[425.445576] [087/132] (615s left) gem_userptr_blits (set-cache-level)
[425.545739] Starting subtest: set-cache-level
[425.546689] Subtest set-cache-level: SUCCESS (0.000s)
[425.795304] [088/132] (615s left) gem_exec_fence (keep-in-fence)
[426.002014] Starting subtest: keep-in-fence
[426.003000] Starting dynamic subtest: rcs0
[426.101156] Dynamic subtest rcs0: SUCCESS (0.098s)
[426.122147] Starting dynamic subtest: bcs0
[426.157718] Dynamic subtest bcs0: SUCCESS (0.055s)
[426.175749] Starting dynamic subtest: vcs0
[426.215789] Dynamic subtest vcs0: SUCCESS (0.055s)
[426.234852] Starting dynamic subtest: vcs1
[426.271161] Dynamic subtest vcs1: SUCCESS (0.054s)
[426.302137] Starting dynamic subtest: vecs0
[426.334171] Dynamic subtest vecs0: SUCCESS (0.061s)
[426.362016] Starting dynamic subtest: vecs1
[426.394960] Dynamic subtest vecs1: SUCCESS (0.058s)
[426.420330] Starting dynamic subtest: ccs0
[426.622974] Dynamic subtest ccs0: SUCCESS (0.225s)
[426.628238] Subtest keep-in-fence: SUCCESS (0.623s)
[427.416199] [089/132] (614s left) kms_pm_rpm (modeset-pc8-residency-stress)
[431.658333] Starting subtest: modeset-pc8-residency-stress
[431.660658] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[432.553748] [090/132] (609s left) kms_psr (fbc-psr2-sprite-plane-move)
[434.066995] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[434.133884] [091/132] (607s left) gem_exec_create (forked)
[434.223825] Starting subtest: forked
[434.224737] Starting dynamic subtest: smem
[454.350596] Dynamic subtest smem: SUCCESS (20.131s)
[454.367719] Starting dynamic subtest: lmem0
[474.495529] Dynamic subtest lmem0: SUCCESS (20.146s)
[474.496551] Subtest forked: SUCCESS (40.280s)
[474.809739] [092/132] (566s left) kms_psr (pr-cursor-mmap-cpu)
[476.325063] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[476.395150] [093/132] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[477.916524] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[477.918340] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[478.144019] [094/132] (563s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[479.662354] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[479.728450] [095/132] (562s left) gem_exec_reloc (basic-wc-read)
[479.814818] Subtest basic-wc-read: SKIP (0.000s)
[479.907768] [096/132] (562s left) kms_psr (psr-cursor-plane-move)
[481.461928] Subtest psr-cursor-plane-move: SKIP (0.000s)
[481.528327] [097/132] (560s left) kms_flip (basic-plain-flip)
[483.039862] Starting subtest: basic-plain-flip
[483.045707] Starting dynamic subtest: A-HDMI-A3
[483.800538] Dynamic subtest A-HDMI-A3: SUCCESS (0.754s)
[483.843979] Starting dynamic subtest: B-HDMI-A3
[484.530705] Dynamic subtest B-HDMI-A3: SUCCESS (0.725s)
[484.546409] Starting dynamic subtest: C-HDMI-A3
[485.214215] Dynamic subtest C-HDMI-A3: SUCCESS (0.681s)
[485.230086] Starting dynamic subtest: D-HDMI-A3
[485.895812] Dynamic subtest D-HDMI-A3: SUCCESS (0.676s)
[485.900644] Subtest basic-plain-flip: SUCCESS (2.858s)
[486.234222] [098/132] (555s left) kms_flip (plain-flip-fb-recreate)
[487.745865] Starting subtest: plain-flip-fb-recreate
[487.751501] Starting dynamic subtest: A-HDMI-A3
[495.795877] Dynamic subtest A-HDMI-A3: SUCCESS (8.043s)
[495.839367] Starting dynamic subtest: B-HDMI-A3
[503.796207] Dynamic subtest B-HDMI-A3: SUCCESS (7.994s)
[503.839873] Starting dynamic subtest: C-HDMI-A3
[511.795829] Dynamic subtest C-HDMI-A3: SUCCESS (7.992s)
[511.837683] Starting dynamic subtest: D-HDMI-A3
[519.795909] Dynamic subtest D-HDMI-A3: SUCCESS (7.993s)
[519.799850] Subtest plain-flip-fb-recreate: SUCCESS (32.051s)
[520.103166] [099/132] (522s left) i915_suspend (debugfs-reader)
[520.195835] Starting subtest: debugfs-reader
[540.609346] Subtest debugfs-reader: SUCCESS (5.804s)
[545.874767] [100/132] (501s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[547.446395] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[547.448303] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[547.680050] [101/132] (499s left) gem_exec_nop (basic-sequential)
[547.773244] Starting subtest: basic-sequential
[552.249338] Subtest basic-sequential: SUCCESS (4.346s)
[552.544331] [102/132] (495s left) gem_pxp (create-regular-buffer)
[555.176066] Starting subtest: create-regular-buffer
[555.178499] Subtest create-regular-buffer: SKIP (0.000s)
[555.308284] [103/132] (492s left) syncobj_basic (test-valid-cycle)
[555.395046] Starting subtest: test-valid-cycle
[555.396215] Subtest test-valid-cycle: SUCCESS (0.000s)
[555.579627] [104/132] (492s left) gem_exec_suspend (basic-s3-devices)
[555.669677] Starting subtest: basic-S3-devices
[555.670586] Starting dynamic subtest: smem
[565.756551] Dynamic subtest smem: SUCCESS (10.007s)
[565.769489] Starting dynamic subtest: lmem0
[575.577464] Dynamic subtest lmem0: SUCCESS (9.796s)
[575.578762] Subtest basic-S3-devices: SUCCESS (19.806s)
[584.886464] [105/132] (472s left) template (a)
[584.966707] Starting subtest: A
[584.967717] Subtest A: SUCCESS (0.000s)
[585.182879] [106/132] (471s left) gem_mmap_gtt (bad-object)
[585.262340] Subtest bad-object: SKIP (0.000s)
[585.340891] [107/132] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[586.859431] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[586.861253] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[587.096931] [108/132] (470s left) api_intel_bb (intel-bb-blit-y)
[587.179563] Starting subtest: intel-bb-blit-y
[588.253212] Subtest intel-bb-blit-y: SUCCESS (1.073s)
[588.447496] [109/132] (468s left) kms_selftest (drm_format_helper)
[588.500989] Starting subtest: drm_format_helper
[588.543000] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[588.619979] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.076s)
[588.636502] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[588.697118] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.076s)
[588.742211] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[588.786833] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.086s)
[588.824367] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[588.868043] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.079s)
[588.900903] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[588.952777] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.079s)
[588.996682] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[589.051251] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.097s)
[589.100524] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[589.129568] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.074s)
[589.149594] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[589.221854] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.088s)
[589.264511] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[589.306125] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.082s)
[589.328335] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[589.394563] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.083s)
[589.440971] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[589.489618] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.093s)
[589.519577] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[589.575927] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.084s)
[589.619342] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[589.657300] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.077s)
[589.676419] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[589.754901] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.091s)
[589.795661] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[589.838406] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.084s)
[589.868154] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[589.938255] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.097s)
[589.982337] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[590.028829] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.085s)
[590.029902] Subtest drm_format_helper: SUCCESS (1.529s)
[590.237905] [110/132] (467s left) gem_mmap_offset (oob-read)
[590.316663] Starting subtest: oob-read
[590.317561] Subtest oob-read: SUCCESS (0.000s)
[590.516653] [111/132] (466s left) gem_spin_batch (resubmit-all)
[590.605695] Starting subtest: resubmit-all
[590.606601] Starting dynamic subtest: rcs0
[590.639735] Dynamic subtest rcs0: SUCCESS (0.033s)
[590.654374] Starting dynamic subtest: bcs0
[590.655297] Dynamic subtest bcs0: SUCCESS (0.003s)
[590.668179] Starting dynamic subtest: vcs0
[590.669267] Dynamic subtest vcs0: SUCCESS (0.003s)
[590.681664] Starting dynamic subtest: vcs1
[590.682752] Dynamic subtest vcs1: SUCCESS (0.003s)
[590.694664] Starting dynamic subtest: vecs0
[590.695780] Dynamic subtest vecs0: SUCCESS (0.003s)
[590.707837] Starting dynamic subtest: vecs1
[590.708868] Dynamic subtest vecs1: SUCCESS (0.003s)
[590.720886] Starting dynamic subtest: ccs0
[590.722055] Dynamic subtest ccs0: SUCCESS (0.002s)
[590.723321] Subtest resubmit-all: SUCCESS (0.057s)
[591.018517] [112/132] (466s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[592.530051] Starting subtest: cursorB-vs-flipA-toggle
[592.533359] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[592.710381] [113/132] (464s left) gen9_exec_parse (valid-registers)
[592.810562] Subtest valid-registers: SKIP (0.000s)
[592.895636] [114/132] (464s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[594.408243] Starting subtest: disable-crc-after-crtc
[594.409196] Starting dynamic subtest: pipe-A-HDMI-A-3
[595.024625] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.615s)
[595.044588] Starting dynamic subtest: pipe-B-HDMI-A-3
[595.483076] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.454s)
[595.498254] Starting dynamic subtest: pipe-C-HDMI-A-3
[595.927493] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.442s)
[595.942312] Starting dynamic subtest: pipe-D-HDMI-A-3
[596.378676] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.449s)
[596.379620] Subtest disable-crc-after-crtc: SUCCESS (1.971s)
[596.620824] [115/132] (461s left) gem_exec_fence (syncobj-unused-fence)
[597.152071] Starting subtest: syncobj-unused-fence
[597.181438] Subtest syncobj-unused-fence: SUCCESS (0.029s)
[597.645987] [116/132] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[599.163146] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[599.165022] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[599.386609] [117/132] (458s left) gem_set_tiling_vs_pwrite
[599.557461] [118/132] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[601.075157] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[601.077305] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[601.315771] [119/132] (456s left) vgem_basic (busy-fence)
[601.374336] Starting subtest: busy-fence
[601.375280] Subtest busy-fence: SUCCESS (0.000s)
[601.531908] [120/132] (456s left) i915_pm_rpm (debugfs-read)
[605.271781] Starting subtest: debugfs-read
[606.178741] Subtest debugfs-read: SUCCESS (0.907s)
[607.243569] [121/132] (451s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[608.778103] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[611.888793] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.110s)
[612.106325] [122/132] (446s left) perf_pmu (busy-start)
[612.177845] Starting subtest: busy-start
[612.178688] Starting dynamic subtest: rcs0
[614.759654] Dynamic subtest rcs0: SUCCESS (2.579s)
[614.776277] Starting dynamic subtest: bcs0
[617.307859] Dynamic subtest bcs0: SUCCESS (2.542s)
[617.325107] Starting dynamic subtest: vcs0
[619.859666] Dynamic subtest vcs0: SUCCESS (2.545s)
[619.876560] Starting dynamic subtest: vcs1
[622.410776] Dynamic subtest vcs1: SUCCESS (2.545s)
[622.428042] Starting dynamic subtest: vecs0
[624.962662] Dynamic subtest vecs0: SUCCESS (2.546s)
[624.979381] Starting dynamic subtest: vecs1
[627.512795] Dynamic subtest vecs1: SUCCESS (2.544s)
[627.530685] Starting dynamic subtest: ccs0
[630.065047] Dynamic subtest ccs0: SUCCESS (2.546s)
[630.070129] Subtest busy-start: SUCCESS (17.883s)
[630.251708] [123/132] (428s left) kms_addfb_basic (size-max)
[631.767138] Starting subtest: size-max
[631.768134] Subtest size-max: SUCCESS (0.000s)
[632.000513] [124/132] (426s left) kms_psr (fbc-pr-primary-blt)
[633.514284] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[633.576020] [125/132] (425s left) kms_color_pipeline (plane-ctm3x4)
[635.100224] Starting subtest: plane-ctm3x4
[635.131403] Starting dynamic subtest: pipe-A-HDMI-A-3
[635.497165] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.366s)
[635.652898] Starting dynamic subtest: pipe-B-HDMI-A-3
[635.972638] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.332s)
[636.115974] Starting dynamic subtest: pipe-C-HDMI-A-3
[636.436440] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.332s)
[636.574599] Starting dynamic subtest: pipe-D-HDMI-A-3
[636.893321] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.331s)
[636.932540] Subtest plane-ctm3x4: SUCCESS (1.833s)
[637.183627] [126/132] (421s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[638.742449] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[638.847263] [127/132] (419s left) api_intel_allocator (standalone)
[638.931904] Starting subtest: standalone
[638.977159] Subtest standalone: SUCCESS (0.046s)
[639.211683] [128/132] (419s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[640.780283] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[640.782063] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[641.045643] [129/132] (417s left) kms_big_fb (y-tiled-addfb)
[642.573302] Starting subtest: y-tiled-addfb
[642.575160] Subtest y-tiled-addfb: SKIP (0.000s)
[642.818569] [130/132] (416s left) kms_prime (basic-crc-vgem)
[644.339993] Subtest basic-crc-vgem: SKIP (0.000s)
[644.561413] [131/132] (414s left) i915_hangman (engine-error-state-capture)
[644.653718] Starting subtest: engine-error-state-capture
[644.654598] Starting dynamic subtest: rcs0
[646.772041] Dynamic subtest rcs0: SUCCESS (2.117s)
[646.786560] Starting dynamic subtest: bcs0
[650.764800] Dynamic subtest bcs0: SUCCESS (3.990s)
[650.783074] Starting dynamic subtest: vcs0
[654.754716] Dynamic subtest vcs0: SUCCESS (3.986s)
[654.769484] Starting dynamic subtest: vcs1
[658.742379] Dynamic subtest vcs1: SUCCESS (3.985s)
[658.758372] Starting dynamic subtest: vecs0
[662.751392] Dynamic subtest vecs0: SUCCESS (4.006s)
[662.765685] Starting dynamic subtest: vecs1
[666.725488] Dynamic subtest vecs1: SUCCESS (3.971s)
[666.739627] Starting dynamic subtest: ccs0
[670.785622] Dynamic subtest ccs0: SUCCESS (4.057s)
[670.786560] Subtest engine-error-state-capture: SUCCESS (26.121s)
[670.977496] [132/132] (388s left) kms_invalid_mode (bad-vsync-end)
[672.496188] Starting subtest: bad-vsync-end
[672.497105] Starting dynamic subtest: pipe-A-HDMI-A-3
[672.547049] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.051s)
[672.560754] Starting dynamic subtest: pipe-B-HDMI-A-3
[672.561925] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[672.574626] Starting dynamic subtest: pipe-C-HDMI-A-3
[672.575670] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[672.588623] Starting dynamic subtest: pipe-D-HDMI-A-3
[672.589522] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.003s)
[672.590357] Subtest bad-vsync-end: SUCCESS (0.063s)
[672.798900] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_sync
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_fenced_exec_thrash
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_force_connector_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_chamelium_audio
results: parsing output: 49/ for test: gem_set_tiling_vs_gtt
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_gtt_cpu_tlb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: kms_dither
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_create
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_nop
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: gem_exec_suspend
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_selftest
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color_pipeline
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_invalid_mode
Done.