[53.381940] Initializing watchdogs
[53.382012]   /dev/watchdog0
[53.397719] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[53.403305] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.405942] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.407712] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512)
[53.508287] Starting subtest: cursor-onscreen-512x512
[53.509664] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[53.618710] [002/133] (960s left) syncobj_timeline (device-signal-unordered)
[53.651960] Starting subtest: device-signal-unordered
[53.653399] Subtest device-signal-unordered: SUCCESS (0.001s)
[53.706398] [003/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[55.115328] Starting subtest: basic-pci-d3-state
[56.442918] Subtest basic-pci-d3-state: SUCCESS (1.343s)
[56.552419] [004/133] (957s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[56.697817] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[56.791881] [005/133] (957s left) kms_flip (2x-busy-flip)
[56.881199] Starting subtest: 2x-busy-flip
[56.889380] Subtest 2x-busy-flip: SKIP (0.009s)
[56.950500] [006/133] (957s left) kms_plane_lowres (tiling-x)
[57.034339] Starting subtest: tiling-x
[57.035049] Starting dynamic subtest: pipe-A-HDMI-A-1
[64.006761] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.019s)
[64.077158] Starting dynamic subtest: pipe-B-HDMI-A-1
[70.892707] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.838s)
[70.974058] Starting dynamic subtest: pipe-C-HDMI-A-1
[77.813680] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.853s)
[77.886076] Starting dynamic subtest: pipe-D-HDMI-A-1
[84.701733] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.822s)
[84.768731] Subtest tiling-x: SUCCESS (27.806s)
[84.929463] [007/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[85.035852] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[85.037245] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[85.130924] [008/133] (929s left) i915_suspend (fence-restore-untiled)
[85.164719] Starting subtest: fence-restore-untiled
[105.422717] Subtest fence-restore-untiled: SUCCESS (5.251s)
[110.535447] [009/133] (908s left) gem_userptr_blits (nohangcheck)
[110.603251] Starting subtest: nohangcheck
[110.774916] Subtest nohangcheck: SUCCESS (0.171s)
[110.886609] [010/133] (908s left) api_intel_allocator (reloc-allocator)
[110.919441] Starting subtest: reloc-allocator
[110.920113] Starting dynamic subtest: basic
[110.922493] Dynamic subtest basic: SUCCESS (0.002s)
[110.929913] Starting dynamic subtest: parallel-one
[110.930623] Dynamic subtest parallel-one: SUCCESS (0.005s)
[110.936635] Starting dynamic subtest: print
[110.937634] Dynamic subtest print: SUCCESS (0.000s)
[110.944128] Starting dynamic subtest: reuse
[110.944835] Dynamic subtest reuse: SUCCESS (0.000s)
[110.950876] Starting dynamic subtest: fork-reopen-allocator
[110.951555] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[110.952217] Subtest reloc-allocator: SUCCESS (0.026s)
[111.036226] [011/133] (908s left) i915_pm_rpm (gem-execbuf)
[112.434956] Starting subtest: gem-execbuf
[112.435939] Starting dynamic subtest: smem0
[116.061886] Dynamic subtest smem0: SUCCESS (3.702s)
[116.065525] Subtest gem-execbuf: SUCCESS (3.705s)
[116.227667] [012/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[116.321329] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[117.584263] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (1.281s)
[117.723007] [013/133] (901s left) vgem_basic (sysfs)
[117.805869] Starting subtest: sysfs
[117.806570] Subtest sysfs: SUCCESS (0.000s)
[117.884089] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[117.885989] [014/133] (901s left) perf (sysctl-defaults)
[117.949752] Starting subtest: sysctl-defaults
[117.950514] Subtest sysctl-defaults: SUCCESS (0.000s)
[118.003042] [015/133] (901s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[118.043316] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[118.044117] Starting dynamic subtest: smem
[118.119748] Dynamic subtest smem: SUCCESS (0.077s)
[118.120500] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.078s)
[118.296402] [016/133] (901s left) kms_hdr (bpc-switch-dpms)
[118.384498] Starting subtest: bpc-switch-dpms
[118.386569] Subtest bpc-switch-dpms: SKIP (0.001s)
[118.440474] [017/133] (901s left) i915_query (query-topology-matches-eu-total)
[118.473284] Starting subtest: query-topology-matches-eu-total
[118.473965] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[118.534880] [018/133] (901s left) perf (blocking-parameterized)
[118.612002] Starting subtest: blocking-parameterized
[138.638355] Subtest blocking-parameterized: SUCCESS (20.105s)
[138.671748] [019/133] (880s left) kms_prop_blob (blob-prop-lifetime)
[138.714260] Starting subtest: blob-prop-lifetime
[138.716749] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[138.794094] [020/133] (880s left) perf_pmu (rc6)
[138.831051] Starting subtest: rc6
[138.831822] Starting dynamic subtest: gt0
[145.169227] Dynamic subtest gt0: SUCCESS (6.339s)
[145.179672] Starting dynamic subtest: runtime-pm-gt0
[152.677286] Dynamic subtest runtime-pm-gt0: SUCCESS (7.495s)
[152.686966] Starting dynamic subtest: runtime-pm-long-gt0
[165.120009] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.441s)
[165.127327] Starting dynamic subtest: other-idle-gt0
[165.128755] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[165.129462] Subtest rc6: SUCCESS (26.283s)
[165.439582] [021/133] (854s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[165.531880] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[165.572398] [022/133] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[165.663809] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[165.665329] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[165.736870] [023/133] (854s left) fbdev (unaligned-read)
[165.774254] Starting subtest: unaligned-read
[165.783014] Subtest unaligned-read: SUCCESS (0.009s)
[165.820523] [024/133] (854s left) gem_ctx_isolation (nonpriv)
[165.861636] Starting subtest: nonpriv
[165.862431] Starting dynamic subtest: rcs0
[166.113553] Dynamic subtest rcs0: SUCCESS (0.242s)
[166.120240] Starting dynamic subtest: bcs0
[166.397501] Dynamic subtest bcs0: SUCCESS (0.283s)
[166.404725] Starting dynamic subtest: vcs0
[166.676571] Dynamic subtest vcs0: SUCCESS (0.278s)
[166.683437] Starting dynamic subtest: vcs1
[166.962080] Dynamic subtest vcs1: SUCCESS (0.284s)
[166.969167] Starting dynamic subtest: vecs0
[167.234349] Dynamic subtest vecs0: SUCCESS (0.271s)
[167.235169] Subtest nonpriv: SUCCESS (1.365s)
[167.392809] [025/133] (852s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[167.488664] Starting subtest: yf-tiled-32bpp-rotate-180
[167.490029] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[167.577389] [026/133] (852s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[167.611944] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[167.637476] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.012s)
[167.669171] [027/133] (852s left) kms_psr (fbc-psr-suspend)
[167.754355] Subtest fbc-psr-suspend: SKIP (0.000s)
[167.796965] [028/133] (852s left) prime_self_import (basic-with_one_bo_two_files)
[167.829739] Starting subtest: basic-with_one_bo_two_files
[167.832295] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[167.897580] [029/133] (852s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[167.986331] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[169.665637] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (1.680s)
[169.761575] [030/133] (850s left) gem_exec_params (invalid-flag)
[169.802446] Starting subtest: invalid-flag
[169.803132] Subtest invalid-flag: SUCCESS (0.000s)
[169.874522] [031/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[169.965394] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[169.966735] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[170.040981] [032/133] (850s left) sw_sync (sync_merge)
[170.074518] Starting subtest: sync_merge
[170.075284] Subtest sync_merge: SUCCESS (0.000s)
[170.109400] [033/133] (850s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[170.143833] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[170.144557] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[170.181205] [034/133] (850s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[170.266589] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[170.479735] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.214s)
[170.614638] [035/133] (849s left) drm_mm (drm_mm)
[170.651083] Starting subtest: drm_mm
[170.658782] Starting dynamic subtest: drm_test_mm_init
[170.727294] Dynamic subtest drm_test_mm_init: SUCCESS (0.064s)
[170.744006] Starting dynamic subtest: drm_test_mm_debug
[170.797007] Dynamic subtest drm_test_mm_debug: SUCCESS (0.069s)
[170.814669] Starting dynamic subtest: drm_test_mm_align32
[170.875115] Dynamic subtest drm_test_mm_align32: SUCCESS (0.075s)
[170.893295] Starting dynamic subtest: drm_test_mm_align64
[170.948420] Dynamic subtest drm_test_mm_align64: SUCCESS (0.069s)
[170.964268] Starting dynamic subtest: drm_test_mm_lowest
[171.019740] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.070s)
[171.038171] Starting dynamic subtest: drm_test_mm_highest
[171.093572] Dynamic subtest drm_test_mm_highest: SUCCESS (0.069s)
[171.094800] Subtest drm_mm: SUCCESS (0.442s)
[171.211453] [036/133] (849s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[171.296302] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[171.305630] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.009s)
[171.352790] [037/133] (848s left) gem_lmem_swapping (random-engines)
[171.390921] Subtest random-engines: SKIP (0.000s)
[171.436927] [038/133] (848s left) kms_content_protection (srm)
[171.550158] Starting subtest: srm
[171.557400] Subtest srm: SKIP (0.005s)
[171.624742] [039/133] (848s left) kms_psr (fbc-psr2-no-drrs)
[171.710398] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[171.750651] [040/133] (848s left) syncobj_wait (multi-wait-for-submit-signaled)
[171.784873] Starting subtest: multi-wait-for-submit-signaled
[171.785569] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[171.830495] [041/133] (848s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[171.916697] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[171.918086] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[171.976639] [042/133] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[172.068889] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[173.352316] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.284s)
[173.456646] [043/133] (847s left) kms_addfb_basic (legacy-format)
[173.490710] Starting subtest: legacy-format
[173.540816] Subtest legacy-format: SUCCESS (0.049s)
[173.670034] [044/133] (846s left) gem_mmap_wc (read)
[173.708914] Starting subtest: read
[173.716860] Subtest read: SUCCESS (0.008s)
[173.787243] [045/133] (846s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[173.873572] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[173.875325] Starting dynamic subtest: pipe-A-valid-mode
[174.850375] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.974s)
[174.851133] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.976s)
[174.983979] [046/133] (845s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[175.090842] Starting subtest: 4-tiled-16bpp-rotate-90
[175.092301] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[175.160284] [047/133] (845s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[175.246719] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[175.248071] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[175.404108] [048/133] (845s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[175.494742] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[175.495460] Starting dynamic subtest: pipe-A-HDMI-A-1
[175.498487] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[175.505765] Starting dynamic subtest: pipe-B-HDMI-A-1
[175.508567] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[175.515655] Starting dynamic subtest: pipe-C-HDMI-A-1
[175.518458] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[175.525535] Starting dynamic subtest: pipe-D-HDMI-A-1
[175.528241] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[175.529617] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[175.722535] [049/133] (845s left) gem_ctx_persistence (hang)
[175.763942] Starting subtest: hang
[175.765732] Subtest hang: SUCCESS (0.002s)
[175.807084] [050/133] (845s left) kms_cursor_crc (cursor-random-128x42)
[175.896723] Starting subtest: cursor-random-128x42
[175.902403] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.097553] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.029s)
[177.104645] Starting dynamic subtest: pipe-D-HDMI-A-1
[178.942082] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.975s)
[178.942820] Subtest cursor-random-128x42: FAIL (3.046s)
[179.057373] [051/133] (841s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[179.097855] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[179.098631] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[179.143212] [052/133] (841s left) kms_psr (psr-suspend)
[179.231784] Subtest psr-suspend: SKIP (0.000s)
[179.273047] [053/133] (841s left) kms_selftest (drm_damage_helper)
[179.307454] Starting subtest: drm_damage_helper
[179.313989] Starting dynamic subtest: drm_test_damage_iter_no_damage
[179.389625] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.074s)
[179.405201] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[179.463368] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.069s)
[179.481724] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[179.526090] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.059s)
[179.544124] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[179.608347] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.079s)
[179.626797] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[179.682472] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.071s)
[179.700767] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[179.751360] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.066s)
[179.769750] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[179.823525] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.068s)
[179.841351] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[179.891407] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.065s)
[179.909360] Starting dynamic subtest: drm_test_damage_iter_single_damage
[179.963438] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.069s)
[179.981574] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[180.040422] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.074s)
[180.058916] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[180.117677] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.074s)
[180.135793] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[180.184313] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.064s)
[180.202315] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[180.252362] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.065s)
[180.270210] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[180.321102] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.065s)
[180.338867] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[180.391282] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.067s)
[180.409487] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[180.465671] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.071s)
[180.483551] Starting dynamic subtest: drm_test_damage_iter_damage
[180.536672] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.068s)
[180.554323] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[180.602426] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.063s)
[180.620550] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[180.673510] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.068s)
[180.691699] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[180.743411] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.066s)
[180.761660] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[180.814379] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.068s)
[180.815620] Subtest drm_damage_helper: SUCCESS (1.509s)
[180.943576] [054/133] (840s left) gem_exec_balancer (parallel-ordering)
[181.104953] Subtest parallel-ordering: SKIP (0.000s)
[181.161433] [055/133] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[181.252419] Starting subtest: fbcpsr-rgb565-draw-pwrite
[181.253773] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[181.321491] [056/133] (839s left) gem_mmap_offset (oob-read)
[181.355411] Starting subtest: oob-read
[181.356093] Subtest oob-read: SUCCESS (0.000s)
[181.428387] [057/133] (839s left) perf_pmu (busy-idle)
[181.464465] Starting subtest: busy-idle
[181.465193] Starting dynamic subtest: rcs0
[182.103840] Dynamic subtest rcs0: SUCCESS (0.639s)
[182.116414] Starting dynamic subtest: bcs0
[182.751573] Dynamic subtest bcs0: SUCCESS (0.644s)
[182.761349] Starting dynamic subtest: vcs0
[183.401810] Dynamic subtest vcs0: SUCCESS (0.650s)
[183.413884] Starting dynamic subtest: vcs1
[184.046527] Dynamic subtest vcs1: SUCCESS (0.641s)
[184.062530] Starting dynamic subtest: vecs0
[184.681193] Dynamic subtest vecs0: SUCCESS (0.634s)
[184.684571] Subtest busy-idle: SUCCESS (3.219s)
[184.733196] [058/133] (836s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[184.824441] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[184.825828] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[184.897824] [059/133] (836s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[184.981614] Starting subtest: read-crc-frame-sequence
[184.983389] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.306089] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.322s)
[185.315023] Starting dynamic subtest: pipe-B-HDMI-A-1
[185.605141] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.298s)
[185.614220] Starting dynamic subtest: pipe-C-HDMI-A-1
[185.892815] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.284s)
[185.899971] Starting dynamic subtest: pipe-D-HDMI-A-1
[186.175983] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.282s)
[186.176687] Subtest read-crc-frame-sequence: SUCCESS (1.195s)
[186.269699] [060/133] (834s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[186.362394] Starting subtest: cursorA-vs-flipA-atomic
[197.215178] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.857s)
[197.357661] [061/133] (823s left) kms_chamelium_color (ctm-limited-range)
[197.450354] Subtest ctm-limited-range: SKIP (0.000s)
[197.501408] [062/133] (823s left) kms_flip (2x-modeset-vs-vblank-race)
[197.585336] Starting subtest: 2x-modeset-vs-vblank-race
[197.594848] Subtest 2x-modeset-vs-vblank-race: SKIP (0.009s)
[197.642974] [063/133] (823s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[197.729655] Starting subtest: bad-aux-stride-y-tiled-ccs
[197.730444] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.737280] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[197.744569] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.751502] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[197.760469] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.767314] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[197.775807] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.782739] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[197.784117] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[197.961494] [064/133] (823s left) gem_eio (in-flight-external)
[198.005989] Starting subtest: in-flight-external
[198.261665] Subtest in-flight-external: SUCCESS (0.255s)
[198.369188] [065/133] (823s left) kms_rotation_crc (sprite-rotation-180)
[198.453667] Starting subtest: sprite-rotation-180
[201.925102] Subtest sprite-rotation-180: SUCCESS (3.472s)
[202.086524] [066/133] (819s left) syncobj_timeline (wait-delayed-signal)
[202.122108] Starting subtest: wait-delayed-signal
[202.224310] Subtest wait-delayed-signal: SUCCESS (0.102s)
[202.289040] [067/133] (819s left) kms_flip (2x-flip-vs-dpms-on-nop)
[202.377695] Starting subtest: 2x-flip-vs-dpms-on-nop
[202.386149] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[202.433182] [068/133] (819s left) kms_vrr (flip-dpms)
[202.519063] Starting subtest: flip-dpms
[202.521235] Subtest flip-dpms: SKIP (0.000s)
[202.566927] [069/133] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[202.655540] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[202.656894] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[202.731813] [070/133] (818s left) gem_exec_schedule (preempt-self)
[202.776631] Starting subtest: preempt-self
[202.777415] Starting dynamic subtest: rcs0
[202.790508] Dynamic subtest rcs0: SUCCESS (0.013s)
[202.802328] Starting dynamic subtest: bcs0
[202.808063] Dynamic subtest bcs0: SUCCESS (0.016s)
[202.819687] Starting dynamic subtest: vcs0
[202.825139] Dynamic subtest vcs0: SUCCESS (0.016s)
[202.837219] Starting dynamic subtest: vcs1
[202.842317] Dynamic subtest vcs1: SUCCESS (0.015s)
[202.851924] Starting dynamic subtest: vecs0
[202.856873] Dynamic subtest vecs0: SUCCESS (0.013s)
[202.857618] Subtest preempt-self: SUCCESS (0.081s)
[203.147792] [071/133] (818s left) kms_cursor_legacy (forked-move)
[203.233644] Starting subtest: forked-move
[203.234360] Starting dynamic subtest: pipe-A
[208.686810] Dynamic subtest pipe-A: SUCCESS (5.418s)
[208.696453] Starting dynamic subtest: pipe-B
[214.119926] Dynamic subtest pipe-B: SUCCESS (5.429s)
[214.130578] Starting dynamic subtest: pipe-C
[219.546752] Dynamic subtest pipe-C: SUCCESS (5.424s)
[219.558230] Starting dynamic subtest: pipe-D
[224.968784] Dynamic subtest pipe-D: SUCCESS (5.420s)
[224.978751] Starting dynamic subtest: all-pipes
[230.427622] Dynamic subtest all-pipes: SUCCESS (5.456s)
[230.428574] Subtest forked-move: SUCCESS (27.155s)
[230.471676] [072/133] (791s left) prime_vgem (basic-fence-mmap)
[230.511864] Starting subtest: basic-fence-mmap
[230.535841] Subtest basic-fence-mmap: SUCCESS (0.024s)
[230.630965] [073/133] (791s left) gem_ctx_shared (detached-shared-gtt)
[230.673380] Starting subtest: detached-shared-gtt
[232.831159] Subtest detached-shared-gtt: SUCCESS (2.149s)
[232.984697] [074/133] (788s left) gem_create (create-ext-placement-each)
[233.132753] Starting subtest: create-ext-placement-each
[233.133946] Subtest create-ext-placement-each: SUCCESS (0.000s)
[233.224941] [075/133] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[233.319157] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[233.320529] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[233.388852] [076/133] (788s left) kms_draw_crc (draw-method-mmap-gtt)
[233.477577] Starting subtest: draw-method-mmap-gtt
[233.478297] Starting dynamic subtest: xrgb8888-untiled
[233.631906] Dynamic subtest xrgb8888-untiled: SUCCESS (0.155s)
[233.650447] Starting dynamic subtest: rgb565-untiled
[233.798418] Dynamic subtest rgb565-untiled: SUCCESS (0.164s)
[233.816994] Starting dynamic subtest: xrgb2101010-untiled
[233.948500] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.148s)
[233.969228] Starting dynamic subtest: xbgr16161616f-untiled
[234.098439] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.146s)
[234.119308] Starting dynamic subtest: xrgb8888-xtiled
[234.181714] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.080s)
[234.198058] Starting dynamic subtest: rgb565-xtiled
[234.265239] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[234.285927] Starting dynamic subtest: xrgb2101010-xtiled
[234.340049] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.071s)
[234.355511] Starting dynamic subtest: xbgr16161616f-xtiled
[234.415227] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.072s)
[234.436990] Starting dynamic subtest: xrgb8888-ytiled
[234.506823] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.088s)
[234.523010] Starting dynamic subtest: rgb565-ytiled
[234.590288] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[234.611770] Starting dynamic subtest: xrgb2101010-ytiled
[234.673569] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.080s)
[234.690353] Starting dynamic subtest: xbgr16161616f-ytiled
[234.781768] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.105s)
[234.786137] Subtest draw-method-mmap-gtt: SUCCESS (1.307s)
[234.852445] [077/133] (787s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[234.943545] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[234.944413] Starting dynamic subtest: pipe-A
[235.066626] Dynamic subtest pipe-A: SUCCESS (0.124s)
[235.078736] Starting dynamic subtest: pipe-B
[235.209569] Dynamic subtest pipe-B: SUCCESS (0.142s)
[235.220952] Starting dynamic subtest: pipe-C
[235.352902] Dynamic subtest pipe-C: SUCCESS (0.142s)
[235.369671] Starting dynamic subtest: pipe-D
[235.486207] Dynamic subtest pipe-D: SUCCESS (0.132s)
[235.486903] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.544s)
[235.650470] [078/133] (786s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[235.749491] Starting subtest: y-tiled-16bpp-rotate-270
[236.794961] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.046s)
[236.891098] [079/133] (785s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[236.931798] Starting subtest: x-tiled-to-vebox-y-tiled
[236.932567] Starting dynamic subtest: smem
[237.029271] Dynamic subtest smem: SUCCESS (0.097s)
[237.030024] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[237.193867] [080/133] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[237.287075] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[237.288521] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[237.354838] [081/133] (784s left) kms_plane (plane-position-hole)
[237.443760] Starting subtest: plane-position-hole
[237.654773] Starting dynamic subtest: pipe-A-plane-1
[237.907188] Dynamic subtest pipe-A-plane-1: SUCCESS (0.251s)
[237.917233] Starting dynamic subtest: pipe-A-plane-2
[238.137064] Dynamic subtest pipe-A-plane-2: SUCCESS (0.229s)
[238.146684] Starting dynamic subtest: pipe-A-plane-3
[238.369392] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[238.380709] Starting dynamic subtest: pipe-A-plane-4
[238.619065] Dynamic subtest pipe-A-plane-4: SUCCESS (0.247s)
[238.626863] Starting dynamic subtest: pipe-A-plane-5
[238.857600] Dynamic subtest pipe-A-plane-5: SUCCESS (0.238s)
[238.868079] Starting dynamic subtest: pipe-A-plane-6
[239.093058] Dynamic subtest pipe-A-plane-6: SUCCESS (0.233s)
[239.103410] Starting dynamic subtest: pipe-A-plane-7
[239.104866] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[239.278572] Starting dynamic subtest: pipe-B-plane-1
[239.479439] Dynamic subtest pipe-B-plane-1: SUCCESS (0.211s)
[239.488132] Starting dynamic subtest: pipe-B-plane-2
[239.712153] Dynamic subtest pipe-B-plane-2: SUCCESS (0.232s)
[239.721190] Starting dynamic subtest: pipe-B-plane-3
[239.982439] Dynamic subtest pipe-B-plane-3: SUCCESS (0.268s)
[239.991264] Starting dynamic subtest: pipe-B-plane-4
[240.208255] Dynamic subtest pipe-B-plane-4: SUCCESS (0.225s)
[240.216557] Starting dynamic subtest: pipe-B-plane-5
[240.424397] Dynamic subtest pipe-B-plane-5: SUCCESS (0.216s)
[240.432463] Starting dynamic subtest: pipe-B-plane-6
[240.634291] Dynamic subtest pipe-B-plane-6: SUCCESS (0.208s)
[240.643183] Starting dynamic subtest: pipe-B-plane-7
[240.644571] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[240.645335] Subtest plane-position-hole: SUCCESS (3.194s)
[240.783443] [082/133] (781s left) gem_exec_flush (basic-uc-ro-default)
[240.832492] Starting subtest: basic-uc-ro-default
[246.257287] Subtest basic-uc-ro-default: SUCCESS (5.425s)
[246.450258] [083/133] (775s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[246.544803] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[246.546225] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[246.607825] [084/133] (775s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[246.641866] Starting subtest: single-wait-all-for-submit-available-signaled
[246.642641] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[246.682881] [085/133] (775s left) gem_exec_fence (submit3)
[246.851315] Starting subtest: submit3
[246.852150] Starting dynamic subtest: rcs0
[246.857421] Dynamic subtest rcs0: SUCCESS (0.006s)
[246.867079] Starting dynamic subtest: bcs0
[246.867770] Dynamic subtest bcs0: SUCCESS (0.004s)
[246.876176] Starting dynamic subtest: vcs0
[246.876881] Dynamic subtest vcs0: SUCCESS (0.004s)
[246.884897] Starting dynamic subtest: vcs1
[246.885584] Dynamic subtest vcs1: SUCCESS (0.005s)
[246.893335] Starting dynamic subtest: vecs0
[246.894012] Dynamic subtest vecs0: SUCCESS (0.005s)
[246.894684] Subtest submit3: SUCCESS (0.031s)
[247.341422] [086/133] (775s left) kms_busy (basic)
[247.430595] Starting subtest: basic
[247.432373] Starting dynamic subtest: flip
[247.774193] Dynamic subtest flip: SUCCESS (0.342s)
[247.785674] Starting dynamic subtest: modeset
[248.345437] Dynamic subtest modeset: SUCCESS (0.569s)
[248.346143] Subtest basic: SUCCESS (0.915s)
[248.455586] [087/133] (773s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[248.559345] Starting subtest: crc-primary-basic-y-tiled-ccs
[248.561725] Starting dynamic subtest: pipe-A-HDMI-A-1
[248.568685] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[248.576539] Starting dynamic subtest: pipe-B-HDMI-A-1
[248.582949] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[248.590578] Starting dynamic subtest: pipe-C-HDMI-A-1
[248.596971] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[248.604493] Starting dynamic subtest: pipe-D-HDMI-A-1
[248.611035] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[248.612330] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.010s)
[248.781738] [088/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[248.874440] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[248.875848] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[248.950283] [089/133] (773s left) gem_softpin (evict-single-offset)
[248.987022] Starting subtest: evict-single-offset
[273.842798] Subtest evict-single-offset: SUCCESS (24.859s)
[273.892940] [090/133] (748s left) gem_sync (basic-each)
[273.986971] Starting subtest: basic-each
[276.088361] Subtest basic-each: SUCCESS (2.102s)
[276.277670] [091/133] (746s left) gem_ctx_param (invalid-param-set)
[276.312308] Starting subtest: invalid-param-set
[276.313059] Subtest invalid-param-set: SUCCESS (0.000s)
[276.355946] [092/133] (746s left) kms_color (ctm-0-25)
[276.448534] Starting subtest: ctm-0-25
[276.449224] Starting dynamic subtest: pipe-A-HDMI-A-1
[277.295875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.847s)
[277.306487] Starting dynamic subtest: pipe-B-HDMI-A-1
[278.094887] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.791s)
[278.105797] Starting dynamic subtest: pipe-C-HDMI-A-1
[278.864725] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.776s)
[278.873705] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.656567] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.790s)
[279.657362] Subtest ctm-0-25: SUCCESS (3.209s)
[279.773542] [093/133] (742s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[279.884259] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[279.923537] [094/133] (742s left) syncobj_timeline (invalid-transfer-illegal-handle)
[279.965150] Starting subtest: invalid-transfer-illegal-handle
[279.965949] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[280.011858] [095/133] (742s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[280.049549] Starting subtest: invalid-bsd1-flag-on-blt
[280.050289] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[280.114459] [096/133] (742s left) kms_async_flips (test-cursor-atomic)
[280.201124] Starting subtest: test-cursor-atomic
[280.324499] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.413972] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.091s)
[280.559858] Starting dynamic subtest: pipe-B-HDMI-A-1
[280.621088] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.074s)
[280.736611] Starting dynamic subtest: pipe-C-HDMI-A-1
[280.803413] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.077s)
[280.919986] Starting dynamic subtest: pipe-D-HDMI-A-1
[280.984806] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.073s)
[280.987156] Subtest test-cursor-atomic: SUCCESS (0.785s)
[281.233235] [097/133] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[281.331113] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[281.332668] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[281.400788] [098/133] (741s left) gem_eio (in-flight-internal-1us)
[281.442677] Starting subtest: in-flight-internal-1us
[282.874397] Subtest in-flight-internal-1us: SUCCESS (1.431s)
[282.975407] [099/133] (739s left) gem_lmem_swapping (heavy-multi)
[283.013501] Subtest heavy-multi: SKIP (0.000s)
[283.056063] [100/133] (739s left) kms_psr (psr2-cursor-plane-onoff)
[283.142521] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[283.182096] [101/133] (739s left) kms_frontbuffer_tracking (fbc-stridechange)
[283.274978] Starting subtest: fbc-stridechange
[284.283191] Subtest fbc-stridechange: SUCCESS (1.008s)
[284.388478] [102/133] (738s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[284.480039] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[284.523378] [103/133] (738s left) i915_fb_tiling (basic-x-tiling)
[284.556967] Starting subtest: basic-x-tiling
[284.557684] Subtest basic-x-tiling: SUCCESS (0.000s)
[284.623465] [104/133] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[284.714236] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[284.715725] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[284.794007] [105/133] (738s left) gem_exec_schedule (preemptive-hang)
[284.953237] Starting subtest: preemptive-hang
[284.954499] Starting dynamic subtest: rcs0
[291.055916] Dynamic subtest rcs0: SUCCESS (6.078s)
[291.064552] Starting dynamic subtest: bcs0
[297.046904] Dynamic subtest bcs0: SUCCESS (6.015s)
[297.057924] Starting dynamic subtest: vcs0
[303.023785] Dynamic subtest vcs0: SUCCESS (5.952s)
[303.032048] Starting dynamic subtest: vcs1
[309.039976] Dynamic subtest vcs1: SUCCESS (6.015s)
[309.048001] Starting dynamic subtest: vecs0
[315.049346] Dynamic subtest vecs0: SUCCESS (6.007s)
[315.050334] Subtest preemptive-hang: SUCCESS (30.077s)
[315.189090] [106/133] (707s left) kms_prime (basic-modeset-hybrid)
[315.289891] Subtest basic-modeset-hybrid: SKIP (0.000s)
[315.331344] [107/133] (707s left) gem_exec_whisper (basic-forked-all)
[315.375109] Starting subtest: basic-forked-all
[317.880349] Subtest basic-forked-all: SUCCESS (2.505s)
[318.065225] [108/133] (705s left) gem_basic (create-close)
[318.098450] Starting subtest: create-close
[318.100935] Subtest create-close: SUCCESS (0.000s)
[318.172818] [109/133] (705s left) api_intel_bb (misplaced-blitter)
[318.206590] Starting subtest: misplaced-blitter
[318.211671] Subtest misplaced-blitter: SUCCESS (0.005s)
[318.304269] [110/133] (705s left) gen9_exec_parse (bb-start-cmd)
[318.345693] Subtest bb-start-cmd: SKIP (0.000s)
[318.387792] [111/133] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[318.480081] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[319.679663] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.200s)
[319.796136] [112/133] (703s left) gem_eio (in-flight-contexts-10ms)
[319.840259] Starting subtest: in-flight-contexts-10ms
[333.886638] Subtest in-flight-contexts-10ms: SUCCESS (14.050s)
[333.989546] [113/133] (689s left) i915_drm_fdinfo (isolation)
[334.030784] Starting subtest: isolation
[334.031561] Starting dynamic subtest: rcs0
[334.553028] Dynamic subtest rcs0: SUCCESS (0.522s)
[334.567232] Starting dynamic subtest: bcs0
[335.079182] Dynamic subtest bcs0: SUCCESS (0.523s)
[335.093515] Starting dynamic subtest: vcs0
[335.607794] Dynamic subtest vcs0: SUCCESS (0.525s)
[335.619841] Starting dynamic subtest: vcs1
[336.132076] Dynamic subtest vcs1: SUCCESS (0.521s)
[336.146594] Starting dynamic subtest: vecs0
[336.660014] Dynamic subtest vecs0: SUCCESS (0.525s)
[336.663456] Subtest isolation: SUCCESS (2.631s)
[336.723331] [114/133] (686s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[336.757732] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[336.758444] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[336.796725] [115/133] (686s left) kms_legacy_colorkey (invalid-plane)
[336.886564] Starting subtest: invalid-plane
[336.887289] Starting dynamic subtest: zero-id
[336.887988] Dynamic subtest zero-id: SUCCESS (0.000s)
[336.896655] Starting dynamic subtest: outrange-id
[336.897360] Dynamic subtest outrange-id: SUCCESS (0.000s)
[336.898048] Subtest invalid-plane: SUCCESS (0.002s)
[336.932189] [116/133] (686s left) kms_invalid_mode (clock-too-high)
[337.020287] Starting subtest: clock-too-high
[337.020982] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.084383] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.063s)
[337.095583] Starting dynamic subtest: pipe-B-HDMI-A-1
[337.099463] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.011s)
[337.109844] Starting dynamic subtest: pipe-C-HDMI-A-1
[337.110636] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[337.123871] Starting dynamic subtest: pipe-D-HDMI-A-1
[337.124576] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[337.125279] Subtest clock-too-high: SUCCESS (0.101s)
[337.251298] [117/133] (686s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[337.354031] Starting subtest: x-tiled-8bpp-rotate-0
[338.325622] Subtest x-tiled-8bpp-rotate-0: SUCCESS (0.971s)
[338.437100] [118/133] (685s left) kms_frontbuffer_tracking (psr-slowdraw)
[338.532420] Starting subtest: psr-slowdraw
[338.533882] Subtest psr-slowdraw: SKIP (0.000s)
[338.597670] [119/133] (685s left) gem_exec_balancer (hang)
[338.757215] Starting subtest: hang
[340.039563] Subtest hang: SUCCESS (1.291s)
[340.087535] [120/133] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[340.180058] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[340.181440] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[340.261916] [121/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[340.351357] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[340.352713] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[340.424691] [122/133] (683s left) gem_mmap_wc (bad-object)
[340.457795] Starting subtest: bad-object
[340.458509] Subtest bad-object: SUCCESS (0.000s)
[340.542842] [123/133] (683s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[340.640446] Starting subtest: yf-tiled-64bpp-rotate-180
[340.641923] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[340.711510] [124/133] (683s left) gem_busy (close-race)
[340.755153] Starting subtest: close-race
[362.577936] Subtest close-race: SUCCESS (21.817s)
[362.924906] [125/133] (661s left) drm_read (empty-nonblock)
[363.110916] Starting subtest: empty-nonblock
[363.111665] Subtest empty-nonblock: SUCCESS (0.000s)
[363.202601] [126/133] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[363.294934] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[363.296355] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[363.361515] [127/133] (660s left) kms_cursor_edge_walk (256x256-left-edge)
[363.451072] Starting subtest: 256x256-left-edge
[363.453295] Starting dynamic subtest: pipe-A-HDMI-A-1
[365.200866] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.748s)
[365.212345] Starting dynamic subtest: pipe-D-HDMI-A-1
[366.896739] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.691s)
[366.897527] Subtest 256x256-left-edge: SUCCESS (3.445s)
[366.987344] [128/133] (657s left) gem_exec_schedule (fifo)
[367.042733] Starting subtest: fifo
[367.043452] Starting dynamic subtest: rcs0
[367.100665] Dynamic subtest rcs0: SUCCESS (0.057s)
[367.115048] Starting dynamic subtest: bcs0
[367.165810] Dynamic subtest bcs0: SUCCESS (0.063s)
[367.181061] Starting dynamic subtest: vcs0
[367.228868] Dynamic subtest vcs0: SUCCESS (0.060s)
[367.243039] Starting dynamic subtest: vcs1
[367.291071] Dynamic subtest vcs1: SUCCESS (0.060s)
[367.303475] Starting dynamic subtest: vecs0
[367.353921] Dynamic subtest vecs0: SUCCESS (0.061s)
[367.357176] Subtest fifo: SUCCESS (0.313s)
[367.651547] [129/133] (656s left) kms_fbcon_fbt (psr)
[367.686647] Starting subtest: psr
[367.688087] Subtest psr: SKIP (0.000s)
[367.731955] [130/133] (656s left) kms_chamelium_frames (hdmi-aspect-ratio)
[367.875460] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[367.969487] [131/133] (656s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[368.063946] Starting subtest: 2x-long-cursor-vs-flip-legacy
[368.066649] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[368.110461] [132/133] (656s left) kms_big_fb (linear-64bpp-rotate-270)
[368.209644] Starting subtest: linear-64bpp-rotate-270
[368.258393] Subtest linear-64bpp-rotate-270: SKIP (0.047s)
[368.362870] [133/133] (655s left) testdisplay
[381.763265] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_plane_lowres
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: fbdev
results: parsing output: 23/ for test: gem_ctx_isolation
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: sriov_basic
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: drm_mm
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_selftest
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_pipe_crc_basic
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_draw_crc
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_exec_flush
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: i915_fb_tiling
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_prime
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: gem_basic
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_legacy_colorkey
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_busy
results: parsing output: 124/ for test: drm_read
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: testdisplay
Done.