[60.708394] Initializing watchdogs
[60.708525]   /dev/watchdog0
[60.725352] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.730200] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.732605] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.736349] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[60.868294] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[60.872328] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[60.971291] [002/155] (960s left) gem_exec_fence (submit)
[61.143347] Starting subtest: submit
[61.148379] Subtest submit: SKIP (0.000s)
[63.371389] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[63.374580] [003/155] (957s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[63.475450] Starting subtest: psr2-cursor-plane-update-sf
[63.477884] Starting dynamic subtest: pipe-A-eDP-1
[64.087781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[64.096604] Starting dynamic subtest: pipe-B-eDP-1
[65.349399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.254s)
[65.351860] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.871s)
[66.226235] [004/155] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[66.341309] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[66.345588] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[66.447944] [005/155] (954s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[66.555645] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[66.557807] Starting dynamic subtest: pipe-A-eDP-1
[66.580250] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.589601] Starting dynamic subtest: pipe-B-eDP-1
[66.610990] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.619528] Starting dynamic subtest: pipe-C-eDP-1
[66.642082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.649809] Starting dynamic subtest: pipe-D-eDP-1
[66.671560] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.676051] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[68.886115] [006/155] (952s left) gem_exec_params (invalid-bsd-ring)
[68.943482] Starting subtest: invalid-bsd-ring
[68.945433] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[69.055917] [007/155] (952s left) kms_feature_discovery (dp-mst)
[69.149076] Starting subtest: dp-mst
[69.153610] Subtest dp-mst: SKIP (0.000s)
[69.230604] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[69.324320] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[69.328701] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[69.421947] [009/155] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[69.530582] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[69.534569] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[69.626603] [010/155] (951s left) gem_mmap_wc (bad-object)
[69.682283] Subtest bad-object: SKIP (0.000s)
[69.738981] [011/155] (951s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[69.794511] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[69.863435] [012/155] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[69.957067] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[77.516287] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.552s)
[77.631541] [013/155] (944s left) gem_exec_schedule (wide)
[77.810644] Starting subtest: wide
[77.813247] Starting dynamic subtest: rcs0
[88.060189] Dynamic subtest rcs0: SUCCESS (10.192s)
[88.069180] Starting dynamic subtest: vcs0
[98.929769] Dynamic subtest vcs0: SUCCESS (10.917s)
[98.943057] Starting dynamic subtest: vcs1
[108.616147] Dynamic subtest vcs1: SUCCESS (9.684s)
[108.627331] Starting dynamic subtest: vecs0
[120.428689] Dynamic subtest vecs0: SUCCESS (11.811s)
[120.438677] Starting dynamic subtest: ccs0
[134.369826] Dynamic subtest ccs0: SUCCESS (13.889s)
[134.372065] Subtest wide: SUCCESS (56.497s)
[135.558263] [014/155] (886s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[135.668102] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[135.672219] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[135.759721] [015/155] (886s left) gem_vm_create (invalid-create)
[135.818332] Starting subtest: invalid-create
[135.820771] Subtest invalid-create: SUCCESS (0.002s)
[135.954191] [016/155] (885s left) kms_plane_cursor (primary)
[136.044061] Starting subtest: primary
[136.048706] Starting dynamic subtest: pipe-A-eDP-1-size-64
[138.613062] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.568s)
[138.637699] Starting dynamic subtest: pipe-A-eDP-1-size-128
[141.239257] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.606s)
[141.260385] Starting dynamic subtest: pipe-A-eDP-1-size-256
[143.872130] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.617s)
[144.193682] Starting dynamic subtest: pipe-B-eDP-1-size-64
[147.450018] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.268s)
[147.474402] Starting dynamic subtest: pipe-B-eDP-1-size-128
[150.051137] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[150.074604] Starting dynamic subtest: pipe-B-eDP-1-size-256
[152.652951] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[152.975188] Starting dynamic subtest: pipe-C-eDP-1-size-64
[155.921317] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.956s)
[155.947884] Starting dynamic subtest: pipe-C-eDP-1-size-128
[158.176786] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[158.202035] Starting dynamic subtest: pipe-C-eDP-1-size-256
[160.365136] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.170s)
[160.684769] Starting dynamic subtest: pipe-D-eDP-1-size-64
[163.691225] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.017s)
[163.717466] Starting dynamic subtest: pipe-D-eDP-1-size-128
[165.913201] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[165.940496] Starting dynamic subtest: pipe-D-eDP-1-size-256
[168.091162] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[168.401217] Subtest primary: SUCCESS (32.355s)
[169.294446] [017/155] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[169.391359] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[169.395839] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[169.483560] [018/155] (852s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[169.578484] Starting subtest: fbc-rgb565-draw-mmap-wc
[173.629655] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.057s)
[174.814251] [019/155] (847s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[174.924897] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[174.929279] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[175.015425] [020/155] (846s left) i915_hangman (error-state-basic)
[175.079215] Starting subtest: error-state-basic
[175.240974] Subtest error-state-basic: SUCCESS (0.161s)
[175.316887] [021/155] (846s left) kms_cursor_edge_walk (256x256-top-edge)
[175.414744] Starting subtest: 256x256-top-edge
[175.417010] Starting dynamic subtest: pipe-A-eDP-1
[178.855251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[178.865070] Starting dynamic subtest: pipe-D-eDP-1
[181.998729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s)
[182.001237] Subtest 256x256-top-edge: SUCCESS (6.585s)
[182.810780] [022/155] (839s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[182.905327] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[182.914411] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[183.029290] [023/155] (839s left) kms_big_fb (linear-8bpp-rotate-90)
[183.138042] Starting subtest: linear-8bpp-rotate-90
[183.159150] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[183.286388] [024/155] (838s left) drm_buddy (drm_buddy)
[183.327436] Starting subtest: drm_buddy
[183.331760] Subtest drm_buddy: SKIP (0.001s)
[183.391602] [025/155] (838s left) kms_pm_rpm (modeset-lpsp)
[185.436370] Starting subtest: modeset-lpsp
[186.910346] Subtest modeset-lpsp: SUCCESS (1.472s)
[187.020666] [026/155] (835s left) kms_lease (lease-unleased-connector)
[187.118640] Starting subtest: lease-unleased-connector
[187.120777] Starting dynamic subtest: pipe-A-eDP-1
[187.122999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[187.132732] Starting dynamic subtest: pipe-B-eDP-1
[187.134940] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[187.144299] Starting dynamic subtest: pipe-C-eDP-1
[187.146703] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[187.155553] Starting dynamic subtest: pipe-D-eDP-1
[187.157438] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[187.159232] Subtest lease-unleased-connector: SUCCESS (0.030s)
[187.253424] [027/155] (835s left) kms_psr (fbc-psr-primary-blt)
[187.341325] Starting subtest: fbc-psr-primary-blt
[187.343651] Starting dynamic subtest: eDP-1
[187.348261] Dynamic subtest eDP-1: SKIP (0.000s)
[187.352843] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[187.412844] [028/155] (834s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[187.508845] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[187.512971] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[187.614263] [029/155] (834s left) gem_exec_fence (concurrent)
[187.784869] Starting subtest: concurrent
[187.789349] Subtest concurrent: SKIP (0.000s)
[189.383650] [030/155] (833s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[189.476601] Starting subtest: fbcpsr-rgb565-draw-blt
[196.636280] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.164s)
[196.776334] [031/155] (825s left) gem_pwrite_snooped
[196.911444] [032/155] (825s left) prime_self_import (reimport-vs-gem_close-race)
[196.947423] Starting subtest: reimport-vs-gem_close-race
[202.064112] Subtest reimport-vs-gem_close-race: SUCCESS (5.102s)
[202.128290] [033/155] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[202.234248] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[202.238665] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[202.328258] [034/155] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[202.438019] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[209.283169] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.851s)
[209.441410] [035/155] (813s left) api_intel_allocator (execbuf-with-allocator)
[209.498078] Starting subtest: execbuf-with-allocator
[209.504647] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[209.625384] [036/155] (813s left) gem_partial_pwrite_pread (writes-after-reads)
[209.684194] Subtest writes-after-reads: SKIP (0.000s)
[209.761643] [037/155] (812s left) gem_tiled_swapping (non-threaded)
[209.817361] Subtest non-threaded: SKIP (0.000s)
[209.872078] [038/155] (812s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[209.971688] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[209.976674] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[210.068432] [039/155] (812s left) gem_ctx_isolation (preservation-s3)
[210.144965] Starting subtest: preservation-S3
[210.147294] Starting dynamic subtest: rcs0
[225.807817] Dynamic subtest rcs0: SUCCESS (1.411s)
[225.819551] Starting dynamic subtest: bcs0
[241.778405] Dynamic subtest bcs0: SUCCESS (1.295s)
[241.789386] Starting dynamic subtest: vcs0
[257.810917] Dynamic subtest vcs0: SUCCESS (2.451s)
[257.822859] Starting dynamic subtest: vcs1
[275.794853] Dynamic subtest vcs1: SUCCESS (4.917s)
[275.809244] Starting dynamic subtest: vecs0
[293.791029] Dynamic subtest vecs0: SUCCESS (4.959s)
[293.801463] Starting dynamic subtest: ccs0
[311.801970] Dynamic subtest ccs0: SUCCESS (3.154s)
[311.804365] Subtest preservation-S3: SUCCESS (18.194s)
[312.025124] [040/155] (710s left) gem_create (create-valid-nonaligned)
[312.087168] Starting subtest: create-valid-nonaligned
[312.089148] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[312.292919] [041/155] (710s left) gem_create (create-clear)
[312.342699] Starting subtest: create-clear
[312.344745] Starting dynamic subtest: smem0
[345.221284] Dynamic subtest smem0: SUCCESS (32.711s)
[345.223254] Subtest create-clear: SUCCESS (32.712s)
[345.408306] [042/155] (677s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[345.534093] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[345.538766] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[345.678334] [043/155] (677s left) kms_flip (2x-busy-flip)
[345.760674] Starting subtest: 2x-busy-flip
[345.772308] Subtest 2x-busy-flip: SKIP (0.011s)
[345.892570] [044/155] (677s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[345.988180] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[345.992702] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[346.081951] [045/155] (677s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[346.212042] Starting subtest: cursorA-vs-flipA-atomic
[357.334994] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s)
[358.148031] [046/155] (664s left) gem_userptr_blits (dmabuf-unsync)
[358.218099] Subtest dmabuf-unsync: SKIP (0.000s)
[358.348227] [047/155] (664s left) gem_eio (wait-1us)
[358.572058] Starting subtest: wait-1us
[358.924221] Subtest wait-1us: SUCCESS (0.352s)
[359.060380] [048/155] (664s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[359.149082] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[359.152465] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[359.262040] [049/155] (664s left) perf (disabled-read-error)
[359.392254] Starting subtest: disabled-read-error
[359.405451] Subtest disabled-read-error: SUCCESS (0.015s)
[359.445663] [050/155] (663s left) gem_exec_whisper (basic-queues-priority)
[359.505753] Starting subtest: basic-queues-priority
[382.489055] Subtest basic-queues-priority: SUCCESS (22.973s)
[382.673120] [051/155] (640s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[382.772797] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[382.775068] Starting dynamic subtest: pipe-A-eDP-1
[383.302735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s)
[383.315475] Starting dynamic subtest: pipe-B-eDP-1
[384.848667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[384.861367] Starting dynamic subtest: pipe-C-eDP-1
[386.251201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[386.264424] Starting dynamic subtest: pipe-D-eDP-1
[387.669308] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[387.671578] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.867s)
[388.865696] [052/155] (634s left) kms_invalid_mode (bad-hsync-end)
[388.966572] Starting subtest: bad-hsync-end
[388.968992] Starting dynamic subtest: pipe-A-eDP-1
[389.251908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[389.263198] Starting dynamic subtest: pipe-B-eDP-1
[389.265148] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[389.275724] Starting dynamic subtest: pipe-C-eDP-1
[389.277875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[389.289326] Starting dynamic subtest: pipe-D-eDP-1
[389.291666] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[389.293861] Subtest bad-hsync-end: SUCCESS (0.291s)
[390.084573] [053/155] (633s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[390.181900] Starting subtest: psr-rgb565-draw-pwrite
[397.320062] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.140s)
[397.424279] [054/155] (626s left) syncobj_timeline (host-signal-points)
[397.484212] Starting subtest: host-signal-points
[397.488469] Subtest host-signal-points: SUCCESS (0.005s)
[397.614782] [055/155] (625s left) kms_chamelium_hpd (hdmi-hpd-fast)
[397.996792] Subtest hdmi-hpd-fast: SKIP (0.000s)
[398.834955] [056/155] (624s left) gem_eio (kms)
[399.119786] Starting subtest: kms
[418.982923] Subtest kms: SUCCESS (19.862s)
[419.110309] [057/155] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[419.213039] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[419.217360] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[419.336628] [058/155] (604s left) gem_fence_thrash (bo-write-verify-x)
[419.372432] Starting subtest: bo-write-verify-x
[419.398719] Subtest bo-write-verify-x: SKIP (0.024s)
[419.466128] [059/155] (604s left) kms_atomic_transition (plane-all-transition-nonblocking)
[419.564638] Starting subtest: plane-all-transition-nonblocking
[419.566928] Starting dynamic subtest: pipe-A-eDP-1
[422.058007] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[422.379705] Starting dynamic subtest: pipe-B-eDP-1
[425.662349] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.296s)
[425.963530] Subtest plane-all-transition-nonblocking: SUCCESS (6.399s)
[426.819020] [060/155] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[426.924537] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[426.928717] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[427.030164] [061/155] (596s left) gem_media_vme
[427.186647] [062/155] (596s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[427.275217] Starting subtest: bad-aux-stride-yf-tiled-ccs
[427.277509] Starting dynamic subtest: pipe-A-eDP-1
[427.301384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.314800] Starting dynamic subtest: pipe-B-eDP-1
[427.336727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.347237] Starting dynamic subtest: pipe-C-eDP-1
[427.369047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.379923] Starting dynamic subtest: pipe-D-eDP-1
[427.402127] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.406173] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[429.569987] [063/155] (594s left) perf (gen8-unprivileged-single-ctx-counters)
[429.672902] Starting subtest: gen8-unprivileged-single-ctx-counters
[429.677538] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[429.716202] [064/155] (594s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[429.806717] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[429.834132] Starting dynamic subtest: pipe-A-plane-0
[430.212150] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s)
[430.223635] Starting dynamic subtest: pipe-A-plane-3
[430.533477] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[431.667000] Starting dynamic subtest: pipe-B-plane-0
[432.076562] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[432.087584] Starting dynamic subtest: pipe-B-plane-3
[432.410761] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[432.721248] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.913s)
[433.530139] [065/155] (590s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[433.630960] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[433.635602] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[433.736419] [066/155] (590s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[433.838813] Starting subtest: plane-upscale-factor-0-25-with-rotation
[433.841128] Starting dynamic subtest: pipe-A
[434.063023] Dynamic subtest pipe-A: SUCCESS (0.226s)
[434.075326] Starting dynamic subtest: pipe-B
[435.405619] Dynamic subtest pipe-B: SUCCESS (1.341s)
[435.417637] Starting dynamic subtest: pipe-C
[436.737140] Dynamic subtest pipe-C: SUCCESS (1.330s)
[436.748877] Starting dynamic subtest: pipe-D
[438.076320] Dynamic subtest pipe-D: SUCCESS (1.338s)
[438.078749] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.241s)
[439.264211] [067/155] (584s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[439.357338] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[439.361814] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[439.467398] [068/155] (584s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[439.582787] Starting subtest: short-busy-flip-before-cursor-toggle
[439.587148] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[439.731655] [069/155] (584s left) sriov_basic (enable-vfs-bind-unbind-each)
[439.779038] Starting subtest: enable-vfs-bind-unbind-each
[439.781386] Starting dynamic subtest: numvfs-1
[439.786155] Dynamic subtest numvfs-1: SKIP (0.001s)
[439.799243] Starting dynamic subtest: numvfs-2
[439.803735] Dynamic subtest numvfs-2: SKIP (0.001s)
[439.814729] Starting dynamic subtest: numvfs-3
[439.819121] Dynamic subtest numvfs-3: SKIP (0.001s)
[439.830397] Starting dynamic subtest: numvfs-4
[439.834559] Dynamic subtest numvfs-4: SKIP (0.001s)
[439.845076] Starting dynamic subtest: numvfs-5
[439.850251] Dynamic subtest numvfs-5: SKIP (0.001s)
[439.867548] Starting dynamic subtest: numvfs-6
[439.871967] Dynamic subtest numvfs-6: SKIP (0.001s)
[439.885169] Starting dynamic subtest: numvfs-7
[439.889635] Dynamic subtest numvfs-7: SKIP (0.001s)
[439.900083] Starting dynamic subtest: numvfs-random
[439.904505] Dynamic subtest numvfs-random: SKIP (0.001s)
[439.909188] Subtest enable-vfs-bind-unbind-each: SKIP (0.010s)
[439.952062] [070/155] (584s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[440.047835] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[440.052269] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[440.163094] [071/155] (584s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[440.257344] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[440.260900] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[440.329623] [072/155] (583s left) kms_chamelium_frames (hdmi-crc-fast)
[440.728670] Subtest hdmi-crc-fast: SKIP (0.000s)
[441.582126] [073/155] (582s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[441.668785] Starting subtest: fbc-psr2-cursor-mmap-gtt
[441.671190] Starting dynamic subtest: eDP-1
[441.675622] Dynamic subtest eDP-1: SKIP (0.000s)
[441.680138] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[441.757901] [074/155] (582s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[441.853795] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[441.857795] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[441.959459] [075/155] (582s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[442.060699] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[442.064696] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.163525] [076/155] (582s left) kms_psr (pr-primary-render)
[442.256703] Starting subtest: pr-primary-render
[442.261184] Subtest pr-primary-render: SKIP (0.000s)
[442.339946] [077/155] (582s left) gem_exec_reloc (basic-wc-read-active)
[442.396507] Subtest basic-wc-read-active: SKIP (0.000s)
[442.474904] [078/155] (582s left) kms_hdmi_inject (inject-audio)
[442.820354] Starting subtest: inject-audio
[443.113297] Subtest inject-audio: SUCCESS (0.295s)
[443.679370] [079/155] (580s left) i915_pm_rps (thresholds)
[443.738201] Starting subtest: thresholds
[443.742908] Subtest thresholds: SKIP (0.001s)
[443.834685] [080/155] (580s left) gem_tiled_blits (basic)
[443.892817] Subtest basic: SKIP (0.000s)
[443.964904] [081/155] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[444.058137] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[444.062809] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.150968] [082/155] (580s left) gem_ctx_persistence (hostile)
[444.207464] Starting subtest: hostile
[453.714448] Subtest hostile: SUCCESS (9.503s)
[453.841404] [083/155] (570s left) kms_plane_multiple (2x-tiling-y)
[453.929598] Starting subtest: 2x-tiling-y
[453.934113] Subtest 2x-tiling-y: SKIP (0.000s)
[454.003343] [084/155] (570s left) gem_mmap_gtt (fault-concurrent)
[454.058561] Subtest fault-concurrent: SKIP (0.000s)
[454.122318] [085/155] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[454.219888] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[454.224125] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[454.319803] [086/155] (570s left) gen9_exec_parse (bb-secure)
[454.381084] Subtest bb-secure: SKIP (0.000s)
[454.454864] [087/155] (570s left) kms_plane_scaling (invalid-num-scalers)
[454.554289] Starting subtest: invalid-num-scalers
[454.556509] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[454.575758] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[454.586915] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[454.608684] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[454.619856] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[454.641800] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[454.652879] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[454.677864] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[454.680120] Subtest invalid-num-scalers: SUCCESS (0.124s)
[454.792120] [088/155] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[454.895881] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[454.899453] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.986386] [089/155] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[455.084551] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[461.816005] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.734s)
[461.956190] [090/155] (563s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[462.053268] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[462.057370] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[462.160934] [091/155] (562s left) gem_ccs (block-copy-compressed)
[462.221697] Starting subtest: block-copy-compressed
[462.226121] Subtest block-copy-compressed: SKIP (0.000s)
[462.320078] [092/155] (562s left) kms_psr (fbc-pr-cursor-blt)
[462.413004] Starting subtest: fbc-pr-cursor-blt
[462.417226] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[462.487716] [093/155] (562s left) gem_workarounds (reset-context)
[462.547068] Starting subtest: reset-context
[462.691234] Subtest reset-context: SUCCESS (0.143s)
[462.829779] [094/155] (562s left) gem_exec_balancer (bonded-dual)
[462.894932] Starting subtest: bonded-dual
[462.898745] Subtest bonded-dual: SKIP (0.000s)
[463.201075] [095/155] (562s left) gem_exec_nop (basic-series)
[463.278063] Starting subtest: basic-series
[477.967022] Subtest basic-series: SUCCESS (14.677s)
[478.197513] [096/155] (547s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[478.309352] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[478.313700] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[478.426364] [097/155] (546s left) perf_pmu (init-busy)
[478.469405] Starting subtest: init-busy
[478.471623] Starting dynamic subtest: rcs0
[478.473744] Dynamic subtest rcs0: SUCCESS (0.001s)
[478.485065] Starting dynamic subtest: bcs0
[478.487101] Dynamic subtest bcs0: SUCCESS (0.000s)
[478.497862] Starting dynamic subtest: vcs0
[478.500012] Dynamic subtest vcs0: SUCCESS (0.001s)
[478.510555] Starting dynamic subtest: vcs1
[478.512362] Dynamic subtest vcs1: SUCCESS (0.000s)
[478.522814] Starting dynamic subtest: vecs0
[478.524938] Dynamic subtest vecs0: SUCCESS (0.001s)
[478.535155] Starting dynamic subtest: ccs0
[478.537069] Dynamic subtest ccs0: SUCCESS (0.000s)
[478.539008] Subtest init-busy: SUCCESS (0.007s)
[478.581911] [098/155] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[478.674261] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[485.411476] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.740s)
[485.553455] [099/155] (539s left) kms_vblank (wait-idle-hang)
[485.646809] Starting subtest: wait-idle-hang
[485.649007] Starting dynamic subtest: pipe-A-eDP-1
[513.047296] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.388s)
[513.064036] Starting dynamic subtest: pipe-D-eDP-1
[537.283624] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.229s)
[537.285941] Subtest wait-idle-hang: SUCCESS (51.624s)
[538.130923] [100/155] (487s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[538.238796] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[538.242696] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[538.343258] [101/155] (487s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[538.432704] Starting subtest: random-ccs-data-y-tiled-ccs
[538.435066] Starting dynamic subtest: pipe-A-eDP-1
[538.460451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[538.473984] Starting dynamic subtest: pipe-B-eDP-1
[538.498299] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[538.509067] Starting dynamic subtest: pipe-C-eDP-1
[538.533522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[538.543995] Starting dynamic subtest: pipe-D-eDP-1
[538.568163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[538.572237] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[540.745122] [102/155] (484s left) i915_drm_fdinfo (busy-check-all)
[540.785373] Starting subtest: busy-check-all
[540.787784] Starting dynamic subtest: rcs0
[540.795350] Dynamic subtest rcs0: SKIP (0.007s)
[540.807470] Starting dynamic subtest: bcs0
[540.812380] Dynamic subtest bcs0: SKIP (0.000s)
[540.823397] Starting dynamic subtest: vcs0
[540.827708] Dynamic subtest vcs0: SKIP (0.000s)
[540.842484] Starting dynamic subtest: vcs1
[540.847328] Dynamic subtest vcs1: SKIP (0.000s)
[540.868830] Starting dynamic subtest: vecs0
[540.874066] Dynamic subtest vecs0: SKIP (0.000s)
[540.893766] Starting dynamic subtest: ccs0
[540.898534] Dynamic subtest ccs0: SKIP (0.000s)
[540.902885] Subtest busy-check-all: SKIP (0.013s)
[540.946196] [103/155] (484s left) syncobj_basic (bad-flags-handle-to-fd)
[541.029938] Starting subtest: bad-flags-handle-to-fd
[541.032518] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[541.156365] [104/155] (484s left) kms_content_protection (dp-mst-type-1)
[541.299999] Starting subtest: dp-mst-type-1
[541.304599] Subtest dp-mst-type-1: SKIP (0.000s)
[541.433374] [105/155] (484s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[541.525099] Starting subtest: 4-tiled-16bpp-rotate-0
[542.872613] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.348s)
[543.018527] [106/155] (482s left) gem_exec_params (invalid-fence-in)
[543.082883] Starting subtest: invalid-fence-in
[543.084999] Subtest invalid-fence-in: SUCCESS (0.000s)
[543.189936] [107/155] (482s left) gem_mmap_gtt (flink-race)
[543.246101] Subtest flink-race: SKIP (0.000s)
[543.309434] [108/155] (482s left) syncobj_timeline (invalid-signal-illegal-point)
[543.367665] Starting subtest: invalid-signal-illegal-point
[543.369585] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[543.466992] [109/155] (482s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[543.556347] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[543.559936] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[543.661864] [110/155] (482s left) kms_panel_fitting (legacy)
[543.752730] Starting subtest: legacy
[543.754669] Starting dynamic subtest: pipe-A-eDP-1
[544.272701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[544.302645] Starting dynamic subtest: pipe-B-eDP-1
[545.833698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.541s)
[545.864863] Starting dynamic subtest: pipe-C-eDP-1
[547.411589] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.558s)
[547.440861] Starting dynamic subtest: pipe-D-eDP-1
[548.910049] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[548.912276] Subtest legacy: SUCCESS (5.157s)
[550.133021] [111/155] (475s left) i915_suspend (debugfs-reader)
[550.187811] Starting subtest: debugfs-reader
[567.725962] Subtest debugfs-reader: SUCCESS (3.143s)
[567.918038] [112/155] (458s left) kms_psr (psr-cursor-plane-move)
[568.014667] Starting subtest: psr-cursor-plane-move
[568.017366] Starting dynamic subtest: eDP-1
[569.734181] Dynamic subtest eDP-1: SUCCESS (1.684s)
[569.736633] Subtest psr-cursor-plane-move: SUCCESS (1.685s)
[570.594341] [113/155] (455s left) gem_exec_schedule (pi-ringfull)
[570.776899] Starting subtest: pi-ringfull
[570.779914] Starting dynamic subtest: rcs0
[570.806793] Dynamic subtest rcs0: SUCCESS (0.032s)
[570.823295] Starting dynamic subtest: bcs0
[570.839598] Dynamic subtest bcs0: SUCCESS (0.031s)
[570.855516] Starting dynamic subtest: vcs0
[570.869951] Dynamic subtest vcs0: SUCCESS (0.029s)
[570.886485] Starting dynamic subtest: vcs1
[570.898568] Dynamic subtest vcs1: SUCCESS (0.027s)
[570.915613] Starting dynamic subtest: vecs0
[570.927943] Dynamic subtest vecs0: SUCCESS (0.028s)
[570.944011] Starting dynamic subtest: ccs0
[570.956812] Dynamic subtest ccs0: SUCCESS (0.028s)
[570.959815] Subtest pi-ringfull: SUCCESS (0.181s)
[571.189362] [114/155] (455s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[571.239006] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[571.345285] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[571.430011] [115/155] (454s left) gem_ctx_param (get-priority-new-ctx)
[571.477490] Starting subtest: get-priority-new-ctx
[571.480199] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[571.573999] [116/155] (454s left) api_intel_bb (lot-of-buffers)
[571.629864] Starting subtest: lot-of-buffers
[572.714963] Subtest lot-of-buffers: SUCCESS (1.071s)
[573.044943] [117/155] (453s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[573.151138] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[574.253127] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.091s)
[574.388332] [118/155] (452s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[574.477234] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[574.482232] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[575.651306] [119/155] (450s left) kms_prime (basic-crc-hybrid)
[575.738534] Subtest basic-crc-hybrid: SKIP (0.000s)
[575.832548] [120/155] (450s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[575.929976] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[575.932845] Starting dynamic subtest: pipe-A-eDP-1
[591.969484] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.355s)
[591.980742] Starting dynamic subtest: pipe-B-eDP-1
[608.949853] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.385s)
[608.961082] Starting dynamic subtest: pipe-C-eDP-1
[625.932558] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.409s)
[625.948619] Starting dynamic subtest: pipe-D-eDP-1
[642.924102] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s)
[642.926481] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.571s)
[644.149097] [121/155] (382s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[644.216728] Starting subtest: multi-wait-for-submit-submitted-signaled
[644.219567] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[644.316703] [122/155] (382s left) prime_vgem (basic-gtt)
[644.390296] Starting subtest: basic-gtt
[644.395267] Subtest basic-gtt: SKIP (0.000s)
[644.485739] [123/155] (382s left) gem_exec_fence (syncobj-timeline-wait)
[645.052680] Starting subtest: syncobj-timeline-wait
[646.207160] Subtest syncobj-timeline-wait: SUCCESS (1.136s)
[648.226612] [124/155] (378s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[648.334397] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[649.180431] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.838s)
[649.346448] [125/155] (377s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[649.413346] Starting subtest: map-fixed-invalidate-overlap-busy
[649.417740] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[649.537025] [126/155] (377s left) gem_softpin (32b-excludes-last-page)
[649.602670] Starting subtest: 32b-excludes-last-page
[649.607991] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[649.725812] [127/155] (377s left) gem_exec_schedule (semaphore-codependency)
[649.798590] Starting subtest: semaphore-codependency
[649.806293] Subtest semaphore-codependency: SUCCESS (0.019s)
[650.163472] [128/155] (376s left) gem_pxp (hw-rejects-pxp-context)
[650.287192] Starting subtest: hw-rejects-pxp-context
[650.293037] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[650.394201] [129/155] (376s left) gem_spin_batch (spin-all-new)
[650.457414] Starting subtest: spin-all-new
[650.476094] Subtest spin-all-new: SUCCESS (0.016s)
[652.176076] [130/155] (374s left) kms_cursor_crc (cursor-offscreen-512x512)
[652.443945] Starting subtest: cursor-offscreen-512x512
[652.449231] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[652.610371] [131/155] (374s left) syncobj_timeline (wait-all-for-submit-complex)
[652.669436] Starting subtest: wait-all-for-submit-complex
[652.885665] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[652.966140] [132/155] (374s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[653.061234] Starting subtest: plane-lut1d-post-ctm3x4
[653.221463] Starting dynamic subtest: pipe-A-plane-0
[653.376826] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[653.389024] Starting dynamic subtest: pipe-A-plane-1
[653.544419] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[653.556417] Starting dynamic subtest: pipe-A-plane-2
[653.735085] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[654.942235] Starting dynamic subtest: pipe-B-plane-0
[655.110116] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[655.122335] Starting dynamic subtest: pipe-B-plane-1
[655.255872] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[655.268380] Starting dynamic subtest: pipe-B-plane-2
[655.424057] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[656.635426] Starting dynamic subtest: pipe-C-plane-0
[656.770299] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[656.782778] Starting dynamic subtest: pipe-C-plane-1
[656.938116] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[656.950457] Starting dynamic subtest: pipe-C-plane-2
[657.082353] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[658.346660] Starting dynamic subtest: pipe-D-plane-0
[658.505364] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[658.518925] Starting dynamic subtest: pipe-D-plane-1
[658.648279] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[658.660184] Starting dynamic subtest: pipe-D-plane-2
[658.817327] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[659.104778] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.016s)
[659.975780] [133/155] (367s left) kms_universal_plane (cursor-fb-leak)
[660.064702] Starting subtest: cursor-fb-leak
[660.067548] Starting dynamic subtest: pipe-A-eDP-1
[660.383890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.320s)
[660.397364] Starting dynamic subtest: pipe-B-eDP-1
[661.768932] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[661.784017] Starting dynamic subtest: pipe-C-eDP-1
[663.150124] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[663.162403] Starting dynamic subtest: pipe-D-eDP-1
[664.550030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[664.552844] Subtest cursor-fb-leak: SUCCESS (4.479s)
[665.703920] [134/155] (361s left) gem_mmap_gtt (basic-small-copy)
[665.761013] Subtest basic-small-copy: SKIP (0.000s)
[665.825128] [135/155] (361s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[665.926453] Starting subtest: x-tiled-64bpp-rotate-180
[667.643456] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.714s)
[667.803928] [136/155] (359s left) kms_cursor_crc (cursor-random-32x32)
[667.947501] Starting subtest: cursor-random-32x32
[667.995811] Subtest cursor-random-32x32: SKIP (0.043s)
[668.260949] [137/155] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[668.354468] Starting subtest: psr-2p-primscrn-cur-indfb-move
[668.358778] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[668.470822] [138/155] (358s left) gem_tiled_fence_blits (basic)
[668.523362] Subtest basic: SKIP (0.000s)
[668.594084] [139/155] (358s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[668.690828] Starting subtest: invalidate-primary-flip-overlay
[679.404030] Subtest invalidate-primary-flip-overlay: SUCCESS (10.709s)
[679.519923] [140/155] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[679.634358] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[679.638854] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[679.726700] [141/155] (347s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[679.825348] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[679.830071] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[679.921963] [142/155] (347s left) perf_pmu (busy-double-start)
[679.963941] Starting subtest: busy-double-start
[679.966294] Starting dynamic subtest: rcs0
[683.538086] Dynamic subtest rcs0: SUCCESS (3.573s)
[683.551505] Starting dynamic subtest: bcs0
[687.112466] Dynamic subtest bcs0: SUCCESS (3.571s)
[687.126170] Starting dynamic subtest: vcs0
[691.681825] Dynamic subtest vcs0: SUCCESS (4.566s)
[691.696590] Starting dynamic subtest: vcs1
[695.711711] Dynamic subtest vcs1: SUCCESS (4.026s)
[695.725971] Starting dynamic subtest: vecs0
[699.700961] Dynamic subtest vecs0: SUCCESS (3.986s)
[699.716911] Starting dynamic subtest: ccs0
[703.360800] Dynamic subtest ccs0: FAIL (3.588s)
[703.363453] Subtest busy-double-start: FAIL (23.322s)
[703.411719] [143/155] (324s left) kms_async_flips (alternate-sync-async-flip)
[703.511365] Starting subtest: alternate-sync-async-flip
[703.899486] Starting dynamic subtest: pipe-A-eDP-1
[706.658260] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.758s)
[707.041931] Starting dynamic subtest: pipe-B-eDP-1
[709.866212] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.834s)
[710.246856] Starting dynamic subtest: pipe-C-eDP-1
[713.062311] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.825s)
[713.436430] Starting dynamic subtest: pipe-D-eDP-1
[716.268359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.841s)
[716.270720] Subtest alternate-sync-async-flip: SUCCESS (12.755s)
[717.507316] [144/155] (310s left) kms_flip (2x-flip-vs-suspend-interruptible)
[717.606225] Starting subtest: 2x-flip-vs-suspend-interruptible
[717.611601] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[717.716089] [145/155] (309s left) kms_joiner (basic-ultra-joiner)
[717.816115] Starting subtest: basic-ultra-joiner
[717.820840] Subtest basic-ultra-joiner: SKIP (0.000s)
[717.885835] [146/155] (309s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[717.981413] Starting subtest: fbc-farfromfence-mmap-gtt
[717.987369] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[718.092142] [147/155] (309s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[718.193356] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[721.699593] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.513s)
[722.916201] [148/155] (304s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[723.019593] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[723.024762] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[723.111286] [149/155] (304s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[723.219729] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[723.224589] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[723.323281] [150/155] (304s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[723.431341] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[723.436193] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[723.532331] [151/155] (304s left) prime_mmap (test_invalid_sync_flags)
[723.587493] Starting subtest: test_invalid_sync_flags
[723.589875] Starting dynamic subtest: test_invalid_sync_flags-smem
[723.592485] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[723.595327] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[723.693896] [152/155] (304s left) perf (invalid-remove-userspace-config)
[723.789976] Starting subtest: invalid-remove-userspace-config
[723.796403] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[723.847452] [153/155] (304s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[723.931582] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[723.935994] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[724.009358] [154/155] (304s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[724.103393] Starting subtest: fbcpsrhdr-suspend
[724.107724] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[724.199965] [155/155] (303s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[724.299508] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[724.304149] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[724.396405] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: drm_buddy
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_pwrite_snooped
results: parsing output: 31/ for test: prime_self_import
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: gem_tiled_swapping
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_media_vme
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: sriov_basic
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_chamelium_frames
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_hdmi_inject
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_tiled_blits
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_workarounds
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: gem_exec_nop
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_panel_fitting
results: parsing output: 110/ for test: i915_suspend
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_prime
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: kms_universal_plane
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_tiled_fence_blits
results: parsing output: 138/ for test: kms_psr_stress_test
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_async_flips
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_joiner
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: prime_mmap
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: kms_flip_scaled_crc
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.