[68.026980] Initializing watchdogs
[68.027067]   /dev/watchdog0
[68.057307] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.071853] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.076945] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.079555] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[68.128160] Starting subtest: wait-for-submit-snapshot
[68.211738] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[68.401309] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[69.882892] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[69.883769] Starting dynamic subtest: pipe-A-HDMI-A-4
[69.905159] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[69.912440] Starting dynamic subtest: pipe-B-HDMI-A-4
[69.933922] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[69.941920] Starting dynamic subtest: pipe-C-HDMI-A-4
[69.964242] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[69.971492] Starting dynamic subtest: pipe-D-HDMI-A-4
[69.994546] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[69.996185] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[70.171582] [003/132] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[71.662210] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[74.059521] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.396s)
[74.340049] [004/132] (954s left) kms_big_fb (linear-8bpp-rotate-270)
[75.844958] Starting subtest: linear-8bpp-rotate-270
[75.950979] Subtest linear-8bpp-rotate-270: SKIP (0.105s)
[76.178902] [005/132] (952s left) kms_busy (extended-modeset-hang-newfb)
[77.668762] Starting subtest: extended-modeset-hang-newfb
[77.671116] Starting dynamic subtest: pipe-A
[93.261145] Dynamic subtest pipe-A: SUCCESS (15.591s)
[93.272091] Starting dynamic subtest: pipe-D
[108.753896] Dynamic subtest pipe-D: SUCCESS (15.489s)
[108.755760] Subtest extended-modeset-hang-newfb: SUCCESS (31.087s)
[108.988306] [006/132] (919s left) perf (oa-exponents)
[109.145514] Starting subtest: oa-exponents
[109.146379] Starting dynamic subtest: 0-rcs0
[112.808583] Dynamic subtest 0-rcs0: SUCCESS (3.660s)
[112.809691] Subtest oa-exponents: SUCCESS (3.660s)
[112.882311] [007/132] (916s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[114.383272] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[115.646278] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.259s)
[115.910247] [008/132] (913s left) kms_pipe_crc_basic (suspend-read-crc)
[117.392520] Starting subtest: suspend-read-crc
[117.393380] Starting dynamic subtest: pipe-A-HDMI-A-4
[139.332289] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.267s)
[139.343661] Starting dynamic subtest: pipe-B-HDMI-A-4
[161.174326] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.528s)
[161.185963] Starting dynamic subtest: pipe-C-HDMI-A-4
[183.209758] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.631s)
[183.221614] Starting dynamic subtest: pipe-D-HDMI-A-4
[205.204457] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.727s)
[205.205304] Subtest suspend-read-crc: SUCCESS (43.161s)
[210.492548] [009/132] (823s left) perf_pmu (interrupts-sync)
[210.543742] Starting subtest: interrupts-sync
[211.726703] Subtest interrupts-sync: SUCCESS (1.179s)
[211.908569] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[211.910730] [010/132] (822s left) gem_exec_reloc (basic-gtt-active)
[211.958894] Subtest basic-gtt-active: SKIP (0.000s)
[212.055758] [011/132] (822s left) kms_flip (modeset-vs-vblank-race)
[214.036020] Starting subtest: modeset-vs-vblank-race
[214.043092] Starting dynamic subtest: A-HDMI-A4
[217.128117] Dynamic subtest A-HDMI-A4: SUCCESS (3.085s)
[217.142522] Starting dynamic subtest: B-HDMI-A4
[220.147216] Dynamic subtest B-HDMI-A4: SUCCESS (3.018s)
[220.159641] Starting dynamic subtest: C-HDMI-A4
[223.153620] Dynamic subtest C-HDMI-A4: SUCCESS (3.005s)
[223.166072] Starting dynamic subtest: D-HDMI-A4
[226.163226] Dynamic subtest D-HDMI-A4: SUCCESS (3.008s)
[226.164135] Subtest modeset-vs-vblank-race: SUCCESS (12.129s)
[226.479635] [012/132] (807s left) gem_sync (basic-each)
[226.545945] Starting subtest: basic-each
[228.692983] Subtest basic-each: SUCCESS (2.147s)
[229.021050] [013/132] (805s left) gem_ctx_persistence (legacy-engines-mixed)
[229.070731] Starting subtest: legacy-engines-mixed
[229.073136] Starting dynamic subtest: render
[229.156079] Dynamic subtest render: SUCCESS (0.084s)
[229.171723] Starting dynamic subtest: bsd1
[229.212050] Dynamic subtest bsd1: SUCCESS (0.053s)
[229.227145] Starting dynamic subtest: bsd2
[229.281288] Dynamic subtest bsd2: SUCCESS (0.066s)
[229.296238] Starting dynamic subtest: blt
[229.327010] Dynamic subtest blt: SUCCESS (0.042s)
[229.345438] Starting dynamic subtest: vebox
[229.395912] Dynamic subtest vebox: SUCCESS (0.066s)
[229.404262] Subtest legacy-engines-mixed: SUCCESS (0.328s)
[229.648630] [014/132] (805s left) kms_plane (plane-panning-bottom-right)
[231.129751] Starting subtest: plane-panning-bottom-right
[231.133008] Starting dynamic subtest: pipe-A
[231.845857] Dynamic subtest pipe-A: SUCCESS (0.714s)
[231.859049] Starting dynamic subtest: pipe-B
[232.357501] Dynamic subtest pipe-B: SUCCESS (0.507s)
[232.358518] Subtest plane-panning-bottom-right: SUCCESS (1.227s)
[232.615863] [015/132] (802s left) prime_vgem (wait)
[232.705777] Starting subtest: wait
[232.706670] Starting dynamic subtest: rcs0
[232.770414] Dynamic subtest rcs0: SUCCESS (0.064s)
[232.783342] Starting dynamic subtest: bcs0
[232.818437] Dynamic subtest bcs0: SUCCESS (0.046s)
[232.832803] Starting dynamic subtest: vcs0
[232.860021] Dynamic subtest vcs0: SUCCESS (0.039s)
[232.878332] Starting dynamic subtest: vcs1
[232.900556] Dynamic subtest vcs1: SUCCESS (0.038s)
[232.918863] Starting dynamic subtest: vecs0
[232.941693] Dynamic subtest vecs0: SUCCESS (0.039s)
[232.942793] Subtest wait: SUCCESS (0.237s)
[233.210842] [016/132] (801s left) i915_query (query-topology-matches-eu-total)
[233.254909] Starting subtest: query-topology-matches-eu-total
[233.255949] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[233.423307] [017/132] (801s left) syncobj_timeline (reset-signaled)
[233.469547] Starting subtest: reset-signaled
[233.470585] Subtest reset-signaled: SUCCESS (0.000s)
[233.664369] [018/132] (801s left) syncobj_timeline (multi-wait-all-available-signaled)
[233.709945] Starting subtest: multi-wait-all-available-signaled
[233.711093] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[233.911143] [019/132] (801s left) kms_cursor_crc (cursor-random-256x256)
[235.613988] Starting subtest: cursor-random-256x256
[235.621759] Starting dynamic subtest: pipe-A-HDMI-A-4
[240.091915] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.470s)
[240.124967] Starting dynamic subtest: pipe-D-HDMI-A-4
[244.584134] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.469s)
[244.585070] Subtest cursor-random-256x256: SUCCESS (8.970s)
[245.001462] [020/132] (790s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[245.053195] Starting subtest: mixed-tiled-to-y-tiled-ccs
[245.054223] Starting dynamic subtest: smem
[245.164095] Dynamic subtest smem: SUCCESS (0.107s)
[245.175747] Starting dynamic subtest: lmem0
[246.114080] Dynamic subtest lmem0: SUCCESS (0.948s)
[246.115410] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.058s)
[246.471708] [021/132] (788s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[247.953984] Starting subtest: primary-y-tiled-reflect-x-180
[258.475962] Subtest primary-y-tiled-reflect-x-180: SUCCESS (10.523s)
[258.815406] [022/132] (776s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[258.867457] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[258.868452] Starting dynamic subtest: smem
[258.968168] Dynamic subtest smem: SUCCESS (0.100s)
[258.981804] Starting dynamic subtest: lmem0
[260.080956] Dynamic subtest lmem0: SUCCESS (1.108s)
[260.082097] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.211s)
[260.418635] [023/132] (775s left) gem_exec_schedule (reorder-wide)
[260.594353] Subtest reorder-wide: SKIP (0.000s)
[260.885842] [024/132] (774s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[262.374579] Starting subtest: fbc-indfb-scaledprimary
[265.995319] Subtest fbc-indfb-scaledprimary: SUCCESS (3.621s)
[266.233463] [025/132] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[267.721917] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[267.723734] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[267.983368] [026/132] (767s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[269.467187] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[269.468015] Starting dynamic subtest: pipe-A-HDMI-A-4
[269.471283] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[269.482874] Starting dynamic subtest: pipe-B-HDMI-A-4
[269.486249] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[269.497828] Starting dynamic subtest: pipe-C-HDMI-A-4
[269.501112] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[269.512302] Starting dynamic subtest: pipe-D-HDMI-A-4
[269.515629] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[269.517165] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.011s)
[269.748120] [027/132] (766s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[271.240502] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[271.319325] [028/132] (764s left) kms_cursor_crc (cursor-random-64x21)
[272.949075] Starting subtest: cursor-random-64x21
[272.955342] Starting dynamic subtest: pipe-A-HDMI-A-4
[277.494432] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.538s)
[277.528460] Starting dynamic subtest: pipe-D-HDMI-A-4
[282.004933] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.487s)
[282.005929] Subtest cursor-random-64x21: SUCCESS (9.056s)
[282.507534] [029/132] (753s left) prime_mmap (test_dup)
[282.552111] Starting subtest: test_dup
[282.553165] Starting dynamic subtest: test_dup-smem
[282.614216] Dynamic subtest test_dup-smem: SUCCESS (0.062s)
[282.627490] Starting dynamic subtest: test_dup-lmem0
[282.680229] Dynamic subtest test_dup-lmem0: SUCCESS (0.065s)
[282.681228] Subtest test_dup: SUCCESS (0.130s)
[282.864765] [030/132] (753s left) gem_exec_schedule (u-submit-late-slice)
[282.927919] Starting subtest: u-submit-late-slice
[282.928926] Starting dynamic subtest: rcs0
[282.984437] Dynamic subtest rcs0: SUCCESS (0.056s)
[282.998357] Starting dynamic subtest: bcs0
[283.024645] Dynamic subtest bcs0: SUCCESS (0.039s)
[283.038458] Starting dynamic subtest: vcs0
[283.063896] Dynamic subtest vcs0: SUCCESS (0.038s)
[283.077868] Starting dynamic subtest: vcs1
[283.103097] Dynamic subtest vcs1: SUCCESS (0.038s)
[283.117042] Starting dynamic subtest: vecs0
[283.143316] Dynamic subtest vecs0: SUCCESS (0.039s)
[283.144314] Subtest u-submit-late-slice: SUCCESS (0.216s)
[283.583788] [031/132] (752s left) syncobj_timeline (etime-multi-wait-all-submitted)
[283.629006] Starting subtest: etime-multi-wait-all-submitted
[283.741440] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s)
[283.933896] [032/132] (752s left) fbdev (write)
[283.997338] Starting subtest: write
[284.722392] Subtest write: SUCCESS (0.723s)
[284.845275] [033/132] (751s left) syncobj_wait (invalid-signal-zero-handles)
[284.890346] Starting subtest: invalid-signal-zero-handles
[284.891210] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[285.033711] [034/132] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[286.521795] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[286.523482] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[286.783776] [035/132] (749s left) gem_exec_balancer (sliced)
[286.840424] Starting subtest: sliced
[286.842262] Subtest sliced: SKIP (0.000s)
[287.354722] [036/132] (749s left) gem_ccs (large-ctrl-surf-copy)
[287.409276] Starting subtest: large-ctrl-surf-copy
[287.411065] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[287.609646] [037/132] (749s left) gem_fenced_exec_thrash (2-spare-fences)
[287.658358] Subtest 2-spare-fences: SKIP (0.000s)
[287.744683] [038/132] (749s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[289.228117] Starting subtest: basic-busy-flip-before-cursor-varying-size
[289.229749] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[289.442141] [039/132] (747s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[290.961826] Starting subtest: 4-tiled-8bpp-rotate-0
[290.964084] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[291.210614] [040/132] (745s left) gem_mmap_wc (copy)
[291.282214] Subtest copy: SKIP (0.000s)
[291.357547] [041/132] (745s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[292.842572] Starting subtest: cursor-vs-flip-toggle
[327.885471] Subtest cursor-vs-flip-toggle: SUCCESS (35.045s)
[328.119348] [042/132] (709s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[329.621661] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[329.623392] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[329.876041] [043/132] (707s left) kms_addfb_basic (unused-handle)
[329.923382] Starting subtest: unused-handle
[329.924196] Subtest unused-handle: SUCCESS (0.000s)
[331.603266] [044/132] (705s left) gem_ctx_shared (q-smoketest-all)
[331.674834] Starting subtest: Q-smoketest-all
[363.975419] Subtest Q-smoketest-all: SUCCESS (32.291s)
[364.387249] [045/132] (673s left) kms_flip (2x-flip-vs-expired-vblank)
[365.873598] Starting subtest: 2x-flip-vs-expired-vblank
[365.887931] Subtest 2x-flip-vs-expired-vblank: SKIP (0.018s)
[366.109728] [046/132] (671s left) kms_force_connector_basic (force-edid)
[366.239335] Starting subtest: force-edid
[366.261787] Subtest force-edid: SUCCESS (0.021s)
[367.997424] [047/132] (669s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[369.501169] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[370.728560] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.227s)
[371.019099] [048/132] (667s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[372.502792] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[372.503835] Starting dynamic subtest: pipe-A
[372.650513] Dynamic subtest pipe-A: SUCCESS (0.149s)
[372.664265] Starting dynamic subtest: pipe-B
[372.790240] Dynamic subtest pipe-B: SUCCESS (0.138s)
[372.803653] Starting dynamic subtest: pipe-C
[372.930269] Dynamic subtest pipe-C: SUCCESS (0.139s)
[372.943723] Starting dynamic subtest: pipe-D
[373.071288] Dynamic subtest pipe-D: SUCCESS (0.140s)
[373.072282] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.571s)
[373.324190] [049/132] (664s left) kms_chamelium_audio (hdmi-audio)
[374.854965] Subtest hdmi-audio: SKIP (0.000s)
[374.964596] [050/132] (663s left) gem_set_tiling_vs_gtt
[375.098832] [051/132] (663s left) gem_lmem_swapping (massive)
[379.406093] Starting subtest: massive
[379.406967] Starting dynamic subtest: lmem0
[387.502920] Dynamic subtest lmem0: SUCCESS (8.094s)
[387.504051] Subtest massive: SUCCESS (8.096s)
[389.026062] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[389.027252] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[389.029645] [052/132] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[393.791733] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[393.793490] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[394.044740] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[394.048181] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[394.054481] [053/132] (644s left) prime_busy (after)
[394.109442] Starting subtest: after
[394.114148] Starting dynamic subtest: rcs0
[394.161760] Dynamic subtest rcs0: SUCCESS (0.048s)
[394.175445] Starting dynamic subtest: bcs0
[394.219280] Dynamic subtest bcs0: SUCCESS (0.056s)
[394.239198] Starting dynamic subtest: vcs0
[394.261330] Dynamic subtest vcs0: SUCCESS (0.040s)
[394.281345] Starting dynamic subtest: vcs1
[394.305324] Dynamic subtest vcs1: SUCCESS (0.042s)
[394.320709] Starting dynamic subtest: vecs0
[394.347374] Dynamic subtest vecs0: SUCCESS (0.040s)
[394.459471] Subtest after: SUCCESS (0.348s)
[394.686813] [054/132] (643s left) syncobj_wait (invalid-signal-illegal-handle)
[394.731626] Starting subtest: invalid-signal-illegal-handle
[394.732528] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[394.942472] [055/132] (643s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[396.423734] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[396.424528] Starting dynamic subtest: pipe-A-valid-mode
[396.472942] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[396.474363] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.050s)
[396.647983] [056/132] (642s left) gem_gtt_cpu_tlb
[396.776846] [057/132] (642s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[399.150968] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[399.152388] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.314437] [058/132] (639s left) gen9_exec_parse (batch-zero-length)
[399.364302] Subtest batch-zero-length: SKIP (0.000s)
[399.442103] [059/132] (639s left) gem_softpin (evict-snoop-interruptible)
[399.496327] Starting subtest: evict-snoop-interruptible
[399.497821] Subtest evict-snoop-interruptible: SKIP (0.000s)
[399.648423] [060/132] (639s left) dmabuf_sync_file (export-basic)
[399.699541] Starting subtest: export-basic
[399.700366] Subtest export-basic: SUCCESS (0.001s)
[399.832046] [061/132] (639s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[401.314352] Starting subtest: fb-8bpc-vs-panel-6bpc
[401.316813] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.001s)
[401.528814] [062/132] (637s left) syncobj_timeline (host-signal-ordered)
[401.573781] Starting subtest: host-signal-ordered
[401.574663] Subtest host-signal-ordered: SUCCESS (0.001s)
[401.771731] [063/132] (637s left) kms_chamelium_hpd (common-hpd-after-suspend)
[403.305013] Subtest common-hpd-after-suspend: SKIP (0.000s)
[403.422843] [064/132] (635s left) kms_flip (2x-flip-vs-fences)
[404.907283] Starting subtest: 2x-flip-vs-fences
[404.908916] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[405.123168] [065/132] (634s left) perf (mi-rpc)
[405.274772] Starting subtest: mi-rpc
[405.276364] Subtest mi-rpc: SKIP (0.000s)
[405.357562] [066/132] (634s left) sw_sync (sync_random_merge)
[405.400176] Starting subtest: sync_random_merge
[405.488441] Subtest sync_random_merge: SUCCESS (0.088s)
[405.646830] [067/132] (634s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[407.135008] Starting subtest: psr-rgb101010-draw-pwrite
[407.136800] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[407.393711] [068/132] (632s left) kms_getfb (getfb2-handle-closed)
[408.876568] Starting subtest: getfb2-handle-closed
[408.877552] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[409.118922] [069/132] (630s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[410.606009] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[410.607751] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.862968] [070/132] (629s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[410.907622] Starting subtest: invalid-smem-bo-on-discrete
[410.908570] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[412.580898] [071/132] (627s left) perf (gen12-invalid-class-instance)
[412.752212] Starting subtest: gen12-invalid-class-instance
[412.774459] Subtest gen12-invalid-class-instance: SUCCESS (0.023s)
[412.856281] [072/132] (627s left) gem_exec_schedule (implicit-read-write)
[412.912444] Starting subtest: implicit-read-write
[412.913344] Starting dynamic subtest: rcs0
[413.115544] Dynamic subtest rcs0: SUCCESS (0.199s)
[413.127018] Starting dynamic subtest: bcs0
[413.247875] Dynamic subtest bcs0: SUCCESS (0.134s)
[413.261237] Starting dynamic subtest: vcs0
[413.385966] Dynamic subtest vcs0: SUCCESS (0.137s)
[413.398535] Starting dynamic subtest: vcs1
[413.528091] Dynamic subtest vcs1: SUCCESS (0.141s)
[413.541405] Starting dynamic subtest: vecs0
[413.677994] Dynamic subtest vecs0: SUCCESS (0.148s)
[413.678917] Subtest implicit-read-write: SUCCESS (0.766s)
[414.159272] [073/132] (626s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[415.644921] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[415.918159] [074/132] (624s left) kms_atomic (plane-cursor-legacy)
[417.401260] Starting subtest: plane-cursor-legacy
[417.403788] Starting dynamic subtest: pipe-A-HDMI-A-4
[417.729924] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.327s)
[417.730825] Subtest plane-cursor-legacy: SUCCESS (0.330s)
[417.989655] [075/132] (622s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[419.476189] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[419.477116] Starting dynamic subtest: pipe-A-HDMI-A-4
[419.484561] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[419.496443] Starting dynamic subtest: pipe-B-HDMI-A-4
[419.503880] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[419.515773] Starting dynamic subtest: pipe-C-HDMI-A-4
[419.523301] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[419.534487] Starting dynamic subtest: pipe-D-HDMI-A-4
[419.542086] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[419.542895] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.013s)
[419.773701] [076/132] (620s left) gem_exec_balancer (bonded-pair)
[419.830836] Starting subtest: bonded-pair
[419.833069] Subtest bonded-pair: SKIP (0.000s)
[420.356097] [077/132] (620s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[421.842659] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[421.844335] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.098045] [078/132] (618s left) gem_ctx_exec (basic-invalid-context)
[422.145189] Starting subtest: basic-invalid-context
[422.148869] Subtest basic-invalid-context: SUCCESS (0.005s)
[422.384809] [079/132] (618s left) kms_content_protection (lic-type-0-hdcp14)
[423.923762] Starting subtest: lic-type-0-hdcp14
[423.930814] Subtest lic-type-0-hdcp14: SKIP (0.005s)
[424.183018] [080/132] (617s left) gem_eio (wait-immediate)
[424.371331] Starting subtest: wait-immediate
[424.810316] Subtest wait-immediate: SUCCESS (0.439s)
[426.458376] [081/132] (614s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[427.946289] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[427.964806] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s)
[428.168219] [082/132] (613s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[429.652703] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[429.653668] Starting dynamic subtest: pipe-A-valid-mode
[430.872345] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.219s)
[430.873171] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.222s)
[431.185405] [083/132] (610s left) kms_psr (psr2-basic)
[432.668308] Subtest psr2-basic: SKIP (0.000s)
[432.755117] [084/132] (608s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[434.237982] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[434.239117] Starting dynamic subtest: pipe-A-HDMI-A-4
[434.251359] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[434.264060] Starting dynamic subtest: pipe-B-HDMI-A-4
[434.273386] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[434.285667] Starting dynamic subtest: pipe-C-HDMI-A-4
[434.294800] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[434.306879] Starting dynamic subtest: pipe-D-HDMI-A-4
[434.316935] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[434.318855] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.014s)
[434.535166] [085/132] (607s left) kms_vblank (query-forked-busy)
[436.048340] Starting subtest: query-forked-busy
[436.050789] Starting dynamic subtest: pipe-A-HDMI-A-4
[438.598112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.546s)
[438.656784] Starting dynamic subtest: pipe-D-HDMI-A-4
[441.076447] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.451s)
[441.085036] Subtest query-forked-busy: SUCCESS (5.032s)
[441.326797] [086/132] (600s left) kms_pm_dc (dc9-dpms)
[443.818402] Starting subtest: dc9-dpms
[444.159664] Subtest dc9-dpms: SUCCESS (0.342s)
[445.027777] [087/132] (596s left) gem_userptr_blits (set-cache-level)
[445.093647] Starting subtest: set-cache-level
[445.094453] Subtest set-cache-level: SUCCESS (0.000s)
[445.352391] [088/132] (596s left) gem_exec_fence (keep-in-fence)
[445.523780] Starting subtest: keep-in-fence
[445.524701] Starting dynamic subtest: rcs0
[445.616222] Dynamic subtest rcs0: SUCCESS (0.092s)
[445.633958] Starting dynamic subtest: bcs0
[445.672767] Dynamic subtest bcs0: SUCCESS (0.054s)
[445.694599] Starting dynamic subtest: vcs0
[445.730169] Dynamic subtest vcs0: SUCCESS (0.055s)
[445.767658] Starting dynamic subtest: vcs1
[445.801813] Dynamic subtest vcs1: SUCCESS (0.068s)
[445.825903] Starting dynamic subtest: vecs0
[445.861184] Dynamic subtest vecs0: SUCCESS (0.057s)
[445.865551] Subtest keep-in-fence: SUCCESS (0.339s)
[446.531326] [089/132] (595s left) kms_pm_rpm (modeset-pc8-residency-stress)
[450.658998] Starting subtest: modeset-pc8-residency-stress
[450.660935] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[451.646137] [090/132] (590s left) kms_psr (fbc-psr2-sprite-plane-move)
[453.137251] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[453.221204] [091/132] (589s left) gem_exec_create (forked)
[453.276671] Starting subtest: forked
[453.277487] Starting dynamic subtest: smem
[473.421170] Dynamic subtest smem: SUCCESS (20.144s)
[473.444264] Starting dynamic subtest: lmem0
[493.579602] Dynamic subtest lmem0: SUCCESS (20.156s)
[493.580489] Subtest forked: SUCCESS (40.304s)
[493.890495] [092/132] (548s left) kms_psr (pr-cursor-mmap-cpu)
[495.373850] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[495.454870] [093/132] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[496.944115] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[496.945756] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[497.194417] [094/132] (545s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[498.697750] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[498.771861] [095/132] (543s left) gem_exec_reloc (basic-wc-read)
[498.822588] Subtest basic-wc-read: SKIP (0.000s)
[498.922273] [096/132] (543s left) kms_psr (psr-cursor-plane-move)
[500.405249] Subtest psr-cursor-plane-move: SKIP (0.000s)
[500.489027] [097/132] (542s left) kms_flip (basic-plain-flip)
[501.971235] Starting subtest: basic-plain-flip
[501.978356] Starting dynamic subtest: A-HDMI-A4
[502.702314] Dynamic subtest A-HDMI-A4: SUCCESS (0.724s)
[502.718260] Starting dynamic subtest: B-HDMI-A4
[503.381942] Dynamic subtest B-HDMI-A4: SUCCESS (0.676s)
[503.399080] Starting dynamic subtest: C-HDMI-A4
[504.058068] Dynamic subtest C-HDMI-A4: SUCCESS (0.670s)
[504.079716] Starting dynamic subtest: D-HDMI-A4
[504.732115] Dynamic subtest D-HDMI-A4: SUCCESS (0.665s)
[504.733051] Subtest basic-plain-flip: SUCCESS (2.763s)
[505.028254] [098/132] (537s left) kms_flip (plain-flip-fb-recreate)
[506.512171] Starting subtest: plain-flip-fb-recreate
[506.519353] Starting dynamic subtest: A-HDMI-A4
[514.534875] Dynamic subtest A-HDMI-A4: SUCCESS (8.014s)
[514.580830] Starting dynamic subtest: B-HDMI-A4
[522.528853] Dynamic subtest B-HDMI-A4: SUCCESS (7.985s)
[522.572226] Starting dynamic subtest: C-HDMI-A4
[530.522402] Dynamic subtest C-HDMI-A4: SUCCESS (7.985s)
[530.566479] Starting dynamic subtest: D-HDMI-A4
[538.515624] Dynamic subtest D-HDMI-A4: SUCCESS (7.984s)
[538.524454] Subtest plain-flip-fb-recreate: SUCCESS (32.008s)
[538.816568] [099/132] (504s left) i915_suspend (debugfs-reader)
[538.861342] Starting subtest: debugfs-reader
[561.116554] Subtest debugfs-reader: SUCCESS (11.795s)
[566.345806] [100/132] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[569.158196] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[569.159623] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[569.331949] [101/132] (478s left) gem_exec_nop (basic-sequential)
[569.388849] Starting subtest: basic-sequential
[573.154059] Subtest basic-sequential: SUCCESS (3.762s)
[573.483736] [102/132] (474s left) gem_pxp (create-regular-buffer)
[576.054082] Starting subtest: create-regular-buffer
[576.056032] Subtest create-regular-buffer: SKIP (0.000s)
[576.196813] [103/132] (472s left) syncobj_basic (test-valid-cycle)
[576.239909] Starting subtest: test-valid-cycle
[576.240798] Subtest test-valid-cycle: SUCCESS (0.000s)
[576.411997] [104/132] (472s left) gem_exec_suspend (basic-s3-devices)
[576.467845] Starting subtest: basic-S3-devices
[576.468690] Starting dynamic subtest: smem
[586.849848] Dynamic subtest smem: SUCCESS (10.383s)
[586.864581] Starting dynamic subtest: lmem0
[597.026767] Dynamic subtest lmem0: SUCCESS (10.176s)
[597.027591] Subtest basic-S3-devices: SUCCESS (20.561s)
[605.378970] [105/132] (451s left) template (a)
[605.425143] Starting subtest: A
[605.425822] Subtest A: SUCCESS (0.000s)
[605.577824] [106/132] (451s left) gem_mmap_gtt (bad-object)
[605.621562] Subtest bad-object: SKIP (0.000s)
[605.721447] [107/132] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[608.145468] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[608.147298] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[608.391658] [108/132] (448s left) api_intel_bb (intel-bb-blit-y)
[608.435741] Starting subtest: intel-bb-blit-y
[610.047387] Subtest intel-bb-blit-y: SUCCESS (1.612s)
[610.299877] [109/132] (446s left) kms_selftest (drm_format_helper)
[610.345237] Starting subtest: drm_format_helper
[610.418785] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[610.507838] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.100s)
[610.523147] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[610.594472] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.084s)
[610.634185] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[610.682649] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.083s)
[610.718589] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[610.764437] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.079s)
[610.802309] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[610.875499] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.100s)
[610.916812] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[610.961669] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.086s)
[610.991815] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[611.060754] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.096s)
[611.106693] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[611.157009] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.088s)
[611.183739] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[611.253020] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.094s)
[611.301539] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[611.345512] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.086s)
[611.368347] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[611.455879] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.107s)
[611.508798] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[611.546501] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.084s)
[611.567763] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[611.632878] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.079s)
[611.677309] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[611.720333] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.083s)
[611.744218] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[611.811956] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.089s)
[611.853866] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[611.903111] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.084s)
[611.926366] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[612.011312] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.106s)
[612.019212] Subtest drm_format_helper: SUCCESS (1.669s)
[612.285706] [110/132] (444s left) gem_mmap_offset (oob-read)
[612.330169] Starting subtest: oob-read
[612.331133] Subtest oob-read: SUCCESS (0.000s)
[612.533477] [111/132] (444s left) gem_spin_batch (resubmit-all)
[612.589977] Starting subtest: resubmit-all
[612.591024] Starting dynamic subtest: rcs0
[612.613340] Dynamic subtest rcs0: SUCCESS (0.023s)
[612.628425] Starting dynamic subtest: bcs0
[612.629579] Dynamic subtest bcs0: SUCCESS (0.002s)
[612.642976] Starting dynamic subtest: vcs0
[612.644245] Dynamic subtest vcs0: SUCCESS (0.002s)
[612.657180] Starting dynamic subtest: vcs1
[612.658430] Dynamic subtest vcs1: SUCCESS (0.002s)
[612.671178] Starting dynamic subtest: vecs0
[612.672418] Dynamic subtest vecs0: SUCCESS (0.002s)
[612.673659] Subtest resubmit-all: SUCCESS (0.038s)
[612.987149] [112/132] (444s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[614.471522] Starting subtest: cursorB-vs-flipA-toggle
[614.475189] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[614.701268] [113/132] (442s left) gen9_exec_parse (valid-registers)
[614.750659] Subtest valid-registers: SKIP (0.000s)
[614.824516] [114/132] (442s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[616.307055] Starting subtest: disable-crc-after-crtc
[616.307932] Starting dynamic subtest: pipe-A-HDMI-A-4
[616.943067] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.633s)
[616.958379] Starting dynamic subtest: pipe-B-HDMI-A-4
[617.380998] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.437s)
[617.399992] Starting dynamic subtest: pipe-C-HDMI-A-4
[617.858271] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.473s)
[617.878099] Starting dynamic subtest: pipe-D-HDMI-A-4
[618.325272] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.462s)
[618.326437] Subtest disable-crc-after-crtc: SUCCESS (2.020s)
[618.572631] [115/132] (439s left) gem_exec_fence (syncobj-unused-fence)
[618.950133] Starting subtest: syncobj-unused-fence
[618.973123] Subtest syncobj-unused-fence: SUCCESS (0.019s)
[619.449502] [116/132] (438s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[620.936936] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[620.938853] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[621.195760] [117/132] (436s left) gem_set_tiling_vs_pwrite
[621.328579] [118/132] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[622.815771] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[622.817563] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[623.045455] [119/132] (435s left) vgem_basic (busy-fence)
[623.091782] Starting subtest: busy-fence
[623.092721] Subtest busy-fence: SUCCESS (0.000s)
[623.256999] [120/132] (434s left) i915_pm_rpm (debugfs-read)
[627.172105] Starting subtest: debugfs-read
[628.150407] Subtest debugfs-read: SUCCESS (0.975s)
[629.264428] [121/132] (429s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[630.754464] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[634.053457] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.298s)
[634.329924] [122/132] (424s left) perf_pmu (busy-start)
[634.377365] Starting subtest: busy-start
[634.378190] Starting dynamic subtest: rcs0
[636.943422] Dynamic subtest rcs0: SUCCESS (2.565s)
[636.960632] Starting dynamic subtest: bcs0
[639.491417] Dynamic subtest bcs0: SUCCESS (2.546s)
[639.508748] Starting dynamic subtest: vcs0
[642.039437] Dynamic subtest vcs0: SUCCESS (2.546s)
[642.056704] Starting dynamic subtest: vcs1
[644.587417] Dynamic subtest vcs1: SUCCESS (2.546s)
[644.605031] Starting dynamic subtest: vecs0
[647.135364] Dynamic subtest vecs0: SUCCESS (2.546s)
[647.138278] Subtest busy-start: SUCCESS (12.758s)
[647.309374] [123/132] (411s left) kms_addfb_basic (size-max)
[648.793015] Starting subtest: size-max
[648.793887] Subtest size-max: SUCCESS (0.000s)
[649.034978] [124/132] (409s left) kms_psr (fbc-pr-primary-blt)
[650.520764] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[650.614887] [125/132] (408s left) kms_color_pipeline (plane-ctm3x4)
[652.103815] Starting subtest: plane-ctm3x4
[652.137891] Starting dynamic subtest: pipe-A-HDMI-A-4
[652.553064] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s)
[652.658520] Starting dynamic subtest: pipe-B-HDMI-A-4
[652.979518] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.332s)
[653.120658] Starting dynamic subtest: pipe-C-HDMI-A-4
[653.456733] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.349s)
[653.580681] Starting dynamic subtest: pipe-D-HDMI-A-4
[653.900989] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.332s)
[653.971845] Subtest plane-ctm3x4: SUCCESS (1.868s)
[654.218411] [126/132] (404s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[655.743634] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[655.857276] [127/132] (403s left) api_intel_allocator (standalone)
[655.900712] Starting subtest: standalone
[655.937372] Subtest standalone: SUCCESS (0.037s)
[656.215364] [128/132] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[657.703480] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[657.705184] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[657.930643] [129/132] (401s left) kms_big_fb (y-tiled-addfb)
[659.434074] Starting subtest: y-tiled-addfb
[659.434883] Subtest y-tiled-addfb: SUCCESS (0.000s)
[659.693574] [130/132] (399s left) kms_prime (basic-crc-vgem)
[661.198532] Subtest basic-crc-vgem: SKIP (0.000s)
[661.442807] [131/132] (398s left) i915_hangman (engine-error-state-capture)
[661.503441] Starting subtest: engine-error-state-capture
[661.504390] Starting dynamic subtest: rcs0
[663.606179] Dynamic subtest rcs0: SUCCESS (2.103s)
[663.623200] Starting dynamic subtest: bcs0
[667.616050] Dynamic subtest bcs0: SUCCESS (4.007s)
[667.632897] Starting dynamic subtest: vcs0
[671.587044] Dynamic subtest vcs0: SUCCESS (3.969s)
[671.604149] Starting dynamic subtest: vcs1
[675.618189] Dynamic subtest vcs1: SUCCESS (4.029s)
[675.636714] Starting dynamic subtest: vecs0
[679.588030] Dynamic subtest vecs0: SUCCESS (3.968s)
[679.589107] Subtest engine-error-state-capture: SUCCESS (18.087s)
[679.864178] [132/132] (379s left) kms_invalid_mode (bad-vsync-end)
[681.347685] Starting subtest: bad-vsync-end
[681.348533] Starting dynamic subtest: pipe-A-HDMI-A-4
[681.397612] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.049s)
[681.412643] Starting dynamic subtest: pipe-B-HDMI-A-4
[681.413717] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[681.427548] Starting dynamic subtest: pipe-C-HDMI-A-4
[681.428442] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[681.441698] Starting dynamic subtest: pipe-D-HDMI-A-4
[681.442543] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[681.443430] Subtest bad-vsync-end: SUCCESS (0.062s)
[681.617305] 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.