[62.326889] Initializing watchdogs
[62.327025]   /dev/watchdog0
[62.342408] [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.347189] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.349573] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.352790] [001/133] (960s left) kms_getfb (getfb-handle-protection)
[62.470524] Starting subtest: getfb-handle-protection
[62.500649] Subtest getfb-handle-protection: SUCCESS (0.031s)
[62.615234] [002/133] (960s left) vgem_basic (bad-pad)
[62.679339] Starting subtest: bad-pad
[62.681227] Subtest bad-pad: SUCCESS (0.000s)
[62.732656] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[62.735569] [003/133] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[62.829334] Starting subtest: pr-cursor-plane-move-continuous-sf
[62.833793] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[62.894892] [004/133] (960s left) gem_exec_reloc (basic-gtt-noreloc)
[62.948535] Subtest basic-gtt-noreloc: SKIP (0.000s)
[63.007147] [005/133] (960s left) gem_softpin (softpin)
[63.060624] Starting subtest: softpin
[95.420522] Subtest softpin: SUCCESS (32.354s)
[95.544310] [006/133] (927s left) kms_flip (2x-flip-vs-modeset)
[95.654255] Starting subtest: 2x-flip-vs-modeset
[95.665404] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[95.743453] [007/133] (927s left) kms_psr (psr-sprite-blt)
[95.846986] Starting subtest: psr-sprite-blt
[95.849447] Starting dynamic subtest: eDP-1
[98.336881] Dynamic subtest eDP-1: SUCCESS (2.490s)
[98.339496] Subtest psr-sprite-blt: SUCCESS (2.490s)
[98.704191] [008/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[98.809796] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[98.811788] Starting dynamic subtest: pipe-A-eDP-1
[98.980908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[98.990999] Starting dynamic subtest: pipe-B-eDP-1
[99.011410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[99.018514] Starting dynamic subtest: pipe-C-eDP-1
[99.038153] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[99.045131] Starting dynamic subtest: pipe-D-eDP-1
[99.064798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[99.066643] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.170s)
[101.269480] [009/133] (921s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[101.357694] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[101.362203] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[101.430837] [010/133] (921s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[101.562733] Starting subtest: multiplane-atomic-fence-wait
[101.882623] Subtest multiplane-atomic-fence-wait: SUCCESS (0.319s)
[103.007499] [011/133] (920s left) kms_async_flips (invalid-async-flip-atomic)
[103.096694] Starting subtest: invalid-async-flip-atomic
[103.469093] Starting dynamic subtest: pipe-A-eDP-1
[104.328842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s)
[104.684783] Starting dynamic subtest: pipe-B-eDP-1
[105.477178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.799s)
[105.833244] Starting dynamic subtest: pipe-C-eDP-1
[106.686749] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.860s)
[107.040273] Starting dynamic subtest: pipe-D-eDP-1
[107.827385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.795s)
[107.829802] Subtest invalid-async-flip-atomic: SUCCESS (4.733s)
[108.974941] [012/133] (914s left) kms_content_protection (srm)
[109.111071] Starting subtest: srm
[109.117999] Subtest srm: SKIP (0.002s)
[109.220905] [013/133] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[109.329510] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[113.599732] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.274s)
[114.793578] [014/133] (908s left) syncobj_wait (invalid-wait-illegal-handle)
[114.847065] Starting subtest: invalid-wait-illegal-handle
[114.849080] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[114.941479] [015/133] (908s left) kms_flip (flip-vs-expired-vblank-interruptible)
[115.042328] Starting subtest: flip-vs-expired-vblank-interruptible
[115.044598] Starting dynamic subtest: A-eDP1
[123.687404] Dynamic subtest A-eDP1: SUCCESS (8.644s)
[123.696930] Starting dynamic subtest: B-eDP1
[132.320654] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[132.330476] Starting dynamic subtest: C-eDP1
[140.944333] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[140.952258] Starting dynamic subtest: D-eDP1
[149.580520] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[149.582957] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.540s)
[150.771528] [016/133] (872s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[150.891492] Starting subtest: basic-flip-after-cursor-legacy
[151.805743] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.913s)
[152.674588] [017/133] (870s left) kms_getfb (getfb-handle-not-fb)
[152.757317] Starting subtest: getfb-handle-not-fb
[152.759671] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[152.854052] [018/133] (870s left) gem_exec_whisper (basic-fds)
[152.917550] Starting subtest: basic-fds
[158.948272] Subtest basic-fds: SUCCESS (6.030s)
[159.145487] [019/133] (864s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[159.240830] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[159.243244] Starting dynamic subtest: pipe-A-eDP-1
[159.264597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[159.275042] Starting dynamic subtest: pipe-B-eDP-1
[159.293507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[159.301309] Starting dynamic subtest: pipe-C-eDP-1
[159.320311] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[159.328172] Starting dynamic subtest: pipe-D-eDP-1
[159.347204] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[159.349093] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[161.462420] [020/133] (862s left) kms_universal_plane (disable-primary-vs-flip)
[161.549515] Starting subtest: disable-primary-vs-flip
[161.551807] Starting dynamic subtest: pipe-A-eDP-1
[163.163382] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.612s)
[163.172975] Starting dynamic subtest: pipe-B-eDP-1
[165.385652] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.224s)
[165.394911] Starting dynamic subtest: pipe-C-eDP-1
[167.565316] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.179s)
[167.574210] Starting dynamic subtest: pipe-D-eDP-1
[169.744549] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[169.746594] Subtest disable-primary-vs-flip: SUCCESS (8.195s)
[170.555025] [021/133] (853s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[170.659078] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[170.663177] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[170.732521] [022/133] (852s left) i915_pm_rps (thresholds-park)
[170.789196] Starting subtest: thresholds-park
[170.793683] Subtest thresholds-park: SKIP (0.001s)
[170.899646] [023/133] (852s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[170.997343] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[171.001338] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[171.098044] [024/133] (852s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[171.231277] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[172.633577] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.401s)
[173.498287] [025/133] (850s left) kms_pipe_stress (stress-xrgb8888-untiled)
[173.595685] Starting subtest: stress-xrgb8888-untiled
[179.465337] Subtest stress-xrgb8888-untiled: SUCCESS (5.870s)
[179.516570] [026/133] (844s left) api_intel_allocator (reopen-fork)
[179.567058] Starting subtest: reopen-fork
[183.068956] Subtest reopen-fork: SUCCESS (3.502s)
[183.159777] [027/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[183.272585] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[183.277093] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[183.364320] [028/133] (840s left) kms_chamelium_audio (dp-audio)
[183.778012] Subtest dp-audio: SKIP (0.000s)
[184.617306] [029/133] (839s left) kms_psr (fbc-psr-primary-blt)
[184.708043] Starting subtest: fbc-psr-primary-blt
[184.710322] Starting dynamic subtest: eDP-1
[184.714632] Dynamic subtest eDP-1: SKIP (0.000s)
[184.718938] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[184.784144] [030/133] (839s left) gem_ctx_bad_destroy (invalid-ctx)
[184.842949] Starting subtest: invalid-ctx
[184.845362] Subtest invalid-ctx: SUCCESS (0.000s)
[184.921107] [031/133] (839s left) gem_ccs (block-copy-uncompressed)
[184.976986] Starting subtest: block-copy-uncompressed
[184.979347] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[185.004649] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.027s)
[185.012870] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[185.022428] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[185.030115] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[185.039761] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[185.047550] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[185.057330] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[185.059630] Subtest block-copy-uncompressed: SUCCESS (0.081s)
[185.168390] [032/133] (838s left) syncobj_timeline (single-wait-all-signaled)
[185.229754] Starting subtest: single-wait-all-signaled
[185.232572] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[185.372775] [033/133] (838s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[185.472451] Starting subtest: fbcpsr-suspend
[226.763377] Subtest fbcpsr-suspend: SUCCESS (10.945s)
[233.899798] [034/133] (797s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[234.012826] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[234.017441] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[234.111780] [035/133] (797s left) gem_eio (kms)
[234.383400] Starting subtest: kms
[254.180784] Subtest kms: SUCCESS (19.783s)
[254.293091] [036/133] (777s left) gem_softpin (allocator-basic)
[254.351881] Starting subtest: allocator-basic
[254.421399] Subtest allocator-basic: SUCCESS (0.071s)
[254.535831] [037/133] (776s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[254.632694] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[254.635036] Starting dynamic subtest: pipe-A
[254.994411] Dynamic subtest pipe-A: SUCCESS (0.364s)
[255.003774] Starting dynamic subtest: pipe-B
[256.460833] Dynamic subtest pipe-B: SUCCESS (1.465s)
[256.471165] Starting dynamic subtest: pipe-C
[257.852244] Dynamic subtest pipe-C: SUCCESS (1.389s)
[257.862861] Starting dynamic subtest: pipe-D
[259.381142] Dynamic subtest pipe-D: SUCCESS (1.528s)
[259.383428] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.751s)
[260.566013] [038/133] (770s left) syncobj_wait (single-wait-all-for-submit-signaled)
[260.621224] Starting subtest: single-wait-all-for-submit-signaled
[260.623529] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[260.722192] [039/133] (770s left) perf_pmu (busy-accuracy-2)
[260.763036] Starting subtest: busy-accuracy-2
[260.765128] Starting dynamic subtest: rcs0
[263.805994] Dynamic subtest rcs0: SUCCESS (3.041s)
[263.817518] Starting dynamic subtest: bcs0
[266.867257] Dynamic subtest bcs0: SUCCESS (3.059s)
[266.877320] Starting dynamic subtest: vcs0
[269.916023] Dynamic subtest vcs0: SUCCESS (3.047s)
[269.926878] Starting dynamic subtest: vcs1
[272.967831] Dynamic subtest vcs1: SUCCESS (3.049s)
[272.977115] Starting dynamic subtest: vecs0
[276.015383] Dynamic subtest vecs0: SUCCESS (3.045s)
[276.027219] Starting dynamic subtest: ccs0
[279.075577] Dynamic subtest ccs0: SUCCESS (3.058s)
[279.078799] Subtest busy-accuracy-2: SUCCESS (18.314s)
[279.199223] [040/133] (752s left) gen9_exec_parse (bb-secure)
[279.264518] Subtest bb-secure: SKIP (0.000s)
[279.334260] [041/133] (752s left) kms_atomic_interruptible (legacy-cursor)
[279.424100] Starting subtest: legacy-cursor
[279.426320] Starting dynamic subtest: pipe-A-eDP-1
[286.873004] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[286.875011] Subtest legacy-cursor: SUCCESS (7.447s)
[287.731185] [042/133] (743s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[287.849717] Starting subtest: basic-busy-flip-before-cursor-legacy
[287.854033] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[287.995986] [043/133] (743s left) gem_exec_balancer (hang)
[288.256135] Starting subtest: hang
[290.268654] Subtest hang: SUCCESS (2.016s)
[290.404036] [044/133] (741s left) gem_workarounds (reset-context)
[290.473193] Starting subtest: reset-context
[290.660142] Subtest reset-context: SUCCESS (0.187s)
[290.783446] [045/133] (740s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[290.841011] Starting subtest: mixed-tiled-to-y-tiled-ccs
[290.845189] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[291.030700] [046/133] (740s left) gem_exec_params (larger-than-life-batch)
[291.092689] Starting subtest: larger-than-life-batch
[293.448219] Subtest larger-than-life-batch: SUCCESS (2.354s)
[294.297845] [047/133] (737s left) kms_flip (plain-flip-fb-recreate-interruptible)
[294.437667] Starting subtest: plain-flip-fb-recreate-interruptible
[294.440001] Starting dynamic subtest: A-eDP1
[303.310504] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[303.324519] Starting dynamic subtest: B-eDP1
[312.150040] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[312.162018] Starting dynamic subtest: C-eDP1
[320.965282] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[320.976934] Starting dynamic subtest: D-eDP1
[329.797821] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[329.802341] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.361s)
[330.977236] [048/133] (700s left) kms_invalid_mode (bad-htotal)
[331.094465] Starting subtest: bad-htotal
[331.096655] Starting dynamic subtest: pipe-A-eDP-1
[331.381265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[331.392115] Starting dynamic subtest: pipe-B-eDP-1
[331.394120] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[331.403692] Starting dynamic subtest: pipe-C-eDP-1
[331.405827] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[331.415315] Starting dynamic subtest: pipe-D-eDP-1
[331.417544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[331.419646] Subtest bad-htotal: SUCCESS (0.292s)
[332.208922] [049/133] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[332.314992] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[332.319242] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[332.409782] [050/133] (699s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[332.472119] Starting subtest: multi-wait-available-unsubmitted-submitted
[332.474539] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[332.578703] [051/133] (699s left) perf_pmu (busy-idle-check-all)
[332.616407] Starting subtest: busy-idle-check-all
[332.618321] Starting dynamic subtest: rcs0
[333.264786] Dynamic subtest rcs0: SUCCESS (0.649s)
[333.277200] Starting dynamic subtest: bcs0
[333.917109] Dynamic subtest bcs0: SUCCESS (0.650s)
[333.930384] Starting dynamic subtest: vcs0
[335.265468] Dynamic subtest vcs0: SUCCESS (1.345s)
[335.277579] Starting dynamic subtest: vcs1
[337.249886] Dynamic subtest vcs1: SUCCESS (1.982s)
[337.262573] Starting dynamic subtest: vecs0
[339.234280] Dynamic subtest vecs0: SUCCESS (1.981s)
[339.247034] Starting dynamic subtest: ccs0
[339.891203] Dynamic subtest ccs0: SUCCESS (0.655s)
[339.893625] Subtest busy-idle-check-all: SUCCESS (7.278s)
[339.989511] [052/133] (691s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[340.088421] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[340.115748] Starting dynamic subtest: pipe-A-plane-0
[340.404423] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[340.416821] Starting dynamic subtest: pipe-A-plane-3
[340.648853] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[340.658477] Starting dynamic subtest: pipe-A-plane-5
[340.662999] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[341.807929] Starting dynamic subtest: pipe-B-plane-0
[342.099264] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[342.109422] Starting dynamic subtest: pipe-B-plane-3
[342.332522] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[342.342033] Starting dynamic subtest: pipe-B-plane-5
[342.346300] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[342.644225] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.555s)
[343.491223] [053/133] (688s left) core_hotunplug (unbind-rebind)
[343.583203] Starting subtest: unbind-rebind
[349.512273] Subtest unbind-rebind: SUCCESS (5.930s)
[349.551913] [054/133] (682s left) gem_create (create-size-update)
[351.240111] Starting subtest: create-size-update
[351.242202] Subtest create-size-update: SUCCESS (0.000s)
[351.461517] [055/133] (680s left) kms_lease (possible-crtcs-filtering)
[351.571530] Starting subtest: possible-crtcs-filtering
[351.575994] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[351.684628] [056/133] (680s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[351.779153] Starting subtest: y-tiled-8bpp-rotate-90
[351.783505] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[351.875763] [057/133] (680s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[351.974564] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[351.976786] Starting dynamic subtest: pipe-A-eDP-1
[351.999721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.013265] Starting dynamic subtest: pipe-B-eDP-1
[352.035362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.044984] Starting dynamic subtest: pipe-C-eDP-1
[352.066554] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.076289] Starting dynamic subtest: pipe-D-eDP-1
[352.098384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.102727] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[354.269978] [058/133] (677s left) gem_eio (in-flight-external)
[354.424026] Starting subtest: in-flight-external
[356.301475] Subtest in-flight-external: SUCCESS (1.877s)
[356.425404] [059/133] (675s left) gem_ctx_param (basic)
[356.482328] Starting subtest: basic
[356.484634] Subtest basic: SUCCESS (0.001s)
[356.592574] [060/133] (675s left) kms_flip (2x-flip-vs-suspend-interruptible)
[356.688151] Starting subtest: 2x-flip-vs-suspend-interruptible
[356.700413] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[356.803875] [061/133] (675s left) gem_pxp (create-protected-buffer)
[356.920171] Starting subtest: create-protected-buffer
[356.922734] Subtest create-protected-buffer: SUCCESS (0.000s)
[357.028097] [062/133] (675s left) syncobj_basic (bad-pad-handle-to-fd)
[357.085016] Starting subtest: bad-pad-handle-to-fd
[357.086915] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[357.177375] [063/133] (675s left) syncobj_wait (invalid-reset-one-illegal-handle)
[357.239044] Starting subtest: invalid-reset-one-illegal-handle
[357.241000] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[357.350412] [064/133] (675s left) gem_mmap_offset (bad-flags)
[357.412361] Starting subtest: bad-flags
[357.414280] Subtest bad-flags: SUCCESS (0.000s)
[357.541526] [065/133] (675s left) i915_drm_fdinfo (most-busy-check-all)
[357.588491] Starting subtest: most-busy-check-all
[357.590180] Starting dynamic subtest: rcs0
[357.593707] Dynamic subtest rcs0: SKIP (0.004s)
[357.604206] Starting dynamic subtest: bcs0
[357.607680] Dynamic subtest bcs0: SKIP (0.000s)
[357.617192] Starting dynamic subtest: vcs0
[357.620479] Dynamic subtest vcs0: SKIP (0.000s)
[357.629767] Starting dynamic subtest: vcs1
[357.633167] Dynamic subtest vcs1: SKIP (0.000s)
[357.642577] Starting dynamic subtest: vecs0
[357.645949] Dynamic subtest vecs0: SKIP (0.000s)
[357.655299] Starting dynamic subtest: ccs0
[357.658766] Dynamic subtest ccs0: SKIP (0.000s)
[357.662164] Subtest most-busy-check-all: SKIP (0.009s)
[357.701103] [066/133] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[357.799133] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[357.802428] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[357.894853] [067/133] (674s left) gem_ctx_persistence (engines-hostile)
[357.956387] Starting subtest: engines-hostile
[357.958411] Starting dynamic subtest: rcs0
[358.030803] Dynamic subtest rcs0: SUCCESS (0.074s)
[358.045860] Starting dynamic subtest: bcs0
[358.104707] Dynamic subtest bcs0: SUCCESS (0.071s)
[358.118808] Starting dynamic subtest: vcs0
[358.231912] Dynamic subtest vcs0: SUCCESS (0.125s)
[358.244754] Starting dynamic subtest: vcs1
[358.329713] Dynamic subtest vcs1: SUCCESS (0.096s)
[358.341802] Starting dynamic subtest: vecs0
[358.441533] Dynamic subtest vecs0: SUCCESS (0.110s)
[358.456677] Starting dynamic subtest: ccs0
[358.540501] Dynamic subtest ccs0: SUCCESS (0.097s)
[358.542432] Subtest engines-hostile: SUCCESS (0.585s)
[358.635043] [068/133] (674s left) kms_chamelium_edid (hdmi-edid-read)
[359.025917] Subtest hdmi-edid-read: SKIP (0.000s)
[359.876701] [069/133] (672s left) kms_cursor_crc (cursor-random-max-size)
[360.188190] Starting subtest: cursor-random-max-size
[360.194511] Subtest cursor-random-max-size: SKIP (0.000s)
[360.314741] [070/133] (672s left) kms_cursor_crc (cursor-onscreen-64x64)
[360.487659] Starting subtest: cursor-onscreen-64x64
[360.492840] Starting dynamic subtest: pipe-A-eDP-1
[362.605595] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[362.638822] Starting dynamic subtest: pipe-D-eDP-1
[365.353506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.723s)
[365.355834] Subtest cursor-onscreen-64x64: SUCCESS (4.865s)
[366.175661] [071/133] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[366.268511] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[366.272505] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[366.380670] [072/133] (666s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[366.477510] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[366.481603] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[366.577017] [073/133] (666s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[366.677046] Starting subtest: 4-tiled-8bpp-rotate-0
[367.901822] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.226s)
[368.017965] [074/133] (664s left) kms_pm_rpm (drm-resources-equal)
[369.548333] Starting subtest: drm-resources-equal
[374.924089] Subtest drm-resources-equal: SUCCESS (5.374s)
[375.029631] [075/133] (657s left) kms_chamelium_hpd (dp-hpd)
[375.438594] Subtest dp-hpd: SKIP (0.000s)
[376.268439] [076/133] (656s left) kms_pm_rpm (modeset-lpsp)
[378.402220] Starting subtest: modeset-lpsp
[379.856310] Subtest modeset-lpsp: SUCCESS (1.456s)
[379.947486] [077/133] (653s left) kms_frontbuffer_tracking (fbc-tiling-4)
[380.050433] Starting subtest: fbc-tiling-4
[384.227383] Subtest fbc-tiling-4: SUCCESS (4.180s)
[385.460099] [078/133] (647s left) prime_mmap (test_correct)
[385.523024] Starting subtest: test_correct
[385.525213] Starting dynamic subtest: test_correct-smem
[385.555285] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[385.557732] Subtest test_correct: SUCCESS (0.034s)
[385.658117] [079/133] (647s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[385.771961] Starting subtest: x-tiled-32bpp-rotate-180
[387.251249] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[387.372829] [080/133] (645s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[387.464693] Starting subtest: plane-lut1d-ctm3x4-lut1d
[387.611550] Starting dynamic subtest: pipe-A-plane-0
[387.778075] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[387.788494] Starting dynamic subtest: pipe-A-plane-1
[387.945023] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[387.956359] Starting dynamic subtest: pipe-A-plane-2
[388.133626] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[389.320932] Starting dynamic subtest: pipe-B-plane-0
[389.475985] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[389.486537] Starting dynamic subtest: pipe-B-plane-1
[389.654725] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[389.665311] Starting dynamic subtest: pipe-B-plane-2
[389.820593] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[391.032398] Starting dynamic subtest: pipe-C-plane-0
[391.167315] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[391.177736] Starting dynamic subtest: pipe-C-plane-1
[391.322846] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[391.335046] Starting dynamic subtest: pipe-C-plane-2
[391.467331] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[392.675039] Starting dynamic subtest: pipe-D-plane-0
[392.821566] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[392.832782] Starting dynamic subtest: pipe-D-plane-1
[392.988377] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[392.999285] Starting dynamic subtest: pipe-D-plane-2
[393.143926] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[393.443782] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.978s)
[394.250441] [081/133] (639s left) gem_exec_schedule (pi-shared-iova)
[394.435457] Starting subtest: pi-shared-iova
[394.437403] Starting dynamic subtest: rcs0
[394.504309] Dynamic subtest rcs0: SUCCESS (0.071s)
[394.516381] Starting dynamic subtest: vcs0
[394.554787] Dynamic subtest vcs0: SUCCESS (0.050s)
[394.568629] Starting dynamic subtest: vcs1
[394.606382] Dynamic subtest vcs1: SUCCESS (0.051s)
[394.618832] Starting dynamic subtest: vecs0
[394.659911] Dynamic subtest vecs0: SUCCESS (0.053s)
[394.672720] Starting dynamic subtest: ccs0
[394.718698] Dynamic subtest ccs0: SUCCESS (0.058s)
[394.721230] Subtest pi-shared-iova: SUCCESS (0.286s)
[396.361647] [082/133] (636s left) kms_cursor_crc (cursor-sliding-max-size)
[396.688218] Starting subtest: cursor-sliding-max-size
[396.694485] Subtest cursor-sliding-max-size: SKIP (0.000s)
[396.816707] [083/133] (636s left) gem_exec_schedule (smoketest)
[396.986291] Starting subtest: smoketest
[396.988447] Starting dynamic subtest: rcs0
[402.540019] Dynamic subtest rcs0: SUCCESS (5.504s)
[402.554855] Starting dynamic subtest: bcs0
[408.044748] Dynamic subtest bcs0: SUCCESS (5.499s)
[408.064844] Starting dynamic subtest: vcs0
[413.544311] Dynamic subtest vcs0: SUCCESS (5.498s)
[413.563265] Starting dynamic subtest: vcs1
[419.055283] Dynamic subtest vcs1: SUCCESS (5.507s)
[419.068801] Starting dynamic subtest: vecs0
[424.570944] Dynamic subtest vecs0: SUCCESS (5.513s)
[424.584943] Starting dynamic subtest: ccs0
[430.087516] Dynamic subtest ccs0: SUCCESS (5.518s)
[430.089774] Subtest smoketest: SUCCESS (33.049s)
[430.235271] [084/133] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[430.342719] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[436.944681] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.605s)
[437.062837] [085/133] (596s left) gem_mmap_gtt (medium-copy-odd)
[437.128035] Subtest medium-copy-odd: SKIP (0.000s)
[437.196117] [086/133] (596s left) gem_exec_reloc (basic-write-gtt)
[437.266472] Subtest basic-write-gtt: SKIP (0.000s)
[437.344150] [087/133] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[437.447603] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[444.787285] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.342s)
[444.925790] [088/133] (588s left) syncobj_timeline (etime-single-wait-submitted)
[444.996945] Starting subtest: etime-single-wait-submitted
[445.102793] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[445.197233] [089/133] (588s left) gem_ctx_persistence (legacy-engines-mixed)
[445.268858] Starting subtest: legacy-engines-mixed
[445.271284] Starting dynamic subtest: render
[445.344118] Dynamic subtest render: SUCCESS (0.075s)
[445.359906] Starting dynamic subtest: bsd1
[445.400904] Dynamic subtest bsd1: SUCCESS (0.054s)
[445.416090] Starting dynamic subtest: bsd2
[445.451044] Dynamic subtest bsd2: SUCCESS (0.047s)
[445.461600] Starting dynamic subtest: blt
[445.500896] Dynamic subtest blt: SUCCESS (0.048s)
[445.515388] Starting dynamic subtest: vebox
[445.553925] Dynamic subtest vebox: SUCCESS (0.050s)
[445.556341] Subtest legacy-engines-mixed: SUCCESS (0.286s)
[445.649316] [090/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[445.738600] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[445.742486] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[445.837887] [091/133] (587s left) kms_flip (flip-vs-rmfb-interruptible)
[445.937319] Starting subtest: flip-vs-rmfb-interruptible
[445.939599] Starting dynamic subtest: A-eDP1
[454.602374] Dynamic subtest A-eDP1: SUCCESS (8.663s)
[454.613031] Starting dynamic subtest: B-eDP1
[463.227384] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[463.243048] Starting dynamic subtest: C-eDP1
[471.839935] Dynamic subtest C-eDP1: SUCCESS (8.609s)
[471.854259] Starting dynamic subtest: D-eDP1
[480.467004] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[480.471670] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.535s)
[481.649624] [092/133] (552s left) kms_psr (pr-cursor-render)
[481.751772] Starting subtest: pr-cursor-render
[481.756571] Subtest pr-cursor-render: SKIP (0.000s)
[481.833896] [093/133] (551s left) gem_exec_whisper (basic-sync)
[481.903761] Starting subtest: basic-sync
[490.515203] Subtest basic-sync: SUCCESS (8.612s)
[490.704313] [094/133] (543s left) gem_sync (basic-each)
[490.788397] Starting subtest: basic-each
[493.161650] Subtest basic-each: SUCCESS (2.383s)
[493.357023] [095/133] (540s left) kms_psr (fbc-pr-cursor-render)
[493.450319] Starting subtest: fbc-pr-cursor-render
[493.454470] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[493.536694] [096/133] (540s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[493.634826] Starting subtest: psr-modesetfrombusy
[499.917630] Subtest psr-modesetfrombusy: SUCCESS (6.286s)
[500.048351] [097/133] (533s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[500.147908] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[500.149878] Starting dynamic subtest: pipe-A-eDP-1
[500.157436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.173623] Starting dynamic subtest: pipe-B-eDP-1
[500.181212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.197416] Starting dynamic subtest: pipe-C-eDP-1
[500.204964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.214618] Starting dynamic subtest: pipe-D-eDP-1
[500.221814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.225325] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[502.479496] [098/133] (531s left) kms_vblank (wait-forked-busy)
[502.587428] Starting subtest: wait-forked-busy
[502.589324] Starting dynamic subtest: pipe-A-eDP-1
[504.475035] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[504.491635] Starting dynamic subtest: pipe-D-eDP-1
[507.041950] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[507.044354] Subtest wait-forked-busy: SUCCESS (4.456s)
[507.850600] [099/133] (526s left) kms_flip (2x-nonexisting-fb)
[507.947383] Starting subtest: 2x-nonexisting-fb
[507.959036] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[508.039409] [100/133] (526s left) kms_big_fb (linear-32bpp-rotate-270)
[508.150455] Starting subtest: linear-32bpp-rotate-270
[508.169202] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[508.276661] [101/133] (525s left) kms_dp_link_training (non-uhbr-sst)
[508.358526] Starting subtest: non-uhbr-sst
[508.367124] Subtest non-uhbr-sst: SKIP (0.000s)
[508.434246] [102/133] (525s left) kms_psr (fbc-pr-suspend)
[508.533274] Starting subtest: fbc-pr-suspend
[508.537430] Subtest fbc-pr-suspend: SKIP (0.000s)
[508.610329] [103/133] (525s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[508.699087] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[508.701210] Starting dynamic subtest: pipe-A
[508.720488] Dynamic subtest pipe-A: SKIP (0.018s)
[508.731498] Starting dynamic subtest: pipe-B
[508.753559] Dynamic subtest pipe-B: SKIP (0.032s)
[508.764230] Starting dynamic subtest: pipe-C
[508.786821] Dynamic subtest pipe-C: SKIP (0.033s)
[508.796896] Starting dynamic subtest: pipe-D
[508.821181] Dynamic subtest pipe-D: SKIP (0.031s)
[508.824900] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s)
[508.915528] [104/133] (525s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[509.000398] Starting subtest: primary-y-tiled-reflect-x-180
[509.060426] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[509.164249] [105/133] (525s left) gem_userptr_blits (stress-purge)
[509.230834] Starting subtest: stress-purge
[514.661222] Subtest stress-purge: SUCCESS (5.430s)
[514.801752] [106/133] (519s left) gem_exec_balancer (smoke)
[514.895284] Starting subtest: smoke
[537.560379] Subtest smoke: SUCCESS (22.655s)
[539.287575] [107/133] (495s left) gem_exec_fence (submit3)
[539.468266] Starting subtest: submit3
[539.472715] Subtest submit3: SKIP (0.000s)
[541.374120] [108/133] (493s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[541.489681] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[541.494064] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.001s)
[541.589873] [109/133] (492s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[541.684710] Starting subtest: yf-tiled-16bpp-rotate-270
[541.688880] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[541.778201] [110/133] (492s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[541.878388] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[541.882771] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[541.957510] [111/133] (492s left) kms_flip (modeset-vs-vblank-race)
[542.057458] Starting subtest: modeset-vs-vblank-race
[542.059757] Starting dynamic subtest: A-eDP1
[546.774305] Dynamic subtest A-eDP1: SUCCESS (4.715s)
[546.787743] Starting dynamic subtest: B-eDP1
[551.507988] Dynamic subtest B-eDP1: SUCCESS (4.731s)
[551.522928] Starting dynamic subtest: C-eDP1
[556.119844] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[556.135022] Starting dynamic subtest: D-eDP1
[560.779635] Dynamic subtest D-eDP1: SUCCESS (4.657s)
[560.785320] Subtest modeset-vs-vblank-race: SUCCESS (18.725s)
[561.947085] [112/133] (472s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[562.019204] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[562.023629] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[562.207689] [113/133] (472s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[562.264474] Starting subtest: invalid-single-wait-all-unsubmitted
[562.266830] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[562.374818] [114/133] (472s left) gem_userptr_blits (process-exit-busy)
[562.454046] Starting subtest: process-exit-busy
[562.466646] Subtest process-exit-busy: SUCCESS (0.015s)
[562.619536] [115/133] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[562.738144] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[567.189519] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.454s)
[568.360076] [116/133] (466s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[568.414659] Starting subtest: etime-multi-wait-all-available-unsubmitted
[568.519031] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[568.598436] [117/133] (466s left) gem_exec_params (invalid-bsd1-flag-on-render)
[568.672812] Starting subtest: invalid-bsd1-flag-on-render
[568.675086] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[568.794533] [118/133] (466s left) gem_eio (in-flight-internal-immediate)
[569.016428] Starting subtest: in-flight-internal-immediate
[570.350834] Subtest in-flight-internal-immediate: SUCCESS (1.333s)
[570.483600] [119/133] (464s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[570.609379] Starting subtest: cursorB-vs-flipA-varying-size
[570.613771] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[570.758247] [120/133] (464s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[570.852392] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[570.856705] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[570.930672] [121/133] (464s left) kms_addfb_basic (unused-offsets)
[570.985411] Starting subtest: unused-offsets
[570.987283] Subtest unused-offsets: SUCCESS (0.000s)
[571.141785] [122/133] (463s left) prime_vgem (wait)
[571.206430] Starting subtest: wait
[571.209096] Starting dynamic subtest: rcs0
[571.242800] Dynamic subtest rcs0: SUCCESS (0.037s)
[571.253193] Starting dynamic subtest: bcs0
[571.289404] Dynamic subtest bcs0: SUCCESS (0.046s)
[571.299812] Starting dynamic subtest: vcs0
[571.333815] Dynamic subtest vcs0: SUCCESS (0.043s)
[571.344217] Starting dynamic subtest: vcs1
[571.381435] Dynamic subtest vcs1: SUCCESS (0.047s)
[571.391615] Starting dynamic subtest: vecs0
[571.427440] Dynamic subtest vecs0: SUCCESS (0.045s)
[571.437872] Starting dynamic subtest: ccs0
[571.473450] Dynamic subtest ccs0: SUCCESS (0.045s)
[571.475407] Subtest wait: SUCCESS (0.269s)
[571.599470] [123/133] (463s left) i915_hangman (engine-engine-hang)
[571.666368] Starting subtest: engine-engine-hang
[571.668329] Starting dynamic subtest: rcs0
[573.249714] Dynamic subtest rcs0: SUCCESS (1.580s)
[573.264190] Starting dynamic subtest: bcs0
[575.232523] Dynamic subtest bcs0: SUCCESS (1.980s)
[575.248944] Starting dynamic subtest: vcs0
[577.215870] Dynamic subtest vcs0: SUCCESS (1.981s)
[577.231128] Starting dynamic subtest: vcs1
[579.200606] Dynamic subtest vcs1: SUCCESS (1.981s)
[579.214251] Starting dynamic subtest: vecs0
[581.184531] Dynamic subtest vecs0: SUCCESS (1.981s)
[581.201520] Starting dynamic subtest: ccs0
[583.232408] Dynamic subtest ccs0: SUCCESS (2.045s)
[583.235534] Subtest engine-engine-hang: SUCCESS (11.565s)
[583.317381] [124/133] (451s left) kms_getfb (getfb-handle-closed)
[583.417141] Starting subtest: getfb-handle-closed
[583.419406] Subtest getfb-handle-closed: SUCCESS (0.000s)
[583.503009] [125/133] (451s left) gem_lmem_swapping (verify-random-ccs)
[583.555079] Subtest verify-random-ccs: SKIP (0.000s)
[583.600382] [126/133] (451s left) prime_vgem (basic-fence-read)
[583.682338] Starting subtest: basic-fence-read
[583.692619] Subtest basic-fence-read: SKIP (0.008s)
[583.795912] [127/133] (451s left) kms_async_flips (alternate-sync-async-flip-atomic)
[583.891617] Starting subtest: alternate-sync-async-flip-atomic
[584.263034] Starting dynamic subtest: pipe-A-eDP-1
[587.026688] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.764s)
[587.410054] Starting dynamic subtest: pipe-B-eDP-1
[590.157246] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[590.539267] Starting dynamic subtest: pipe-C-eDP-1
[593.287702] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[593.667407] Starting dynamic subtest: pipe-D-eDP-1
[596.421130] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[596.423234] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.532s)
[597.605057] [128/133] (437s left) api_intel_bb (object-noreloc-purge-cache-simple)
[597.665745] Starting subtest: object-noreloc-purge-cache-simple
[597.668331] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[597.782290] [129/133] (437s left) i915_pm_rps (min-max-config-idle)
[597.839579] Starting subtest: min-max-config-idle
[597.843795] Subtest min-max-config-idle: SKIP (0.000s)
[597.948715] [130/133] (437s left) kms_psr (psr2-cursor-mmap-gtt)
[598.049614] Starting subtest: psr2-cursor-mmap-gtt
[598.051915] Starting dynamic subtest: eDP-1
[599.787590] Dynamic subtest eDP-1: SUCCESS (1.736s)
[599.789765] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.737s)
[600.588816] [131/133] (434s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[600.721088] Starting subtest: cursor-vs-flip-toggle
[632.068287] Subtest cursor-vs-flip-toggle: SUCCESS (31.346s)
[632.941164] [132/133] (402s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[633.066005] Starting subtest: cursorB-vs-flipB-atomic-transitions
[633.070580] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[633.214835] [133/133] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[633.310480] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[633.314411] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[633.394913] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_explicit_fence
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_universal_plane
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_pipe_stress
results: parsing output: 25/ for test: api_intel_allocator
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_audio
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_ctx_bad_destroy
results: parsing output: 30/ for test: gem_ccs
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: gem_workarounds
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: core_hotunplug
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_ctx_param
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_chamelium_edid
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_cursor_crc
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_big_fb
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: prime_mmap
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_color_pipeline
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_vblank
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_dp_link_training
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_rotation_crc
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_getfb
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: i915_pm_rps
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.