[57.228336] Initializing watchdogs
[57.228383]   /dev/watchdog0
[57.243129] [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]
[57.247477] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.249701] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.252876] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[57.377299] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[57.414812] Starting dynamic subtest: pipe-A-plane-0
[57.888673] Dynamic subtest pipe-A-plane-0: SUCCESS (0.478s)
[57.897355] Starting dynamic subtest: pipe-A-plane-3
[58.142505] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[59.225773] Starting dynamic subtest: pipe-B-plane-0
[59.639801] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[59.647389] Starting dynamic subtest: pipe-B-plane-3
[59.895375] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[60.218625] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.861s)
[61.013858] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[61.129791] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[61.133772] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[61.232897] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[61.332974] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.337423] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[61.461385] [004/133] (956s left) prime_mmap_coherency (ioctl-errors)
[61.524658] Starting subtest: ioctl-errors
[77.070784] Subtest ioctl-errors: SUCCESS (15.575s)
[77.238355] [005/133] (940s left) perf (non-sampling-read-error)
[77.408493] Starting subtest: non-sampling-read-error
[77.419371] Subtest non-sampling-read-error: SUCCESS (0.010s)
[77.465101] [006/133] (940s left) core_getversion (basic)
[77.499459] Starting subtest: basic
[77.502936] Subtest basic: SUCCESS (0.000s)
[77.574552] [007/133] (940s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[77.685888] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[77.695559] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[77.824395] [008/133] (940s left) api_intel_allocator (execbuf-with-allocator)
[77.874853] Starting subtest: execbuf-with-allocator
[77.878987] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[78.008607] [009/133] (940s left) tools_test (sysfs_l3_parity)
[78.061305] Starting subtest: sysfs_l3_parity
[78.154654] Subtest sysfs_l3_parity: SKIP (0.102s)
[78.247888] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[78.344528] Starting subtest: bad-htotal
[78.346566] Starting dynamic subtest: pipe-A-eDP-1
[78.632493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[78.641202] Starting dynamic subtest: pipe-B-eDP-1
[78.643435] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[78.651075] Starting dynamic subtest: pipe-C-eDP-1
[78.653236] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[78.660602] Starting dynamic subtest: pipe-D-eDP-1
[78.662456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[78.664356] Subtest bad-htotal: SUCCESS (0.293s)
[79.519247] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[79.619908] Starting subtest: getfb2-handle-closed
[79.622160] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[79.747618] [012/133] (938s left) gen3_mixed_blits
[79.867162] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[79.955117] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[87.348095] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.397s)
[87.495336] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[87.608322] Starting subtest: cursor-tearing-position-change
[87.610528] Starting dynamic subtest: pipe-A-eDP-1
[88.196342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[88.205679] Starting dynamic subtest: pipe-D-eDP-1
[89.486755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[89.488849] Subtest cursor-tearing-position-change: SUCCESS (1.876s)
[90.357400] [015/133] (927s left) kms_flip (absolute-wf_vblank)
[90.474438] Starting subtest: absolute-wf_vblank
[90.476715] Starting dynamic subtest: A-eDP1
[99.174169] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[99.184443] Starting dynamic subtest: B-eDP1
[107.902577] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[107.912935] Starting dynamic subtest: C-eDP1
[116.620511] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[116.629923] Starting dynamic subtest: D-eDP1
[125.350640] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[125.353085] Subtest absolute-wf_vblank: SUCCESS (34.882s)
[126.570776] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[126.688281] Starting subtest: basic-brightness
[126.735431] Starting dynamic subtest: eDP-1
[127.253708] Dynamic subtest eDP-1: SUCCESS (0.515s)
[127.256165] Subtest basic-brightness: SUCCESS (0.565s)
[128.110288] [017/133] (890s left) kms_color (ctm-max)
[128.209833] Starting subtest: ctm-max
[128.211697] Starting dynamic subtest: pipe-A-eDP-1
[128.912428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[128.925179] Starting dynamic subtest: pipe-B-eDP-1
[130.338890] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[130.348117] Starting dynamic subtest: pipe-C-eDP-1
[131.682999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[131.694209] Starting dynamic subtest: pipe-D-eDP-1
[133.009817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[133.012266] Subtest ctm-max: SUCCESS (4.801s)
[133.823561] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[133.884268] Starting subtest: rel-constants-invalid
[133.886211] Subtest rel-constants-invalid: SUCCESS (0.000s)
[134.009411] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[134.194777] Starting subtest: noreorder-corked
[134.197245] Starting dynamic subtest: rcs0
[135.342229] Dynamic subtest rcs0: SUCCESS (1.149s)
[135.352855] Starting dynamic subtest: vcs0
[136.958414] Dynamic subtest vcs0: SUCCESS (1.613s)
[136.969575] Starting dynamic subtest: vcs1
[138.928234] Dynamic subtest vcs1: SUCCESS (1.968s)
[138.938078] Starting dynamic subtest: vecs0
[140.907627] Dynamic subtest vecs0: SUCCESS (1.977s)
[140.918881] Starting dynamic subtest: ccs0
[142.060657] Dynamic subtest ccs0: SUCCESS (1.153s)
[142.063441] Subtest noreorder-corked: SUCCESS (7.868s)
[142.256321] [020/133] (876s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[142.315470] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[142.375932] [021/133] (876s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[142.764062] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[143.537048] [022/133] (875s left) gem_exec_whisper (basic-contexts-priority-all)
[143.602246] Starting subtest: basic-contexts-priority-all
[165.811331] Subtest basic-contexts-priority-all: SUCCESS (22.206s)
[166.020569] [023/133] (852s left) gen9_exec_parse (allowed-all)
[166.081840] Subtest allowed-all: SKIP (0.000s)
[166.151928] [024/133] (852s left) perf_pmu (busy-accuracy-98)
[166.190610] Starting subtest: busy-accuracy-98
[166.192706] Starting dynamic subtest: rcs0
[169.233724] Dynamic subtest rcs0: SUCCESS (3.040s)
[169.242601] Starting dynamic subtest: bcs0
[172.279357] Dynamic subtest bcs0: SUCCESS (3.043s)
[172.289906] Starting dynamic subtest: vcs0
[175.319345] Dynamic subtest vcs0: SUCCESS (3.038s)
[175.330114] Starting dynamic subtest: vcs1
[178.357845] Dynamic subtest vcs1: SUCCESS (3.036s)
[178.368912] Starting dynamic subtest: vecs0
[181.396328] Dynamic subtest vecs0: SUCCESS (3.036s)
[181.407284] Starting dynamic subtest: ccs0
[184.446777] Dynamic subtest ccs0: SUCCESS (3.048s)
[184.449724] Subtest busy-accuracy-98: SUCCESS (18.253s)
[184.567191] [025/133] (834s left) gem_workarounds (suspend-resume-fd)
[184.641842] Starting subtest: suspend-resume-fd
[201.849327] Subtest suspend-resume-fd: SUCCESS (1.755s)
[210.020446] [026/133] (816s left) kms_psr (fbc-pr-sprite-plane-move)
[210.123593] Starting subtest: fbc-pr-sprite-plane-move
[210.127628] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[210.213166] [027/133] (816s left) syncobj_wait (invalid-wait-bad-flags)
[210.260764] Starting subtest: invalid-wait-bad-flags
[210.262537] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[210.355742] [028/133] (816s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[210.448542] Starting subtest: fbc-rgb565-draw-mmap-wc
[214.459488] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.106s)
[215.606309] [029/133] (811s left) kms_addfb_basic (unused-offsets)
[215.663184] Starting subtest: unused-offsets
[215.665233] Subtest unused-offsets: SUCCESS (0.000s)
[215.816534] [030/133] (811s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[215.877526] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[215.879374] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[215.991140] [031/133] (810s left) kms_psr (fbc-pr-cursor-plane-move)
[216.088733] Starting subtest: fbc-pr-cursor-plane-move
[216.092802] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[216.170202] [032/133] (810s left) kms_psr (psr-cursor-render)
[216.257859] Starting subtest: psr-cursor-render
[216.260112] Starting dynamic subtest: eDP-1
[217.956086] Dynamic subtest eDP-1: SUCCESS (1.719s)
[217.958356] Subtest psr-cursor-render: SUCCESS (1.720s)
[218.826871] [033/133] (808s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[218.919211] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[218.930851] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[219.016811] [034/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[219.112084] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[219.116542] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[219.236338] [035/133] (807s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[219.332976] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[219.336922] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[219.429360] [036/133] (807s left) kms_addfb_basic (invalid-get-prop)
[219.481662] Starting subtest: invalid-get-prop
[219.483893] Subtest invalid-get-prop: SUCCESS (0.000s)
[219.656593] [037/133] (807s left) gem_softpin (evict-prime-sanity-check)
[219.714720] Starting subtest: evict-prime-sanity-check
[219.716959] Starting dynamic subtest: rcs0
[220.874828] Dynamic subtest rcs0: SUCCESS (1.169s)
[220.886577] Starting dynamic subtest: bcs0
[222.017612] Dynamic subtest bcs0: SUCCESS (1.149s)
[222.030729] Starting dynamic subtest: vcs0
[223.362402] Dynamic subtest vcs0: SUCCESS (1.350s)
[223.373363] Starting dynamic subtest: vcs1
[225.347425] Dynamic subtest vcs1: SUCCESS (1.994s)
[225.359921] Starting dynamic subtest: vecs0
[227.328326] Dynamic subtest vecs0: SUCCESS (1.987s)
[227.340685] Starting dynamic subtest: ccs0
[228.478171] Dynamic subtest ccs0: SUCCESS (1.153s)
[228.490968] Starting dynamic subtest: all
[229.614228] Dynamic subtest all: SUCCESS (1.137s)
[229.616750] Subtest evict-prime-sanity-check: SUCCESS (9.949s)
[229.706586] [038/133] (797s left) i915_suspend (fence-restore-untiled)
[229.770128] Starting subtest: fence-restore-untiled
[229.774439] Subtest fence-restore-untiled: SKIP (0.000s)
[229.891570] [039/133] (797s left) kms_psr (psr-sprite-mmap-gtt)
[230.001927] Starting subtest: psr-sprite-mmap-gtt
[230.004188] Starting dynamic subtest: eDP-1
[231.485307] Dynamic subtest eDP-1: SKIP (1.484s)
[231.490186] Subtest psr-sprite-mmap-gtt: SKIP (1.486s)
[231.662218] [040/133] (795s left) gem_userptr_blits (unsync-unmap)
[231.733839] Subtest unsync-unmap: SKIP (0.000s)
[231.867400] [041/133] (795s left) gem_exec_balancer (bonded-true-hang)
[232.132567] Starting subtest: bonded-true-hang
[232.137371] Subtest bonded-true-hang: SKIP (0.000s)
[232.247246] [042/133] (795s left) gem_lmem_swapping (parallel-random-engines)
[232.293558] Subtest parallel-random-engines: SKIP (0.000s)
[232.333753] [043/133] (795s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[232.387669] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[232.392144] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[232.586859] [044/133] (794s left) syncobj_timeline (etime-single-wait-all-submitted)
[232.636609] Starting subtest: etime-single-wait-all-submitted
[232.742866] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[232.833233] [045/133] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[232.928119] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[232.932098] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[233.042732] [046/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[233.146612] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[233.150770] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[233.260152] [047/133] (794s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[233.394958] Starting subtest: short-busy-flip-before-cursor-toggle
[233.399105] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[233.561918] [048/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[233.658594] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[240.711485] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.058s)
[240.856023] [049/133] (786s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[240.951941] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[240.954186] Starting dynamic subtest: pipe-A-eDP-1
[240.976928] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.988322] Starting dynamic subtest: pipe-B-eDP-1
[241.009681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.018957] Starting dynamic subtest: pipe-C-eDP-1
[241.040073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[241.048925] Starting dynamic subtest: pipe-D-eDP-1
[241.070469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[241.074570] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[243.212185] [050/133] (784s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[243.310071] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[243.312422] Starting dynamic subtest: pipe-A-eDP-1
[243.333077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[243.343948] Starting dynamic subtest: pipe-B-eDP-1
[243.363505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[243.372467] Starting dynamic subtest: pipe-C-eDP-1
[243.391953] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[243.403355] Starting dynamic subtest: pipe-D-eDP-1
[243.422994] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[243.424904] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[245.561784] [051/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[245.663499] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[245.668149] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.790069] [052/133] (782s left) gem_partial_pwrite_pread (reads-snoop)
[245.850389] Subtest reads-snoop: SKIP (0.000s)
[245.929864] [053/133] (781s left) syncobj_timeline (invalid-query-illegal-handle)
[245.989761] Starting subtest: invalid-query-illegal-handle
[245.992067] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[246.109275] [054/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[246.205818] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[253.247620] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.044s)
[253.441256] [055/133] (774s left) kms_lease (lease-unleased-connector)
[253.542143] Starting subtest: lease-unleased-connector
[253.544346] Starting dynamic subtest: pipe-A-eDP-1
[253.549945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[253.564681] Starting dynamic subtest: pipe-B-eDP-1
[253.567022] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[253.578832] Starting dynamic subtest: pipe-C-eDP-1
[253.580904] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[253.591910] Starting dynamic subtest: pipe-D-eDP-1
[253.593843] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[253.595750] Subtest lease-unleased-connector: SUCCESS (0.033s)
[253.679316] [056/133] (774s left) syncobj_wait (invalid-single-wait-unsubmitted)
[253.740394] Starting subtest: invalid-single-wait-unsubmitted
[253.742818] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[253.860884] [057/133] (774s left) gem_mmap_gtt (ptrace)
[253.926621] Subtest ptrace: SKIP (0.000s)
[253.988987] [058/133] (774s left) syncobj_timeline (multi-wait-submitted-signaled)
[254.048066] Starting subtest: multi-wait-submitted-signaled
[254.050553] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[254.165994] [059/133] (773s left) gem_madvise (dontneed-before-exec)
[254.205750] Starting subtest: dontneed-before-exec
[254.227595] Subtest dontneed-before-exec: SKIP (0.020s)
[254.280828] [060/133] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[254.374061] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[254.377401] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[254.466679] [061/133] (773s left) gem_ccs (ctrl-surf-copy-new-ctx)
[254.527210] Starting subtest: ctrl-surf-copy-new-ctx
[254.530983] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[254.652212] [062/133] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[254.745237] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[259.092905] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.351s)
[260.328142] [063/133] (767s left) syncobj_wait (single-wait-all-for-submit-signaled)
[260.393813] Starting subtest: single-wait-all-for-submit-signaled
[260.396012] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[260.513498] [064/133] (767s left) gem_ctx_isolation (nonpriv-switch)
[260.570636] Starting subtest: nonpriv-switch
[260.572985] Starting dynamic subtest: rcs0
[260.889360] Dynamic subtest rcs0: SUCCESS (0.318s)
[260.900774] Starting dynamic subtest: bcs0
[261.210651] Dynamic subtest bcs0: SUCCESS (0.320s)
[261.223339] Starting dynamic subtest: vcs0
[261.493417] Dynamic subtest vcs0: SUCCESS (0.281s)
[261.504785] Starting dynamic subtest: vcs1
[263.587346] Dynamic subtest vcs1: SUCCESS (2.093s)
[263.596984] Starting dynamic subtest: vecs0
[265.715840] Dynamic subtest vecs0: SUCCESS (2.128s)
[265.725522] Starting dynamic subtest: ccs0
[267.728320] Dynamic subtest ccs0: SUCCESS (2.012s)
[267.730639] Subtest nonpriv-switch: SUCCESS (7.159s)
[268.003031] [065/133] (760s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[268.108610] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[268.112981] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[268.210785] [066/133] (760s left) i915_drm_fdinfo (most-busy-check-all)
[268.254257] Starting subtest: most-busy-check-all
[268.256198] Starting dynamic subtest: rcs0
[268.260834] Dynamic subtest rcs0: SKIP (0.004s)
[268.272052] Starting dynamic subtest: bcs0
[268.276290] Dynamic subtest bcs0: SKIP (0.000s)
[268.285769] Starting dynamic subtest: vcs0
[268.289766] Dynamic subtest vcs0: SKIP (0.000s)
[268.299170] Starting dynamic subtest: vcs1
[268.303434] Dynamic subtest vcs1: SKIP (0.000s)
[268.312297] Starting dynamic subtest: vecs0
[268.316594] Dynamic subtest vecs0: SKIP (0.000s)
[268.325440] Starting dynamic subtest: ccs0
[268.329772] Dynamic subtest ccs0: SKIP (0.000s)
[268.333997] Subtest most-busy-check-all: SKIP (0.012s)
[268.369423] [067/133] (760s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[268.476046] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[268.480859] Starting dynamic subtest: pipe-A-eDP-1
[268.564855] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[268.576797] Starting dynamic subtest: pipe-B-eDP-1
[269.678365] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[269.682760] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.214s)
[270.878222] [068/133] (757s left) gem_create (create-ext-placement-each)
[271.046586] Starting subtest: create-ext-placement-each
[271.049506] Subtest create-ext-placement-each: SUCCESS (0.000s)
[271.175330] [069/133] (757s left) gen7_exec_parse (basic-allocation)
[271.244450] Subtest basic-allocation: SKIP (0.000s)
[271.335405] [070/133] (757s left) api_intel_bb (intel-bb-blit-none)
[271.407836] Starting subtest: intel-bb-blit-none
[275.804266] Subtest intel-bb-blit-none: SUCCESS (4.399s)
[275.949497] [071/133] (752s left) kms_chamelium_hpd (vga-hpd)
[276.323444] Subtest vga-hpd: SKIP (0.000s)
[277.175942] [072/133] (751s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[277.248786] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[277.323188] [073/133] (751s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[277.381781] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[277.462726] [074/133] (751s left) i915_pm_rps (reset)
[277.525136] Starting subtest: reset
[286.017112] Subtest reset: SUCCESS (8.494s)
[286.174984] [075/133] (742s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[286.307056] Starting subtest: cursor-vs-flip-legacy
[315.612653] Subtest cursor-vs-flip-legacy: SUCCESS (29.303s)
[316.433305] [076/133] (712s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[316.522059] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[316.524250] Starting dynamic subtest: pipe-A-eDP-1
[316.533219] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.544051] Starting dynamic subtest: pipe-B-eDP-1
[316.553104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.562525] Starting dynamic subtest: pipe-C-eDP-1
[316.571156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.580658] Starting dynamic subtest: pipe-D-eDP-1
[316.589262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.593534] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[318.794319] [077/133] (710s left) gem_exec_balancer (parallel-keep-in-fence)
[319.051691] Starting subtest: parallel-keep-in-fence
[320.270284] Subtest parallel-keep-in-fence: SUCCESS (1.218s)
[320.396985] [078/133] (708s left) prime_busy (after-wait)
[320.455942] Starting subtest: after-wait
[320.458251] Starting dynamic subtest: rcs0
[320.494158] Dynamic subtest rcs0: SUCCESS (0.038s)
[320.505979] Starting dynamic subtest: bcs0
[320.577690] Dynamic subtest bcs0: SUCCESS (0.082s)
[320.588928] Starting dynamic subtest: vcs0
[320.618379] Dynamic subtest vcs0: SUCCESS (0.040s)
[320.628009] Starting dynamic subtest: vcs1
[320.658288] Dynamic subtest vcs1: SUCCESS (0.039s)
[320.667981] Starting dynamic subtest: vecs0
[320.699443] Dynamic subtest vecs0: SUCCESS (0.040s)
[320.709453] Starting dynamic subtest: ccs0
[320.740046] Dynamic subtest ccs0: SUCCESS (0.040s)
[320.848867] Subtest after-wait: SUCCESS (0.393s)
[320.936040] [079/133] (707s left) gem_exec_schedule (u-independent)
[321.010253] Starting subtest: u-independent
[321.012614] Starting dynamic subtest: rcs0
[322.354261] Dynamic subtest rcs0: SUCCESS (1.353s)
[322.367152] Starting dynamic subtest: vcs0
[324.377271] Dynamic subtest vcs0: SUCCESS (2.019s)
[324.390710] Starting dynamic subtest: vcs1
[326.406451] Dynamic subtest vcs1: SUCCESS (2.027s)
[326.419606] Starting dynamic subtest: vecs0
[328.401934] Dynamic subtest vecs0: SUCCESS (1.994s)
[328.415153] Starting dynamic subtest: ccs0
[330.354294] Dynamic subtest ccs0: SUCCESS (1.949s)
[330.356918] Subtest u-independent: SUCCESS (9.353s)
[330.666304] [080/133] (698s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[330.788527] Starting subtest: fbc-pr-cursor-plane-update-sf
[330.792907] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[330.868759] [081/133] (698s left) kms_sequence (queue-busy)
[330.969085] Starting subtest: queue-busy
[330.971365] Starting dynamic subtest: pipe-A-eDP-1
[332.908611] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[332.918736] Starting dynamic subtest: pipe-B-eDP-1
[335.479901] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.572s)
[335.495002] Starting dynamic subtest: pipe-C-eDP-1
[338.092155] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[338.102829] Starting dynamic subtest: pipe-D-eDP-1
[340.646800] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s)
[340.649066] Subtest queue-busy: SUCCESS (9.677s)
[341.458032] [082/133] (687s left) kms_chamelium_audio (hdmi-audio)
[341.851822] Subtest hdmi-audio: SKIP (0.000s)
[342.651644] [083/133] (686s left) gem_mmap_gtt (big-bo-tiledy)
[342.715388] Subtest big-bo-tiledY: SKIP (0.000s)
[342.782165] [084/133] (686s left) gem_mmap_wc (write-prefaulted)
[342.845983] Subtest write-prefaulted: SKIP (0.000s)
[342.913204] [085/133] (686s left) gem_exec_fence (syncobj-unused-fence)
[343.389980] Starting subtest: syncobj-unused-fence
[343.395771] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[345.457513] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[345.460920] [086/133] (683s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[345.526179] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[345.631500] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[345.731108] [087/133] (683s left) i915_hangman (engine-engine-hang)
[345.808163] Starting subtest: engine-engine-hang
[345.810505] Starting dynamic subtest: rcs0
[347.346217] Dynamic subtest rcs0: SUCCESS (1.537s)
[347.359715] Starting dynamic subtest: bcs0
[349.328285] Dynamic subtest bcs0: SUCCESS (1.980s)
[349.341333] Starting dynamic subtest: vcs0
[351.313338] Dynamic subtest vcs0: SUCCESS (1.982s)
[351.326186] Starting dynamic subtest: vcs1
[353.298235] Dynamic subtest vcs1: SUCCESS (1.982s)
[353.310764] Starting dynamic subtest: vecs0
[355.345318] Dynamic subtest vecs0: SUCCESS (2.045s)
[355.357902] Starting dynamic subtest: ccs0
[357.328539] Dynamic subtest ccs0: SUCCESS (1.981s)
[357.331322] Subtest engine-engine-hang: SUCCESS (11.523s)
[357.426104] [088/133] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[357.541924] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[357.544208] Starting dynamic subtest: pipe-A-eDP-1
[357.600265] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[357.615156] Starting dynamic subtest: pipe-B-eDP-1
[357.672218] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[357.684674] Starting dynamic subtest: pipe-C-eDP-1
[357.742050] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[357.753924] Starting dynamic subtest: pipe-D-eDP-1
[357.810453] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[357.814652] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[359.845819] [089/133] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[359.939238] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[359.943949] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[360.044378] [090/133] (669s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[360.146026] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[360.150166] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[360.231240] [091/133] (669s left) prime_mmap (test_map_unmap)
[360.305335] Starting subtest: test_map_unmap
[360.307304] Starting dynamic subtest: test_map_unmap-smem
[360.335688] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[360.338100] Subtest test_map_unmap: SUCCESS (0.032s)
[360.474674] [092/133] (668s left) prime_self_import (basic-with_two_bos)
[360.506485] Starting subtest: basic-with_two_bos
[360.538099] Subtest basic-with_two_bos: SUCCESS (0.032s)
[360.679477] [093/133] (668s left) sysfs_preempt_timeout (invalid)
[360.745771] Starting subtest: invalid
[360.748009] Starting dynamic subtest: vecs0
[360.750177] Dynamic subtest vecs0: SUCCESS (0.000s)
[360.764980] Starting dynamic subtest: ccs0
[360.766776] Dynamic subtest ccs0: SUCCESS (0.000s)
[360.776698] Starting dynamic subtest: vcs0
[360.778443] Dynamic subtest vcs0: SUCCESS (0.000s)
[360.787619] Starting dynamic subtest: bcs0
[360.789427] Dynamic subtest bcs0: SUCCESS (0.000s)
[360.798563] Starting dynamic subtest: rcs0
[360.800374] Dynamic subtest rcs0: SUCCESS (0.000s)
[360.809612] Starting dynamic subtest: vcs1
[360.811144] Dynamic subtest vcs1: SUCCESS (0.000s)
[360.813018] Subtest invalid: SUCCESS (0.006s)
[360.883190] [094/133] (668s left) kms_big_fb (linear-64bpp-rotate-180)
[360.989743] Starting subtest: linear-64bpp-rotate-180
[362.514427] Subtest linear-64bpp-rotate-180: SUCCESS (1.523s)
[362.703890] [095/133] (666s left) gem_tiled_pread_pwrite
[362.840862] [096/133] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[362.950992] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[368.227201] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.279s)
[369.457811] [097/133] (660s left) gem_fence_thrash (bo-write-verify-y)
[369.500102] Starting subtest: bo-write-verify-y
[369.525848] Subtest bo-write-verify-y: SKIP (0.023s)
[369.593325] [098/133] (660s left) kms_big_fb (4-tiled-addfb)
[369.692564] Starting subtest: 4-tiled-addfb
[369.694845] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[369.822506] [099/133] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[369.919965] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[374.405948] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.490s)
[375.545892] [100/133] (654s left) gem_exec_fence (syncobj-timeline-chain-engines)
[376.089828] Starting subtest: syncobj-timeline-chain-engines
[376.223761] Subtest syncobj-timeline-chain-engines: SUCCESS (0.134s)
[377.456891] [101/133] (652s left) kms_pm_rpm (modeset-non-lpsp)
[379.579083] Starting subtest: modeset-non-lpsp
[380.725213] Subtest modeset-non-lpsp: SKIP (1.146s)
[381.134722] [102/133] (648s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[381.243605] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[381.377965] [103/133] (648s left) kms_cursor_crc (cursor-size-hints)
[381.516053] Starting subtest: cursor-size-hints
[381.518219] Starting dynamic subtest: pipe-A-eDP-1
[382.121234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[382.131641] Starting dynamic subtest: pipe-D-eDP-1
[383.343847] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[383.346132] Subtest cursor-size-hints: SUCCESS (1.831s)
[384.169258] [104/133] (645s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[384.280641] Starting subtest: yf-tiled-addfb-size-overflow
[384.284986] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[384.425922] [105/133] (645s left) gem_pxp (verify-pxp-stale-ctx-execution)
[384.550286] Starting subtest: verify-pxp-stale-ctx-execution
[385.610592] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.059s)
[385.738306] [106/133] (644s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[385.840661] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[386.875491] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[387.021260] [107/133] (643s left) kms_psr (psr2-cursor-mmap-cpu)
[387.110350] Starting subtest: psr2-cursor-mmap-cpu
[387.112235] Starting dynamic subtest: eDP-1
[388.825681] Dynamic subtest eDP-1: SUCCESS (1.715s)
[388.828063] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.716s)
[389.655496] [108/133] (640s left) kms_psr (fbc-psr-sprite-plane-onoff)
[389.756852] Starting subtest: fbc-psr-sprite-plane-onoff
[389.759145] Starting dynamic subtest: eDP-1
[389.763336] Dynamic subtest eDP-1: SKIP (0.000s)
[389.767491] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[389.842059] [109/133] (640s left) kms_pm_rpm (fences-dpms)
[391.469457] Starting subtest: fences-dpms
[391.474227] Subtest fences-dpms: SKIP (0.000s)
[392.097167] [110/133] (638s left) prime_mmap_coherency (read)
[392.159495] Starting subtest: read
[397.533487] Subtest read: SUCCESS (5.374s)
[397.703771] [111/133] (632s left) gem_exec_fence (basic-busy-all)
[397.773419] Starting subtest: basic-busy-all
[397.893930] Subtest basic-busy-all: SUCCESS (0.121s)
[399.437713] [112/133] (630s left) prime_vgem (basic-fence-flip)
[399.518549] Starting subtest: basic-fence-flip
[399.810286] Subtest basic-fence-flip: SUCCESS (0.291s)
[399.942817] [113/133] (630s left) syncobj_wait (invalid-signal-bad-pad)
[400.009050] Starting subtest: invalid-signal-bad-pad
[400.011227] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[400.119708] [114/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[400.223968] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[400.228250] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[400.346420] [115/133] (630s left) kms_big_fb (x-tiled-addfb)
[400.441705] Starting subtest: x-tiled-addfb
[400.443936] Subtest x-tiled-addfb: SUCCESS (0.000s)
[400.549377] [116/133] (629s left) gem_ctx_persistence (legacy-engines-hostile)
[400.627281] Starting subtest: legacy-engines-hostile
[400.629217] Starting dynamic subtest: render
[400.765831] Dynamic subtest render: SUCCESS (0.139s)
[400.778988] Starting dynamic subtest: bsd1
[400.885263] Dynamic subtest bsd1: SUCCESS (0.117s)
[400.900522] Starting dynamic subtest: bsd2
[401.025836] Dynamic subtest bsd2: SUCCESS (0.137s)
[401.038962] Starting dynamic subtest: blt
[401.143796] Dynamic subtest blt: SUCCESS (0.115s)
[401.159178] Starting dynamic subtest: vebox
[401.265399] Dynamic subtest vebox: SUCCESS (0.119s)
[401.267628] Subtest legacy-engines-hostile: SUCCESS (0.642s)
[401.370938] [117/133] (629s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[401.479277] Starting subtest: 4-tiled-16bpp-rotate-180
[402.747273] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.268s)
[402.909213] [118/133] (627s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[403.005426] Starting subtest: compare-crc-sanitycheck-nv12
[403.007266] Starting dynamic subtest: pipe-A-eDP-1
[403.689501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[403.700530] Starting dynamic subtest: pipe-B-eDP-1
[404.935107] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[404.946077] Starting dynamic subtest: pipe-C-eDP-1
[406.195531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.258s)
[406.205957] Starting dynamic subtest: pipe-D-eDP-1
[407.445682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[407.448181] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.443s)
[408.296779] [119/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[408.408201] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[415.075934] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.671s)
[415.236919] [120/133] (615s left) kms_flip (wf_vblank-ts-check-interruptible)
[415.331234] Starting subtest: wf_vblank-ts-check-interruptible
[415.333522] Starting dynamic subtest: A-eDP1
[424.228618] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[424.240951] Starting dynamic subtest: B-eDP1
[433.154332] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[433.167468] Starting dynamic subtest: C-eDP1
[442.065752] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[442.076619] Starting dynamic subtest: D-eDP1
[450.918575] Dynamic subtest D-eDP1: SUCCESS (8.849s)
[450.924021] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.587s)
[452.160853] [121/133] (578s left) gem_eio (create)
[452.400495] Starting subtest: create
[452.753139] Subtest create: SUCCESS (0.351s)
[452.914236] [122/133] (577s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[453.052252] Starting subtest: dp-mst-lic-type-0-hdcp14
[453.056616] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[453.204986] [123/133] (577s left) kms_vblank (query-idle)
[453.303335] Starting subtest: query-idle
[453.304931] Starting dynamic subtest: pipe-A-eDP-1
[455.054935] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[455.070393] Starting dynamic subtest: pipe-D-eDP-1
[457.492900] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[457.495190] Subtest query-idle: SUCCESS (4.188s)
[458.338310] [124/133] (572s left) kms_plane_scaling (invalid-num-scalers)
[458.439055] Starting subtest: invalid-num-scalers
[458.441319] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[458.458124] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[458.468462] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[458.490409] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[458.500784] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[458.522618] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[458.532868] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[458.559483] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[458.561615] Subtest invalid-num-scalers: SUCCESS (0.121s)
[458.691279] [125/133] (572s left) kms_cursor_crc (cursor-onscreen-512x170)
[459.011849] Starting subtest: cursor-onscreen-512x170
[459.015638] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[459.156984] [126/133] (571s left) kms_rotation_crc (primary-rotation-270)
[459.271302] Starting subtest: primary-rotation-270
[459.275067] Subtest primary-rotation-270: SKIP (0.001s)
[459.355842] [127/133] (571s left) perf (invalid-oa-metric-set-id)
[459.456314] Starting subtest: invalid-oa-metric-set-id
[459.465270] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[459.510195] [128/133] (571s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[459.576817] Starting subtest: single-wait-all-for-submit-available-submitted
[459.578946] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[459.705015] [129/133] (571s left) kms_draw_crc (draw-method-render)
[459.790102] Starting subtest: draw-method-render
[459.791934] Starting dynamic subtest: xrgb8888-untiled
[460.031940] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[460.041950] Starting dynamic subtest: rgb565-untiled
[460.254351] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[460.264681] Starting dynamic subtest: xrgb2101010-untiled
[460.465707] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[460.475719] Starting dynamic subtest: xbgr16161616f-untiled
[460.676644] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[460.687429] Starting dynamic subtest: xrgb8888-xtiled
[460.798717] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[460.809131] Starting dynamic subtest: rgb565-xtiled
[460.909999] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[460.920111] Starting dynamic subtest: xrgb2101010-xtiled
[461.021221] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[461.031441] Starting dynamic subtest: xbgr16161616f-xtiled
[461.154459] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[461.164723] Starting dynamic subtest: xrgb8888-4tiled
[461.288418] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[461.304791] Starting dynamic subtest: rgb565-4tiled
[461.421136] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[461.431718] Starting dynamic subtest: xrgb2101010-4tiled
[461.532386] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[461.552157] Starting dynamic subtest: xbgr16161616f-4tiled
[461.665631] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[461.667601] Subtest draw-method-render: SUCCESS (1.878s)
[461.819514] [130/133] (569s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[461.948283] Starting subtest: basic-flip-before-cursor-legacy
[462.862817] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.913s)
[463.751219] [131/133] (567s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[463.846663] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[463.851047] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[463.984346] [132/133] (567s left) perf_pmu (idle-no-semaphores)
[464.024618] Starting subtest: idle-no-semaphores
[464.026793] Starting dynamic subtest: rcs0
[464.585919] Dynamic subtest rcs0: SUCCESS (0.561s)
[464.599130] Starting dynamic subtest: bcs0
[465.112082] Dynamic subtest bcs0: SUCCESS (0.523s)
[465.125624] Starting dynamic subtest: vcs0
[465.628366] Dynamic subtest vcs0: SUCCESS (0.513s)
[465.640747] Starting dynamic subtest: vcs1
[466.155817] Dynamic subtest vcs1: SUCCESS (0.524s)
[466.174142] Starting dynamic subtest: vecs0
[466.684966] Dynamic subtest vecs0: SUCCESS (0.527s)
[466.698188] Starting dynamic subtest: ccs0
[467.214268] Dynamic subtest ccs0: SUCCESS (0.526s)
[467.217161] Subtest idle-no-semaphores: SUCCESS (3.190s)
[467.343304] [133/133] (563s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[467.407022] Starting subtest: multi-wait-all-for-submit-signaled
[467.409430] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[467.529917] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: prime_mmap_coherency
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: core_getversion
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_madvise
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_pipe_b_c_ivb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_sequence
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: sysfs_preempt_timeout
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_tiled_pread_pwrite
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: syncobj_wait
Done.