[62.434342] Initializing watchdogs
[62.434426]   /dev/watchdog0
[62.449351] [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]
[62.454201] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.456930] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.460641] [001/156] (960s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[62.579336] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[62.584035] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[63.748958] [002/156] (959s left) sysfs_defaults (readonly)
[63.813891] Starting subtest: readonly
[63.816365] Starting dynamic subtest: vecs0
[63.818726] Dynamic subtest vecs0: SUCCESS (0.000s)
[63.828127] Starting dynamic subtest: ccs0
[63.830361] Dynamic subtest ccs0: SUCCESS (0.000s)
[63.837728] Starting dynamic subtest: vcs0
[63.839970] Dynamic subtest vcs0: SUCCESS (0.000s)
[63.847533] Starting dynamic subtest: bcs0
[63.849775] Dynamic subtest bcs0: SUCCESS (0.000s)
[63.860351] Starting dynamic subtest: rcs0
[63.862300] Dynamic subtest rcs0: SUCCESS (0.000s)
[63.870278] Starting dynamic subtest: vcs1
[63.872454] Dynamic subtest vcs1: SUCCESS (0.000s)
[63.874692] Subtest readonly: SUCCESS (0.003s)
[63.910319] [003/156] (959s left) gem_exec_whisper (basic-fds-forked-all)
[63.978772] Starting subtest: basic-fds-forked-all
[85.002090] Subtest basic-fds-forked-all: SUCCESS (21.010s)
[85.200371] [004/156] (937s left) gen3_render_tiledy_blits
[85.305248] [005/156] (937s left) gem_mmap_wc (write-prefaulted)
[85.355085] Subtest write-prefaulted: SKIP (0.000s)
[85.408594] [006/156] (937s left) gem_gpgpu_fill (offset-16x16)
[85.459719] Starting subtest: offset-16x16
[85.464121] Subtest offset-16x16: SUCCESS (0.007s)
[85.595773] [007/156] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[85.710294] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[89.903622] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (4.199s)
[91.079843] [008/156] (932s left) gem_exec_reloc (basic-wc-read-noreloc)
[91.144332] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[91.213502] [009/156] (932s left) gem_userptr_blits (create-destroy-sync)
[91.288629] Starting subtest: create-destroy-sync
[96.304137] Subtest create-destroy-sync: SUCCESS (5.016s)
[96.422193] [010/156] (926s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[96.554732] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[128.521831] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.964s)
[129.386755] [011/156] (893s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[129.440818] Starting subtest: y-tiled-to-vebox-y-tiled
[129.444984] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[129.619357] [012/156] (893s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[129.670364] Starting subtest: saturated-hostile-nopreempt
[129.672657] Starting dynamic subtest: rcs0
[129.747039] Dynamic subtest rcs0: SKIP (0.074s)
[129.758140] Starting dynamic subtest: bcs0
[129.766732] Dynamic subtest bcs0: SKIP (0.019s)
[129.777179] Starting dynamic subtest: vcs0
[129.781624] Dynamic subtest vcs0: SKIP (0.013s)
[129.790079] Starting dynamic subtest: vcs1
[129.796686] Dynamic subtest vcs1: SKIP (0.015s)
[129.807514] Starting dynamic subtest: vecs0
[129.819101] Dynamic subtest vecs0: SKIP (0.023s)
[129.827404] Starting dynamic subtest: ccs0
[129.836542] Dynamic subtest ccs0: SKIP (0.018s)
[129.840769] Subtest saturated-hostile-nopreempt: SKIP (0.164s)
[129.922222] [013/156] (893s left) api_intel_bb (render-ccs)
[129.971887] Starting subtest: render-ccs
[130.330791] Subtest render-ccs: SUCCESS (0.359s)
[130.453162] [014/156] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[130.555189] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[130.559347] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[130.662209] [015/156] (892s left) i915_drm_fdinfo (virtual-busy-idle)
[130.703515] Starting subtest: virtual-busy-idle
[130.707630] Subtest virtual-busy-idle: SKIP (0.000s)
[130.770585] [016/156] (892s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[130.871834] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[130.876240] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[130.962061] [017/156] (892s left) i915_pm_rps (thresholds)
[131.031686] Starting subtest: thresholds
[131.036428] Subtest thresholds: SKIP (0.001s)
[131.129161] [018/156] (892s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[131.227516] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[131.232070] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[131.321250] [019/156] (892s left) gem_mmap_wc (read)
[131.383808] Subtest read: SKIP (0.000s)
[131.445591] [020/156] (892s left) gem_ctx_shared (q-independent)
[131.506063] Starting subtest: Q-independent
[131.508081] Starting dynamic subtest: rcs0
[131.577560] Dynamic subtest rcs0: SUCCESS (0.071s)
[131.589039] Starting dynamic subtest: vcs0
[131.616763] Dynamic subtest vcs0: SUCCESS (0.040s)
[131.625400] Starting dynamic subtest: vcs1
[131.659036] Dynamic subtest vcs1: SUCCESS (0.042s)
[131.668243] Starting dynamic subtest: vecs0
[131.702473] Dynamic subtest vecs0: SUCCESS (0.043s)
[131.712053] Starting dynamic subtest: ccs0
[131.748172] Dynamic subtest ccs0: SUCCESS (0.045s)
[131.750274] Subtest Q-independent: SUCCESS (0.242s)
[133.401392] [021/156] (890s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[133.525398] Starting subtest: flip-vs-cursor-toggle
[142.700751] Subtest flip-vs-cursor-toggle: SUCCESS (9.174s)
[143.510930] [022/156] (880s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[143.607851] Starting subtest: 4-tiled-64bpp-rotate-270
[143.627566] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[143.740030] [023/156] (880s left) kms_selftest (drm_format_helper)
[143.773652] Starting subtest: drm_format_helper
[143.840796] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[143.946526] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.105s)
[143.957157] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[144.048273] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.103s)
[144.059757] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[144.150924] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.102s)
[144.159765] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[144.248403] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.097s)
[144.258257] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[144.365075] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.116s)
[144.375927] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[144.475246] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.110s)
[144.485381] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[144.582392] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.106s)
[144.593186] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[144.694497] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.111s)
[144.705252] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[144.802496] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.108s)
[144.813097] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[144.901166] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.097s)
[144.911508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[145.001226] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.102s)
[145.012123] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[145.121191] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.118s)
[145.131676] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[145.240264] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.120s)
[145.251680] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[145.397304] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.126s)
[145.409334] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[145.461413] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[145.470356] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[145.549916] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.088s)
[145.560401] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[145.659190] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.108s)
[145.661436] Subtest drm_format_helper: SUCCESS (1.887s)
[145.841253] [024/156] (877s left) gem_exec_balancer (parallel)
[146.099996] Starting subtest: parallel
[147.079932] Subtest parallel: SUCCESS (0.981s)
[147.379206] [025/156] (876s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[147.464926] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[147.469285] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[147.533543] [026/156] (876s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[147.626037] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[147.630268] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[147.721992] [027/156] (876s left) kms_plane_alpha_blend (constant-alpha-max)
[147.809206] Starting subtest: constant-alpha-max
[148.091451] Starting dynamic subtest: pipe-A-eDP-1
[149.160802] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.068s)
[149.175149] Starting dynamic subtest: pipe-D-eDP-1
[150.856446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.693s)
[150.858844] Subtest constant-alpha-max: SUCCESS (3.047s)
[151.669140] [028/156] (872s left) sriov_basic (enable-vfs-autoprobe-on)
[151.727233] Starting subtest: enable-vfs-autoprobe-on
[151.729662] Starting dynamic subtest: numvfs-1
[151.804195] Dynamic subtest numvfs-1: FAIL (0.015s)
[151.814551] Starting dynamic subtest: numvfs-2
[151.887727] Dynamic subtest numvfs-2: FAIL (0.004s)
[151.899679] Starting dynamic subtest: numvfs-3
[151.973702] Dynamic subtest numvfs-3: FAIL (0.004s)
[151.983675] Starting dynamic subtest: numvfs-4
[152.056462] Dynamic subtest numvfs-4: FAIL (0.003s)
[152.066377] Starting dynamic subtest: numvfs-5
[152.137668] Dynamic subtest numvfs-5: FAIL (0.004s)
[152.148729] Starting dynamic subtest: numvfs-6
[152.224596] Dynamic subtest numvfs-6: FAIL (0.004s)
[152.237727] Starting dynamic subtest: numvfs-7
[152.311683] Dynamic subtest numvfs-7: FAIL (0.003s)
[152.321203] Starting dynamic subtest: numvfs-random
[152.390169] Dynamic subtest numvfs-random: FAIL (0.004s)
[152.399030] Starting dynamic subtest: numvfs-all
[152.470730] Dynamic subtest numvfs-all: FAIL (0.521s)
[152.472967] Subtest enable-vfs-autoprobe-on: FAIL (0.566s)
[152.507943] [029/156] (871s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[152.602427] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[152.606057] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[152.692852] [030/156] (871s left) kms_big_fb (x-tiled-addfb)
[152.790692] Starting subtest: x-tiled-addfb
[152.792693] Subtest x-tiled-addfb: SUCCESS (0.000s)
[152.887967] [031/156] (871s left) gem_userptr_blits (coherency-sync)
[152.945327] Starting subtest: coherency-sync
[153.295063] Subtest coherency-sync: SKIP (0.311s)
[153.411608] [032/156] (870s left) gem_exec_schedule (preempt-user)
[153.534159] Starting subtest: preempt-user
[153.536241] Starting dynamic subtest: rcs0
[153.556101] Dynamic subtest rcs0: SUCCESS (0.024s)
[153.567949] Starting dynamic subtest: bcs0
[153.575441] Dynamic subtest bcs0: SUCCESS (0.019s)
[153.584618] Starting dynamic subtest: vcs0
[153.595582] Dynamic subtest vcs0: SUCCESS (0.020s)
[153.607336] Starting dynamic subtest: vcs1
[153.616637] Dynamic subtest vcs1: SUCCESS (0.021s)
[153.626400] Starting dynamic subtest: vecs0
[153.635371] Dynamic subtest vecs0: SUCCESS (0.018s)
[153.645504] Starting dynamic subtest: ccs0
[153.658313] Dynamic subtest ccs0: SUCCESS (0.023s)
[153.660486] Subtest preempt-user: SUCCESS (0.127s)
[155.345780] [033/156] (868s left) i915_drm_fdinfo (busy-idle-check-all)
[155.390962] Starting subtest: busy-idle-check-all
[155.393338] Starting dynamic subtest: rcs0
[155.397952] Dynamic subtest rcs0: SKIP (0.003s)
[155.408668] Starting dynamic subtest: bcs0
[155.412961] Dynamic subtest bcs0: SKIP (0.000s)
[155.424709] Starting dynamic subtest: vcs0
[155.428918] Dynamic subtest vcs0: SKIP (0.000s)
[155.438069] Starting dynamic subtest: vcs1
[155.442151] Dynamic subtest vcs1: SKIP (0.000s)
[155.451185] Starting dynamic subtest: vecs0
[155.455174] Dynamic subtest vecs0: SKIP (0.000s)
[155.463738] Starting dynamic subtest: ccs0
[155.467696] Dynamic subtest ccs0: SKIP (0.000s)
[155.471721] Subtest busy-idle-check-all: SKIP (0.007s)
[155.507061] [034/156] (868s left) kms_plane (plane-panning-top-left)
[155.658429] Starting subtest: plane-panning-top-left
[155.660485] Starting dynamic subtest: pipe-A
[157.324915] Dynamic subtest pipe-A: SUCCESS (1.668s)
[157.335577] Starting dynamic subtest: pipe-B
[159.679938] Dynamic subtest pipe-B: SUCCESS (2.352s)
[159.682669] Subtest plane-panning-top-left: SUCCESS (4.022s)
[160.501411] [035/156] (863s left) dumb_buffer (create-valid-dumb)
[160.564107] Starting subtest: create-valid-dumb
[160.566479] Subtest create-valid-dumb: SUCCESS (0.000s)
[160.673065] [036/156] (863s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[160.765714] Starting subtest: psr-2p-primscrn-cur-indfb-move
[160.769981] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[160.853999] [037/156] (863s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[160.942091] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[160.946613] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[161.013978] [038/156] (863s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[161.119242] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[161.123203] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[161.209932] [039/156] (863s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[161.303692] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[161.307873] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[161.394157] [040/156] (863s left) kms_frontbuffer_tracking (hdr-1p-rte)
[161.486890] Starting subtest: hdr-1p-rte
[161.490298] Subtest hdr-1p-rte: SKIP (0.000s)
[161.590939] [041/156] (862s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[161.697823] Starting subtest: fbc-indfb-scaledprimary
[164.552960] Subtest fbc-indfb-scaledprimary: SUCCESS (2.860s)
[165.719657] [042/156] (858s left) vgem_basic (sysfs)
[165.795741] Starting subtest: sysfs
[165.797611] Subtest sysfs: SUCCESS (0.001s)
[165.863816] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[165.867500] [043/156] (858s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[165.919553] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[165.975436] [044/156] (858s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[166.072170] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[166.076499] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[166.186985] [045/156] (858s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[166.282243] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[166.286197] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[166.390323] [046/156] (858s left) gem_compute (compute-square)
[166.442198] Starting subtest: compute-square
[166.446840] Subtest compute-square: SUCCESS (0.007s)
[166.554080] [047/156] (858s left) gem_exec_reloc (basic-concurrent16)
[166.607686] Subtest basic-concurrent16: SKIP (0.000s)
[166.677611] [048/156] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[166.785576] Starting subtest: basic-busy-flip-before-cursor-atomic
[166.789374] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[166.930459] [049/156] (857s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[166.975756] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[167.076361] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[167.153687] [050/156] (857s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[169.399124] Starting subtest: modeset-non-lpsp-stress-no-wait
[169.460370] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.061s)
[169.795556] [051/156] (855s left) kms_setmode (invalid-clone-single-crtc)
[169.860501] Starting subtest: invalid-clone-single-crtc
[169.867186] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[169.983745] [052/156] (854s left) syncobj_wait (wait-any-complex)
[170.046776] Starting subtest: wait-any-complex
[170.109224] Subtest wait-any-complex: SUCCESS (0.062s)
[170.203488] [053/156] (854s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[170.307861] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[170.312025] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[170.415181] [054/156] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[170.505138] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[170.509278] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[170.600495] [055/156] (854s left) kms_frontbuffer_tracking (psr-suspend)
[170.698514] Starting subtest: psr-suspend
[208.651220] Subtest psr-suspend: SUCCESS (8.060s)
[208.758622] [056/156] (816s left) kms_flip (flip-vs-suspend-interruptible)
[208.857030] Starting subtest: flip-vs-suspend-interruptible
[208.859029] Starting dynamic subtest: A-eDP1
[354.119495] Dynamic subtest A-eDP1: SUCCESS (11.178s)
[354.121799] Subtest flip-vs-suspend-interruptible: SUCCESS (11.180s)
[354.258289] [057/156] (670s left) perf_pmu (busy-double-start)
[354.306297] Starting subtest: busy-double-start
[354.308400] Starting dynamic subtest: rcs0
[357.948926] Dynamic subtest rcs0: FAIL (3.586s)
[357.959916] Starting dynamic subtest: bcs0
[361.468356] Dynamic subtest bcs0: SUCCESS (3.565s)
[361.481453] Starting dynamic subtest: vcs0
[365.793688] Dynamic subtest vcs0: FAIL (4.251s)
[365.805254] Starting dynamic subtest: vcs1
[369.790276] Dynamic subtest vcs1: SUCCESS (4.062s)
[369.803034] Starting dynamic subtest: vecs0
[373.794530] Dynamic subtest vecs0: FAIL (3.930s)
[373.806508] Starting dynamic subtest: ccs0
[377.361062] Dynamic subtest ccs0: FAIL (3.564s)
[377.362948] Subtest busy-double-start: FAIL (22.964s)
[377.411989] [058/156] (647s left) gen9_exec_parse (allowed-all)
[377.486609] Subtest allowed-all: SKIP (0.000s)
[377.552043] [059/156] (647s left) kms_dp_link_training (uhbr-sst)
[377.663550] Starting subtest: uhbr-sst
[377.671751] Subtest uhbr-sst: SKIP (0.000s)
[377.738839] [060/156] (647s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[377.830883] Starting subtest: random-ccs-data-y-tiled-ccs
[377.833223] Starting dynamic subtest: pipe-A-eDP-1
[377.858658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.869933] Starting dynamic subtest: pipe-B-eDP-1
[377.893996] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.904309] Starting dynamic subtest: pipe-C-eDP-1
[377.928394] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.938592] Starting dynamic subtest: pipe-D-eDP-1
[377.963227] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.967326] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[380.149420] [061/156] (645s left) gem_caching (writes)
[380.205051] Subtest writes: SKIP (0.000s)
[380.279726] [062/156] (645s left) syncobj_timeline (multi-wait-for-submit-signaled)
[380.335168] Starting subtest: multi-wait-for-submit-signaled
[380.337544] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[380.439998] [063/156] (645s left) kms_big_fb (x-tiled-addfb-size-overflow)
[380.550242] Starting subtest: x-tiled-addfb-size-overflow
[380.552572] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[380.669400] [064/156] (644s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[380.779008] Starting subtest: fbcpsrhdr-modesetfrombusy
[380.783494] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[380.889000] [065/156] (644s left) gem_watchdog (default-physical)
[380.962865] Starting subtest: default-physical
[382.722856] Subtest default-physical: SUCCESS (1.769s)
[382.828791] [066/156] (642s left) gem_set_tiling_vs_pwrite
[382.943143] [067/156] (642s left) syncobj_eventfd (invalid-illegal-handle)
[383.009244] Starting subtest: invalid-illegal-handle
[383.011419] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[383.125603] [068/156] (642s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[383.222936] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[383.227160] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[383.323014] [069/156] (642s left) kms_plane_multiple (tiling-4)
[383.424354] Starting subtest: tiling-4
[383.427269] Starting dynamic subtest: pipe-A-eDP-1
[387.225901] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.798s)
[387.237300] Starting dynamic subtest: pipe-B-eDP-1
[391.743436] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.516s)
[391.754484] Starting dynamic subtest: pipe-C-eDP-1
[396.111752] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.363s)
[396.123148] Starting dynamic subtest: pipe-D-eDP-1
[400.561718] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.448s)
[400.564261] Subtest tiling-4: SUCCESS (17.131s)
[401.378277] [070/156] (624s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[401.483667] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[401.487967] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.591294] [071/156] (624s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[401.689810] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[401.694000] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[401.789669] [072/156] (624s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[401.886169] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[401.890219] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[401.982241] [073/156] (623s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[402.076875] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[402.080724] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[402.153187] [074/156] (623s left) kms_pm_rpm (fences-dpms)
[404.379089] Starting subtest: fences-dpms
[404.384044] Subtest fences-dpms: SKIP (0.000s)
[404.784576] [075/156] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[404.894391] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[412.241041] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.347s)
[412.377441] [076/156] (613s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[412.474693] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[412.478839] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.571114] [077/156] (613s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[412.672435] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[412.676456] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[412.777892] [078/156] (613s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[412.873583] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[412.875829] Starting dynamic subtest: pipe-A-eDP-1
[412.884668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[412.897403] Starting dynamic subtest: pipe-B-eDP-1
[412.906536] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[412.916983] Starting dynamic subtest: pipe-C-eDP-1
[412.925404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[412.935680] Starting dynamic subtest: pipe-D-eDP-1
[412.944531] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[412.948686] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[415.160157] [079/156] (610s left) fbdev (unaligned-write)
[415.199042] Starting subtest: unaligned-write
[415.299306] Subtest unaligned-write: SUCCESS (0.100s)
[415.368329] [080/156] (610s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[415.467645] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[415.471695] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[415.590156] [081/156] (610s left) gem_tiled_pread_pwrite
[415.724869] [082/156] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[415.819697] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[423.208570] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.391s)
[423.335802] [083/156] (602s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[423.405072] Starting subtest: invalid-bsd1-flag-on-vebox
[423.407020] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[423.500062] [084/156] (602s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[423.626998] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[423.632050] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[423.773357] [085/156] (602s left) kms_getfb (getfb2-handle-closed)
[423.873263] Starting subtest: getfb2-handle-closed
[423.875495] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[423.972758] [086/156] (602s left) kms_busy (extended-pageflip-hang-oldfb)
[424.070176] Starting subtest: extended-pageflip-hang-oldfb
[424.072526] Starting dynamic subtest: pipe-A
[424.468895] Dynamic subtest pipe-A: SUCCESS (0.399s)
[424.480081] Starting dynamic subtest: pipe-D
[425.585221] Dynamic subtest pipe-D: SUCCESS (1.115s)
[425.587427] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.518s)
[426.427658] [087/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[426.535005] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[426.539451] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[426.640187] [088/156] (599s left) gem_exec_fence (submit-chain)
[426.818684] Starting subtest: submit-chain
[426.836023] Subtest submit-chain: SUCCESS (0.019s)
[428.350826] [089/156] (598s left) gem_ctx_create (basic)
[428.415542] Starting subtest: basic
[428.417465] Subtest basic: SUCCESS (0.000s)
[428.609793] [090/156] (598s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[428.703441] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[428.705704] Starting dynamic subtest: pipe-A-eDP-1
[428.726250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[428.741470] Starting dynamic subtest: pipe-B-eDP-1
[428.761122] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[428.772111] Starting dynamic subtest: pipe-C-eDP-1
[428.791988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[428.802686] Starting dynamic subtest: pipe-D-eDP-1
[428.823702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[428.826199] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[431.098840] [091/156] (595s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[431.196526] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[431.200779] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[431.278681] [092/156] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[431.374100] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[431.378424] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[431.482402] [093/156] (595s left) gem_mmap_gtt (basic-small-bo)
[431.537273] Subtest basic-small-bo: SKIP (0.000s)
[431.594720] [094/156] (595s left) kms_rotation_crc (sprite-rotation-90)
[431.683755] Starting subtest: sprite-rotation-90
[431.688235] Subtest sprite-rotation-90: SKIP (0.001s)
[431.767688] [095/156] (595s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[431.870857] Starting subtest: fbc-tiling-linear
[435.645517] Subtest fbc-tiling-linear: SUCCESS (3.779s)
[436.809485] [096/156] (590s left) gem_exec_flush (basic-wb-set-default)
[436.870310] Starting subtest: basic-wb-set-default
[442.329060] Subtest basic-wb-set-default: SUCCESS (5.457s)
[442.518366] [097/156] (584s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[442.627692] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[442.629966] Starting dynamic subtest: pipe-A-eDP-1
[442.653105] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[442.668733] Starting dynamic subtest: pipe-B-eDP-1
[442.691287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[442.702505] Starting dynamic subtest: pipe-C-eDP-1
[442.724821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[442.735149] Starting dynamic subtest: pipe-D-eDP-1
[442.757663] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.761881] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[444.954269] [098/156] (582s left) kms_color (ctm-0-75)
[445.041218] Starting subtest: ctm-0-75
[445.043192] Starting dynamic subtest: pipe-A-eDP-1
[449.997873] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.955s)
[450.009345] Starting dynamic subtest: pipe-B-eDP-1
[455.724463] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.721s)
[455.735604] Starting dynamic subtest: pipe-C-eDP-1
[461.118603] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.391s)
[461.129513] Starting dynamic subtest: pipe-D-eDP-1
[466.462064] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.340s)
[466.464291] Subtest ctm-0-75: SUCCESS (21.412s)
[467.297392] [099/156] (559s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[467.406259] Starting subtest: basic-max-pipe-crc-check
[467.410468] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[467.455831] [100/156] (559s left) kms_chamelium_hpd (hdmi-hpd-storm)
[467.846474] Subtest hdmi-hpd-storm: SKIP (0.000s)
[468.702341] [101/156] (558s left) tools_test (tools_test)
[468.756294] Starting subtest: tools_test
[468.811510] Subtest tools_test: SUCCESS (0.071s)
[468.888382] [102/156] (558s left) gem_gtt_cpu_tlb
[469.014330] [103/156] (558s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[469.110232] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[469.114738] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[469.213423] [104/156] (558s left) kms_psr (psr2-cursor-render)
[469.303292] Starting subtest: psr2-cursor-render
[469.305515] Starting dynamic subtest: eDP-1
[471.013318] Dynamic subtest eDP-1: SUCCESS (1.706s)
[471.015869] Subtest psr2-cursor-render: SUCCESS (1.707s)
[471.883329] [105/156] (555s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[471.984543] Starting subtest: yf-tiled-8bpp-rotate-0
[471.988878] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[472.084707] [106/156] (555s left) api_intel_allocator (default-alignment)
[472.136620] Starting subtest: default-alignment
[472.138810] Subtest default-alignment: SUCCESS (0.003s)
[472.266130] [107/156] (555s left) i915_pm_sseu (full-enable)
[472.329710] Subtest full-enable: SKIP (0.000s)
[472.443548] [108/156] (554s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[472.497743] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[472.604159] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[472.699619] [109/156] (554s left) kms_atomic (atomic-plane-damage)
[472.807612] Starting subtest: atomic-plane-damage
[472.853399] Starting dynamic subtest: pipe-A-eDP-1
[473.386304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[473.388486] Subtest atomic-plane-damage: SUCCESS (0.578s)
[474.217083] [110/156] (553s left) gem_exec_reloc (basic-cpu)
[474.285991] Subtest basic-cpu: SKIP (0.000s)
[474.361410] [111/156] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[474.472211] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[479.067511] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.600s)
[480.221831] [112/156] (547s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[480.337786] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[480.340054] Starting dynamic subtest: pipe-A-eDP-1
[480.413019] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[480.426712] Starting dynamic subtest: pipe-B-eDP-1
[481.585740] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[481.590321] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.250s)
[482.881149] [113/156] (544s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[482.983961] Starting subtest: y-tiled-8bpp-rotate-0
[482.988490] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[483.081861] [114/156] (544s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[483.187499] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[483.191907] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[483.288380] [115/156] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[483.396484] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[483.400952] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[483.503539] [116/156] (544s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[483.613457] Starting subtest: flip-vs-cursor-busy-crc-legacy
[484.356577] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.740s)
[485.217650] [117/156] (542s left) kms_psr (fbc-psr-no-drrs)
[485.319823] Starting subtest: fbc-psr-no-drrs
[485.322081] Starting dynamic subtest: eDP-1
[485.326252] Dynamic subtest eDP-1: SKIP (0.000s)
[485.330448] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[485.395520] [118/156] (542s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[485.500926] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[486.699296] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.606s)
[486.740034] [119/156] (541s left) kms_content_protection (mei-interface)
[486.871405] Starting subtest: mei-interface
[486.875022] Subtest mei-interface: SKIP (0.001s)
[486.991348] [120/156] (540s left) gem_ctx_param (vm)
[487.047055] Starting subtest: vm
[487.098126] Subtest vm: SUCCESS (0.050s)
[487.254558] [121/156] (540s left) gem_mmap_offset (bad-flags)
[487.310989] Starting subtest: bad-flags
[487.312889] Subtest bad-flags: SUCCESS (0.000s)
[487.423512] [122/156] (540s left) gem_softpin (noreloc-interruptible)
[487.490930] Starting subtest: noreloc-interruptible
[492.901723] Subtest noreloc-interruptible: SUCCESS (5.406s)
[493.023870] [123/156] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[493.123927] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[493.128148] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[493.225518] [124/156] (534s left) kms_chamelium_frames (vga-frame-dump)
[493.613138] Subtest vga-frame-dump: SKIP (0.000s)
[494.419015] [125/156] (533s left) gem_softpin (evict-single-offset)
[494.480403] Starting subtest: evict-single-offset
[522.209709] Subtest evict-single-offset: SUCCESS (27.713s)
[522.296560] [126/156] (505s left) gem_exec_reloc (basic-wc-cpu-active)
[522.389971] Subtest basic-wc-cpu-active: SKIP (0.000s)
[522.461521] [127/156] (505s left) syncobj_wait (single-wait-all-submitted)
[522.526435] Starting subtest: single-wait-all-submitted
[522.636985] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[522.716492] [128/156] (505s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[522.829075] Starting subtest: verify-pxp-execution-after-suspend-resume
[529.872171] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.040s)
[531.040525] [129/156] (498s left) perf_pmu (render-node-busy-idle)
[531.127306] Starting subtest: render-node-busy-idle
[531.129618] Starting dynamic subtest: rcs0
[531.819290] Dynamic subtest rcs0: SUCCESS (0.693s)
[531.833193] Starting dynamic subtest: bcs0
[532.482353] Dynamic subtest bcs0: SUCCESS (0.660s)
[532.494655] Starting dynamic subtest: vcs0
[534.240956] Dynamic subtest vcs0: SUCCESS (1.754s)
[534.253399] Starting dynamic subtest: vcs1
[536.224938] Dynamic subtest vcs1: SUCCESS (1.984s)
[536.237873] Starting dynamic subtest: vecs0
[538.208368] Dynamic subtest vecs0: SUCCESS (1.989s)
[538.220386] Starting dynamic subtest: ccs0
[538.881153] Dynamic subtest ccs0: SUCCESS (0.674s)
[538.883696] Subtest render-node-busy-idle: SUCCESS (7.771s)
[538.963463] [130/156] (490s left) kms_psr (fbc-pr-primary-mmap-cpu)
[539.074703] Starting subtest: fbc-pr-primary-mmap-cpu
[539.078859] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[539.150459] [131/156] (490s left) kms_feature_discovery (display-2x)
[539.248496] Starting subtest: display-2x
[539.252943] Subtest display-2x: SKIP (0.000s)
[539.322994] [132/156] (490s left) gem_exec_params (sol-reset-invalid)
[539.390504] Starting subtest: sol-reset-invalid
[539.395522] Subtest sol-reset-invalid: SUCCESS (0.004s)
[541.264953] [133/156] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[541.359952] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[541.363856] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[541.474885] [134/156] (488s left) gem_tiled_partial_pwrite_pread (writes)
[541.531725] Subtest writes: SKIP (0.000s)
[541.623304] [135/156] (487s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[541.749249] Starting subtest: basic-busy-flip-before-cursor-varying-size
[541.753821] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[541.906940] [136/156] (487s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[542.001707] Starting subtest: fbc-psr2-primary-mmap-gtt
[542.004085] Starting dynamic subtest: eDP-1
[542.008590] Dynamic subtest eDP-1: SKIP (0.000s)
[542.013226] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[542.088782] [137/156] (487s left) kms_cursor_crc (cursor-offscreen-max-size)
[542.388847] Starting subtest: cursor-offscreen-max-size
[542.394490] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[542.527061] [138/156] (487s left) kms_flip (basic-flip-vs-modeset)
[542.629048] Starting subtest: basic-flip-vs-modeset
[542.631012] Starting dynamic subtest: A-eDP1
[545.178989] Dynamic subtest A-eDP1: SUCCESS (2.553s)
[545.192138] Starting dynamic subtest: B-eDP1
[547.368972] Dynamic subtest B-eDP1: SUCCESS (2.190s)
[547.382846] Starting dynamic subtest: C-eDP1
[549.545548] Dynamic subtest C-eDP1: SUCCESS (2.178s)
[549.556484] Starting dynamic subtest: D-eDP1
[551.725370] Dynamic subtest D-eDP1: SUCCESS (2.180s)
[551.727684] Subtest basic-flip-vs-modeset: SUCCESS (9.110s)
[552.539369] [139/156] (477s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[552.655934] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[559.307214] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.658s)
[559.435500] [140/156] (470s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[559.488652] Starting subtest: multi-wait-all-for-submit-submitted
[559.596985] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[559.691348] [141/156] (470s left) kms_cursor_crc (cursor-random-256x85)
[559.938095] Starting subtest: cursor-random-256x85
[559.986508] Subtest cursor-random-256x85: SKIP (0.044s)
[560.175399] [142/156] (469s left) syncobj_timeline (wait-all-delayed-signal)
[560.235734] Starting subtest: wait-all-delayed-signal
[560.339673] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[560.431003] [143/156] (469s left) gem_exec_capture (capture-invisible)
[560.486211] Starting subtest: capture-invisible
[560.488076] Starting dynamic subtest: smem0
[560.491954] Dynamic subtest smem0: SKIP (0.000s)
[560.495784] Subtest capture-invisible: SKIP (0.001s)
[560.578316] [144/156] (469s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[560.693285] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[560.695716] Starting dynamic subtest: pipe-A-eDP-1
[571.383204] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.694s)
[571.395154] Starting dynamic subtest: pipe-B-eDP-1
[582.835609] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.449s)
[582.837882] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.147s)
[583.690466] [145/156] (446s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[583.794979] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[583.799419] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[583.883343] [146/156] (446s left) syncobj_basic (create-signaled)
[583.950691] Starting subtest: create-signaled
[583.952988] Subtest create-signaled: SUCCESS (0.000s)
[584.064270] [147/156] (446s left) kms_vblank (ts-continuation-modeset-hang)
[584.170738] Starting subtest: ts-continuation-modeset-hang
[584.172675] Starting dynamic subtest: pipe-A-eDP-1
[611.032744] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.863s)
[611.048253] Starting dynamic subtest: pipe-D-eDP-1
[636.006239] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.972s)
[636.008672] Subtest ts-continuation-modeset-hang: SUCCESS (51.839s)
[636.813736] [148/156] (393s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[636.924532] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[636.928728] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[637.014921] [149/156] (393s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[637.104286] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[637.106417] Starting dynamic subtest: pipe-A
[637.168399] Dynamic subtest pipe-A: SUCCESS (0.066s)
[637.181834] Starting dynamic subtest: pipe-B
[638.332774] Dynamic subtest pipe-B: SUCCESS (1.162s)
[638.346318] Starting dynamic subtest: pipe-C
[639.441369] Dynamic subtest pipe-C: SUCCESS (1.107s)
[639.459566] Starting dynamic subtest: pipe-D
[640.577468] Dynamic subtest pipe-D: SUCCESS (1.134s)
[640.579829] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.475s)
[641.737038] [150/156] (388s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[641.844462] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[641.848706] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[641.951178] [151/156] (388s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[642.012281] Starting subtest: multi-wait-all-for-submit-available-submitted
[642.014693] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[642.112070] [152/156] (388s left) kms_psr (psr-no-drrs)
[642.208555] Starting subtest: psr-no-drrs
[642.210896] Starting dynamic subtest: eDP-1
[643.826017] Dynamic subtest eDP-1: SUCCESS (1.618s)
[643.828247] Subtest psr-no-drrs: SUCCESS (1.619s)
[644.712396] [153/156] (385s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[644.798392] Starting subtest: primary-4-tiled-reflect-x-0
[651.817139] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.019s)
[652.990384] [154/156] (377s left) kms_addfb_basic (basic-x-tiled-legacy)
[653.051196] Starting subtest: basic-x-tiled-legacy
[653.055688] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[653.188450] [155/156] (377s left) prime_mmap (test_reprime)
[653.243152] Starting subtest: test_reprime
[653.245196] Starting dynamic subtest: test_reprime-smem
[653.273321] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[653.275808] Subtest test_reprime: SUCCESS (0.034s)
[653.388587] [156/156] (377s left) gem_exec_schedule (pi-shared-iova)
[653.567915] Starting subtest: pi-shared-iova
[653.570094] Starting dynamic subtest: rcs0
[653.644841] Dynamic subtest rcs0: SUCCESS (0.078s)
[653.657142] Starting dynamic subtest: vcs0
[653.711065] Dynamic subtest vcs0: SUCCESS (0.064s)
[653.723070] Starting dynamic subtest: vcs1
[653.766942] Dynamic subtest vcs1: SUCCESS (0.054s)
[653.778654] Starting dynamic subtest: vecs0
[653.820134] Dynamic subtest vecs0: SUCCESS (0.052s)
[653.831294] Starting dynamic subtest: ccs0
[653.875285] Dynamic subtest ccs0: SUCCESS (0.054s)
[653.877782] Subtest pi-shared-iova: SUCCESS (0.310s)
[655.304376] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: sysfs_defaults
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: gen3_render_tiledy_blits
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: gem_gpgpu_fill
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_selftest
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_plane_alpha_blend
results: parsing output: 27/ for test: sriov_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: vgem_basic
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_compute
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_setmode
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_dp_link_training
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_caching
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_watchdog
results: parsing output: 65/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_multiple
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: fbdev
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_tiled_pread_pwrite
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_ctx_create
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: kms_multipipe_modeset
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: tools_test
results: parsing output: 101/ for test: gem_gtt_cpu_tlb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: i915_pm_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_feature_discovery
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_cursor_crc
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: syncobj_wait
results: parsing output: 140/ for test: kms_cursor_crc
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: gem_exec_capture
results: parsing output: 143/ for test: kms_psr2_sf
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: syncobj_basic
results: parsing output: 146/ for test: kms_vblank
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_plane_scaling
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_rotation_crc
results: parsing output: 153/ for test: kms_addfb_basic
results: parsing output: 154/ for test: prime_mmap
results: parsing output: 155/ for test: gem_exec_schedule
Done.