[66.542376] Initializing watchdogs
[66.542458]   /dev/watchdog0
[66.572402] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.587224] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.591955] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.594934] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[66.648928] Starting subtest: wait-for-submit-snapshot
[66.731568] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[66.945432] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[68.428128] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[68.429567] Starting dynamic subtest: pipe-A-HDMI-A-4
[68.467657] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[68.476168] Starting dynamic subtest: pipe-B-HDMI-A-4
[68.515659] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[68.524108] Starting dynamic subtest: pipe-C-HDMI-A-4
[68.565480] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[68.573156] Starting dynamic subtest: pipe-D-HDMI-A-4
[68.608271] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[68.611165] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[68.712111] [003/132] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[70.213173] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[72.979482] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.781s)
[73.203863] [004/132] (954s left) kms_big_fb (linear-8bpp-rotate-270)
[74.711579] Starting subtest: linear-8bpp-rotate-270
[74.807433] Subtest linear-8bpp-rotate-270: SKIP (0.095s)
[75.035911] [005/132] (952s left) kms_busy (extended-modeset-hang-newfb)
[76.549581] Starting subtest: extended-modeset-hang-newfb
[76.551251] Starting dynamic subtest: pipe-A
[92.177832] Dynamic subtest pipe-A: SUCCESS (15.629s)
[92.188026] Starting dynamic subtest: pipe-D
[107.669322] Dynamic subtest pipe-D: SUCCESS (15.489s)
[107.670736] Subtest extended-modeset-hang-newfb: SUCCESS (31.125s)
[107.941140] [006/132] (919s left) perf (oa-exponents)
[108.134583] Starting subtest: oa-exponents
[108.136135] Starting dynamic subtest: 0-rcs0
[111.797782] Dynamic subtest 0-rcs0: SUCCESS (3.660s)
[111.799467] Subtest oa-exponents: SUCCESS (3.661s)
[111.869936] [007/132] (915s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[113.375841] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[114.648749] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.270s)
[114.946201] [008/132] (912s left) kms_pipe_crc_basic (suspend-read-crc)
[116.432610] Starting subtest: suspend-read-crc
[116.434169] Starting dynamic subtest: pipe-A-HDMI-A-4
[138.715460] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.252s)
[138.726226] Starting dynamic subtest: pipe-B-HDMI-A-4
[160.674512] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.734s)
[160.686504] Starting dynamic subtest: pipe-C-HDMI-A-4
[182.687930] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.698s)
[182.700205] Starting dynamic subtest: pipe-D-HDMI-A-4
[204.722059] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.679s)
[204.723537] Subtest suspend-read-crc: SUCCESS (43.372s)
[208.969147] [009/132] (822s left) perf_pmu (interrupts-sync)
[209.020214] Starting subtest: interrupts-sync
[210.211230] Subtest interrupts-sync: SUCCESS (1.187s)
[210.397501] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[210.400227] [010/132] (821s left) gem_exec_reloc (basic-gtt-active)
[210.453539] Subtest basic-gtt-active: SKIP (0.000s)
[210.573481] [011/132] (821s left) kms_flip (modeset-vs-vblank-race)
[212.060535] Starting subtest: modeset-vs-vblank-race
[212.067438] Starting dynamic subtest: A-HDMI-A4
[215.083576] Dynamic subtest A-HDMI-A4: SUCCESS (3.016s)
[215.096054] Starting dynamic subtest: B-HDMI-A4
[218.087491] Dynamic subtest B-HDMI-A4: SUCCESS (3.003s)
[218.099158] Starting dynamic subtest: C-HDMI-A4
[221.110891] Dynamic subtest C-HDMI-A4: SUCCESS (3.022s)
[221.122023] Starting dynamic subtest: D-HDMI-A4
[224.110531] Dynamic subtest D-HDMI-A4: SUCCESS (2.998s)
[224.112285] Subtest modeset-vs-vblank-race: SUCCESS (12.052s)
[224.403794] [012/132] (807s left) gem_sync (basic-each)
[224.487123] Starting subtest: basic-each
[226.571160] Subtest basic-each: SUCCESS (2.086s)
[226.904556] [013/132] (805s left) gem_ctx_persistence (legacy-engines-mixed)
[226.956486] Starting subtest: legacy-engines-mixed
[226.958116] Starting dynamic subtest: render
[227.029374] Dynamic subtest render: SUCCESS (0.072s)
[227.048349] Starting dynamic subtest: bsd1
[227.089815] Dynamic subtest bsd1: SUCCESS (0.058s)
[227.128167] Starting dynamic subtest: bsd2
[227.166534] Dynamic subtest bsd2: SUCCESS (0.072s)
[227.194051] Starting dynamic subtest: blt
[227.228800] Dynamic subtest blt: SUCCESS (0.059s)
[227.258226] Starting dynamic subtest: vebox
[227.298852] Dynamic subtest vebox: SUCCESS (0.066s)
[227.301057] Subtest legacy-engines-mixed: SUCCESS (0.344s)
[227.555243] [014/132] (804s left) kms_plane (plane-panning-bottom-right)
[229.040673] Starting subtest: plane-panning-bottom-right
[229.042391] Starting dynamic subtest: pipe-A
[229.726705] Dynamic subtest pipe-A: SUCCESS (0.684s)
[229.740344] Starting dynamic subtest: pipe-B
[230.234417] Dynamic subtest pipe-B: SUCCESS (0.505s)
[230.236026] Subtest plane-panning-bottom-right: SUCCESS (1.195s)
[230.479274] [015/132] (801s left) prime_vgem (wait)
[230.557012] Starting subtest: wait
[230.558716] Starting dynamic subtest: rcs0
[230.623900] Dynamic subtest rcs0: SUCCESS (0.066s)
[230.637173] Starting dynamic subtest: bcs0
[230.678697] Dynamic subtest bcs0: SUCCESS (0.053s)
[230.695764] Starting dynamic subtest: vcs0
[230.719771] Dynamic subtest vcs0: SUCCESS (0.039s)
[230.740328] Starting dynamic subtest: vcs1
[230.760556] Dynamic subtest vcs1: SUCCESS (0.039s)
[230.771894] Starting dynamic subtest: vecs0
[230.799830] Dynamic subtest vecs0: SUCCESS (0.038s)
[230.801613] Subtest wait: SUCCESS (0.244s)
[231.043623] [016/132] (801s left) i915_query (query-topology-matches-eu-total)
[231.090302] Starting subtest: query-topology-matches-eu-total
[231.091824] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[231.295685] [017/132] (801s left) syncobj_timeline (reset-signaled)
[231.345904] Starting subtest: reset-signaled
[231.347801] Subtest reset-signaled: SUCCESS (0.001s)
[231.539242] [018/132] (801s left) syncobj_timeline (multi-wait-all-available-signaled)
[231.603500] Starting subtest: multi-wait-all-available-signaled
[231.605285] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[231.764890] [019/132] (800s left) kms_cursor_crc (cursor-random-256x256)
[233.462676] Starting subtest: cursor-random-256x256
[233.471078] Starting dynamic subtest: pipe-A-HDMI-A-4
[238.039176] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.569s)
[238.073135] Starting dynamic subtest: pipe-D-HDMI-A-4
[242.500022] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.436s)
[242.501831] Subtest cursor-random-256x256: SUCCESS (9.036s)
[242.900524] [020/132] (789s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[242.952776] Starting subtest: mixed-tiled-to-y-tiled-ccs
[242.954366] Starting dynamic subtest: smem
[243.060480] Dynamic subtest smem: SUCCESS (0.105s)
[243.072205] Starting dynamic subtest: lmem0
[244.009825] Dynamic subtest lmem0: SUCCESS (0.947s)
[244.011458] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.055s)
[244.309560] [021/132] (788s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[245.797029] Starting subtest: primary-y-tiled-reflect-x-180
[256.362735] Subtest primary-y-tiled-reflect-x-180: SUCCESS (10.568s)
[256.679860] [022/132] (776s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[256.732182] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[256.733795] Starting dynamic subtest: smem
[256.830198] Dynamic subtest smem: SUCCESS (0.097s)
[256.841807] Starting dynamic subtest: lmem0
[257.938524] Dynamic subtest lmem0: SUCCESS (1.104s)
[257.940473] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.204s)
[258.256513] [023/132] (774s left) gem_exec_schedule (reorder-wide)
[258.470942] Subtest reorder-wide: SKIP (0.000s)
[258.737130] [024/132] (774s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[260.227844] Starting subtest: fbc-indfb-scaledprimary
[263.865974] Subtest fbc-indfb-scaledprimary: SUCCESS (3.640s)
[264.153258] [025/132] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[265.643410] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[265.646153] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[265.907803] [026/132] (767s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[267.390742] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[267.392403] Starting dynamic subtest: pipe-A-HDMI-A-4
[267.399178] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[267.411110] Starting dynamic subtest: pipe-B-HDMI-A-4
[267.418023] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[267.429752] Starting dynamic subtest: pipe-C-HDMI-A-4
[267.436476] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[267.457293] Starting dynamic subtest: pipe-D-HDMI-A-4
[267.463200] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[267.465995] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.011s)
[267.667224] [027/132] (765s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[269.160561] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[269.240433] [028/132] (764s left) kms_cursor_crc (cursor-random-64x21)
[270.865645] Starting subtest: cursor-random-64x21
[270.873347] Starting dynamic subtest: pipe-A-HDMI-A-4
[275.449364] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.576s)
[275.482430] Starting dynamic subtest: pipe-D-HDMI-A-4
[279.957261] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.485s)
[279.958724] Subtest cursor-random-64x21: SUCCESS (9.091s)
[280.492604] [029/132] (753s left) prime_mmap (test_dup)
[280.550439] Starting subtest: test_dup
[280.551887] Starting dynamic subtest: test_dup-smem
[280.600943] Dynamic subtest test_dup-smem: SUCCESS (0.061s)
[280.612599] Starting dynamic subtest: test_dup-lmem0
[280.662208] Dynamic subtest test_dup-lmem0: SUCCESS (0.060s)
[280.663741] Subtest test_dup: SUCCESS (0.123s)
[280.874399] [030/132] (752s left) gem_exec_schedule (u-submit-late-slice)
[280.934296] Starting subtest: u-submit-late-slice
[280.935817] Starting dynamic subtest: rcs0
[280.992497] Dynamic subtest rcs0: SUCCESS (0.058s)
[281.004111] Starting dynamic subtest: bcs0
[281.030544] Dynamic subtest bcs0: SUCCESS (0.037s)
[281.042699] Starting dynamic subtest: vcs0
[281.071001] Dynamic subtest vcs0: SUCCESS (0.039s)
[281.082953] Starting dynamic subtest: vcs1
[281.112615] Dynamic subtest vcs1: SUCCESS (0.040s)
[281.124612] Starting dynamic subtest: vecs0
[281.155291] Dynamic subtest vecs0: SUCCESS (0.041s)
[281.156919] Subtest u-submit-late-slice: SUCCESS (0.222s)
[281.618635] [031/132] (752s left) syncobj_timeline (etime-multi-wait-all-submitted)
[281.664855] Starting subtest: etime-multi-wait-all-submitted
[281.771510] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[281.976038] [032/132] (751s left) fbdev (write)
[282.034167] Starting subtest: write
[282.753722] Subtest write: SUCCESS (0.716s)
[282.884893] [033/132] (751s left) syncobj_wait (invalid-signal-zero-handles)
[282.930436] Starting subtest: invalid-signal-zero-handles
[282.932321] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[283.141508] [034/132] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[284.632806] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[284.635924] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[284.889744] [035/132] (749s left) gem_exec_balancer (sliced)
[284.949118] Starting subtest: sliced
[284.952532] Subtest sliced: SKIP (0.000s)
[285.422307] [036/132] (748s left) gem_ccs (large-ctrl-surf-copy)
[285.474674] Starting subtest: large-ctrl-surf-copy
[285.488510] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[285.675940] [037/132] (748s left) gem_fenced_exec_thrash (2-spare-fences)
[285.726050] Subtest 2-spare-fences: SKIP (0.000s)
[285.811807] [038/132] (748s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[287.298354] Starting subtest: basic-busy-flip-before-cursor-varying-size
[287.301234] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[287.505599] [039/132] (747s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[289.010776] Starting subtest: 4-tiled-8bpp-rotate-0
[289.014613] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[289.268254] [040/132] (745s left) gem_mmap_wc (copy)
[289.318462] Subtest copy: SKIP (0.000s)
[289.400257] [041/132] (745s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[290.886969] Starting subtest: cursor-vs-flip-toggle
[325.904356] Subtest cursor-vs-flip-toggle: SUCCESS (35.019s)
[326.156761] [042/132] (708s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[327.659469] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[327.662348] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[327.906617] [043/132] (707s left) kms_addfb_basic (unused-handle)
[327.968912] Starting subtest: unused-handle
[327.970373] Subtest unused-handle: SUCCESS (0.000s)
[329.654303] [044/132] (705s left) gem_ctx_shared (q-smoketest-all)
[329.727777] Starting subtest: Q-smoketest-all
[362.040815] Subtest Q-smoketest-all: SUCCESS (32.300s)
[362.452448] [045/132] (672s left) kms_flip (2x-flip-vs-expired-vblank)
[363.936537] Starting subtest: 2x-flip-vs-expired-vblank
[363.954922] Subtest 2x-flip-vs-expired-vblank: SKIP (0.018s)
[364.172219] [046/132] (671s left) kms_force_connector_basic (force-edid)
[364.303390] Starting subtest: force-edid
[364.322684] Subtest force-edid: SUCCESS (0.021s)
[366.060050] [047/132] (669s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[367.564303] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[368.790915] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.227s)
[369.078521] [048/132] (666s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[370.565371] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[370.566881] Starting dynamic subtest: pipe-A
[370.714861] Dynamic subtest pipe-A: SUCCESS (0.149s)
[370.727588] Starting dynamic subtest: pipe-B
[370.856100] Dynamic subtest pipe-B: SUCCESS (0.140s)
[370.868686] Starting dynamic subtest: pipe-C
[370.996345] Dynamic subtest pipe-C: SUCCESS (0.139s)
[371.008333] Starting dynamic subtest: pipe-D
[371.136891] Dynamic subtest pipe-D: SUCCESS (0.139s)
[371.138331] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.573s)
[371.360796] [049/132] (664s left) kms_chamelium_audio (hdmi-audio)
[372.887410] Subtest hdmi-audio: SKIP (0.000s)
[373.001203] [050/132] (662s left) gem_set_tiling_vs_gtt
[373.129494] [051/132] (662s left) gem_lmem_swapping (massive)
[377.422973] Starting subtest: massive
[377.424809] Starting dynamic subtest: lmem0
[388.542307] Dynamic subtest lmem0: SUCCESS (11.115s)
[388.544025] Subtest massive: SUCCESS (11.117s)
[390.180143] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[390.181322] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[390.184081] [052/132] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[394.937083] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[394.940031] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[395.194842] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[395.197928] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[395.204598] [053/132] (640s left) prime_busy (after)
[395.263028] Starting subtest: after
[395.269404] Starting dynamic subtest: rcs0
[395.321342] Dynamic subtest rcs0: SUCCESS (0.052s)
[395.334909] Starting dynamic subtest: bcs0
[395.378741] Dynamic subtest bcs0: SUCCESS (0.056s)
[395.400617] Starting dynamic subtest: vcs0
[395.421440] Dynamic subtest vcs0: SUCCESS (0.040s)
[395.447093] Starting dynamic subtest: vcs1
[395.464837] Dynamic subtest vcs1: SUCCESS (0.040s)
[395.486465] Starting dynamic subtest: vecs0
[395.505812] Dynamic subtest vecs0: SUCCESS (0.039s)
[395.629744] Subtest after: SUCCESS (0.362s)
[395.880114] [054/132] (640s left) syncobj_wait (invalid-signal-illegal-handle)
[395.930231] Starting subtest: invalid-signal-illegal-handle
[395.931789] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[396.139249] [055/132] (640s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[397.624270] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[397.628193] Starting dynamic subtest: pipe-A-valid-mode
[397.673269] Dynamic subtest pipe-A-valid-mode: SKIP (0.045s)
[397.676147] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.047s)
[397.867900] [056/132] (638s left) gem_gtt_cpu_tlb
[397.992502] [057/132] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[399.482958] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[399.485815] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.728308] [058/132] (636s left) gen9_exec_parse (batch-zero-length)
[399.789870] Subtest batch-zero-length: SKIP (0.000s)
[399.870248] [059/132] (636s left) gem_softpin (evict-snoop-interruptible)
[399.928062] Starting subtest: evict-snoop-interruptible
[399.934748] Subtest evict-snoop-interruptible: SKIP (0.000s)
[400.124387] [060/132] (636s left) dmabuf_sync_file (export-basic)
[400.268946] Starting subtest: export-basic
[400.286603] Subtest export-basic: SUCCESS (0.001s)
[400.445271] [061/132] (636s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[401.962627] Starting subtest: fb-8bpc-vs-panel-6bpc
[401.967491] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.001s)
[402.175954] [062/132] (635s left) syncobj_timeline (host-signal-ordered)
[402.224344] Starting subtest: host-signal-ordered
[402.226006] Subtest host-signal-ordered: SUCCESS (0.001s)
[402.410492] [063/132] (634s left) kms_chamelium_hpd (common-hpd-after-suspend)
[403.939265] Subtest common-hpd-after-suspend: SKIP (0.000s)
[404.051811] [064/132] (633s left) kms_flip (2x-flip-vs-fences)
[405.537879] Starting subtest: 2x-flip-vs-fences
[405.540983] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[405.776246] [065/132] (631s left) perf (mi-rpc)
[405.938678] Starting subtest: mi-rpc
[405.942362] Subtest mi-rpc: SKIP (0.000s)
[406.016516] [066/132] (631s left) sw_sync (sync_random_merge)
[406.060532] Starting subtest: sync_random_merge
[406.145914] Subtest sync_random_merge: SUCCESS (0.086s)
[406.306733] [067/132] (631s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[407.797558] Starting subtest: psr-rgb101010-draw-pwrite
[407.800669] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[408.058911] [068/132] (629s left) kms_getfb (getfb2-handle-closed)
[409.544178] Starting subtest: getfb2-handle-closed
[409.545707] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[409.809895] [069/132] (628s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[411.300409] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[411.303255] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.547559] [070/132] (626s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[411.607599] Starting subtest: invalid-smem-bo-on-discrete
[411.609236] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[413.301367] [071/132] (624s left) perf (gen12-invalid-class-instance)
[413.479439] Starting subtest: gen12-invalid-class-instance
[413.503389] Subtest gen12-invalid-class-instance: SUCCESS (0.023s)
[413.582634] [072/132] (624s left) gem_exec_schedule (implicit-read-write)
[413.641757] Starting subtest: implicit-read-write
[413.643353] Starting dynamic subtest: rcs0
[413.843267] Dynamic subtest rcs0: SUCCESS (0.200s)
[413.855128] Starting dynamic subtest: bcs0
[413.979143] Dynamic subtest bcs0: SUCCESS (0.138s)
[413.992796] Starting dynamic subtest: vcs0
[414.118745] Dynamic subtest vcs0: SUCCESS (0.138s)
[414.132521] Starting dynamic subtest: vcs1
[414.261287] Dynamic subtest vcs1: SUCCESS (0.141s)
[414.272831] Starting dynamic subtest: vecs0
[414.410338] Dynamic subtest vecs0: SUCCESS (0.148s)
[414.411835] Subtest implicit-read-write: SUCCESS (0.772s)
[414.942853] [073/132] (623s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[416.430142] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[416.688873] [074/132] (621s left) kms_atomic (plane-cursor-legacy)
[418.172415] Starting subtest: plane-cursor-legacy
[418.173815] Starting dynamic subtest: pipe-A-HDMI-A-4
[418.507488] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.333s)
[418.509054] Subtest plane-cursor-legacy: SUCCESS (0.336s)
[418.770938] [075/132] (619s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[420.254340] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[420.255840] Starting dynamic subtest: pipe-A-HDMI-A-4
[420.269243] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[420.281457] Starting dynamic subtest: pipe-B-HDMI-A-4
[420.295262] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[420.306816] Starting dynamic subtest: pipe-C-HDMI-A-4
[420.320662] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[420.332410] Starting dynamic subtest: pipe-D-HDMI-A-4
[420.346751] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[420.348532] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.013s)
[420.554244] [076/132] (618s left) gem_exec_balancer (bonded-pair)
[420.612914] Starting subtest: bonded-pair
[420.615798] Subtest bonded-pair: SKIP (0.000s)
[421.149496] [077/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[422.656924] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[422.660678] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.910894] [078/132] (616s left) gem_ctx_exec (basic-invalid-context)
[422.970391] Starting subtest: basic-invalid-context
[422.972290] Subtest basic-invalid-context: SUCCESS (0.005s)
[423.215449] [079/132] (615s left) kms_content_protection (lic-type-0-hdcp14)
[424.757368] Starting subtest: lic-type-0-hdcp14
[424.767440] Subtest lic-type-0-hdcp14: SKIP (0.005s)
[425.011785] [080/132] (614s left) gem_eio (wait-immediate)
[425.202796] Starting subtest: wait-immediate
[425.644619] Subtest wait-immediate: SUCCESS (0.443s)
[427.283094] [081/132] (612s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[428.773542] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[428.792812] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s)
[429.005554] [082/132] (610s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[430.489296] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[430.490733] Starting dynamic subtest: pipe-A-valid-mode
[431.692595] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.201s)
[431.694109] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.204s)
[431.934005] [083/132] (607s left) kms_psr (psr2-basic)
[433.421988] Subtest psr2-basic: SKIP (0.000s)
[433.500548] [084/132] (606s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[434.985725] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[434.987209] Starting dynamic subtest: pipe-A-HDMI-A-4
[435.001470] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[435.014246] Starting dynamic subtest: pipe-B-HDMI-A-4
[435.029078] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[435.041322] Starting dynamic subtest: pipe-C-HDMI-A-4
[435.056133] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[435.068433] Starting dynamic subtest: pipe-D-HDMI-A-4
[435.084198] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[435.087299] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.014s)
[435.278528] [085/132] (604s left) kms_vblank (query-forked-busy)
[436.763274] Starting subtest: query-forked-busy
[436.767224] Starting dynamic subtest: pipe-A-HDMI-A-4
[439.344204] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.574s)
[439.402836] Starting dynamic subtest: pipe-D-HDMI-A-4
[441.834054] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.463s)
[441.836743] Subtest query-forked-busy: SUCCESS (5.072s)
[442.067739] [086/132] (597s left) kms_pm_dc (dc9-dpms)
[444.561412] Starting subtest: dc9-dpms
[444.895600] Subtest dc9-dpms: SUCCESS (0.334s)
[445.738967] [087/132] (594s left) gem_userptr_blits (set-cache-level)
[445.805593] Starting subtest: set-cache-level
[445.807591] Subtest set-cache-level: SUCCESS (0.000s)
[446.044854] [088/132] (593s left) gem_exec_fence (keep-in-fence)
[446.235896] Starting subtest: keep-in-fence
[446.237351] Starting dynamic subtest: rcs0
[446.319385] Dynamic subtest rcs0: SUCCESS (0.083s)
[446.337322] Starting dynamic subtest: bcs0
[446.373944] Dynamic subtest bcs0: SUCCESS (0.052s)
[446.397372] Starting dynamic subtest: vcs0
[446.433460] Dynamic subtest vcs0: SUCCESS (0.057s)
[446.470599] Starting dynamic subtest: vcs1
[446.505588] Dynamic subtest vcs1: SUCCESS (0.069s)
[446.530380] Starting dynamic subtest: vecs0
[446.565429] Dynamic subtest vecs0: SUCCESS (0.057s)
[446.567459] Subtest keep-in-fence: SUCCESS (0.331s)
[447.234086] [089/132] (592s left) kms_pm_rpm (modeset-pc8-residency-stress)
[450.935004] Starting subtest: modeset-pc8-residency-stress
[450.938645] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[451.859855] [090/132] (588s left) kms_psr (fbc-psr2-sprite-plane-move)
[453.343501] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[453.419114] [091/132] (586s left) gem_exec_create (forked)
[453.478011] Starting subtest: forked
[453.479528] Starting dynamic subtest: smem
[473.616056] Dynamic subtest smem: SUCCESS (20.139s)
[473.636820] Starting dynamic subtest: lmem0
[493.772476] Dynamic subtest lmem0: SUCCESS (20.155s)
[493.774082] Subtest forked: SUCCESS (40.297s)
[494.110680] [092/132] (546s left) kms_psr (pr-cursor-mmap-cpu)
[495.593991] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[495.670089] [093/132] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[497.160596] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[497.163346] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[497.401495] [094/132] (543s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[498.893271] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[498.970317] [095/132] (541s left) gem_exec_reloc (basic-wc-read)
[499.023021] Subtest basic-wc-read: SKIP (0.000s)
[499.146492] [096/132] (541s left) kms_psr (psr-cursor-plane-move)
[500.629540] Subtest psr-cursor-plane-move: SKIP (0.000s)
[500.705669] [097/132] (540s left) kms_flip (basic-plain-flip)
[502.190532] Starting subtest: basic-plain-flip
[502.197689] Starting dynamic subtest: A-HDMI-A4
[502.933627] Dynamic subtest A-HDMI-A4: SUCCESS (0.736s)
[502.949674] Starting dynamic subtest: B-HDMI-A4
[503.610406] Dynamic subtest B-HDMI-A4: SUCCESS (0.674s)
[503.625672] Starting dynamic subtest: C-HDMI-A4
[504.288195] Dynamic subtest C-HDMI-A4: SUCCESS (0.676s)
[504.304003] Starting dynamic subtest: D-HDMI-A4
[504.965622] Dynamic subtest D-HDMI-A4: SUCCESS (0.675s)
[504.967286] Subtest basic-plain-flip: SUCCESS (2.777s)
[505.263519] [098/132] (535s left) kms_flip (plain-flip-fb-recreate)
[506.750191] Starting subtest: plain-flip-fb-recreate
[506.757656] Starting dynamic subtest: A-HDMI-A4
[514.770756] Dynamic subtest A-HDMI-A4: SUCCESS (8.012s)
[514.816615] Starting dynamic subtest: B-HDMI-A4
[522.781781] Dynamic subtest B-HDMI-A4: SUCCESS (8.002s)
[522.830819] Starting dynamic subtest: C-HDMI-A4
[530.774844] Dynamic subtest C-HDMI-A4: SUCCESS (7.984s)
[530.817817] Starting dynamic subtest: D-HDMI-A4
[538.768824] Dynamic subtest D-HDMI-A4: SUCCESS (7.985s)
[538.778168] Subtest plain-flip-fb-recreate: SUCCESS (32.023s)
[539.103450] [099/132] (501s left) i915_suspend (debugfs-reader)
[539.149723] Starting subtest: debugfs-reader
[561.641453] Subtest debugfs-reader: SUCCESS (11.870s)
[566.849916] [100/132] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[568.344080] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[568.347130] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[568.581598] [101/132] (477s left) gem_exec_nop (basic-sequential)
[568.644973] Starting subtest: basic-sequential
[572.380956] Subtest basic-sequential: SUCCESS (3.737s)
[572.683591] [102/132] (473s left) gem_pxp (create-regular-buffer)
[575.256572] Starting subtest: create-regular-buffer
[575.259592] Subtest create-regular-buffer: SKIP (0.000s)
[575.411549] [103/132] (471s left) syncobj_basic (test-valid-cycle)
[575.456894] Starting subtest: test-valid-cycle
[575.458292] Subtest test-valid-cycle: SUCCESS (0.000s)
[575.661442] [104/132] (470s left) gem_exec_suspend (basic-s3-devices)
[575.717774] Starting subtest: basic-S3-devices
[575.719296] Starting dynamic subtest: smem
[586.075729] Dynamic subtest smem: SUCCESS (10.357s)
[586.089598] Starting dynamic subtest: lmem0
[596.370968] Dynamic subtest lmem0: SUCCESS (10.294s)
[596.372816] Subtest basic-S3-devices: SUCCESS (20.654s)
[601.690819] [105/132] (449s left) template (a)
[601.740308] Starting subtest: A
[601.742061] Subtest A: SUCCESS (0.000s)
[601.921245] [106/132] (449s left) gem_mmap_gtt (bad-object)
[601.969194] Subtest bad-object: SKIP (0.000s)
[602.053802] [107/132] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[603.542946] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[603.545710] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[603.782709] [108/132] (448s left) api_intel_bb (intel-bb-blit-y)
[603.827712] Starting subtest: intel-bb-blit-y
[605.424487] Subtest intel-bb-blit-y: SUCCESS (1.594s)
[605.663912] [109/132] (446s left) kms_selftest (drm_format_helper)
[605.713145] Starting subtest: drm_format_helper
[605.846733] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[605.954689] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.103s)
[605.968646] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[606.033166] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.076s)
[606.065014] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[606.107513] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.070s)
[606.135739] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[606.182826] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.072s)
[606.216009] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[606.289982] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.104s)
[606.336490] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[606.377868] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.081s)
[606.399556] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[606.468415] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.086s)
[606.516000] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[606.552599] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.079s)
[606.570427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[606.648954] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.093s)
[606.699425] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[606.741596] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.085s)
[606.772778] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[606.833505] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.089s)
[606.881192] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[606.916914] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.079s)
[606.937386] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[607.002966] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.082s)
[607.054407] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[607.095708] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.084s)
[607.120011] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[607.200128] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.101s)
[607.246635] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[607.296454] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.085s)
[607.327866] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[607.409595] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.117s)
[607.417958] Subtest drm_format_helper: SUCCESS (1.699s)
[607.701949] [110/132] (444s left) gem_mmap_offset (oob-read)
[607.752122] Starting subtest: oob-read
[607.753729] Subtest oob-read: SUCCESS (0.000s)
[607.981113] [111/132] (444s left) gem_spin_batch (resubmit-all)
[608.038924] Starting subtest: resubmit-all
[608.040604] Starting dynamic subtest: rcs0
[608.064189] Dynamic subtest rcs0: SUCCESS (0.025s)
[608.078509] Starting dynamic subtest: bcs0
[608.080375] Dynamic subtest bcs0: SUCCESS (0.002s)
[608.094163] Starting dynamic subtest: vcs0
[608.096093] Dynamic subtest vcs0: SUCCESS (0.002s)
[608.109606] Starting dynamic subtest: vcs1
[608.111453] Dynamic subtest vcs1: SUCCESS (0.002s)
[608.124801] Starting dynamic subtest: vecs0
[608.126756] Dynamic subtest vecs0: SUCCESS (0.002s)
[608.128707] Subtest resubmit-all: SUCCESS (0.040s)
[608.457045] [112/132] (443s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[609.943768] Starting subtest: cursorB-vs-flipA-toggle
[609.946572] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[610.138542] [113/132] (442s left) gen9_exec_parse (valid-registers)
[610.191053] Subtest valid-registers: SKIP (0.000s)
[610.270999] [114/132] (442s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[611.787522] Starting subtest: disable-crc-after-crtc
[611.791438] Starting dynamic subtest: pipe-A-HDMI-A-4
[612.451229] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.661s)
[612.467142] Starting dynamic subtest: pipe-B-HDMI-A-4
[612.905000] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.450s)
[612.922760] Starting dynamic subtest: pipe-C-HDMI-A-4
[613.360835] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.451s)
[613.380897] Starting dynamic subtest: pipe-D-HDMI-A-4
[613.829239] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.465s)
[613.831000] Subtest disable-crc-after-crtc: SUCCESS (2.042s)
[614.075162] [115/132] (438s left) gem_exec_fence (syncobj-unused-fence)
[614.447701] Starting subtest: syncobj-unused-fence
[614.469630] Subtest syncobj-unused-fence: SUCCESS (0.022s)
[614.967405] [116/132] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[616.461356] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[616.464544] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[616.712489] [117/132] (436s left) gem_set_tiling_vs_pwrite
[616.848530] [118/132] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[618.339906] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[618.342960] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[618.596498] [119/132] (434s left) vgem_basic (busy-fence)
[618.663272] Starting subtest: busy-fence
[618.665046] Subtest busy-fence: SUCCESS (0.000s)
[618.824184] [120/132] (434s left) i915_pm_rpm (debugfs-read)
[622.640920] Starting subtest: debugfs-read
[623.618300] Subtest debugfs-read: SUCCESS (0.975s)
[624.741233] [121/132] (428s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[626.234903] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[629.528294] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.285s)
[629.741130] [122/132] (423s left) perf_pmu (busy-start)
[629.790906] Starting subtest: busy-start
[629.792412] Starting dynamic subtest: rcs0
[632.355279] Dynamic subtest rcs0: SUCCESS (2.564s)
[632.374088] Starting dynamic subtest: bcs0
[634.902391] Dynamic subtest bcs0: SUCCESS (2.545s)
[634.921439] Starting dynamic subtest: vcs0
[637.450376] Dynamic subtest vcs0: SUCCESS (2.546s)
[637.469067] Starting dynamic subtest: vcs1
[639.998337] Dynamic subtest vcs1: SUCCESS (2.546s)
[640.016846] Starting dynamic subtest: vecs0
[642.546365] Dynamic subtest vecs0: SUCCESS (2.546s)
[642.547999] Subtest busy-start: SUCCESS (12.757s)
[642.758436] [123/132] (410s left) kms_addfb_basic (size-max)
[644.243459] Starting subtest: size-max
[644.244800] Subtest size-max: SUCCESS (0.000s)
[644.466778] [124/132] (409s left) kms_psr (fbc-pr-primary-blt)
[645.970676] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[646.048839] [125/132] (407s left) kms_color_pipeline (plane-ctm3x4)
[647.538491] Starting subtest: plane-ctm3x4
[647.567088] Starting dynamic subtest: pipe-A-HDMI-A-4
[647.966045] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.399s)
[648.093581] Starting dynamic subtest: pipe-B-HDMI-A-4
[648.396841] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.315s)
[648.521710] Starting dynamic subtest: pipe-C-HDMI-A-4
[648.842225] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.332s)
[648.981821] Starting dynamic subtest: pipe-D-HDMI-A-4
[649.318962] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.349s)
[649.374378] Subtest plane-ctm3x4: SUCCESS (1.837s)
[649.624623] [126/132] (404s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[651.182258] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[651.301247] [127/132] (402s left) api_intel_allocator (standalone)
[651.347968] Starting subtest: standalone
[651.382680] Subtest standalone: SUCCESS (0.035s)
[651.629106] [128/132] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[653.168008] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[653.171067] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[653.442307] [129/132] (400s left) kms_big_fb (y-tiled-addfb)
[654.975899] Starting subtest: y-tiled-addfb
[654.977520] Subtest y-tiled-addfb: SUCCESS (0.000s)
[655.198827] [130/132] (399s left) kms_prime (basic-crc-vgem)
[656.708685] Subtest basic-crc-vgem: SKIP (0.000s)
[656.971280] [131/132] (397s left) i915_hangman (engine-error-state-capture)
[657.032040] Starting subtest: engine-error-state-capture
[657.033612] Starting dynamic subtest: rcs0
[659.029902] Dynamic subtest rcs0: SUCCESS (1.999s)
[659.052120] Starting dynamic subtest: bcs0
[663.059952] Dynamic subtest bcs0: SUCCESS (4.028s)
[663.079063] Starting dynamic subtest: vcs0
[667.020947] Dynamic subtest vcs0: SUCCESS (3.959s)
[667.039800] Starting dynamic subtest: vcs1
[671.042114] Dynamic subtest vcs1: SUCCESS (4.019s)
[671.056205] Starting dynamic subtest: vecs0
[675.029319] Dynamic subtest vecs0: SUCCESS (3.986s)
[675.031127] Subtest engine-error-state-capture: SUCCESS (18.000s)
[675.258541] [132/132] (379s left) kms_invalid_mode (bad-vsync-end)
[676.751277] Starting subtest: bad-vsync-end
[676.752822] Starting dynamic subtest: pipe-A-HDMI-A-4
[676.787392] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.035s)
[676.803826] Starting dynamic subtest: pipe-B-HDMI-A-4
[676.805726] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[676.819493] Starting dynamic subtest: pipe-C-HDMI-A-4
[676.821163] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[676.836890] Starting dynamic subtest: pipe-D-HDMI-A-4
[676.838512] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[676.840067] Subtest bad-vsync-end: SUCCESS (0.047s)
[677.014495] 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.