[60.732914] Initializing watchdogs
[60.732970]   /dev/watchdog0
[60.748778] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750]
[60.753289] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.755590] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.757680] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[60.788786] Starting subtest: wait-for-submit-snapshot
[60.872619] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[61.018755] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[61.104355] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[61.105028] Starting dynamic subtest: pipe-A-HDMI-A-2
[61.120654] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[61.125378] Starting dynamic subtest: pipe-B-HDMI-A-2
[61.141266] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[61.145793] Starting dynamic subtest: pipe-C-HDMI-A-2
[61.161428] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[61.162651] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[61.368196] [003/132] (959s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[61.456683] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[63.596832] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.141s)
[63.807593] [004/132] (957s left) kms_big_fb (linear-8bpp-rotate-270)
[63.902903] Starting subtest: linear-8bpp-rotate-270
[63.968358] Subtest linear-8bpp-rotate-270: SKIP (0.065s)
[64.156486] [005/132] (957s left) kms_busy (extended-modeset-hang-newfb)
[64.246380] Starting subtest: extended-modeset-hang-newfb
[64.247735] Starting dynamic subtest: pipe-A
[101.009286] Dynamic subtest pipe-A: SUCCESS (36.765s)
[101.014885] Starting dynamic subtest: pipe-C
[125.054379] Dynamic subtest pipe-C: SUCCESS (24.044s)
[125.055075] Subtest extended-modeset-hang-newfb: SUCCESS (60.812s)
[125.299179] [006/132] (896s left) perf (oa-exponents)
[125.432426] Starting subtest: oa-exponents
[125.433117] Starting dynamic subtest: 0-rcs0
[130.804133] Dynamic subtest 0-rcs0: SUCCESS (5.338s)
[130.805145] Subtest oa-exponents: SUCCESS (5.338s)
[130.874797] [007/132] (890s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[130.996213] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[132.392619] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.387s)
[132.617759] [008/132] (888s left) kms_pipe_crc_basic (suspend-read-crc)
[132.702527] Starting subtest: suspend-read-crc
[132.703169] Starting dynamic subtest: pipe-A-HDMI-A-2
[150.887773] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (15.967s)
[150.893630] Starting dynamic subtest: pipe-B-HDMI-A-2
[168.838875] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.811s)
[168.847478] Starting dynamic subtest: pipe-C-HDMI-A-2
[186.847866] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.805s)
[186.848561] Subtest suspend-read-crc: SUCCESS (21.586s)
[192.047912] [009/132] (834s left) perf_pmu (interrupts-sync)
[192.091812] Starting subtest: interrupts-sync
[193.260903] Subtest interrupts-sync: SUCCESS (1.109s)
[193.438340] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[193.442278] [010/132] (833s left) gem_exec_reloc (basic-gtt-active)
[193.473983] Subtest basic-gtt-active: SKIP (0.000s)
[193.575230] [011/132] (833s left) kms_flip (modeset-vs-vblank-race)
[193.662304] Starting subtest: modeset-vs-vblank-race
[193.663672] Starting dynamic subtest: A-HDMI-A2
[197.605763] Dynamic subtest A-HDMI-A2: SUCCESS (3.821s)
[197.615753] Starting dynamic subtest: B-HDMI-A2
[201.438481] Dynamic subtest B-HDMI-A2: SUCCESS (3.759s)
[201.458237] Starting dynamic subtest: C-HDMI-A2
[205.367015] Dynamic subtest C-HDMI-A2: SUCCESS (3.881s)
[205.370598] Subtest modeset-vs-vblank-race: SUCCESS (11.471s)
[205.617920] [012/132] (821s left) gem_sync (basic-each)
[205.667863] Starting subtest: basic-each
[207.760546] Subtest basic-each: SUCCESS (2.077s)
[208.026486] [013/132] (818s left) gem_ctx_persistence (legacy-engines-mixed)
[208.057523] Starting subtest: legacy-engines-mixed
[208.058182] Starting dynamic subtest: render
[208.117528] Dynamic subtest render: SUCCESS (0.058s)
[208.139073] Starting dynamic subtest: bsd
[208.188355] Dynamic subtest bsd: SUCCESS (0.067s)
[208.211954] Starting dynamic subtest: blt
[208.281545] Dynamic subtest blt: SUCCESS (0.089s)
[208.305368] Starting dynamic subtest: vebox
[208.374274] Dynamic subtest vebox: SUCCESS (0.089s)
[208.375799] Subtest legacy-engines-mixed: SUCCESS (0.316s)
[208.524345] [014/132] (818s left) kms_plane (plane-panning-bottom-right)
[208.610015] Starting subtest: plane-panning-bottom-right
[208.610671] Starting dynamic subtest: pipe-A
[209.178239] Dynamic subtest pipe-A: SUCCESS (0.565s)
[209.185806] Starting dynamic subtest: pipe-B
[209.596241] Dynamic subtest pipe-B: SUCCESS (0.414s)
[209.596871] Subtest plane-panning-bottom-right: SUCCESS (0.981s)
[209.807444] [015/132] (817s left) prime_vgem (wait)
[209.874635] Starting subtest: wait
[209.875409] Starting dynamic subtest: rcs0
[209.912351] Dynamic subtest rcs0: SUCCESS (0.038s)
[209.925213] Starting dynamic subtest: bcs0
[209.968660] Dynamic subtest bcs0: SUCCESS (0.054s)
[209.989807] Starting dynamic subtest: vcs0
[209.992850] Dynamic subtest vcs0: SUCCESS (0.022s)
[210.000183] Starting dynamic subtest: vecs0
[210.023741] Dynamic subtest vecs0: SUCCESS (0.030s)
[210.026634] Subtest wait: SUCCESS (0.150s)
[210.207676] [016/132] (816s left) i915_query (query-topology-matches-eu-total)
[210.236692] Starting subtest: query-topology-matches-eu-total
[210.237329] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[210.405016] [017/132] (816s left) syncobj_timeline (reset-signaled)
[210.433603] Starting subtest: reset-signaled
[210.434253] Subtest reset-signaled: SUCCESS (0.000s)
[210.550335] [018/132] (816s left) syncobj_timeline (multi-wait-all-available-signaled)
[210.577703] Starting subtest: multi-wait-all-available-signaled
[210.578338] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[210.722048] [019/132] (816s left) kms_cursor_crc (cursor-random-256x256)
[210.809776] Starting subtest: cursor-random-256x256
[210.812184] Starting dynamic subtest: pipe-A-HDMI-A-2
[215.017341] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.189s)
[215.043489] Starting dynamic subtest: pipe-C-HDMI-A-2
[219.115140] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.068s)
[219.115757] Subtest cursor-random-256x256: SUCCESS (8.281s)
[219.336306] [020/132] (807s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[219.371123] Starting subtest: mixed-tiled-to-y-tiled-ccs
[219.371745] Starting dynamic subtest: smem
[219.484643] Dynamic subtest smem: SUCCESS (0.114s)
[219.485286] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.115s)
[219.724237] [021/132] (807s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[219.809033] Starting subtest: primary-y-tiled-reflect-x-180
[229.597740] Subtest primary-y-tiled-reflect-x-180: SUCCESS (9.780s)
[229.856625] [022/132] (797s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[229.891860] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[229.892523] Starting dynamic subtest: smem
[229.965131] Dynamic subtest smem: SUCCESS (0.073s)
[229.965800] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.074s)
[230.224303] [023/132] (797s left) gem_exec_schedule (reorder-wide)
[230.391268] Starting subtest: reorder-wide
[230.392102] Starting dynamic subtest: rcs0
[230.449222] Dynamic subtest rcs0: SUCCESS (0.058s)
[230.460729] Starting dynamic subtest: bcs0
[230.508399] Dynamic subtest bcs0: SUCCESS (0.058s)
[230.520205] Starting dynamic subtest: vcs0
[230.566472] Dynamic subtest vcs0: SUCCESS (0.056s)
[230.578873] Starting dynamic subtest: vecs0
[230.625397] Dynamic subtest vecs0: SUCCESS (0.057s)
[230.627800] Subtest reorder-wide: SUCCESS (0.237s)
[230.869022] [024/132] (796s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[230.957092] Starting subtest: fbc-indfb-scaledprimary
[234.517054] Subtest fbc-indfb-scaledprimary: SUCCESS (3.558s)
[234.751697] [025/132] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[234.839141] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[234.840368] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[235.008744] [026/132] (792s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[235.094077] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[235.094743] Starting dynamic subtest: pipe-A-HDMI-A-2
[235.097333] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[235.104233] Starting dynamic subtest: pipe-B-HDMI-A-2
[235.106840] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[235.113662] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.116282] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[235.117591] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[235.349620] [027/132] (792s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[235.440661] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[235.484433] [028/132] (792s left) kms_cursor_crc (cursor-random-64x21)
[235.571184] Starting subtest: cursor-random-64x21
[235.573678] Starting dynamic subtest: pipe-A-HDMI-A-2
[239.794183] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.194s)
[239.801148] Starting dynamic subtest: pipe-C-HDMI-A-2
[243.862227] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.068s)
[243.862867] Subtest cursor-random-64x21: SUCCESS (8.286s)
[244.069215] [029/132] (783s left) prime_mmap (test_dup)
[244.097523] Starting subtest: test_dup
[244.098153] Starting dynamic subtest: test_dup-smem
[244.137335] Dynamic subtest test_dup-smem: SUCCESS (0.040s)
[244.137984] Subtest test_dup: SUCCESS (0.040s)
[244.285592] [030/132] (783s left) gem_exec_schedule (u-submit-late-slice)
[244.322855] Starting subtest: u-submit-late-slice
[244.323528] Starting dynamic subtest: rcs0
[244.343627] Dynamic subtest rcs0: SUCCESS (0.020s)
[244.351460] Starting dynamic subtest: bcs0
[244.361587] Dynamic subtest bcs0: SUCCESS (0.017s)
[244.369444] Starting dynamic subtest: vcs0
[244.380757] Dynamic subtest vcs0: SUCCESS (0.018s)
[244.387702] Starting dynamic subtest: vecs0
[244.398541] Dynamic subtest vecs0: SUCCESS (0.017s)
[244.399223] Subtest u-submit-late-slice: SUCCESS (0.076s)
[244.768276] [031/132] (782s left) syncobj_timeline (etime-multi-wait-all-submitted)
[244.796739] Starting subtest: etime-multi-wait-all-submitted
[244.900045] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[245.044749] [032/132] (782s left) fbdev (write)
[245.085142] Starting subtest: write
[245.499976] Subtest write: SUCCESS (0.406s)
[245.603343] [033/132] (782s left) syncobj_wait (invalid-signal-zero-handles)
[245.631561] Starting subtest: invalid-signal-zero-handles
[245.632195] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[245.765434] [034/132] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[245.853018] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[245.854242] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[246.031859] [035/132] (781s left) gem_exec_balancer (sliced)
[246.066698] Starting subtest: sliced
[247.204372] Subtest sliced: SUCCESS (1.128s)
[247.440217] [036/132] (780s left) gem_ccs (large-ctrl-surf-copy)
[247.469725] Starting subtest: large-ctrl-surf-copy
[247.470993] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[247.598419] [037/132] (780s left) gem_fenced_exec_thrash (2-spare-fences)
[247.627990] Starting subtest: 2-spare-fences
[249.783426] Subtest 2-spare-fences: SUCCESS (2.153s)
[249.970494] [038/132] (777s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[250.057128] Starting subtest: basic-busy-flip-before-cursor-varying-size
[250.058361] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[250.209046] [039/132] (777s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[250.302769] Starting subtest: 4-tiled-8bpp-rotate-0
[250.304050] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[250.473794] [040/132] (777s left) gem_mmap_wc (copy)
[250.502924] Starting subtest: copy
[250.596419] Subtest copy: SUCCESS (0.094s)
[250.733521] [041/132] (777s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[250.819083] Starting subtest: cursor-vs-flip-toggle
[281.516272] Subtest cursor-vs-flip-toggle: SUCCESS (30.681s)
[281.738144] [042/132] (746s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[281.831120] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[281.832358] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[282.022914] [043/132] (746s left) kms_addfb_basic (unused-handle)
[282.050875] Starting subtest: unused-handle
[282.051526] Subtest unused-handle: SUCCESS (0.000s)
[282.279145] [044/132] (745s left) gem_ctx_shared (q-smoketest-all)
[282.314434] Starting subtest: Q-smoketest-all
[314.599709] Subtest Q-smoketest-all: SUCCESS (32.277s)
[314.840350] [045/132] (713s left) kms_flip (2x-flip-vs-expired-vblank)
[314.925947] Starting subtest: 2x-flip-vs-expired-vblank
[314.927296] Subtest 2x-flip-vs-expired-vblank: SKIP (0.002s)
[315.106443] [046/132] (713s left) kms_force_connector_basic (force-edid)
[315.209995] Starting subtest: force-edid
[315.236176] Subtest force-edid: SUCCESS (0.026s)
[315.528291] [047/132] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[315.622629] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[316.928595] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.305s)
[317.173533] [048/132] (711s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[317.257836] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[317.258473] Starting dynamic subtest: pipe-A
[317.412733] Dynamic subtest pipe-A: SUCCESS (0.154s)
[317.434701] Starting dynamic subtest: pipe-B
[317.548417] Dynamic subtest pipe-B: SUCCESS (0.132s)
[317.567363] Starting dynamic subtest: pipe-C
[317.684558] Dynamic subtest pipe-C: SUCCESS (0.133s)
[317.689192] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.428s)
[317.933444] [049/132] (710s left) kms_chamelium_audio (hdmi-audio)
[318.055414] Subtest hdmi-audio: SKIP (0.000s)
[318.129625] [050/132] (710s left) gem_set_tiling_vs_gtt
[318.612049] [051/132] (709s left) gem_lmem_swapping (massive)
[318.643348] Subtest massive: SKIP (0.000s)
[318.700871] [052/132] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[318.789140] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[318.790356] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[318.950570] [053/132] (709s left) prime_busy (after)
[318.982184] Starting subtest: after
[318.985609] Starting dynamic subtest: rcs0
[319.018569] Dynamic subtest rcs0: SUCCESS (0.033s)
[319.034851] Starting dynamic subtest: bcs0
[319.082148] Dynamic subtest bcs0: SUCCESS (0.062s)
[319.103625] Starting dynamic subtest: vcs0
[319.105862] Dynamic subtest vcs0: SUCCESS (0.020s)
[319.113651] Starting dynamic subtest: vecs0
[319.128953] Dynamic subtest vecs0: SUCCESS (0.022s)
[319.243926] Subtest after: SUCCESS (0.253s)
[319.389459] [054/132] (709s left) syncobj_wait (invalid-signal-illegal-handle)
[319.418724] Starting subtest: invalid-signal-illegal-handle
[319.419402] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[319.557456] [055/132] (709s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[319.642379] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[319.643045] Starting dynamic subtest: pipe-A-valid-mode
[319.676811] Dynamic subtest pipe-A-valid-mode: SKIP (0.033s)
[319.678032] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.034s)
[319.832730] [056/132] (708s left) gem_gtt_cpu_tlb
[320.015272] [057/132] (708s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[320.104212] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[320.105479] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[320.262346] [058/132] (708s left) gen9_exec_parse (batch-zero-length)
[320.292603] Subtest batch-zero-length: SKIP (0.000s)
[320.328213] [059/132] (708s left) gem_softpin (evict-snoop-interruptible)
[320.360919] Starting subtest: evict-snoop-interruptible
[320.362290] Subtest evict-snoop-interruptible: SKIP (0.000s)
[320.508644] [060/132] (708s left) dmabuf_sync_file (export-basic)
[320.548270] Starting subtest: export-basic
[320.550231] Subtest export-basic: SUCCESS (0.001s)
[320.678807] [061/132] (708s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[320.763237] Starting subtest: fb-8bpc-vs-panel-6bpc
[320.764872] Starting dynamic subtest: pipe-A-HDMI-A-2
[320.800908] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.036s)
[320.802255] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.037s)
[321.028538] [062/132] (707s left) syncobj_timeline (host-signal-ordered)
[321.056770] Starting subtest: host-signal-ordered
[321.057447] Subtest host-signal-ordered: SUCCESS (0.000s)
[321.198632] [063/132] (707s left) kms_chamelium_hpd (common-hpd-after-suspend)
[321.318872] Subtest common-hpd-after-suspend: SKIP (0.000s)
[321.388768] [064/132] (707s left) kms_flip (2x-flip-vs-fences)
[321.473645] Starting subtest: 2x-flip-vs-fences
[321.475935] Subtest 2x-flip-vs-fences: SKIP (0.002s)
[321.662081] [065/132] (707s left) perf (mi-rpc)
[321.787582] Starting subtest: mi-rpc
[321.788874] Subtest mi-rpc: SKIP (0.000s)
[321.827461] [066/132] (707s left) sw_sync (sync_random_merge)
[321.854405] Starting subtest: sync_random_merge
[321.905749] Subtest sync_random_merge: SUCCESS (0.052s)
[322.020078] [067/132] (707s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[322.108242] Starting subtest: psr-rgb101010-draw-pwrite
[322.109562] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[322.287661] [068/132] (706s left) kms_getfb (getfb2-handle-closed)
[322.373097] Starting subtest: getfb2-handle-closed
[322.373744] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[322.553911] [069/132] (706s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[322.642017] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[322.643260] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[322.815136] [070/132] (706s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[322.842340] Starting subtest: invalid-smem-bo-on-discrete
[322.843577] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[323.084949] [071/132] (706s left) perf (gen12-invalid-class-instance)
[323.209788] Starting subtest: gen12-invalid-class-instance
[323.216256] Subtest gen12-invalid-class-instance: SUCCESS (0.006s)
[323.248354] [072/132] (706s left) gem_exec_schedule (implicit-read-write)
[323.284193] Starting subtest: implicit-read-write
[323.284824] Starting dynamic subtest: rcs0
[323.332682] Dynamic subtest rcs0: SUCCESS (0.049s)
[323.350727] Starting dynamic subtest: bcs0
[323.390929] Dynamic subtest bcs0: SUCCESS (0.056s)
[323.404305] Starting dynamic subtest: vcs0
[323.457182] Dynamic subtest vcs0: SUCCESS (0.063s)
[323.465725] Starting dynamic subtest: vecs0
[323.518917] Dynamic subtest vecs0: SUCCESS (0.060s)
[323.519641] Subtest implicit-read-write: SUCCESS (0.236s)
[323.883456] [073/132] (705s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[323.971156] Starting subtest: addfb25-framebuffer-vs-set-tiling
[323.971801] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[324.147325] [074/132] (705s left) kms_atomic (plane-cursor-legacy)
[324.232205] Starting subtest: plane-cursor-legacy
[324.232870] Starting dynamic subtest: pipe-A-HDMI-A-2
[324.407539] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.174s)
[324.408414] Subtest plane-cursor-legacy: SUCCESS (0.176s)
[324.610027] [075/132] (704s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[324.694860] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[324.696592] Starting dynamic subtest: pipe-A-HDMI-A-2
[324.702552] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[324.709551] Starting dynamic subtest: pipe-B-HDMI-A-2
[324.715568] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[324.722330] Starting dynamic subtest: pipe-C-HDMI-A-2
[324.727902] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[324.728537] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.005s)
[324.946941] [076/132] (704s left) gem_exec_balancer (bonded-pair)
[324.983077] Starting subtest: bonded-pair
[326.122366] Subtest bonded-pair: SUCCESS (1.130s)
[326.373152] [077/132] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[326.462457] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[326.463704] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.647020] [078/132] (703s left) gem_ctx_exec (basic-invalid-context)
[326.675759] Starting subtest: basic-invalid-context
[326.676856] Subtest basic-invalid-context: SUCCESS (0.002s)
[326.874181] [079/132] (702s left) kms_content_protection (lic-type-0-hdcp14)
[326.964198] Starting subtest: lic-type-0-hdcp14
[326.970419] Subtest lic-type-0-hdcp14: SKIP (0.006s)
[327.141476] [080/132] (702s left) gem_eio (wait-immediate)
[327.176411] Starting subtest: wait-immediate
[327.321849] Subtest wait-immediate: SUCCESS (0.144s)
[327.519309] [081/132] (702s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[327.607978] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[327.610249] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.002s)
[327.785874] [082/132] (702s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[327.870147] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[327.871725] Starting dynamic subtest: pipe-A-valid-mode
[328.805448] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.933s)
[328.806317] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.935s)
[329.019101] [083/132] (700s left) kms_psr (psr2-basic)
[329.105452] Subtest psr2-basic: SKIP (0.000s)
[329.145263] [084/132] (700s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[329.231165] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[329.231807] Starting dynamic subtest: pipe-A-HDMI-A-2
[329.237939] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[329.245215] Starting dynamic subtest: pipe-B-HDMI-A-2
[329.251344] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[329.258382] Starting dynamic subtest: pipe-C-HDMI-A-2
[329.264486] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[329.265704] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[329.503671] [085/132] (700s left) kms_vblank (query-forked-busy)
[329.589098] Starting subtest: query-forked-busy
[329.590732] Starting dynamic subtest: pipe-A-HDMI-A-2
[332.382275] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.790s)
[332.404717] Starting dynamic subtest: pipe-C-HDMI-A-2
[335.098027] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.707s)
[335.099111] Subtest query-forked-busy: SUCCESS (5.507s)
[335.340945] [086/132] (694s left) kms_pm_dc (dc9-dpms)
[336.435423] Starting subtest: dc9-dpms
[339.738889] Subtest dc9-dpms: SKIP (3.293s)
[339.902678] [087/132] (690s left) gem_userptr_blits (set-cache-level)
[339.934610] Starting subtest: set-cache-level
[339.935243] Subtest set-cache-level: SUCCESS (0.000s)
[340.110356] [088/132] (690s left) gem_exec_fence (keep-in-fence)
[340.266127] Starting subtest: keep-in-fence
[340.267196] Starting dynamic subtest: rcs0
[340.343449] Dynamic subtest rcs0: SUCCESS (0.078s)
[340.367631] Starting dynamic subtest: bcs0
[340.393960] Dynamic subtest bcs0: SUCCESS (0.045s)
[340.412349] Starting dynamic subtest: vcs0
[340.438871] Dynamic subtest vcs0: SUCCESS (0.040s)
[340.456924] Starting dynamic subtest: vecs0
[340.490249] Dynamic subtest vecs0: SUCCESS (0.046s)
[340.494425] Subtest keep-in-fence: SUCCESS (0.228s)
[341.022514] [089/132] (689s left) kms_pm_rpm (modeset-pc8-residency-stress)
[342.416081] Starting subtest: modeset-pc8-residency-stress
[342.418240] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[342.617773] [090/132] (687s left) kms_psr (fbc-psr2-sprite-plane-move)
[342.705114] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[342.746708] [091/132] (687s left) gem_exec_create (forked)
[342.781233] Starting subtest: forked
[342.781862] Starting dynamic subtest: smem
[362.888215] Dynamic subtest smem: SUCCESS (20.102s)
[362.891205] Subtest forked: SUCCESS (20.103s)
[363.159236] [092/132] (667s left) kms_psr (pr-cursor-mmap-cpu)
[363.247039] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[363.281047] [093/132] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[363.367974] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[363.369223] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[363.536471] [094/132] (666s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[363.624013] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[363.660501] [095/132] (666s left) gem_exec_reloc (basic-wc-read)
[363.691207] Subtest basic-wc-read: SKIP (0.000s)
[363.792309] [096/132] (666s left) kms_psr (psr-cursor-plane-move)
[363.877917] Subtest psr-cursor-plane-move: SKIP (0.000s)
[363.930309] [097/132] (666s left) kms_flip (basic-plain-flip)
[364.015965] Starting subtest: basic-plain-flip
[364.016608] Starting dynamic subtest: A-HDMI-A2
[364.899316] Dynamic subtest A-HDMI-A2: SUCCESS (0.882s)
[364.910560] Starting dynamic subtest: B-HDMI-A2
[365.715415] Dynamic subtest B-HDMI-A2: SUCCESS (0.812s)
[365.726450] Starting dynamic subtest: C-HDMI-A2
[366.531446] Dynamic subtest C-HDMI-A2: SUCCESS (0.811s)
[366.535531] Subtest basic-plain-flip: SUCCESS (2.519s)
[366.779377] [098/132] (663s left) kms_flip (plain-flip-fb-recreate)
[366.866520] Starting subtest: plain-flip-fb-recreate
[366.867220] Starting dynamic subtest: A-HDMI-A2
[377.382111] Dynamic subtest A-HDMI-A2: SUCCESS (10.511s)
[377.405133] Starting dynamic subtest: B-HDMI-A2
[387.861461] Dynamic subtest B-HDMI-A2: SUCCESS (10.472s)
[387.882750] Starting dynamic subtest: C-HDMI-A2
[398.341046] Dynamic subtest C-HDMI-A2: SUCCESS (10.472s)
[398.345066] Subtest plain-flip-fb-recreate: SUCCESS (31.468s)
[398.551526] [099/132] (632s left) i915_suspend (debugfs-reader)
[398.578940] Starting subtest: debugfs-reader
[417.269706] Subtest debugfs-reader: SUCCESS (4.074s)
[426.342065] [100/132] (613s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[426.436256] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[426.437590] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[426.617165] [101/132] (613s left) gem_exec_nop (basic-sequential)
[426.654339] Starting subtest: basic-sequential
[429.746988] Subtest basic-sequential: SUCCESS (2.974s)
[430.052008] [102/132] (609s left) gem_pxp (create-regular-buffer)
[430.152340] Starting subtest: create-regular-buffer
[430.153810] Subtest create-regular-buffer: SUCCESS (0.000s)
[430.335924] [103/132] (609s left) syncobj_basic (test-valid-cycle)
[430.364975] Starting subtest: test-valid-cycle
[430.365633] Subtest test-valid-cycle: SUCCESS (0.000s)
[430.509611] [104/132] (609s left) gem_exec_suspend (basic-s3-devices)
[430.543937] Starting subtest: basic-S3-devices
[430.544656] Starting dynamic subtest: smem
[438.242653] Dynamic subtest smem: SUCCESS (7.558s)
[438.243361] Subtest basic-S3-devices: SUCCESS (7.559s)
[447.544055] [105/132] (601s left) template (a)
[447.602049] Starting subtest: A
[447.602685] Subtest A: SUCCESS (0.000s)
[447.728835] [106/132] (601s left) gem_mmap_gtt (bad-object)
[447.755703] Starting subtest: bad-object
[447.756327] Subtest bad-object: SUCCESS (0.000s)
[447.928574] [107/132] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[448.016186] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[448.017432] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[448.190864] [108/132] (600s left) api_intel_bb (intel-bb-blit-y)
[448.218937] Starting subtest: intel-bb-blit-y
[451.055451] Subtest intel-bb-blit-y: SUCCESS (2.825s)
[451.219946] [109/132] (597s left) kms_selftest (drm_format_helper)
[451.247622] Starting subtest: drm_format_helper
[451.257551] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[451.355610] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.098s)
[451.364243] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[451.456015] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.099s)
[451.478379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[451.555076] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.094s)
[451.575244] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[451.666460] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.110s)
[451.675635] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[451.766322] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.098s)
[451.788484] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[451.860442] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.092s)
[451.876656] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[451.969531] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.108s)
[451.984270] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[452.078087] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.106s)
[452.088298] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[452.186532] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.105s)
[452.209251] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[452.290939] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.101s)
[452.313985] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[452.402539] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.108s)
[452.421392] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[452.494337] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.087s)
[452.516986] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[452.592444] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[452.603705] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[452.684589] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.089s)
[452.707687] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[452.780268] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[452.803067] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[452.879067] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.093s)
[452.886696] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[452.991028] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.110s)
[452.992001] Subtest drm_format_helper: SUCCESS (1.742s)
[453.209793] [110/132] (595s left) gem_mmap_offset (oob-read)
[453.238024] Starting subtest: oob-read
[453.238671] Subtest oob-read: SUCCESS (0.000s)
[453.420025] [111/132] (595s left) gem_spin_batch (resubmit-all)
[453.454088] Starting subtest: resubmit-all
[453.454759] Starting dynamic subtest: rcs0
[453.457282] Dynamic subtest rcs0: SUCCESS (0.003s)
[453.466247] Starting dynamic subtest: bcs0
[453.466895] Dynamic subtest bcs0: SUCCESS (0.001s)
[453.474545] Starting dynamic subtest: vcs0
[453.475218] Dynamic subtest vcs0: SUCCESS (0.001s)
[453.482680] Starting dynamic subtest: vecs0
[453.483322] Dynamic subtest vecs0: SUCCESS (0.001s)
[453.483955] Subtest resubmit-all: SUCCESS (0.009s)
[453.723559] [112/132] (595s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[453.809219] Starting subtest: cursorB-vs-flipA-toggle
[453.810451] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[453.950789] [113/132] (595s left) gen9_exec_parse (valid-registers)
[453.981742] Subtest valid-registers: SKIP (0.000s)
[454.017212] [114/132] (595s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[454.101194] Starting subtest: disable-crc-after-crtc
[454.102888] Starting dynamic subtest: pipe-A-HDMI-A-2
[454.648758] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.544s)
[454.660789] Starting dynamic subtest: pipe-B-HDMI-A-2
[455.055364] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.404s)
[455.063101] Starting dynamic subtest: pipe-C-HDMI-A-2
[455.467082] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.410s)
[455.467751] Subtest disable-crc-after-crtc: SUCCESS (1.364s)
[455.684339] [115/132] (593s left) gem_exec_fence (syncobj-unused-fence)
[455.990257] Starting subtest: syncobj-unused-fence
[455.991905] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[456.370171] [116/132] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[456.459187] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[456.460404] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[456.633824] [117/132] (592s left) gem_set_tiling_vs_pwrite
[456.714918] [118/132] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[456.802003] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[456.803256] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[456.987005] [119/132] (592s left) vgem_basic (busy-fence)
[457.025210] Starting subtest: busy-fence
[457.025940] Subtest busy-fence: SUCCESS (0.000s)
[457.157134] [120/132] (592s left) i915_pm_rpm (debugfs-read)
[458.554635] Starting subtest: debugfs-read
[458.737996] Subtest debugfs-read: SUCCESS (0.184s)
[458.923742] [121/132] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[459.014725] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[461.948302] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.931s)
[462.196127] [122/132] (587s left) perf_pmu (busy-start)
[462.225395] Starting subtest: busy-start
[462.226035] Starting dynamic subtest: rcs0
[464.772423] Dynamic subtest rcs0: SUCCESS (2.524s)
[464.784494] Starting dynamic subtest: bcs0
[467.301885] Dynamic subtest bcs0: SUCCESS (2.518s)
[467.313441] Starting dynamic subtest: vcs0
[469.824501] Dynamic subtest vcs0: SUCCESS (2.522s)
[469.836808] Starting dynamic subtest: vecs0
[472.353521] Dynamic subtest vecs0: SUCCESS (2.524s)
[472.354774] Subtest busy-start: SUCCESS (10.101s)
[472.486557] [123/132] (577s left) kms_addfb_basic (size-max)
[472.573245] Starting subtest: size-max
[472.573891] Subtest size-max: SUCCESS (0.000s)
[472.752079] [124/132] (577s left) kms_psr (fbc-pr-primary-blt)
[472.837713] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[472.876076] [125/132] (576s left) kms_color_pipeline (plane-ctm3x4)
[472.964406] Starting subtest: plane-ctm3x4
[473.005038] Starting dynamic subtest: pipe-A-HDMI-A-2
[473.323846] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.320s)
[473.430614] Starting dynamic subtest: pipe-B-HDMI-A-2
[473.724023] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.302s)
[473.809083] Starting dynamic subtest: pipe-C-HDMI-A-2
[474.104377] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.302s)
[474.144244] Subtest plane-ctm3x4: SUCCESS (1.179s)
[474.313244] [126/132] (575s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[474.431465] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[474.502342] [127/132] (575s left) api_intel_allocator (standalone)
[474.530836] Starting subtest: standalone
[474.544648] Subtest standalone: SUCCESS (0.014s)
[474.720444] [128/132] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[474.808019] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[474.809270] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[474.984403] [129/132] (575s left) kms_big_fb (y-tiled-addfb)
[475.077220] Starting subtest: y-tiled-addfb
[475.077859] Subtest y-tiled-addfb: SUCCESS (0.000s)
[475.249752] [130/132] (574s left) kms_prime (basic-crc-vgem)
[475.345923] Starting subtest: basic-crc-vgem
[475.346603] Starting dynamic subtest: second-to-first
[476.561264] Dynamic subtest second-to-first: SUCCESS (1.214s)
[476.567453] Subtest basic-crc-vgem: SUCCESS (1.217s)
[476.736104] [131/132] (573s left) i915_hangman (engine-error-state-capture)
[476.771074] Starting subtest: engine-error-state-capture
[476.771714] Starting dynamic subtest: rcs0
[479.550310] Dynamic subtest rcs0: SUCCESS (2.776s)
[479.567869] Starting dynamic subtest: bcs0
[483.575975] Dynamic subtest bcs0: SUCCESS (4.019s)
[483.590641] Starting dynamic subtest: vcs0
[487.549983] Dynamic subtest vcs0: SUCCESS (3.967s)
[487.565265] Starting dynamic subtest: vecs0
[491.584864] Dynamic subtest vecs0: SUCCESS (4.029s)
[491.589012] Subtest engine-error-state-capture: SUCCESS (14.804s)
[491.721378] [132/132] (558s left) kms_invalid_mode (bad-vsync-end)
[491.805844] Starting subtest: bad-vsync-end
[491.806507] Starting dynamic subtest: pipe-A-HDMI-A-2
[491.854978] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.047s)
[491.865695] Starting dynamic subtest: pipe-B-HDMI-A-2
[491.866371] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[491.874716] Starting dynamic subtest: pipe-C-HDMI-A-2
[491.875355] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.001s)
[491.875990] Subtest bad-vsync-end: SUCCESS (0.054s)
[492.083726] 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.