[62.705484] Initializing watchdogs
[62.705550]   /dev/watchdog0
[62.726444] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.737347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.740956] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.743233] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[62.816473] Starting subtest: wait-for-submit-snapshot
[62.900904] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[63.060487] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[64.555260] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[64.556152] Starting dynamic subtest: pipe-A-HDMI-A-3
[64.578008] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[64.585522] Starting dynamic subtest: pipe-B-HDMI-A-3
[64.607266] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[64.614601] Starting dynamic subtest: pipe-C-HDMI-A-3
[64.638479] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[64.645552] Starting dynamic subtest: pipe-D-HDMI-A-3
[64.667245] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[64.668951] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s)
[64.868940] [003/132] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[66.372137] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[68.926777] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.560s)
[69.129956] [004/132] (954s left) kms_big_fb (linear-8bpp-rotate-270)
[70.655184] Starting subtest: linear-8bpp-rotate-270
[70.724373] Subtest linear-8bpp-rotate-270: SKIP (0.069s)
[70.950547] [005/132] (952s left) kms_busy (extended-modeset-hang-newfb)
[72.464155] Starting subtest: extended-modeset-hang-newfb
[72.465034] Starting dynamic subtest: pipe-A
[88.093223] Dynamic subtest pipe-A: SUCCESS (15.631s)
[88.102935] Starting dynamic subtest: pipe-D
[103.631220] Dynamic subtest pipe-D: SUCCESS (15.533s)
[103.632162] Subtest extended-modeset-hang-newfb: SUCCESS (31.169s)
[103.915945] [006/132] (919s left) perf (oa-exponents)
[104.331100] Starting subtest: oa-exponents
[104.331956] Starting dynamic subtest: 0-rcs0
[106.587412] Dynamic subtest 0-rcs0: SUCCESS (2.256s)
[106.588470] Subtest oa-exponents: SUCCESS (2.256s)
[106.656536] [007/132] (917s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[108.193055] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[109.507655] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.314s)
[109.730391] [008/132] (913s left) kms_pipe_crc_basic (suspend-read-crc)
[111.231287] Starting subtest: suspend-read-crc
[111.232216] Starting dynamic subtest: pipe-A-HDMI-A-3
[132.185467] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.917s)
[132.195493] Starting dynamic subtest: pipe-B-HDMI-A-3
[153.247236] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (4.418s)
[153.263454] Starting dynamic subtest: pipe-C-HDMI-A-3
[174.191881] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (4.329s)
[174.202272] Starting dynamic subtest: pipe-D-HDMI-A-3
[195.186239] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.353s)
[195.187138] Subtest suspend-read-crc: SUCCESS (18.022s)
[201.436800] [009/132] (828s left) perf_pmu (interrupts-sync)
[201.501461] Starting subtest: interrupts-sync
[202.670104] Subtest interrupts-sync: SUCCESS (1.167s)
[202.844342] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[202.846241] [010/132] (827s left) gem_exec_reloc (basic-gtt-active)
[202.930464] Subtest basic-gtt-active: SKIP (0.000s)
[203.032829] [011/132] (826s left) kms_flip (modeset-vs-vblank-race)
[204.542809] Starting subtest: modeset-vs-vblank-race
[204.546962] Starting dynamic subtest: A-HDMI-A3
[207.684231] Dynamic subtest A-HDMI-A3: SUCCESS (3.137s)
[207.698558] Starting dynamic subtest: B-HDMI-A3
[210.686324] Dynamic subtest B-HDMI-A3: SUCCESS (3.000s)
[210.699975] Starting dynamic subtest: C-HDMI-A3
[213.716875] Dynamic subtest C-HDMI-A3: SUCCESS (3.029s)
[213.730839] Starting dynamic subtest: D-HDMI-A3
[216.707333] Dynamic subtest D-HDMI-A3: SUCCESS (2.989s)
[216.708457] Subtest modeset-vs-vblank-race: SUCCESS (12.167s)
[217.033645] [012/132] (812s left) gem_sync (basic-each)
[217.131178] Starting subtest: basic-each
[219.432966] Subtest basic-each: SUCCESS (2.301s)
[219.724550] [013/132] (810s left) gem_ctx_persistence (legacy-engines-mixed)
[219.813064] Starting subtest: legacy-engines-mixed
[219.814187] Starting dynamic subtest: render
[219.918893] Dynamic subtest render: SUCCESS (0.106s)
[219.934897] Starting dynamic subtest: bsd1
[219.973052] Dynamic subtest bsd1: SUCCESS (0.052s)
[220.001953] Starting dynamic subtest: bsd2
[220.042244] Dynamic subtest bsd2: SUCCESS (0.066s)
[220.056484] Starting dynamic subtest: blt
[220.105017] Dynamic subtest blt: SUCCESS (0.060s)
[220.133660] Starting dynamic subtest: vebox
[220.182786] Dynamic subtest vebox: SUCCESS (0.075s)
[220.187587] Subtest legacy-engines-mixed: SUCCESS (0.373s)
[220.394256] [014/132] (809s left) kms_plane (plane-panning-bottom-right)
[221.907821] Starting subtest: plane-panning-bottom-right
[221.908753] Starting dynamic subtest: pipe-A
[222.590903] Dynamic subtest pipe-A: SUCCESS (0.683s)
[222.612394] Starting dynamic subtest: pipe-B
[223.099989] Dynamic subtest pipe-B: SUCCESS (0.504s)
[223.100855] Subtest plane-panning-bottom-right: SUCCESS (1.194s)
[223.344312] [015/132] (806s left) prime_vgem (wait)
[223.455087] Starting subtest: wait
[223.456019] Starting dynamic subtest: rcs0
[223.520527] Dynamic subtest rcs0: SUCCESS (0.065s)
[223.532830] Starting dynamic subtest: bcs0
[223.583438] Dynamic subtest bcs0: SUCCESS (0.061s)
[223.604684] Starting dynamic subtest: vcs0
[223.626200] Dynamic subtest vcs0: SUCCESS (0.041s)
[223.647968] Starting dynamic subtest: vcs1
[223.667848] Dynamic subtest vcs1: SUCCESS (0.039s)
[223.689676] Starting dynamic subtest: vecs0
[223.707964] Dynamic subtest vecs0: SUCCESS (0.038s)
[223.726772] Starting dynamic subtest: vecs1
[223.749578] Dynamic subtest vecs1: SUCCESS (0.040s)
[223.766161] Starting dynamic subtest: ccs0
[223.791284] Dynamic subtest ccs0: SUCCESS (0.040s)
[223.792252] Subtest wait: SUCCESS (0.337s)
[224.008969] [016/132] (806s left) i915_query (query-topology-matches-eu-total)
[224.087542] Starting subtest: query-topology-matches-eu-total
[224.088497] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[224.296058] [017/132] (806s left) syncobj_timeline (reset-signaled)
[224.371543] Starting subtest: reset-signaled
[224.372500] Subtest reset-signaled: SUCCESS (0.001s)
[224.554657] [018/132] (805s left) syncobj_timeline (multi-wait-all-available-signaled)
[224.642086] Starting subtest: multi-wait-all-available-signaled
[224.642950] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[224.847446] [019/132] (805s left) kms_cursor_crc (cursor-random-256x256)
[226.591953] Starting subtest: cursor-random-256x256
[226.597077] Starting dynamic subtest: pipe-A-HDMI-A-3
[231.141761] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.544s)
[231.181132] Starting dynamic subtest: pipe-D-HDMI-A-3
[235.604483] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.432s)
[235.605392] Subtest cursor-random-256x256: SUCCESS (9.011s)
[235.986145] [020/132] (794s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[236.070979] Starting subtest: mixed-tiled-to-y-tiled-ccs
[236.072778] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[236.359512] [021/132] (794s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[237.872784] Starting subtest: primary-y-tiled-reflect-x-180
[237.962857] Subtest primary-y-tiled-reflect-x-180: SKIP (0.090s)
[238.172740] [022/132] (792s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[238.260512] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[238.262477] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[238.510430] [023/132] (792s left) gem_exec_schedule (reorder-wide)
[238.715192] Subtest reorder-wide: SKIP (0.000s)
[238.975189] [024/132] (792s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[240.490725] Starting subtest: fbc-indfb-scaledprimary
[241.996077] Subtest fbc-indfb-scaledprimary: SUCCESS (1.506s)
[242.256310] [025/132] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[243.774606] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[243.776464] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[243.973533] [026/132] (787s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[245.490817] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[245.491739] Starting dynamic subtest: pipe-A-HDMI-A-3
[245.495146] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[245.506431] Starting dynamic subtest: pipe-B-HDMI-A-3
[245.509837] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[245.520958] Starting dynamic subtest: pipe-C-HDMI-A-3
[245.524570] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[245.535568] Starting dynamic subtest: pipe-D-HDMI-A-3
[245.539032] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[245.540738] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[245.780472] [027/132] (785s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[247.300806] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[247.447268] [028/132] (783s left) kms_cursor_crc (cursor-random-64x21)
[249.132968] Starting subtest: cursor-random-64x21
[249.138041] Starting dynamic subtest: pipe-A-HDMI-A-3
[253.518381] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.380s)
[253.556480] Starting dynamic subtest: pipe-D-HDMI-A-3
[257.993407] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.448s)
[257.994263] Subtest cursor-random-64x21: SUCCESS (8.861s)
[258.430470] [029/132] (773s left) prime_mmap (test_dup)
[258.510515] Starting subtest: test_dup
[258.511428] Starting dynamic subtest: test_dup-smem
[258.556985] Dynamic subtest test_dup-smem: SUCCESS (0.046s)
[258.569494] Starting dynamic subtest: test_dup-lmem0
[258.744993] Dynamic subtest test_dup-lmem0: SUCCESS (0.187s)
[258.745965] Subtest test_dup: SUCCESS (0.235s)
[258.870006] [030/132] (772s left) gem_exec_schedule (u-submit-late-slice)
[258.962543] Starting subtest: u-submit-late-slice
[258.963514] Starting dynamic subtest: rcs0
[259.039076] Dynamic subtest rcs0: SUCCESS (0.076s)
[259.051999] Starting dynamic subtest: bcs0
[259.087851] Dynamic subtest bcs0: SUCCESS (0.048s)
[259.100744] Starting dynamic subtest: vcs0
[259.136878] Dynamic subtest vcs0: SUCCESS (0.048s)
[259.149844] Starting dynamic subtest: vcs1
[259.186175] Dynamic subtest vcs1: SUCCESS (0.048s)
[259.199103] Starting dynamic subtest: vecs0
[259.236103] Dynamic subtest vecs0: SUCCESS (0.049s)
[259.248635] Starting dynamic subtest: vecs1
[259.284877] Dynamic subtest vecs1: SUCCESS (0.048s)
[259.297797] Starting dynamic subtest: ccs0
[259.336687] Dynamic subtest ccs0: SUCCESS (0.051s)
[259.337761] Subtest u-submit-late-slice: SUCCESS (0.375s)
[259.850071] [031/132] (771s left) syncobj_timeline (etime-multi-wait-all-submitted)
[259.928093] Starting subtest: etime-multi-wait-all-submitted
[260.036005] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[260.216734] [032/132] (771s left) fbdev (write)
[260.285968] Starting subtest: write
[261.661434] Subtest write: SUCCESS (1.375s)
[261.814372] [033/132] (770s left) syncobj_wait (invalid-signal-zero-handles)
[261.894049] Starting subtest: invalid-signal-zero-handles
[261.894980] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[262.095322] [034/132] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[263.615703] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[263.617507] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[263.841589] [035/132] (768s left) gem_exec_balancer (sliced)
[263.933514] Starting subtest: sliced
[263.935600] Subtest sliced: SKIP (0.000s)
[264.372898] [036/132] (767s left) gem_ccs (large-ctrl-surf-copy)
[264.456734] Starting subtest: large-ctrl-surf-copy
[265.104744] Subtest large-ctrl-surf-copy: SUCCESS (0.648s)
[265.304400] [037/132] (766s left) gem_fenced_exec_thrash (2-spare-fences)
[265.390681] Subtest 2-spare-fences: SKIP (0.000s)
[265.486979] [038/132] (766s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[267.002010] Starting subtest: basic-busy-flip-before-cursor-varying-size
[267.003872] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[267.187869] [039/132] (765s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[268.737098] Starting subtest: 4-tiled-8bpp-rotate-0
[270.269726] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.532s)
[270.468717] [040/132] (761s left) gem_mmap_wc (copy)
[270.546771] Subtest copy: SKIP (0.000s)
[270.615315] [041/132] (761s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[272.128745] Starting subtest: cursor-vs-flip-toggle
[305.378579] Subtest cursor-vs-flip-toggle: SUCCESS (33.248s)
[305.609400] [042/132] (726s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[307.133560] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[307.135356] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[307.354298] [043/132] (725s left) kms_addfb_basic (unused-handle)
[307.440193] Starting subtest: unused-handle
[307.441078] Subtest unused-handle: SUCCESS (0.000s)
[309.091060] [044/132] (723s left) gem_ctx_shared (q-smoketest-all)
[309.199268] Starting subtest: Q-smoketest-all
[341.503530] Subtest Q-smoketest-all: SUCCESS (32.297s)
[341.876408] [045/132] (690s left) kms_flip (2x-flip-vs-expired-vblank)
[343.387880] Starting subtest: 2x-flip-vs-expired-vblank
[343.401057] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[343.596217] [046/132] (689s left) kms_force_connector_basic (force-edid)
[343.753982] Starting subtest: force-edid
[343.774977] Subtest force-edid: SUCCESS (0.022s)
[345.499490] [047/132] (687s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[347.046038] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[348.323123] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.276s)
[348.537179] [048/132] (684s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[350.052749] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[350.053760] Starting dynamic subtest: pipe-A
[350.138854] Dynamic subtest pipe-A: SUCCESS (0.087s)
[350.156195] Starting dynamic subtest: pipe-B
[350.284867] Dynamic subtest pipe-B: SUCCESS (0.145s)
[350.304928] Starting dynamic subtest: pipe-C
[350.428124] Dynamic subtest pipe-C: SUCCESS (0.142s)
[350.446992] Starting dynamic subtest: pipe-D
[350.552205] Dynamic subtest pipe-D: SUCCESS (0.123s)
[350.553091] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.501s)
[350.820525] [049/132] (682s left) kms_chamelium_audio (hdmi-audio)
[352.385236] Subtest hdmi-audio: SKIP (0.000s)
[352.489995] [050/132] (680s left) gem_set_tiling_vs_gtt
[352.654325] [051/132] (680s left) gem_lmem_swapping (massive)
[357.250775] Starting subtest: massive
[357.251554] Starting dynamic subtest: lmem0
[365.415345] Dynamic subtest lmem0: SUCCESS (8.164s)
[365.416227] Subtest massive: SUCCESS (8.166s)
[366.795288] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[366.796249] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[366.798112] [052/132] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[371.740510] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[371.742791] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[371.971554] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[371.975312] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[371.982543] [053/132] (661s left) prime_busy (after)
[372.074606] Starting subtest: after
[372.079568] Starting dynamic subtest: rcs0
[372.142877] Dynamic subtest rcs0: SUCCESS (0.063s)
[372.156065] Starting dynamic subtest: bcs0
[372.200335] Dynamic subtest bcs0: SUCCESS (0.056s)
[372.215266] Starting dynamic subtest: vcs0
[372.244064] Dynamic subtest vcs0: SUCCESS (0.042s)
[372.256002] Starting dynamic subtest: vcs1
[372.285816] Dynamic subtest vcs1: SUCCESS (0.041s)
[372.297605] Starting dynamic subtest: vecs0
[372.326502] Dynamic subtest vecs0: SUCCESS (0.040s)
[372.338770] Starting dynamic subtest: vecs1
[372.366872] Dynamic subtest vecs1: SUCCESS (0.039s)
[372.387295] Starting dynamic subtest: ccs0
[372.408553] Dynamic subtest ccs0: SUCCESS (0.040s)
[372.521438] Subtest after: SUCCESS (0.446s)
[372.725572] [054/132] (660s left) syncobj_wait (invalid-signal-illegal-handle)
[372.805066] Starting subtest: invalid-signal-illegal-handle
[372.806021] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[372.963979] [055/132] (660s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[374.480655] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[374.481558] Starting dynamic subtest: pipe-A-valid-mode
[374.527976] Dynamic subtest pipe-A-valid-mode: SKIP (0.045s)
[374.529795] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.047s)
[374.744213] [056/132] (658s left) gem_gtt_cpu_tlb
[374.888396] [057/132] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[376.401748] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[376.403701] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[376.613009] [058/132] (657s left) gen9_exec_parse (batch-zero-length)
[376.703048] Subtest batch-zero-length: SKIP (0.000s)
[376.772104] [059/132] (657s left) gem_softpin (evict-snoop-interruptible)
[376.862259] Starting subtest: evict-snoop-interruptible
[376.863941] Subtest evict-snoop-interruptible: SKIP (0.000s)
[377.084801] [060/132] (656s left) dmabuf_sync_file (export-basic)
[377.143833] Starting subtest: export-basic
[377.144778] Subtest export-basic: SUCCESS (0.001s)
[377.262610] [061/132] (656s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[378.780946] Starting subtest: fb-8bpc-vs-panel-6bpc
[378.783715] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.000s)
[378.970824] [062/132] (655s left) syncobj_timeline (host-signal-ordered)
[379.060174] Starting subtest: host-signal-ordered
[379.061258] Subtest host-signal-ordered: SUCCESS (0.000s)
[379.252094] [063/132] (655s left) kms_chamelium_hpd (common-hpd-after-suspend)
[380.819400] Subtest common-hpd-after-suspend: SKIP (0.000s)
[380.921757] [064/132] (653s left) kms_flip (2x-flip-vs-fences)
[382.439818] Starting subtest: 2x-flip-vs-fences
[382.441521] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[382.679006] [065/132] (651s left) perf (mi-rpc)
[383.079767] Starting subtest: mi-rpc
[383.081467] Subtest mi-rpc: SKIP (0.000s)
[383.135189] [066/132] (651s left) sw_sync (sync_random_merge)
[383.185881] Starting subtest: sync_random_merge
[383.250417] Subtest sync_random_merge: SUCCESS (0.066s)
[383.400306] [067/132] (651s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[384.915656] Starting subtest: psr-rgb101010-draw-pwrite
[384.917508] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[385.155018] [068/132] (649s left) kms_getfb (getfb2-handle-closed)
[386.681806] Starting subtest: getfb2-handle-closed
[386.682719] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[386.922465] [069/132] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[388.440806] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[388.442580] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.676048] [070/132] (646s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[388.769562] Starting subtest: invalid-smem-bo-on-discrete
[388.770950] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[390.443347] [071/132] (644s left) perf (gen12-invalid-class-instance)
[390.738085] Starting subtest: gen12-invalid-class-instance
[390.757682] Subtest gen12-invalid-class-instance: SUCCESS (0.021s)
[390.819346] [072/132] (644s left) gem_exec_schedule (implicit-read-write)
[390.910741] Starting subtest: implicit-read-write
[390.911662] Starting dynamic subtest: rcs0
[391.215481] Dynamic subtest rcs0: SUCCESS (0.297s)
[391.226559] Starting dynamic subtest: bcs0
[391.426384] Dynamic subtest bcs0: SUCCESS (0.211s)
[391.437549] Starting dynamic subtest: vcs0
[391.649729] Dynamic subtest vcs0: SUCCESS (0.219s)
[391.660555] Starting dynamic subtest: vcs1
[391.859669] Dynamic subtest vcs1: SUCCESS (0.218s)
[391.870762] Starting dynamic subtest: vecs0
[392.083005] Dynamic subtest vecs0: SUCCESS (0.222s)
[392.094079] Starting dynamic subtest: vecs1
[392.300805] Dynamic subtest vecs1: SUCCESS (0.216s)
[392.312002] Starting dynamic subtest: ccs0
[392.520616] Dynamic subtest ccs0: SUCCESS (0.219s)
[392.521689] Subtest implicit-read-write: SUCCESS (1.610s)
[393.052557] [073/132] (642s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[394.565884] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[394.776316] [074/132] (640s left) kms_atomic (plane-cursor-legacy)
[396.294720] Starting subtest: plane-cursor-legacy
[396.295684] Starting dynamic subtest: pipe-A-HDMI-A-3
[396.795114] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.500s)
[396.796036] Subtest plane-cursor-legacy: SUCCESS (0.502s)
[397.089234] [075/132] (638s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[398.602790] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[398.603666] Starting dynamic subtest: pipe-A-HDMI-A-3
[398.612257] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[398.623471] Starting dynamic subtest: pipe-B-HDMI-A-3
[398.631906] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[398.642992] Starting dynamic subtest: pipe-C-HDMI-A-3
[398.651369] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[398.662350] Starting dynamic subtest: pipe-D-HDMI-A-3
[398.671343] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[398.673037] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[398.918673] [076/132] (636s left) gem_exec_balancer (bonded-pair)
[399.016845] Starting subtest: bonded-pair
[399.018774] Subtest bonded-pair: SKIP (0.000s)
[399.444973] [077/132] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[400.956752] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[400.958504] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.206689] [078/132] (634s left) gem_ctx_exec (basic-invalid-context)
[401.297323] Starting subtest: basic-invalid-context
[401.301993] Subtest basic-invalid-context: SUCCESS (0.005s)
[401.490977] [079/132] (634s left) kms_content_protection (lic-type-0-hdcp14)
[403.075661] Starting subtest: lic-type-0-hdcp14
[403.086211] Subtest lic-type-0-hdcp14: SKIP (0.005s)
[403.295211] [080/132] (632s left) gem_eio (wait-immediate)
[403.577029] Starting subtest: wait-immediate
[404.125108] Subtest wait-immediate: SUCCESS (0.548s)
[405.762985] [081/132] (630s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[407.291117] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[407.304856] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.013s)
[407.483585] [082/132] (628s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[409.027734] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[409.028670] Starting dynamic subtest: pipe-A-valid-mode
[410.769591] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.740s)
[410.770539] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.742s)
[411.016633] [083/132] (625s left) kms_psr (psr2-basic)
[412.532243] Subtest psr2-basic: SKIP (0.000s)
[412.587995] [084/132] (623s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[414.100839] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[414.101731] Starting dynamic subtest: pipe-A-HDMI-A-3
[414.109890] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[414.121893] Starting dynamic subtest: pipe-B-HDMI-A-3
[414.130822] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[414.142611] Starting dynamic subtest: pipe-C-HDMI-A-3
[414.150848] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[414.162121] Starting dynamic subtest: pipe-D-HDMI-A-3
[414.171647] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[414.173651] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[414.401400] [085/132] (621s left) kms_vblank (query-forked-busy)
[415.916663] Starting subtest: query-forked-busy
[415.917520] Starting dynamic subtest: pipe-A-HDMI-A-3
[418.411027] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.491s)
[418.456639] Starting dynamic subtest: pipe-D-HDMI-A-3
[420.865919] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.445s)
[420.870396] Subtest query-forked-busy: SUCCESS (4.952s)
[421.154711] [086/132] (615s left) kms_pm_dc (dc9-dpms)
[423.685806] Starting subtest: dc9-dpms
[424.031992] Subtest dc9-dpms: SUCCESS (0.346s)
[424.867478] [087/132] (611s left) gem_userptr_blits (set-cache-level)
[424.976474] Starting subtest: set-cache-level
[424.977341] Subtest set-cache-level: SUCCESS (0.000s)
[425.186249] [088/132] (611s left) gem_exec_fence (keep-in-fence)
[425.420844] Starting subtest: keep-in-fence
[425.425459] Starting dynamic subtest: rcs0
[425.534074] Dynamic subtest rcs0: SUCCESS (0.112s)
[425.571691] Starting dynamic subtest: bcs0
[425.602500] Dynamic subtest bcs0: SUCCESS (0.066s)
[425.635680] Starting dynamic subtest: vcs0
[425.673017] Dynamic subtest vcs0: SUCCESS (0.068s)
[425.699533] Starting dynamic subtest: vcs1
[425.733404] Dynamic subtest vcs1: SUCCESS (0.058s)
[425.766432] Starting dynamic subtest: vecs0
[425.798057] Dynamic subtest vecs0: SUCCESS (0.062s)
[425.821292] Starting dynamic subtest: vecs1
[425.855231] Dynamic subtest vecs1: SUCCESS (0.055s)
[425.885034] Starting dynamic subtest: ccs0
[426.086897] Dynamic subtest ccs0: SUCCESS (0.229s)
[426.087917] Subtest keep-in-fence: SUCCESS (0.667s)
[426.825994] [089/132] (609s left) kms_pm_rpm (modeset-pc8-residency-stress)
[430.981127] Starting subtest: modeset-pc8-residency-stress
[430.983177] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[431.961401] [090/132] (604s left) kms_psr (fbc-psr2-sprite-plane-move)
[433.498446] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[433.638020] [091/132] (603s left) gem_exec_create (forked)
[433.728995] Starting subtest: forked
[433.729898] Starting dynamic subtest: smem
[453.856988] Dynamic subtest smem: SUCCESS (20.128s)
[453.876428] Starting dynamic subtest: lmem0
[474.010793] Dynamic subtest lmem0: SUCCESS (20.152s)
[474.011755] Subtest forked: SUCCESS (40.282s)
[474.293587] [092/132] (562s left) kms_psr (pr-cursor-mmap-cpu)
[475.802138] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[475.865972] [093/132] (561s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[477.382832] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[477.384533] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[477.606853] [094/132] (559s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[479.126875] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[479.181458] [095/132] (557s left) gem_exec_reloc (basic-wc-read)
[479.270197] Subtest basic-wc-read: SKIP (0.000s)
[479.354401] [096/132] (557s left) kms_psr (psr-cursor-plane-move)
[480.870284] Subtest psr-cursor-plane-move: SKIP (0.000s)
[480.979369] [097/132] (556s left) kms_flip (basic-plain-flip)
[482.514843] Starting subtest: basic-plain-flip
[482.520547] Starting dynamic subtest: A-HDMI-A3
[483.287850] Dynamic subtest A-HDMI-A3: SUCCESS (0.767s)
[483.304528] Starting dynamic subtest: B-HDMI-A3
[483.986334] Dynamic subtest B-HDMI-A3: SUCCESS (0.697s)
[484.003598] Starting dynamic subtest: C-HDMI-A3
[484.669895] Dynamic subtest C-HDMI-A3: SUCCESS (0.682s)
[484.684001] Starting dynamic subtest: D-HDMI-A3
[485.352569] Dynamic subtest D-HDMI-A3: SUCCESS (0.681s)
[485.353541] Subtest basic-plain-flip: SUCCESS (2.839s)
[485.621919] [098/132] (551s left) kms_flip (plain-flip-fb-recreate)
[487.130664] Starting subtest: plain-flip-fb-recreate
[487.135572] Starting dynamic subtest: A-HDMI-A3
[495.161245] Dynamic subtest A-HDMI-A3: SUCCESS (8.025s)
[495.203167] Starting dynamic subtest: B-HDMI-A3
[503.159348] Dynamic subtest B-HDMI-A3: SUCCESS (7.993s)
[503.173787] Starting dynamic subtest: C-HDMI-A3
[511.126928] Dynamic subtest C-HDMI-A3: SUCCESS (7.966s)
[511.144272] Starting dynamic subtest: D-HDMI-A3
[519.094520] Dynamic subtest D-HDMI-A3: SUCCESS (7.965s)
[519.099656] Subtest plain-flip-fb-recreate: SUCCESS (31.966s)
[519.401176] [099/132] (518s left) i915_suspend (debugfs-reader)
[519.496144] Starting subtest: debugfs-reader
[541.188762] Subtest debugfs-reader: SUCCESS (5.876s)
[546.445056] [100/132] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[547.969169] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[547.970746] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[548.219213] [101/132] (494s left) gem_exec_nop (basic-sequential)
[548.308928] Starting subtest: basic-sequential
[552.737918] Subtest basic-sequential: SUCCESS (4.428s)
[553.084197] [102/132] (489s left) gem_pxp (create-regular-buffer)
[555.691584] Starting subtest: create-regular-buffer
[555.693596] Subtest create-regular-buffer: SKIP (0.000s)
[555.821437] [103/132] (487s left) syncobj_basic (test-valid-cycle)
[555.907947] Starting subtest: test-valid-cycle
[555.909044] Subtest test-valid-cycle: SUCCESS (0.000s)
[556.098235] [104/132] (486s left) gem_exec_suspend (basic-s3-devices)
[556.184247] Starting subtest: basic-S3-devices
[556.185170] Starting dynamic subtest: smem
[566.298298] Dynamic subtest smem: SUCCESS (10.113s)
[566.310880] Starting dynamic subtest: lmem0
[576.138270] Dynamic subtest lmem0: SUCCESS (9.839s)
[576.139470] Subtest basic-S3-devices: SUCCESS (19.954s)
[584.478717] [105/132] (466s left) template (a)
[584.565575] Starting subtest: A
[584.566485] Subtest A: SUCCESS (0.000s)
[584.727970] [106/132] (466s left) gem_mmap_gtt (bad-object)
[584.808592] Subtest bad-object: SKIP (0.000s)
[584.875876] [107/132] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[586.392337] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[586.394276] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[586.623944] [108/132] (464s left) api_intel_bb (intel-bb-blit-y)
[586.702904] Starting subtest: intel-bb-blit-y
[587.709347] Subtest intel-bb-blit-y: SUCCESS (1.006s)
[587.877397] [109/132] (463s left) kms_selftest (drm_format_helper)
[587.929801] Starting subtest: drm_format_helper
[587.968209] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[588.063252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.092s)
[588.077209] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[588.160761] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.094s)
[588.202875] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[588.247986] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.084s)
[588.276427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[588.347549] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.097s)
[588.387754] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[588.430041] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.079s)
[588.454587] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[588.518126] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.083s)
[588.555807] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[588.597096] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.078s)
[588.622647] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[588.679163] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.080s)
[588.693209] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[588.773014] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.090s)
[588.812978] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[588.865077] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.090s)
[588.898329] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[588.946760] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.078s)
[588.989514] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[589.036086] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.088s)
[589.070322] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[589.118382] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.078s)
[589.159238] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[589.209712] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.090s)
[589.253887] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[589.296218] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.084s)
[589.338290] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[589.385486] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.085s)
[589.423823] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[589.477230] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.091s)
[589.482324] Subtest drm_format_helper: SUCCESS (1.551s)
[589.708397] [110/132] (461s left) gem_mmap_offset (oob-read)
[589.789019] Starting subtest: oob-read
[589.789897] Subtest oob-read: SUCCESS (0.000s)
[589.994472] [111/132] (461s left) gem_spin_batch (resubmit-all)
[590.081879] Starting subtest: resubmit-all
[590.082808] Starting dynamic subtest: rcs0
[590.116409] Dynamic subtest rcs0: SUCCESS (0.034s)
[590.130588] Starting dynamic subtest: bcs0
[590.131489] Dynamic subtest bcs0: SUCCESS (0.003s)
[590.144098] Starting dynamic subtest: vcs0
[590.145055] Dynamic subtest vcs0: SUCCESS (0.003s)
[590.157519] Starting dynamic subtest: vcs1
[590.158680] Dynamic subtest vcs1: SUCCESS (0.003s)
[590.170651] Starting dynamic subtest: vecs0
[590.171712] Dynamic subtest vecs0: SUCCESS (0.003s)
[590.183718] Starting dynamic subtest: vecs1
[590.184787] Dynamic subtest vecs1: SUCCESS (0.003s)
[590.196925] Starting dynamic subtest: ccs0
[590.198117] Dynamic subtest ccs0: SUCCESS (0.002s)
[590.199206] Subtest resubmit-all: SUCCESS (0.058s)
[590.479062] [112/132] (461s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[591.988524] Starting subtest: cursorB-vs-flipA-toggle
[591.990515] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[592.151876] [113/132] (459s left) gen9_exec_parse (valid-registers)
[592.264803] Subtest valid-registers: SKIP (0.000s)
[592.372011] [114/132] (459s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[593.881392] Starting subtest: disable-crc-after-crtc
[593.882300] Starting dynamic subtest: pipe-A-HDMI-A-3
[594.499761] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.617s)
[594.516142] Starting dynamic subtest: pipe-B-HDMI-A-3
[594.940863] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.439s)
[594.955866] Starting dynamic subtest: pipe-C-HDMI-A-3
[595.387165] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.443s)
[595.402267] Starting dynamic subtest: pipe-D-HDMI-A-3
[595.818006] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.429s)
[595.818943] Subtest disable-crc-after-crtc: SUCCESS (1.937s)
[596.060082] [115/132] (455s left) gem_exec_fence (syncobj-unused-fence)
[596.596790] Starting subtest: syncobj-unused-fence
[596.627230] Subtest syncobj-unused-fence: SUCCESS (0.030s)
[597.063206] [116/132] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[598.578521] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[598.580410] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[598.817787] [117/132] (453s left) gem_set_tiling_vs_pwrite
[598.994258] [118/132] (453s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[600.510227] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[600.511847] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[600.740520] [119/132] (451s left) vgem_basic (busy-fence)
[600.797459] Starting subtest: busy-fence
[600.798394] Subtest busy-fence: SUCCESS (0.000s)
[600.993958] [120/132] (451s left) i915_pm_rpm (debugfs-read)
[604.743764] Starting subtest: debugfs-read
[605.783934] Subtest debugfs-read: SUCCESS (1.038s)
[606.812371] [121/132] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[608.335215] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[611.377665] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.043s)
[611.609456] [122/132] (440s left) perf_pmu (busy-start)
[611.683142] Starting subtest: busy-start
[611.684148] Starting dynamic subtest: rcs0
[614.279859] Dynamic subtest rcs0: SUCCESS (2.595s)
[614.295902] Starting dynamic subtest: bcs0
[616.831033] Dynamic subtest bcs0: SUCCESS (2.546s)
[616.847246] Starting dynamic subtest: vcs0
[619.381703] Dynamic subtest vcs0: SUCCESS (2.546s)
[619.398000] Starting dynamic subtest: vcs1
[621.932830] Dynamic subtest vcs1: SUCCESS (2.546s)
[621.949658] Starting dynamic subtest: vecs0
[624.485014] Dynamic subtest vecs0: SUCCESS (2.547s)
[624.501850] Starting dynamic subtest: vecs1
[627.036934] Dynamic subtest vecs1: SUCCESS (2.547s)
[627.053188] Starting dynamic subtest: ccs0
[629.587843] Dynamic subtest ccs0: SUCCESS (2.546s)
[629.592343] Subtest busy-start: SUCCESS (17.905s)
[629.777381] [123/132] (422s left) kms_addfb_basic (size-max)
[631.290546] Starting subtest: size-max
[631.291462] Subtest size-max: SUCCESS (0.000s)
[631.491650] [124/132] (421s left) kms_psr (fbc-pr-primary-blt)
[633.011614] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[633.075505] [125/132] (419s left) kms_color_pipeline (plane-ctm3x4)
[634.589754] Starting subtest: plane-ctm3x4
[634.613072] Starting dynamic subtest: pipe-A-HDMI-A-3
[634.979729] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.366s)
[635.132419] Starting dynamic subtest: pipe-B-HDMI-A-3
[635.452989] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.332s)
[635.582530] Starting dynamic subtest: pipe-C-HDMI-A-3
[635.886207] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.315s)
[636.001870] Starting dynamic subtest: pipe-D-HDMI-A-3
[636.320556] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.331s)
[636.360644] Subtest plane-ctm3x4: SUCCESS (1.771s)
[636.631236] [126/132] (416s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[638.180972] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[638.283390] [127/132] (414s left) api_intel_allocator (standalone)
[638.364125] Starting subtest: standalone
[638.407641] Subtest standalone: SUCCESS (0.045s)
[638.636187] [128/132] (414s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[640.150361] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[640.152157] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[640.383654] [129/132] (412s left) kms_big_fb (y-tiled-addfb)
[641.912942] Starting subtest: y-tiled-addfb
[641.914768] Subtest y-tiled-addfb: SKIP (0.000s)
[642.144934] [130/132] (411s left) kms_prime (basic-crc-vgem)
[643.662401] Subtest basic-crc-vgem: SKIP (0.000s)
[643.864869] [131/132] (409s left) i915_hangman (engine-error-state-capture)
[643.961996] Starting subtest: engine-error-state-capture
[643.962837] Starting dynamic subtest: rcs0
[646.322582] Dynamic subtest rcs0: SUCCESS (2.360s)
[646.336844] Starting dynamic subtest: bcs0
[650.306027] Dynamic subtest bcs0: SUCCESS (3.982s)
[650.322124] Starting dynamic subtest: vcs0
[654.313748] Dynamic subtest vcs0: SUCCESS (4.006s)
[654.328326] Starting dynamic subtest: vcs1
[658.302035] Dynamic subtest vcs1: SUCCESS (3.987s)
[658.318392] Starting dynamic subtest: vecs0
[662.305704] Dynamic subtest vecs0: SUCCESS (4.002s)
[662.320132] Starting dynamic subtest: vecs1
[666.284905] Dynamic subtest vecs1: SUCCESS (3.978s)
[666.299534] Starting dynamic subtest: ccs0
[670.329622] Dynamic subtest ccs0: SUCCESS (4.043s)
[670.330539] Subtest engine-error-state-capture: SUCCESS (26.367s)
[670.515103] [132/132] (382s left) kms_invalid_mode (bad-vsync-end)
[672.031401] Starting subtest: bad-vsync-end
[672.032401] Starting dynamic subtest: pipe-A-HDMI-A-3
[672.073556] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.042s)
[672.088168] Starting dynamic subtest: pipe-B-HDMI-A-3
[672.089346] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[672.102379] Starting dynamic subtest: pipe-C-HDMI-A-3
[672.103575] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[672.116024] Starting dynamic subtest: pipe-D-HDMI-A-3
[672.116884] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[672.117758] Subtest bad-vsync-end: SUCCESS (0.051s)
[672.315133] 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.