[57.902013] Initializing watchdogs
[57.902082]   /dev/watchdog0
[57.922141] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.933519] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.937476] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.939926] [001/134] (960s left) vgem_basic (bad-handle)
[58.040304] Starting subtest: bad-handle
[58.041483] Subtest bad-handle: SUCCESS (0.000s)
[58.156705] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[58.158755] [002/134] (960s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[58.354990] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[58.370165] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.015s)
[58.555113] [003/134] (960s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[58.642663] Starting subtest: x-tiled-to-vebox-yf-tiled
[58.644817] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[58.924835] [004/134] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[59.118948] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[61.885438] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.771s)
[62.098340] [005/134] (956s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[62.192120] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[62.289620] [006/134] (956s left) gem_exec_whisper (basic-fds-forked-all)
[62.384771] Starting subtest: basic-fds-forked-all
[85.850623] Subtest basic-fds-forked-all: SUCCESS (23.470s)
[86.125092] [007/134] (932s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[86.349872] Starting subtest: extended-modeset-hang-newfb-with-reset
[86.351901] Starting dynamic subtest: pipe-A
[107.420066] Dynamic subtest pipe-A: SUCCESS (21.068s)
[107.435893] Starting dynamic subtest: pipe-D
[128.387345] Dynamic subtest pipe-D: SUCCESS (20.964s)
[128.388358] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.038s)
[128.721183] [008/134] (890s left) kms_psr (fbc-psr2-cursor-render)
[128.910686] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[128.963944] [009/134] (890s left) kms_invalid_mode (bad-vsync-start)
[129.154345] Starting subtest: bad-vsync-start
[129.155269] Starting dynamic subtest: pipe-A-DP-3
[129.226283] Dynamic subtest pipe-A-DP-3: SUCCESS (0.072s)
[129.235944] Starting dynamic subtest: pipe-B-DP-3
[129.237169] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[129.246379] Starting dynamic subtest: pipe-C-DP-3
[129.247357] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[129.256532] Starting dynamic subtest: pipe-D-DP-3
[129.257475] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[129.258398] Subtest bad-vsync-start: SUCCESS (0.077s)
[129.499411] [010/134] (889s left) i915_drm_fdinfo (virtual-busy-idle-all)
[129.571398] Starting subtest: virtual-busy-idle-all
[129.573273] Subtest virtual-busy-idle-all: SKIP (0.000s)
[129.713329] [011/134] (889s left) kms_psr (fbc-psr-suspend)
[129.901735] Subtest fbc-psr-suspend: SKIP (0.000s)
[129.953515] [012/134] (889s left) kms_selftest (drm_format)
[130.003888] Starting subtest: drm_format
[130.049201] Starting dynamic subtest: drm_test_format_block_width_invalid
[130.133133] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.084s)
[130.146064] Starting dynamic subtest: drm_test_format_block_width_one_plane
[130.237059] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.101s)
[130.275432] Starting dynamic subtest: drm_test_format_block_width_two_plane
[130.328914] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.093s)
[130.364965] Starting dynamic subtest: drm_test_format_block_width_three_plane
[130.421751] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.090s)
[130.457504] Starting dynamic subtest: drm_test_format_block_width_tiled
[130.525684] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.102s)
[130.564152] Starting dynamic subtest: drm_test_format_block_height_invalid
[130.612898] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.088s)
[130.650263] Starting dynamic subtest: drm_test_format_block_height_one_plane
[130.713847] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.099s)
[130.751641] Starting dynamic subtest: drm_test_format_block_height_two_plane
[130.805765] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[130.841079] Starting dynamic subtest: drm_test_format_block_height_three_plane
[130.882215] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.076s)
[130.917593] Starting dynamic subtest: drm_test_format_block_height_tiled
[130.978608] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.095s)
[131.017187] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[131.060185] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.081s)
[131.085560] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[131.141920] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.080s)
[131.153175] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[131.229947] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.086s)
[131.268438] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[131.314966] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.085s)
[131.350910] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[131.385659] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.071s)
[131.407342] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[131.457751] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.071s)
[131.467823] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[131.536716] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.076s)
[131.575445] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[131.613116] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.077s)
[131.614599] Subtest drm_format: SUCCESS (1.610s)
[131.860163] [013/134] (887s left) gem_ctx_exec (basic)
[131.942951] Starting subtest: basic
[131.951097] Subtest basic: SUCCESS (0.008s)
[132.159987] [014/134] (887s left) gem_softpin (allocator-basic)
[132.245602] Starting subtest: allocator-basic
[132.485481] Subtest allocator-basic: SUCCESS (0.239s)
[132.692714] [015/134] (886s left) kms_big_fb (linear-64bpp-rotate-0)
[132.897291] Starting subtest: linear-64bpp-rotate-0
[135.377944] Subtest linear-64bpp-rotate-0: SUCCESS (2.481s)
[135.565336] [016/134] (883s left) prime_mmap (test_refcounting)
[135.645932] Starting subtest: test_refcounting
[135.646893] Starting dynamic subtest: test_refcounting-smem
[135.695446] Dynamic subtest test_refcounting-smem: SUCCESS (0.050s)
[135.705083] Starting dynamic subtest: test_refcounting-lmem0
[135.901953] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.206s)
[135.902970] Subtest test_refcounting: SUCCESS (0.256s)
[136.030728] [017/134] (883s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[136.119331] Subtest writes-after-reads: SKIP (0.000s)
[136.186946] [018/134] (883s left) syncobj_timeline (invalid-signal-illegal-handle)
[136.265940] Starting subtest: invalid-signal-illegal-handle
[136.267008] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[136.425974] [019/134] (883s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[136.512256] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[136.513184] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[136.657532] [020/134] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[136.851829] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[136.853545] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[137.015408] [021/134] (882s left) kms_plane_alpha_blend (coverage-7efc)
[137.204975] Starting subtest: coverage-7efc
[137.472914] Starting dynamic subtest: pipe-A-DP-3
[137.950935] Dynamic subtest pipe-A-DP-3: SUCCESS (0.478s)
[137.983601] Starting dynamic subtest: pipe-D-DP-3
[138.639354] Dynamic subtest pipe-D-DP-3: SUCCESS (0.665s)
[138.640259] Subtest coverage-7efc: SUCCESS (1.435s)
[138.945652] [022/134] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[139.139819] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[139.141536] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[139.332189] [023/134] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[139.526859] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[139.528574] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[139.734623] [024/134] (880s left) gem_mmap_gtt (hang)
[139.817064] Subtest hang: SKIP (0.000s)
[139.895554] [025/134] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[140.085558] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[140.087290] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[140.249015] [026/134] (879s left) gem_exec_capture (capture)
[140.335750] Starting subtest: capture
[140.336648] Starting dynamic subtest: rcs0-smem
[141.295068] Dynamic subtest rcs0-smem: SUCCESS (0.959s)
[141.304850] Starting dynamic subtest: rcs0-lmem0
[142.237127] Dynamic subtest rcs0-lmem0: SUCCESS (0.942s)
[142.246673] Starting dynamic subtest: bcs0-smem
[143.158177] Dynamic subtest bcs0-smem: SUCCESS (0.920s)
[143.167662] Starting dynamic subtest: bcs0-lmem0
[144.232330] Dynamic subtest bcs0-lmem0: SUCCESS (1.073s)
[144.241786] Starting dynamic subtest: vcs0-smem
[145.141242] Dynamic subtest vcs0-smem: SUCCESS (0.909s)
[145.150694] Starting dynamic subtest: vcs0-lmem0
[146.224343] Dynamic subtest vcs0-lmem0: SUCCESS (1.083s)
[146.233774] Starting dynamic subtest: vcs1-smem
[147.143278] Dynamic subtest vcs1-smem: SUCCESS (0.919s)
[147.152916] Starting dynamic subtest: vcs1-lmem0
[148.277269] Dynamic subtest vcs1-lmem0: SUCCESS (1.133s)
[148.286791] Starting dynamic subtest: vecs0-smem
[149.220843] Dynamic subtest vecs0-smem: FAIL (0.924s)
[149.230117] Starting dynamic subtest: vecs0-lmem0
[150.231283] Dynamic subtest vecs0-lmem0: FAIL (1.007s)
[150.240472] Starting dynamic subtest: vecs1-smem
[151.659830] Dynamic subtest vecs1-smem: FAIL (1.427s)
[151.669042] Starting dynamic subtest: vecs1-lmem0
[152.660249] Dynamic subtest vecs1-lmem0: FAIL (1.001s)
[152.669489] Starting dynamic subtest: ccs0-smem
[154.068152] Dynamic subtest ccs0-smem: SUCCESS (1.430s)
[154.077684] Starting dynamic subtest: ccs0-lmem0
[154.992056] Dynamic subtest ccs0-lmem0: SUCCESS (0.923s)
[154.992957] Subtest capture: FAIL (14.655s)
[155.179244] [027/134] (865s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[155.379799] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[156.481558] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.102s)
[156.733740] [028/134] (863s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[156.922989] Starting subtest: async-flip-with-page-flip-events-tiled
[157.144673] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs
[159.434774] Dynamic subtest pipe-A-DP-3-4-rc-ccs: SUCCESS (2.290s)
[159.444829] Starting dynamic subtest: pipe-A-DP-3-4
[161.633562] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.198s)
[161.643553] Starting dynamic subtest: pipe-A-DP-3-4
[163.650579] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.016s)
[163.665225] Starting dynamic subtest: pipe-A-DP-3-x
[165.850336] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.199s)
[166.089795] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs
[168.351933] Dynamic subtest pipe-B-DP-3-4-rc-ccs: SUCCESS (2.272s)
[168.363510] Starting dynamic subtest: pipe-B-DP-3-4
[170.533826] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.181s)
[170.543454] Starting dynamic subtest: pipe-B-DP-3-4
[172.550865] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.016s)
[172.562658] Starting dynamic subtest: pipe-B-DP-3-x
[174.717446] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.166s)
[174.900212] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs
[177.152130] Dynamic subtest pipe-C-DP-3-4-rc-ccs: SUCCESS (2.262s)
[177.164823] Starting dynamic subtest: pipe-C-DP-3-4
[179.333893] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.181s)
[179.343920] Starting dynamic subtest: pipe-C-DP-3-4
[181.350663] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.016s)
[181.360650] Starting dynamic subtest: pipe-C-DP-3-x
[183.517426] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.166s)
[183.725758] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs
[185.985154] Dynamic subtest pipe-D-DP-3-4-rc-ccs: SUCCESS (2.268s)
[185.994876] Starting dynamic subtest: pipe-D-DP-3-4
[188.149253] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.164s)
[188.159265] Starting dynamic subtest: pipe-D-DP-3-4
[190.165815] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.016s)
[190.175664] Starting dynamic subtest: pipe-D-DP-3-x
[192.332513] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.166s)
[192.333334] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.409s)
[192.807640] [029/134] (827s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[192.994617] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[192.996893] Starting dynamic subtest: pipe-A-DP-3
[193.071389] Dynamic subtest pipe-A-DP-3: SUCCESS (0.076s)
[193.172407] Starting dynamic subtest: pipe-B-DP-3
[193.372810] Dynamic subtest pipe-B-DP-3: SUCCESS (0.210s)
[193.446954] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.452s)
[193.714208] [030/134] (826s left) gem_lmem_swapping (verify-random)
[196.506018] Starting subtest: verify-random
[196.507554] Starting dynamic subtest: lmem0
[205.327103] Dynamic subtest lmem0: SUCCESS (8.826s)
[205.328096] Subtest verify-random: SUCCESS (8.826s)
[206.505754] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[206.506811] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[206.509113] [031/134] (814s left) kms_dp_link_training (non-uhbr-mst)
[208.155203] Starting subtest: non-uhbr-mst
[208.158697] Subtest non-uhbr-mst: SKIP (0.000s)
[208.346795] [FACT kms_dp_link_training (non-uhbr-mst)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[208.349187] [FACT kms_dp_link_training (non-uhbr-mst)] new: kernel.kmod_is_loaded.i915: true
[208.352009] [032/134] (812s left) kms_flip (2x-flip-vs-dpms)
[208.544476] Starting subtest: 2x-flip-vs-dpms
[208.560400] Subtest 2x-flip-vs-dpms: SKIP (0.015s)
[208.729458] [033/134] (811s left) kms_flip (2x-busy-flip)
[208.918036] Starting subtest: 2x-busy-flip
[208.932789] Subtest 2x-busy-flip: SKIP (0.015s)
[209.071542] [034/134] (811s left) syncobj_timeline (single-wait-available-submitted)
[209.157215] Starting subtest: single-wait-available-submitted
[209.158186] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[209.302161] [035/134] (811s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[209.489281] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[209.490168] Starting dynamic subtest: pipe-A-DP-3
[209.498993] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[209.507483] Starting dynamic subtest: pipe-B-DP-3
[209.516239] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[209.524478] Starting dynamic subtest: pipe-C-DP-3
[209.532960] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[209.540895] Starting dynamic subtest: pipe-D-DP-3
[209.550103] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[209.552623] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.008s)
[209.981987] [036/134] (810s left) gem_exec_reloc (basic-cpu-read-noreloc)
[210.080860] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[210.167244] [037/134] (810s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[210.356431] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[210.357362] Starting dynamic subtest: pipe-A-valid-mode
[212.610252] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.253s)
[212.611115] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.254s)
[212.903723] [038/134] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[213.100709] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[213.102385] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[213.248635] [039/134] (807s left) perf_pmu (busy-start)
[213.321744] Starting subtest: busy-start
[213.322609] Starting dynamic subtest: rcs0
[215.905224] Dynamic subtest rcs0: SUCCESS (2.582s)
[215.917804] Starting dynamic subtest: bcs0
[218.456841] Dynamic subtest bcs0: SUCCESS (2.548s)
[218.469559] Starting dynamic subtest: vcs0
[221.007734] Dynamic subtest vcs0: SUCCESS (2.548s)
[221.024441] Starting dynamic subtest: vcs1
[223.558701] Dynamic subtest vcs1: SUCCESS (2.548s)
[223.571563] Starting dynamic subtest: vecs0
[226.108723] Dynamic subtest vecs0: SUCCESS (2.547s)
[226.125416] Starting dynamic subtest: vecs1
[228.656962] Dynamic subtest vecs1: SUCCESS (2.545s)
[228.673785] Starting dynamic subtest: ccs0
[231.208046] Dynamic subtest ccs0: SUCCESS (2.548s)
[231.210134] Subtest busy-start: SUCCESS (17.887s)
[231.395567] [040/134] (789s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[231.590047] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[231.591842] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[231.809142] [041/134] (789s left) gem_softpin (evict-active)
[231.897577] Starting subtest: evict-active
[231.915188] Subtest evict-active: SUCCESS (0.017s)
[232.108090] [042/134] (789s left) kms_lease (atomic-implicit-crtc)
[232.296977] Starting subtest: atomic-implicit-crtc
[232.297915] Starting dynamic subtest: pipe-A-DP-3
[232.302241] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[232.311711] Starting dynamic subtest: pipe-B-DP-3
[232.316018] Dynamic subtest pipe-B-DP-3: SUCCESS (0.010s)
[232.325390] Starting dynamic subtest: pipe-C-DP-3
[232.329825] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[232.339248] Starting dynamic subtest: pipe-D-DP-3
[232.343492] Dynamic subtest pipe-D-DP-3: SUCCESS (0.010s)
[232.344328] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[232.511444] [043/134] (788s left) kms_chamelium_frames (dp-frame-dump)
[232.781645] Subtest dp-frame-dump: SKIP (0.000s)
[232.926708] [044/134] (788s left) gem_exec_schedule (lateslice)
[233.025798] Starting subtest: lateslice
[233.026802] Starting dynamic subtest: rcs0
[233.078622] Dynamic subtest rcs0: SUCCESS (0.053s)
[233.088407] Starting dynamic subtest: bcs0
[233.103318] Dynamic subtest bcs0: SUCCESS (0.024s)
[233.113126] Starting dynamic subtest: vcs0
[233.124517] Dynamic subtest vcs0: SUCCESS (0.021s)
[233.134393] Starting dynamic subtest: vcs1
[233.145443] Dynamic subtest vcs1: SUCCESS (0.020s)
[233.155175] Starting dynamic subtest: vecs0
[233.169251] Dynamic subtest vecs0: SUCCESS (0.023s)
[233.179529] Starting dynamic subtest: vecs1
[233.190627] Dynamic subtest vecs1: SUCCESS (0.021s)
[233.200563] Starting dynamic subtest: ccs0
[233.214174] Dynamic subtest ccs0: SUCCESS (0.023s)
[233.215175] Subtest lateslice: SUCCESS (0.189s)
[233.711401] [045/134] (787s left) kms_addfb_basic (unused-handle)
[233.791484] Starting subtest: unused-handle
[233.792410] Subtest unused-handle: SUCCESS (0.000s)
[234.080385] [046/134] (787s left) gem_madvise (dontneed-before-pwrite)
[234.127936] Starting subtest: dontneed-before-pwrite
[234.161164] Subtest dontneed-before-pwrite: SKIP (0.032s)
[234.234285] [047/134] (787s left) kms_writeback (writeback-check-output-xrgb2101010)
[234.425190] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[234.483749] [048/134] (787s left) gem_ctx_persistence (heartbeat-hostile)
[234.573637] Starting subtest: heartbeat-hostile
[234.575790] Subtest heartbeat-hostile: SKIP (0.000s)
[234.751790] [049/134] (787s left) gem_exercise_blt (fast-copy-emit)
[234.835184] Starting subtest: fast-copy-emit
[234.836153] Starting dynamic subtest: linear-smem-smem-emit
[234.883564] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.048s)
[234.893211] Starting dynamic subtest: linear-smem-lmem0-emit
[234.899279] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[234.909235] Starting dynamic subtest: linear-lmem0-smem-emit
[234.993730] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.094s)
[235.003240] Starting dynamic subtest: linear-lmem0-lmem0-emit
[235.099623] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.105s)
[235.109169] Starting dynamic subtest: xmajor-smem-smem-emit
[235.115297] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.015s)
[235.124826] Starting dynamic subtest: xmajor-smem-lmem0-emit
[235.130359] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.014s)
[235.139990] Starting dynamic subtest: xmajor-lmem0-smem-emit
[235.231037] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.100s)
[235.240539] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[235.330887] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.099s)
[235.340475] Starting dynamic subtest: tile4-smem-smem-emit
[235.346570] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[235.356066] Starting dynamic subtest: tile4-smem-lmem0-emit
[235.361644] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[235.371258] Starting dynamic subtest: tile4-lmem0-smem-emit
[235.464904] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.102s)
[235.474383] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[235.564590] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.099s)
[235.574062] Starting dynamic subtest: tile64-smem-smem-emit
[235.582217] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[235.591731] Starting dynamic subtest: tile64-smem-lmem0-emit
[235.597184] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[235.607510] Starting dynamic subtest: tile64-lmem0-smem-emit
[235.706540] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.109s)
[235.716396] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[235.806494] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.099s)
[235.807379] Subtest fast-copy-emit: SUCCESS (0.972s)
[235.973593] [050/134] (785s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[236.172964] Starting subtest: fbc-rgb565-draw-render
[238.873533] Subtest fbc-rgb565-draw-render: SUCCESS (2.701s)
[239.060044] [051/134] (782s left) gem_eio (in-flight-suspend)
[239.348171] Starting subtest: in-flight-suspend
[280.972143] Subtest in-flight-suspend: SUCCESS (11.798s)
[281.260944] [052/134] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[281.468055] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[281.469808] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[281.667851] [053/134] (740s left) syncobj_wait (invalid-wait-bad-flags)
[281.753570] Starting subtest: invalid-wait-bad-flags
[281.754545] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[281.933959] [054/134] (740s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[282.121471] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[282.123819] Starting dynamic subtest: pipe-A-DP-3
[282.132422] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[282.145374] Starting dynamic subtest: pipe-B-DP-3
[282.154161] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[282.166672] Starting dynamic subtest: pipe-C-DP-3
[282.175178] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[282.187570] Starting dynamic subtest: pipe-D-DP-3
[282.197457] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[282.199248] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[282.599654] [055/134] (739s left) kms_big_fb (x-tiled-addfb)
[282.797503] Starting subtest: x-tiled-addfb
[282.798464] Subtest x-tiled-addfb: SUCCESS (0.000s)
[283.017467] [056/134] (739s left) gem_exec_params (mmapped)
[283.102604] Starting subtest: mmapped
[283.104799] Subtest mmapped: SUCCESS (0.002s)
[283.265328] [057/134] (739s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[283.466201] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[283.471095] Starting dynamic subtest: A-DP3
[284.396218] Dynamic subtest A-DP3: SUCCESS (0.924s)
[284.410515] Starting dynamic subtest: B-DP3
[285.094504] Dynamic subtest B-DP3: SUCCESS (0.698s)
[285.109176] Starting dynamic subtest: C-DP3
[285.800935] Dynamic subtest C-DP3: SUCCESS (0.705s)
[285.814088] Starting dynamic subtest: D-DP3
[286.522118] Dynamic subtest D-DP3: SUCCESS (0.720s)
[286.524438] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.057s)
[286.839258] [058/134] (735s left) gem_userptr_blits (unsync-overlap)
[286.929408] Subtest unsync-overlap: SKIP (0.000s)
[287.105385] [059/134] (735s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[287.299799] Starting subtest: fbc-rgb565-draw-mmap-gtt
[287.301469] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[287.475361] [060/134] (735s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[287.663759] Starting subtest: plane-all-transition-nonblocking-fencing
[287.666058] Starting dynamic subtest: pipe-A-DP-3
[291.465580] Dynamic subtest pipe-A-DP-3: SUCCESS (3.799s)
[291.605043] Starting dynamic subtest: pipe-B-DP-3
[295.489055] Dynamic subtest pipe-B-DP-3: SUCCESS (3.898s)
[295.595137] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.930s)
[295.889179] [061/134] (726s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[296.091032] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[296.868174] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.777s)
[297.176039] [062/134] (725s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[297.366811] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[297.367740] Starting dynamic subtest: pipe-A
[299.334828] Dynamic subtest pipe-A: SUCCESS (1.967s)
[299.358686] Starting dynamic subtest: pipe-B
[301.383288] Dynamic subtest pipe-B: SUCCESS (2.047s)
[301.405419] Starting dynamic subtest: pipe-C
[301.679886] Dynamic subtest pipe-C: SUCCESS (0.295s)
[301.700973] Starting dynamic subtest: pipe-D
[301.977342] Dynamic subtest pipe-D: SUCCESS (0.296s)
[301.980884] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.612s)
[302.315647] [063/134] (720s left) kms_psr (fbc-psr2-sprite-render)
[302.506310] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[302.573187] [064/134] (720s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[303.243629] Starting subtest: syncobj-timeline-multiple-ext-nodes
[303.245073] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[303.546286] [065/134] (719s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[303.625565] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[303.745861] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[303.931083] [066/134] (719s left) gem_ctx_param (invalid-param-set)
[304.007902] Starting subtest: invalid-param-set
[304.008891] Subtest invalid-param-set: SUCCESS (0.000s)
[304.163317] [067/134] (719s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[304.359534] Starting subtest: multiplane-rotation-cropping-bottom
[316.044640] Subtest multiplane-rotation-cropping-bottom: SUCCESS (11.686s)
[316.279657] [068/134] (707s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[316.481447] Starting subtest: yf-tiled-8bpp-rotate-270
[316.483246] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[316.700043] [069/134] (706s left) i915_pm_rps (fence-order)
[316.786644] Starting subtest: fence-order
[321.008748] Subtest fence-order: SUCCESS (4.221s)
[321.210523] [070/134] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[321.407373] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[321.409126] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[321.594547] [071/134] (701s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[321.789873] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[321.857181] [072/134] (701s left) kms_pm_dc (dc6-dpms)
[323.057597] Starting subtest: dc6-dpms
[323.059400] Subtest dc6-dpms: SKIP (0.000s)
[323.240611] [073/134] (700s left) kms_cursor_crc (cursor-random-64x21)
[323.595919] Starting subtest: cursor-random-64x21
[323.601298] Starting dynamic subtest: pipe-A-DP-3
[328.207484] Dynamic subtest pipe-A-DP-3: SUCCESS (4.606s)
[328.262187] Starting dynamic subtest: pipe-D-DP-3
[332.691523] Dynamic subtest pipe-D-DP-3: SUCCESS (4.441s)
[332.692562] Subtest cursor-random-64x21: SUCCESS (9.095s)
[333.202421] [074/134] (690s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[333.397156] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[333.398859] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[333.561704] [075/134] (690s left) kms_concurrent (multi-plane-atomic-lowres)
[333.752456] Starting subtest: multi-plane-atomic-lowres
[333.754755] Starting dynamic subtest: pipe-A-DP-3
[334.260042] Dynamic subtest pipe-A-DP-3: SUCCESS (0.506s)
[334.261167] Subtest multi-plane-atomic-lowres: SUCCESS (0.508s)
[334.592634] [076/134] (689s left) gem_exec_balancer (bonded-chain)
[334.685435] Starting subtest: bonded-chain
[348.558615] Subtest bonded-chain: SUCCESS (13.874s)
[348.999644] [077/134] (675s left) gem_ctx_shared (create-shared-gtt)
[349.100645] Starting subtest: create-shared-gtt
[351.257017] Subtest create-shared-gtt: SUCCESS (2.150s)
[353.506560] [078/134] (670s left) sw_sync (sync_multi_timeline_wait)
[353.555686] Starting subtest: sync_multi_timeline_wait
[353.556573] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[353.686070] [079/134] (670s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[353.884747] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[353.940804] [080/134] (670s left) kms_flip (2x-flip-vs-fences-interruptible)
[354.138737] Starting subtest: 2x-flip-vs-fences-interruptible
[354.140468] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[354.346024] [081/134] (669s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[354.533296] Starting subtest: compare-crc-sanitycheck-xr24
[354.534211] Starting dynamic subtest: pipe-A-DP-3
[355.092414] Dynamic subtest pipe-A-DP-3: SUCCESS (0.558s)
[355.122288] Starting dynamic subtest: pipe-B-DP-3
[355.580138] Dynamic subtest pipe-B-DP-3: SUCCESS (0.483s)
[355.595381] Starting dynamic subtest: pipe-C-DP-3
[356.038171] Dynamic subtest pipe-C-DP-3: SUCCESS (0.456s)
[356.053476] Starting dynamic subtest: pipe-D-DP-3
[356.500280] Dynamic subtest pipe-D-DP-3: SUCCESS (0.460s)
[356.501198] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.968s)
[356.813763] [082/134] (667s left) gem_fence_thrash (bo-copy)
[356.863075] Starting subtest: bo-copy
[356.895351] Subtest bo-copy: SKIP (0.032s)
[356.981603] [083/134] (667s left) kms_getfb (getfb-handle-valid)
[357.167790] Starting subtest: getfb-handle-valid
[357.168737] Subtest getfb-handle-valid: SUCCESS (0.000s)
[357.353727] [084/134] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[357.551647] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[357.553433] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[357.770261] [085/134] (666s left) prime_busy (hang)
[357.851441] Starting subtest: hang
[357.854078] Starting dynamic subtest: rcs0
[384.309184] Dynamic subtest rcs0: SUCCESS (26.453s)
[384.322677] Starting dynamic subtest: bcs0
[391.465110] Dynamic subtest bcs0: SUCCESS (7.156s)
[391.478680] Starting dynamic subtest: vcs0
[398.441142] Dynamic subtest vcs0: SUCCESS (6.975s)
[398.454649] Starting dynamic subtest: vcs1
[405.482938] Dynamic subtest vcs1: SUCCESS (7.040s)
[405.496566] Starting dynamic subtest: vecs0
[412.456863] Dynamic subtest vecs0: SUCCESS (6.972s)
[412.470401] Starting dynamic subtest: vecs1
[419.443698] Dynamic subtest vecs1: SUCCESS (6.984s)
[419.457264] Starting dynamic subtest: ccs0
[433.333887] Dynamic subtest ccs0: SUCCESS (13.888s)
[433.334971] Subtest hang: SUCCESS (75.480s)
[433.500928] [086/134] (591s left) sw_sync (alloc_timeline)
[433.550402] Starting subtest: alloc_timeline
[433.551306] Subtest alloc_timeline: SUCCESS (0.000s)
[433.705822] [087/134] (591s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[433.895327] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[433.897170] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[434.103130] [088/134] (590s left) kms_cursor_crc (cursor-alpha-opaque)
[434.292422] Starting subtest: cursor-alpha-opaque
[434.293311] Starting dynamic subtest: pipe-A-DP-3
[434.930417] Dynamic subtest pipe-A-DP-3: SUCCESS (0.637s)
[434.952876] Starting dynamic subtest: pipe-D-DP-3
[435.412656] Dynamic subtest pipe-D-DP-3: SUCCESS (0.479s)
[435.413612] Subtest cursor-alpha-opaque: SUCCESS (1.122s)
[436.077812] [089/134] (588s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[436.272296] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[436.274128] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.482973] [090/134] (588s left) api_intel_bb (simple-bb)
[436.561947] Starting subtest: simple-bb
[436.592758] Subtest simple-bb: SUCCESS (0.031s)
[436.774088] [091/134] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[436.968218] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[436.970000] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[437.156512] [092/134] (588s left) kms_psr (psr2-sprite-blt)
[437.343489] Subtest psr2-sprite-blt: SKIP (0.000s)
[437.403786] [093/134] (587s left) api_intel_bb (blit-reloc-purge-cache)
[437.489589] Starting subtest: blit-reloc-purge-cache
[437.491354] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[437.710885] [094/134] (587s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[437.903335] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[437.904270] Starting dynamic subtest: pipe-A-DP-3
[446.828139] Dynamic subtest pipe-A-DP-3: SUCCESS (8.919s)
[446.849581] Starting dynamic subtest: pipe-B-DP-3
[447.609301] Dynamic subtest pipe-B-DP-3: SUCCESS (0.774s)
[447.651590] Starting dynamic subtest: pipe-C-DP-3
[448.405352] Dynamic subtest pipe-C-DP-3: SUCCESS (0.788s)
[448.446310] Starting dynamic subtest: pipe-D-DP-3
[449.201664] Dynamic subtest pipe-D-DP-3: SUCCESS (0.788s)
[449.203467] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.296s)
[449.585473] [095/134] (575s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[449.674640] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[449.676801] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[449.925177] [096/134] (575s left) kms_cursor_crc (cursor-sliding-max-size)
[450.445723] Starting subtest: cursor-sliding-max-size
[450.448856] Subtest cursor-sliding-max-size: SKIP (0.000s)
[450.677009] [097/134] (574s left) i915_drm_fdinfo (busy)
[450.748039] Starting subtest: busy
[450.749158] Starting dynamic subtest: rcs0
[450.773226] Dynamic subtest rcs0: SKIP (0.024s)
[450.787956] Starting dynamic subtest: bcs0
[450.789975] Dynamic subtest bcs0: SKIP (0.000s)
[450.804451] Starting dynamic subtest: vcs0
[450.806384] Dynamic subtest vcs0: SKIP (0.000s)
[450.820177] Starting dynamic subtest: vcs1
[450.822057] Dynamic subtest vcs1: SKIP (0.000s)
[450.834767] Starting dynamic subtest: vecs0
[450.837035] Dynamic subtest vecs0: SKIP (0.000s)
[450.852780] Starting dynamic subtest: vecs1
[450.855224] Dynamic subtest vecs1: SKIP (0.000s)
[450.867894] Starting dynamic subtest: ccs0
[450.870191] Dynamic subtest ccs0: SKIP (0.000s)
[450.872569] Subtest busy: SKIP (0.034s)
[450.922422] [098/134] (574s left) gem_mmap_offset (clear-via-pagefault)
[451.004435] Starting subtest: clear-via-pagefault
[451.005397] Starting dynamic subtest: lmem0
[478.602478] Dynamic subtest lmem0: SUCCESS (27.595s)
[478.621296] Starting dynamic subtest: smem0
[503.183981] Dynamic subtest smem0: SUCCESS (24.580s)
[503.184895] Subtest clear-via-pagefault: SUCCESS (52.177s)
[503.476622] [099/134] (522s left) gem_mmap_gtt (basic-write-read)
[503.554311] Subtest basic-write-read: SKIP (0.000s)
[503.638931] [100/134] (522s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[503.869213] Starting subtest: y-tiled-addfb-size-offset-overflow
[503.871058] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[504.078470] [101/134] (521s left) kms_atomic (plane-immutable-zpos)
[504.270783] Starting subtest: plane-immutable-zpos
[504.273135] Starting dynamic subtest: pipe-A-DP-3
[505.215225] Dynamic subtest pipe-A-DP-3: SUCCESS (0.943s)
[505.216170] Subtest plane-immutable-zpos: SUCCESS (0.945s)
[505.546330] [102/134] (520s left) gem_exec_reloc (basic-cpu-read)
[505.634897] Subtest basic-cpu-read: SKIP (0.000s)
[505.753057] [103/134] (520s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[505.944356] Starting subtest: cursorA-vs-flipB-legacy
[505.946170] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[506.130984] [104/134] (519s left) sriov_basic (enable-vfs-autoprobe-on)
[506.214429] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[506.295774] [105/134] (519s left) kms_plane (plane-position-hole-dpms)
[506.484492] Starting subtest: plane-position-hole-dpms
[506.927573] Starting dynamic subtest: pipe-A-plane-1
[507.609805] Dynamic subtest pipe-A-plane-1: SUCCESS (0.684s)
[507.627749] Starting dynamic subtest: pipe-A-plane-2
[508.286629] Dynamic subtest pipe-A-plane-2: SUCCESS (0.675s)
[508.303065] Starting dynamic subtest: pipe-A-plane-3
[508.964129] Dynamic subtest pipe-A-plane-3: SUCCESS (0.675s)
[508.979505] Starting dynamic subtest: pipe-A-plane-4
[509.636975] Dynamic subtest pipe-A-plane-4: SUCCESS (0.672s)
[509.662391] Starting dynamic subtest: pipe-A-plane-5
[509.669408] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[510.017576] Starting dynamic subtest: pipe-B-plane-1
[510.612213] Dynamic subtest pipe-B-plane-1: SUCCESS (0.608s)
[510.625990] Starting dynamic subtest: pipe-B-plane-2
[511.218344] Dynamic subtest pipe-B-plane-2: SUCCESS (0.605s)
[511.232381] Starting dynamic subtest: pipe-B-plane-3
[511.824210] Dynamic subtest pipe-B-plane-3: SUCCESS (0.605s)
[511.838411] Starting dynamic subtest: pipe-B-plane-4
[512.429074] Dynamic subtest pipe-B-plane-4: SUCCESS (0.604s)
[512.443069] Starting dynamic subtest: pipe-B-plane-5
[512.451048] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[512.452011] Subtest plane-position-hole-dpms: SUCCESS (5.967s)
[512.751905] [106/134] (513s left) gem_ctx_isolation (preservation-reset)
[512.959288] Starting subtest: preservation-reset
[512.960301] Starting dynamic subtest: rcs0
[513.562441] Dynamic subtest rcs0: SUCCESS (0.601s)
[513.575971] Starting dynamic subtest: bcs0
[514.229480] Dynamic subtest bcs0: SUCCESS (0.666s)
[514.243287] Starting dynamic subtest: vcs0
[514.841150] Dynamic subtest vcs0: SUCCESS (0.612s)
[514.854490] Starting dynamic subtest: vcs1
[515.462389] Dynamic subtest vcs1: SUCCESS (0.627s)
[515.475712] Starting dynamic subtest: vecs0
[516.078520] Dynamic subtest vecs0: SUCCESS (0.615s)
[516.092217] Starting dynamic subtest: vecs1
[516.739553] Dynamic subtest vecs1: SUCCESS (0.660s)
[516.753132] Starting dynamic subtest: ccs0
[517.393330] Dynamic subtest ccs0: SUCCESS (0.653s)
[517.394290] Subtest preservation-reset: SUCCESS (4.443s)
[517.649419] [107/134] (508s left) gem_pxp (create-regular-buffer)
[520.258835] Starting subtest: create-regular-buffer
[520.260658] Subtest create-regular-buffer: SKIP (0.000s)
[520.396197] [108/134] (505s left) gem_exec_schedule (u-lateslice)
[520.488378] Starting subtest: u-lateslice
[520.489288] Starting dynamic subtest: rcs0
[520.537792] Dynamic subtest rcs0: SUCCESS (0.049s)
[520.553214] Starting dynamic subtest: bcs0
[520.562398] Dynamic subtest bcs0: SUCCESS (0.023s)
[520.578056] Starting dynamic subtest: vcs0
[520.584179] Dynamic subtest vcs0: SUCCESS (0.021s)
[520.599163] Starting dynamic subtest: vcs1
[520.606317] Dynamic subtest vcs1: SUCCESS (0.021s)
[520.621728] Starting dynamic subtest: vecs0
[520.630383] Dynamic subtest vecs0: SUCCESS (0.023s)
[520.645601] Starting dynamic subtest: vecs1
[520.652016] Dynamic subtest vecs1: SUCCESS (0.020s)
[520.667301] Starting dynamic subtest: ccs0
[520.675491] Dynamic subtest ccs0: SUCCESS (0.022s)
[520.676422] Subtest u-lateslice: SUCCESS (0.188s)
[521.150826] [109/134] (505s left) gen9_exec_parse (bb-start-far)
[521.237689] Subtest bb-start-far: SKIP (0.000s)
[521.328423] [110/134] (505s left) gem_busy (busy)
[521.420996] Starting subtest: busy
[521.421924] Starting dynamic subtest: all-engines
[521.530408] Dynamic subtest all-engines: SUCCESS (0.109s)
[521.548591] Starting dynamic subtest: rcs0
[521.620131] Dynamic subtest rcs0: SUCCESS (0.088s)
[521.635236] Starting dynamic subtest: bcs0
[521.685324] Dynamic subtest bcs0: SUCCESS (0.063s)
[521.727885] Starting dynamic subtest: vcs0
[521.729176] Dynamic subtest vcs0: SUCCESS (0.040s)
[521.748512] Starting dynamic subtest: vcs1
[521.766444] Dynamic subtest vcs1: SUCCESS (0.038s)
[521.780802] Starting dynamic subtest: vecs0
[521.805436] Dynamic subtest vecs0: SUCCESS (0.038s)
[521.819162] Starting dynamic subtest: vecs1
[521.844553] Dynamic subtest vecs1: SUCCESS (0.038s)
[521.860585] Starting dynamic subtest: ccs0
[521.884447] Dynamic subtest ccs0: SUCCESS (0.039s)
[521.885451] Subtest busy: SUCCESS (0.464s)
[522.358023] [111/134] (504s left) i915_selftest (perf)
[523.536816] Starting subtest: perf
[523.537780] Starting dynamic subtest: engine_cs
[525.305278] Dynamic subtest engine_cs: SUCCESS (1.768s)
[525.315877] Starting dynamic subtest: request
[530.113090] Dynamic subtest request: SUCCESS (4.806s)
[530.125399] Starting dynamic subtest: migrate
[531.955102] Dynamic subtest migrate: SUCCESS (1.840s)
[531.966145] Starting dynamic subtest: region
[560.518184] Dynamic subtest region: SUCCESS (28.561s)
[560.519157] Subtest perf: SUCCESS (36.981s)
[560.550919] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[560.551970] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[560.554073] [112/134] (466s left) core_auth (many-magics)
[562.104011] Starting subtest: many-magics
[563.851074] Subtest many-magics: SUCCESS (1.747s)
[564.252538] [FACT core_auth (many-magics)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[564.255198] [FACT core_auth (many-magics)] new: kernel.kmod_is_loaded.i915: true
[564.258125] [113/134] (462s left) kms_pm_rpm (dpms-non-lpsp)
[565.882824] Starting subtest: dpms-non-lpsp
[566.105293] Subtest dpms-non-lpsp: SUCCESS (0.227s)
[566.413985] [114/134] (460s left) kms_universal_plane (universal-plane-sanity)
[566.611253] Starting subtest: universal-plane-sanity
[566.612127] Starting dynamic subtest: pipe-A-DP-3
[567.227253] Dynamic subtest pipe-A-DP-3: SUCCESS (0.615s)
[567.245647] Starting dynamic subtest: pipe-B-DP-3
[567.709290] Dynamic subtest pipe-B-DP-3: SUCCESS (0.480s)
[567.725116] Starting dynamic subtest: pipe-C-DP-3
[568.194707] Dynamic subtest pipe-C-DP-3: SUCCESS (0.483s)
[568.210894] Starting dynamic subtest: pipe-D-DP-3
[568.685595] Dynamic subtest pipe-D-DP-3: SUCCESS (0.488s)
[568.686538] Subtest universal-plane-sanity: SUCCESS (2.076s)
[568.964896] [115/134] (457s left) kms_flip (flip-vs-suspend)
[569.155339] Starting subtest: flip-vs-suspend
[569.160255] Starting dynamic subtest: A-DP3
[608.917053] Dynamic subtest A-DP3: SUCCESS (7.823s)
[608.930810] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[608.932617] Starting dynamic subtest: B-DP3
[648.133739] Dynamic subtest B-DP3: SUCCESS (7.239s)
[648.135577] Starting dynamic subtest: C-DP3
[687.387600] Dynamic subtest C-DP3: SUCCESS (7.251s)
[687.388494] Starting dynamic subtest: D-DP3
[726.708300] Dynamic subtest D-DP3: SUCCESS (7.516s)
[726.709632] Subtest flip-vs-suspend: SUCCESS (29.842s)
[726.973112] [FACT kms_flip (flip-vs-suspend)] new: kernel.is_tainted.taint_warn: true
[726.974235] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pipe_b_c_ivb
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_busy
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_selftest
results: parsing output: 12/ for test: gem_ctx_exec
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: prime_mmap
results: parsing output: 16/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_capture
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: kms_chamelium_frames
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_madvise
results: parsing output: 46/ for test: kms_writeback
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: gem_exercise_blt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_atomic_transition
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_concurrent
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_pipe_crc_basic
results: parsing output: 81/ for test: gem_fence_thrash
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_busy
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_atomic
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: sriov_basic
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: gem_ctx_isolation
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: gem_busy
results: parsing output: 110/ for test: i915_selftest
results: parsing output: 111/ for test: core_auth
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_universal_plane
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 116/ for test: kms_color
results: no output, setting notrun
results: parsing output: 117/ for test: gem_ctx_engines
results: no output, setting notrun
results: parsing output: 118/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 119/ for test: kms_colorop
results: no output, setting notrun
results: parsing output: 120/ for test: kms_prop_blob
results: no output, setting notrun
results: parsing output: 121/ for test: gem_vm_create
results: no output, setting notrun
results: parsing output: 122/ for test: device_reset
results: no output, setting notrun
results: parsing output: 123/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 127/ for test: kms_hdmi_inject
results: no output, setting notrun
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 129/ for test: kms_color
results: no output, setting notrun
results: parsing output: 130/ for test: kms_setmode
results: no output, setting notrun
results: parsing output: 131/ for test: perf
results: no output, setting notrun
results: parsing output: 132/ for test: kms_chamelium_color
results: no output, setting notrun
results: parsing output: 133/ for test: kms_cursor_edge_walk
results: no output, setting notrun
Done.