[58.388493] Initializing watchdogs
[58.388541]   /dev/watchdog0
[58.402559] [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]
[58.406829] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.409357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.413184] [001/132] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[58.538947] Starting subtest: plane-downscale-factor-0-75-with-rotation
[58.541291] Starting dynamic subtest: pipe-A
[58.779535] Dynamic subtest pipe-A: SUCCESS (0.243s)
[58.787603] Starting dynamic subtest: pipe-B
[60.107315] Dynamic subtest pipe-B: SUCCESS (1.328s)
[60.117121] Starting dynamic subtest: pipe-C
[61.450713] Dynamic subtest pipe-C: SUCCESS (1.343s)
[61.459109] Starting dynamic subtest: pipe-D
[62.779510] Dynamic subtest pipe-D: SUCCESS (1.328s)
[62.781988] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.243s)
[63.957892] [002/132] (954s left) syncobj_timeline (wait-any-interrupted)
[64.013185] Starting subtest: wait-any-interrupted
[64.117290] Subtest wait-any-interrupted: SUCCESS (0.103s)
[64.189638] [003/132] (954s left) gem_ctx_param (invalid-param-get)
[64.247783] Starting subtest: invalid-param-get
[64.250558] Subtest invalid-param-get: SUCCESS (0.001s)
[64.351226] [004/132] (954s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[64.408939] Starting subtest: multi-wait-all-for-submit-available-signaled
[64.411312] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[64.505946] [005/132] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[64.614259] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[71.209195] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.596s)
[71.329718] [006/132] (947s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[71.427695] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[71.429986] Starting dynamic subtest: pipe-A
[71.453641] Dynamic subtest pipe-A: SKIP (0.022s)
[71.461423] Starting dynamic subtest: pipe-B
[71.485453] Dynamic subtest pipe-B: SKIP (0.033s)
[71.493509] Starting dynamic subtest: pipe-C
[71.518042] Dynamic subtest pipe-C: SKIP (0.032s)
[71.527263] Starting dynamic subtest: pipe-D
[71.551096] Dynamic subtest pipe-D: SKIP (0.032s)
[71.555101] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.120s)
[71.655236] [007/132] (947s left) kms_flip (plain-flip-fb-recreate)
[71.749292] Starting subtest: plain-flip-fb-recreate
[71.751723] Starting dynamic subtest: A-eDP1
[80.600757] Dynamic subtest A-eDP1: SUCCESS (8.852s)
[80.610021] Starting dynamic subtest: B-eDP1
[89.435027] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[89.444095] Starting dynamic subtest: C-eDP1
[98.249194] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[98.257842] Starting dynamic subtest: D-eDP1
[107.076206] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[107.080369] Subtest plain-flip-fb-recreate: SUCCESS (35.335s)
[108.264907] [008/132] (910s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[108.366862] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[108.371484] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[108.435951] [009/132] (910s left) i915_pm_rps (waitboost)
[108.491863] Starting subtest: waitboost
[114.562845] Subtest waitboost: SUCCESS (6.071s)
[114.681629] [010/132] (904s left) gem_partial_pwrite_pread (write-display)
[114.751407] Subtest write-display: SKIP (0.000s)
[114.821538] [011/132] (904s left) gem_lmem_swapping (heavy-verify-random-ccs)
[114.867729] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[114.909678] [012/132] (904s left) perf_pmu (init-busy)
[114.945857] Starting subtest: init-busy
[114.948181] Starting dynamic subtest: rcs0
[114.950480] Dynamic subtest rcs0: SUCCESS (0.002s)
[114.960417] Starting dynamic subtest: bcs0
[114.962613] Dynamic subtest bcs0: SUCCESS (0.001s)
[114.970078] Starting dynamic subtest: vcs0
[114.972249] Dynamic subtest vcs0: SUCCESS (0.002s)
[114.979399] Starting dynamic subtest: vcs1
[114.981293] Dynamic subtest vcs1: SUCCESS (0.001s)
[114.988858] Starting dynamic subtest: vecs0
[114.991123] Dynamic subtest vecs0: SUCCESS (0.001s)
[114.998555] Starting dynamic subtest: ccs0
[115.000439] Dynamic subtest ccs0: SUCCESS (0.001s)
[115.002360] Subtest init-busy: SUCCESS (0.009s)
[115.051503] [013/132] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[115.152589] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[122.269434] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.120s)
[122.377043] [014/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[122.477253] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[122.481386] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[122.579260] [015/132] (896s left) gem_exec_schedule (promotion)
[122.643729] Starting subtest: promotion
[122.645621] Starting dynamic subtest: rcs0
[122.747616] Dynamic subtest rcs0: SUCCESS (0.106s)
[122.757481] Starting dynamic subtest: vcs0
[122.836455] Dynamic subtest vcs0: SUCCESS (0.088s)
[122.844591] Starting dynamic subtest: vcs1
[122.921277] Dynamic subtest vcs1: SUCCESS (0.084s)
[122.933709] Starting dynamic subtest: vecs0
[123.002829] Dynamic subtest vecs0: SUCCESS (0.081s)
[123.014062] Starting dynamic subtest: ccs0
[123.087564] Dynamic subtest ccs0: SUCCESS (0.085s)
[123.090047] Subtest promotion: SUCCESS (0.447s)
[124.393148] [016/132] (895s left) gem_spin_batch (resubmit-new)
[124.450934] Starting subtest: resubmit-new
[124.452979] Starting dynamic subtest: rcs0
[124.458262] Dynamic subtest rcs0: SUCCESS (0.008s)
[124.471870] Starting dynamic subtest: bcs0
[124.474242] Dynamic subtest bcs0: SUCCESS (0.004s)
[124.482563] Starting dynamic subtest: vcs0
[124.484870] Dynamic subtest vcs0: SUCCESS (0.006s)
[124.492209] Starting dynamic subtest: vcs1
[124.494180] Dynamic subtest vcs1: SUCCESS (0.006s)
[124.501883] Starting dynamic subtest: vecs0
[124.503895] Dynamic subtest vecs0: SUCCESS (0.004s)
[124.511191] Starting dynamic subtest: ccs0
[124.513127] Dynamic subtest ccs0: SUCCESS (0.003s)
[124.515075] Subtest resubmit-new: SUCCESS (0.034s)
[126.310674] [017/132] (893s left) kms_cursor_crc (cursor-random-512x170)
[126.585147] Starting subtest: cursor-random-512x170
[126.589875] Subtest cursor-random-512x170: SKIP (0.001s)
[126.754886] [018/132] (892s left) gem_ctx_persistence (engines-persistence)
[126.812132] Starting subtest: engines-persistence
[126.814087] Starting dynamic subtest: rcs0
[127.614845] Dynamic subtest rcs0: SUCCESS (0.803s)
[127.625831] Starting dynamic subtest: bcs0
[128.377099] Dynamic subtest bcs0: SUCCESS (0.761s)
[128.388515] Starting dynamic subtest: vcs0
[129.151066] Dynamic subtest vcs0: SUCCESS (0.773s)
[129.161493] Starting dynamic subtest: vcs1
[129.920014] Dynamic subtest vcs1: SUCCESS (0.768s)
[129.930662] Starting dynamic subtest: vecs0
[130.665140] Dynamic subtest vecs0: SUCCESS (0.744s)
[130.674696] Starting dynamic subtest: ccs0
[131.431401] Dynamic subtest ccs0: SUCCESS (0.765s)
[131.434404] Subtest engines-persistence: SUCCESS (4.620s)
[131.575537] [019/132] (888s left) api_intel_bb (reset-bb)
[131.626181] Starting subtest: reset-bb
[131.631166] Subtest reset-bb: SUCCESS (0.006s)
[131.737635] [020/132] (887s left) kms_flip (2x-dpms-vs-vblank-race)
[131.831559] Starting subtest: 2x-dpms-vs-vblank-race
[131.844748] Subtest 2x-dpms-vs-vblank-race: SKIP (0.013s)
[131.921139] [021/132] (887s left) kms_addfb_basic (small-bo)
[132.005594] Starting subtest: small-bo
[132.007814] Subtest small-bo: SUCCESS (0.000s)
[132.088914] [022/132] (887s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[132.194759] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[136.222337] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.028s)
[137.396921] [023/132] (882s left) kms_panel_fitting (atomic-fastset)
[137.484084] Starting subtest: atomic-fastset
[137.486513] Starting dynamic subtest: pipe-A-eDP-1
[137.621592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[137.631523] Starting dynamic subtest: pipe-B-eDP-1
[138.850404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[138.862666] Starting dynamic subtest: pipe-C-eDP-1
[140.044979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.193s)
[140.056693] Starting dynamic subtest: pipe-D-eDP-1
[141.261747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[141.264051] Subtest atomic-fastset: SUCCESS (3.780s)
[142.499082] [024/132] (877s left) vgem_basic (setversion)
[142.614645] Starting subtest: setversion
[142.619019] Subtest setversion: SUCCESS (0.000s)
[142.666717] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[142.669992] [025/132] (877s left) kms_joiner (basic-force-big-joiner)
[142.758840] Starting subtest: basic-force-big-joiner
[142.762941] Subtest basic-force-big-joiner: SKIP (0.000s)
[142.823427] [026/132] (877s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[142.915711] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[143.751564] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.838s)
[143.924420] [027/132] (875s left) gem_exec_flush (basic-wb-pro-default)
[143.985616] Starting subtest: basic-wb-pro-default
[149.444346] Subtest basic-wb-pro-default: SUCCESS (5.458s)
[149.644094] [028/132] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[149.749787] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[149.753798] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[149.862123] [029/132] (870s left) api_intel_allocator (fork-simple-stress)
[149.911277] Starting subtest: fork-simple-stress
[155.310068] Subtest fork-simple-stress: SUCCESS (5.398s)
[155.434411] [030/132] (864s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[155.529417] Starting subtest: y-tiled-64bpp-rotate-90
[155.533686] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[155.648543] [031/132] (864s left) gem_exec_await (wide-contexts)
[155.854691] Starting subtest: wide-contexts
[179.292222] Subtest wide-contexts: SUCCESS (23.438s)
[179.479665] [032/132] (840s left) kms_flip (2x-plain-flip-interruptible)
[179.616266] Starting subtest: 2x-plain-flip-interruptible
[179.626838] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[179.750980] [033/132] (840s left) kms_plane_alpha_blend (constant-alpha-mid)
[179.844039] Starting subtest: constant-alpha-mid
[180.130800] Starting dynamic subtest: pipe-A-eDP-1
[181.000590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.868s)
[181.010328] Starting dynamic subtest: pipe-D-eDP-1
[182.492240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.491s)
[182.494724] Subtest constant-alpha-mid: SUCCESS (2.649s)
[183.288673] [034/132] (836s left) gem_render_copy (y-tiled)
[183.343142] Starting subtest: y-tiled
[183.347628] Subtest y-tiled: SKIP (0.000s)
[183.528214] [035/132] (836s left) kms_cursor_crc (cursor-onscreen-512x512)
[183.806745] Starting subtest: cursor-onscreen-512x512
[183.811386] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[183.968663] [036/132] (836s left) kms_psr (fbc-psr-cursor-plane-onoff)
[184.064124] Starting subtest: fbc-psr-cursor-plane-onoff
[184.066403] Starting dynamic subtest: eDP-1
[184.070753] Dynamic subtest eDP-1: SKIP (0.000s)
[184.075214] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[184.134326] [037/132] (836s left) gem_exec_balancer (parallel-bb-first)
[184.393805] Starting subtest: parallel-bb-first
[185.340452] Subtest parallel-bb-first: SUCCESS (0.946s)
[186.349963] [038/132] (833s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[186.448335] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[187.562505] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.114s)
[187.698509] [039/132] (832s left) prime_self_import (basic-with_fd_dup)
[187.735281] Starting subtest: basic-with_fd_dup
[187.747949] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[187.858840] [040/132] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[187.944881] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[187.948497] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[188.045681] [041/132] (832s left) kms_psr (pr-primary-blt)
[188.143314] Starting subtest: pr-primary-blt
[188.146879] Subtest pr-primary-blt: SKIP (0.000s)
[188.212187] [042/132] (832s left) gem_exec_create (legacy)
[188.275330] Starting subtest: legacy
[188.277074] Starting dynamic subtest: smem
[190.365678] Dynamic subtest smem: SUCCESS (2.091s)
[190.368294] Subtest legacy: SUCCESS (2.093s)
[190.553916] [043/132] (829s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[190.660896] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[190.663086] Starting dynamic subtest: pipe-A-eDP-1
[190.682775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[190.693724] Starting dynamic subtest: pipe-B-eDP-1
[190.712029] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[190.720405] Starting dynamic subtest: pipe-C-eDP-1
[190.738871] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[190.747651] Starting dynamic subtest: pipe-D-eDP-1
[190.766728] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[190.768655] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[192.957353] [044/132] (827s left) gem_eio (reset-stress)
[193.185243] Starting subtest: reset-stress
[193.187511] Starting dynamic subtest: render
[198.155780] Dynamic subtest render: SUCCESS (4.965s)
[198.172363] Starting dynamic subtest: bsd1
[215.838431] Dynamic subtest bsd1: SUCCESS (17.683s)
[215.853673] Starting dynamic subtest: bsd2
[233.824331] Dynamic subtest bsd2: SUCCESS (17.984s)
[233.841170] Starting dynamic subtest: blt
[233.845100] Dynamic subtest blt: SKIP (0.000s)
[233.855256] Starting dynamic subtest: vebox
[251.866298] Dynamic subtest vebox: SUCCESS (18.039s)
[251.868231] Subtest reset-stress: SUCCESS (58.676s)
[253.350182] [045/132] (767s left) sriov_basic (enable-vfs-autoprobe-on)
[253.401275] Starting subtest: enable-vfs-autoprobe-on
[253.403721] Starting dynamic subtest: numvfs-1
[253.485254] Dynamic subtest numvfs-1: FAIL (0.030s)
[253.494492] Starting dynamic subtest: numvfs-2
[253.566671] Dynamic subtest numvfs-2: FAIL (0.003s)
[253.577091] Starting dynamic subtest: numvfs-3
[253.650654] Dynamic subtest numvfs-3: FAIL (0.003s)
[253.660818] Starting dynamic subtest: numvfs-4
[253.734020] Dynamic subtest numvfs-4: FAIL (0.003s)
[253.742973] Starting dynamic subtest: numvfs-5
[253.817069] Dynamic subtest numvfs-5: FAIL (0.003s)
[253.827469] Starting dynamic subtest: numvfs-6
[253.898318] Dynamic subtest numvfs-6: FAIL (0.003s)
[253.908127] Starting dynamic subtest: numvfs-7
[253.981327] Dynamic subtest numvfs-7: FAIL (0.004s)
[253.990380] Starting dynamic subtest: numvfs-random
[254.060805] Dynamic subtest numvfs-random: FAIL (0.003s)
[254.070064] Starting dynamic subtest: numvfs-all
[254.138752] Dynamic subtest numvfs-all: FAIL (0.508s)
[254.140956] Subtest enable-vfs-autoprobe-on: FAIL (0.569s)
[254.177501] [046/132] (766s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[254.229736] Starting subtest: yf-tiled-to-vebox-y-tiled
[254.234730] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[254.414371] [047/132] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[254.514795] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[254.518899] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.624727] [048/132] (766s left) syncobj_wait (invalid-wait-bad-flags)
[254.691530] Starting subtest: invalid-wait-bad-flags
[254.693547] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[254.792265] [049/132] (765s left) kms_vblank (wait-idle)
[254.876047] Starting subtest: wait-idle
[254.877949] Starting dynamic subtest: pipe-A-eDP-1
[256.639086] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[256.655537] Starting dynamic subtest: pipe-D-eDP-1
[259.105485] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.463s)
[259.107855] Subtest wait-idle: SUCCESS (4.230s)
[259.935843] [050/132] (760s left) perf_pmu (interrupts-sync)
[259.981532] Starting subtest: interrupts-sync
[261.070423] Subtest interrupts-sync: SUCCESS (1.089s)
[261.184307] [051/132] (759s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[261.268741] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[261.642350] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[264.413317] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[264.426064] Starting dynamic subtest: pipe-A-eDP-1-4
[266.587371] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[266.597461] Starting dynamic subtest: pipe-A-eDP-1-4
[268.597192] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[268.609513] Starting dynamic subtest: pipe-A-eDP-1-x
[270.799720] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s)
[271.168923] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[273.939454] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[273.952708] Starting dynamic subtest: pipe-B-eDP-1-4
[276.125288] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[276.134975] Starting dynamic subtest: pipe-B-eDP-1-4
[278.135681] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[278.145779] Starting dynamic subtest: pipe-B-eDP-1-x
[280.325195] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[280.700812] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[283.475836] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[283.488378] Starting dynamic subtest: pipe-C-eDP-1-4
[285.649772] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[285.659794] Starting dynamic subtest: pipe-C-eDP-1-4
[287.660426] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[287.674193] Starting dynamic subtest: pipe-C-eDP-1-x
[289.850544] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[290.216962] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[293.010132] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[293.020375] Starting dynamic subtest: pipe-D-eDP-1-4
[295.195401] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[295.205496] Starting dynamic subtest: pipe-D-eDP-1-4
[297.206150] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[297.215966] Starting dynamic subtest: pipe-D-eDP-1-x
[299.398315] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.190s)
[299.400771] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.128s)
[300.607959] [052/132] (720s left) kms_plane_lowres (tiling-none)
[300.709068] Starting subtest: tiling-none
[300.711378] Starting dynamic subtest: pipe-A-eDP-1
[300.715753] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.003756] Starting dynamic subtest: pipe-B-eDP-1
[301.008103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.017872] Starting dynamic subtest: pipe-C-eDP-1
[301.022280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.032044] Starting dynamic subtest: pipe-D-eDP-1
[301.036144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.040071] Subtest tiling-none: SKIP (0.293s)
[301.839202] [053/132] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[301.940715] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[301.945325] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[302.037673] [054/132] (718s left) gen9_exec_parse (bb-start-param)
[302.109920] Subtest bb-start-param: SKIP (0.000s)
[302.171110] [055/132] (718s left) perf_pmu (busy-check-all)
[302.213367] Starting subtest: busy-check-all
[302.215585] Starting dynamic subtest: rcs0
[302.776386] Dynamic subtest rcs0: SUCCESS (0.565s)
[302.790042] Starting dynamic subtest: bcs0
[303.327720] Dynamic subtest bcs0: SUCCESS (0.550s)
[303.340389] Starting dynamic subtest: vcs0
[305.279609] Dynamic subtest vcs0: SUCCESS (1.948s)
[305.291532] Starting dynamic subtest: vcs1
[307.264407] Dynamic subtest vcs1: SUCCESS (1.983s)
[307.276290] Starting dynamic subtest: vecs0
[309.311824] Dynamic subtest vecs0: SUCCESS (2.045s)
[309.324654] Starting dynamic subtest: ccs0
[309.865188] Dynamic subtest ccs0: SUCCESS (0.553s)
[309.867642] Subtest busy-check-all: SUCCESS (7.655s)
[309.990150] [056/132] (711s left) kms_flip (dpms-off-confusion)
[310.088494] Starting subtest: dpms-off-confusion
[310.090797] Starting dynamic subtest: A-eDP1
[318.737647] Dynamic subtest A-eDP1: SUCCESS (8.651s)
[318.747063] Starting dynamic subtest: B-eDP1
[327.377905] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[327.389938] Starting dynamic subtest: C-eDP1
[336.000442] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[336.011690] Starting dynamic subtest: D-eDP1
[344.630861] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[344.636364] Subtest dpms-off-confusion: SUCCESS (34.549s)
[345.810594] [057/132] (675s left) kms_pm_rpm (system-suspend-idle)
[347.446199] Starting subtest: system-suspend-idle
[366.552730] Subtest system-suspend-idle: SUCCESS (4.415s)
[366.935254] [058/132] (654s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[367.043674] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[367.045842] Starting dynamic subtest: pipe-A-eDP-1
[367.068568] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.080307] Starting dynamic subtest: pipe-B-eDP-1
[367.101328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.111237] Starting dynamic subtest: pipe-C-eDP-1
[367.132025] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.142226] Starting dynamic subtest: pipe-D-eDP-1
[367.164137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.168143] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[369.209277] [059/132] (651s left) gem_ctx_shared (exec-single-timeline)
[369.285707] Starting subtest: exec-single-timeline
[369.287598] Starting dynamic subtest: rcs0
[370.366043] Dynamic subtest rcs0: SUCCESS (1.080s)
[370.379484] Starting dynamic subtest: bcs0
[371.453610] Dynamic subtest bcs0: SUCCESS (1.083s)
[371.467566] Starting dynamic subtest: vcs0
[372.542572] Dynamic subtest vcs0: SUCCESS (1.084s)
[372.556285] Starting dynamic subtest: vcs1
[373.631881] Dynamic subtest vcs1: SUCCESS (1.084s)
[373.644997] Starting dynamic subtest: vecs0
[374.718611] Dynamic subtest vecs0: SUCCESS (1.084s)
[374.735492] Starting dynamic subtest: ccs0
[375.807043] Dynamic subtest ccs0: SUCCESS (1.083s)
[375.810013] Subtest exec-single-timeline: SUCCESS (6.519s)
[376.012256] [060/132] (645s left) gem_exec_parallel (contexts)
[376.072016] Starting subtest: contexts
[376.074337] Starting dynamic subtest: rcs0
[379.441404] Dynamic subtest rcs0: SUCCESS (3.366s)
[379.453384] Starting dynamic subtest: bcs0
[382.878798] Dynamic subtest bcs0: SUCCESS (3.435s)
[382.897327] Starting dynamic subtest: vcs0
[387.356907] Dynamic subtest vcs0: SUCCESS (4.476s)
[387.367858] Starting dynamic subtest: vcs1
[391.425932] Dynamic subtest vcs1: SUCCESS (4.064s)
[391.439049] Starting dynamic subtest: vecs0
[395.452441] Dynamic subtest vecs0: SUCCESS (4.024s)
[395.465717] Starting dynamic subtest: ccs0
[399.478837] Dynamic subtest ccs0: SUCCESS (4.023s)
[399.481646] Subtest contexts: SUCCESS (23.400s)
[399.685971] [061/132] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[399.788481] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[399.792519] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[399.900488] [062/132] (621s left) gem_ctx_persistence (heartbeat-hang)
[399.958840] Starting subtest: heartbeat-hang
[399.963310] Subtest heartbeat-hang: SKIP (0.000s)
[400.064863] [063/132] (621s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[400.116198] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[400.118748] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[400.222086] [064/132] (621s left) syncobj_wait (wait-all-snapshot)
[400.272024] Starting subtest: wait-all-snapshot
[400.352098] Subtest wait-all-snapshot: SUCCESS (0.081s)
[400.431979] [065/132] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[400.523601] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[407.821458] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.296s)
[407.969561] [066/132] (613s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[408.089960] Starting subtest: basic-flip-after-cursor-legacy
[409.004917] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s)
[409.874161] [067/132] (611s left) gem_exec_whisper (basic-fds-forked-all)
[409.941369] Starting subtest: basic-fds-forked-all
[430.772221] Subtest basic-fds-forked-all: SUCCESS (20.826s)
[430.979354] [068/132] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[431.075201] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[431.079936] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[431.174917] [069/132] (590s left) kms_dsc (dsc-basic)
[431.263677] Starting subtest: dsc-basic
[431.276026] Subtest dsc-basic: SKIP (0.000s)
[431.337584] [070/132] (590s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[431.435255] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[432.069980] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[432.242710] [071/132] (589s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[432.323124] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[432.325469] Starting dynamic subtest: pipe-A-eDP-1
[432.385609] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[432.397028] Starting dynamic subtest: pipe-B-eDP-1
[432.454583] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[432.466620] Starting dynamic subtest: pipe-C-eDP-1
[432.523342] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[432.533914] Starting dynamic subtest: pipe-D-eDP-1
[432.588954] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[432.593395] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[434.662306] [072/132] (587s left) kms_atomic (atomic-plane-damage)
[434.754719] Starting subtest: atomic-plane-damage
[434.808880] Starting dynamic subtest: pipe-A-eDP-1
[435.365569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[435.367838] Subtest atomic-plane-damage: SUCCESS (0.611s)
[436.181342] [073/132] (585s left) gem_userptr_blits (mmap-offset-banned)
[436.248658] Starting subtest: mmap-offset-banned
[436.250925] Starting dynamic subtest: wb
[436.252821] Dynamic subtest wb: SUCCESS (0.000s)
[436.265634] Starting dynamic subtest: wc
[436.267719] Dynamic subtest wc: SUCCESS (0.000s)
[436.278284] Starting dynamic subtest: uc
[436.280444] Dynamic subtest uc: SUCCESS (0.000s)
[436.282739] Subtest mmap-offset-banned: SUCCESS (0.002s)
[436.363718] [074/132] (585s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[436.454798] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[436.458786] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[436.557046] [075/132] (585s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[436.646269] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[436.648846] Starting dynamic subtest: pipe-A-default-mode
[439.399807] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s)
[439.401756] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.751s)
[440.261081] [076/132] (581s left) gem_compute (compute-square)
[440.327398] Starting subtest: compute-square
[440.336146] Subtest compute-square: SUCCESS (0.010s)
[440.458212] [077/132] (581s left) kms_lease (cursor-implicit-plane)
[440.543608] Starting subtest: cursor-implicit-plane
[440.545843] Starting dynamic subtest: pipe-A-eDP-1
[441.007386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[441.019262] Starting dynamic subtest: pipe-B-eDP-1
[442.093380] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.084s)
[442.104462] Starting dynamic subtest: pipe-C-eDP-1
[443.199475] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[443.211297] Starting dynamic subtest: pipe-D-eDP-1
[444.345812] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[444.348166] Subtest cursor-implicit-plane: SUCCESS (3.802s)
[445.205241] [078/132] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[445.297151] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[445.301302] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[445.386405] [079/132] (576s left) gem_mmap_gtt (big-bo)
[445.442796] Subtest big-bo: SKIP (0.000s)
[445.508327] [080/132] (576s left) kms_scaling_modes (scaling-mode-center)
[445.599253] Starting subtest: scaling-mode-center
[445.601506] Starting dynamic subtest: pipe-A-eDP-1
[445.695680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.102s)
[445.706776] Starting dynamic subtest: pipe-B-eDP-1
[446.847968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[446.859341] Starting dynamic subtest: pipe-C-eDP-1
[447.970597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[447.984580] Starting dynamic subtest: pipe-D-eDP-1
[449.105152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[449.107487] Subtest scaling-mode-center: SUCCESS (3.512s)
[450.259497] [081/132] (571s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[450.362402] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[450.366890] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[450.447329] [082/132] (571s left) gem_mmap_wc (set-cache-level)
[450.511578] Subtest set-cache-level: SKIP (0.000s)
[450.564232] [083/132] (571s left) perf (create-destroy-userspace-config)
[450.691148] Starting subtest: create-destroy-userspace-config
[450.717589] Subtest create-destroy-userspace-config: SUCCESS (0.025s)
[450.768841] [084/132] (571s left) gem_userptr_blits (process-exit-busy)
[450.839224] Starting subtest: process-exit-busy
[450.851801] Subtest process-exit-busy: SUCCESS (0.014s)
[450.978826] [085/132] (571s left) i915_pm_freq_api (freq-basic-api)
[451.045246] Starting subtest: freq-basic-api
[451.047569] Starting dynamic subtest: gt0
[451.049796] Dynamic subtest gt0: SUCCESS (0.002s)
[451.061037] Starting dynamic subtest: gt1
[451.063269] Dynamic subtest gt1: SUCCESS (0.004s)
[451.065596] Subtest freq-basic-api: SUCCESS (0.007s)
[451.144700] [086/132] (571s left) syncobj_wait (wait-all-interrupted)
[451.191164] Starting subtest: wait-all-interrupted
[451.292619] Subtest wait-all-interrupted: SUCCESS (0.101s)
[451.386048] [087/132] (571s left) gem_mmap_wc (pf-nonblock)
[451.446444] Subtest pf-nonblock: SKIP (0.000s)
[451.507325] [088/132] (570s left) kms_prop_blob (invalid-get-prop)
[451.561993] Starting subtest: invalid-get-prop
[451.563599] Subtest invalid-get-prop: SUCCESS (0.000s)
[451.673571] [089/132] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[451.760519] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[458.592660] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.834s)
[458.729218] [090/132] (563s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[458.822545] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[458.826868] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[459.915217] [091/132] (562s left) gem_exec_parallel (basic)
[459.974807] Starting subtest: basic
[459.977244] Starting dynamic subtest: rcs0
[461.407476] Dynamic subtest rcs0: SUCCESS (1.433s)
[461.420321] Starting dynamic subtest: bcs0
[462.860475] Dynamic subtest bcs0: SUCCESS (1.451s)
[462.875062] Starting dynamic subtest: vcs0
[464.993065] Dynamic subtest vcs0: SUCCESS (2.130s)
[465.005756] Starting dynamic subtest: vcs1
[466.976889] Dynamic subtest vcs1: SUCCESS (1.982s)
[466.989965] Starting dynamic subtest: vecs0
[468.960875] Dynamic subtest vecs0: SUCCESS (1.981s)
[468.972591] Starting dynamic subtest: ccs0
[470.462510] Dynamic subtest ccs0: SUCCESS (1.500s)
[470.465006] Subtest basic: SUCCESS (10.491s)
[470.668411] [092/132] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[470.719736] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[470.830081] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[470.909443] [093/132] (551s left) gem_gtt_cpu_tlb
[471.023969] [094/132] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[471.120429] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[477.753899] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.635s)
[477.885051] [095/132] (544s left) kms_debugfs (display-off-read-all)
[477.978560] Starting subtest: display-off-read-all
[478.265573] Subtest display-off-read-all: SUCCESS (0.287s)
[479.067592] [096/132] (543s left) kms_vblank (accuracy-idle)
[479.157878] Starting subtest: accuracy-idle
[479.159851] Starting dynamic subtest: pipe-A-eDP-1
[480.925890] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[480.942418] Starting dynamic subtest: pipe-D-eDP-1
[483.417241] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[483.419592] Subtest accuracy-idle: SUCCESS (4.262s)
[484.228055] [097/132] (538s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[484.342965] Starting subtest: basic-busy-flip-before-cursor-varying-size
[484.348185] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[484.495723] [098/132] (538s left) kms_chamelium_audio (hdmi-audio)
[484.876687] Subtest hdmi-audio: SKIP (0.000s)
[485.658554] [099/132] (537s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[485.751452] Starting subtest: yf-tiled-64bpp-rotate-90
[485.755876] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[485.835702] [100/132] (537s left) gem_exec_fence (syncobj-import)
[486.287570] Starting subtest: syncobj-import
[486.293848] Subtest syncobj-import: SUCCESS (0.005s)
[488.049199] [101/132] (534s left) kms_pm_rpm (dpms-non-lpsp)
[490.179106] Starting subtest: dpms-non-lpsp
[490.184024] Subtest dpms-non-lpsp: SKIP (0.001s)
[490.561170] [102/132] (532s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[490.613921] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[490.717764] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[490.795833] [103/132] (532s left) sysfs_preempt_timeout (idempotent)
[490.849889] Starting subtest: idempotent
[490.852293] Starting dynamic subtest: vecs0
[490.854829] Dynamic subtest vecs0: SUCCESS (0.000s)
[490.866924] Starting dynamic subtest: ccs0
[490.868908] Dynamic subtest ccs0: SUCCESS (0.000s)
[490.879153] Starting dynamic subtest: vcs0
[490.881123] Dynamic subtest vcs0: SUCCESS (0.000s)
[490.891414] Starting dynamic subtest: bcs0
[490.893377] Dynamic subtest bcs0: SUCCESS (0.000s)
[490.903428] Starting dynamic subtest: rcs0
[490.906091] Dynamic subtest rcs0: SUCCESS (0.000s)
[490.916364] Starting dynamic subtest: vcs1
[490.918658] Dynamic subtest vcs1: SUCCESS (0.000s)
[490.920550] Subtest idempotent: SUCCESS (0.006s)
[490.965755] [104/132] (532s left) gem_mmap_wc (read)
[491.020685] Subtest read: SKIP (0.000s)
[491.075917] [105/132] (532s left) gen3_render_mixed_blits
[491.184336] [106/132] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[491.275918] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[491.280325] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[491.383222] [107/132] (531s left) dmabuf_sync_file (import-multiple-read-write)
[491.432927] Starting subtest: import-multiple-read-write
[491.435211] Subtest import-multiple-read-write: SUCCESS (0.003s)
[491.492106] [108/132] (531s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[491.584521] Starting subtest: plane-lut1d-ctm3x4-lut1d
[491.752097] Starting dynamic subtest: pipe-A-plane-0
[491.929630] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[491.941289] Starting dynamic subtest: pipe-A-plane-1
[492.107387] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[492.118520] Starting dynamic subtest: pipe-A-plane-2
[492.274255] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[493.487699] Starting dynamic subtest: pipe-B-plane-0
[493.667616] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[493.679598] Starting dynamic subtest: pipe-B-plane-1
[493.844001] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[493.858736] Starting dynamic subtest: pipe-B-plane-2
[494.022323] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[495.268177] Starting dynamic subtest: pipe-C-plane-0
[495.391196] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[495.402956] Starting dynamic subtest: pipe-C-plane-1
[495.535864] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[495.547640] Starting dynamic subtest: pipe-C-plane-2
[495.704131] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[496.898321] Starting dynamic subtest: pipe-D-plane-0
[497.024153] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[497.035412] Starting dynamic subtest: pipe-D-plane-1
[497.177953] Dynamic subtest pipe-D-plane-1: SUCCESS (0.154s)
[497.189061] Starting dynamic subtest: pipe-D-plane-2
[497.333687] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[497.619804] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.036s)
[498.473847] [109/132] (524s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[498.568728] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[498.573008] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[498.675375] [110/132] (524s left) gem_mmap_gtt (close-race)
[498.737208] Subtest close-race: SKIP (0.000s)
[498.803935] [111/132] (524s left) kms_atomic_transition (plane-all-modeset-transition)
[498.888144] Starting subtest: plane-all-modeset-transition
[498.892730] Subtest plane-all-modeset-transition: SKIP (0.000s)
[498.962106] [112/132] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[499.055013] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[499.059308] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[499.153277] [113/132] (524s left) gem_exec_schedule (fifo)
[499.225997] Starting subtest: fifo
[499.228256] Starting dynamic subtest: rcs0
[499.323002] Dynamic subtest rcs0: SUCCESS (0.103s)
[499.336840] Starting dynamic subtest: vcs0
[499.412561] Dynamic subtest vcs0: SUCCESS (0.090s)
[499.430970] Starting dynamic subtest: vcs1
[499.492460] Dynamic subtest vcs1: SUCCESS (0.078s)
[499.509787] Starting dynamic subtest: vecs0
[499.571409] Dynamic subtest vecs0: SUCCESS (0.078s)
[499.586851] Starting dynamic subtest: ccs0
[499.649021] Dynamic subtest ccs0: SUCCESS (0.076s)
[499.651380] Subtest fifo: SUCCESS (0.431s)
[501.076433] [114/132] (522s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[501.140279] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[501.144902] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[501.333892] [115/132] (522s left) kms_psr (fbc-pr-cursor-plane-move)
[501.418605] Starting subtest: fbc-pr-cursor-plane-move
[501.423060] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[501.495008] [116/132] (522s left) gem_busy (busy)
[501.542238] Starting subtest: busy
[501.544571] Starting dynamic subtest: all-engines
[501.595760] Dynamic subtest all-engines: SUCCESS (0.053s)
[501.610230] Starting dynamic subtest: rcs0
[503.015121] Dynamic subtest rcs0: SUCCESS (1.418s)
[503.028431] Starting dynamic subtest: bcs0
[503.055620] Dynamic subtest bcs0: SUCCESS (0.039s)
[503.066752] Starting dynamic subtest: vcs0
[503.095980] Dynamic subtest vcs0: SUCCESS (0.038s)
[503.106809] Starting dynamic subtest: vcs1
[505.000837] Dynamic subtest vcs1: SUCCESS (1.901s)
[505.013099] Starting dynamic subtest: vecs0
[506.983897] Dynamic subtest vecs0: SUCCESS (1.982s)
[506.995948] Starting dynamic subtest: ccs0
[508.968581] Dynamic subtest ccs0: SUCCESS (1.982s)
[508.971015] Subtest busy: SUCCESS (7.422s)
[509.338042] [117/132] (514s left) gem_reg_read (timestamp-monotonic)
[509.389106] Starting subtest: timestamp-monotonic
[513.743963] Subtest timestamp-monotonic: SUCCESS (4.355s)
[513.820586] [118/132] (509s left) kms_psr (fbc-pr-sprite-render)
[513.922438] Starting subtest: fbc-pr-sprite-render
[513.926976] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[514.003010] [119/132] (509s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[514.380801] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[515.185244] [120/132] (508s left) gem_exec_reloc (basic-cpu-wc-active)
[515.240367] Subtest basic-cpu-wc-active: SKIP (0.000s)
[515.314343] [121/132] (508s left) i915_drm_fdinfo (busy)
[515.352145] Starting subtest: busy
[515.354463] Starting dynamic subtest: rcs0
[515.380561] Dynamic subtest rcs0: SKIP (0.028s)
[515.394791] Starting dynamic subtest: bcs0
[515.399275] Dynamic subtest bcs0: SKIP (0.000s)
[515.410705] Starting dynamic subtest: vcs0
[515.415044] Dynamic subtest vcs0: SKIP (0.000s)
[515.426008] Starting dynamic subtest: vcs1
[515.430430] Dynamic subtest vcs1: SKIP (0.000s)
[515.444339] Starting dynamic subtest: vecs0
[515.448740] Dynamic subtest vecs0: SKIP (0.000s)
[515.459481] Starting dynamic subtest: ccs0
[515.463890] Dynamic subtest ccs0: SKIP (0.000s)
[515.468275] Subtest busy: SKIP (0.035s)
[515.507635] [122/132] (508s left) i915_pm_rpm (system-suspend)
[517.029754] Starting subtest: system-suspend
[535.101748] Subtest system-suspend: SUCCESS (2.875s)
[535.485097] [123/132] (488s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[535.871598] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[536.691773] [124/132] (487s left) kms_psr (psr-cursor-mmap-gtt)
[536.788366] Starting subtest: psr-cursor-mmap-gtt
[536.790533] Starting dynamic subtest: eDP-1
[546.498566] Dynamic subtest eDP-1: SUCCESS (9.696s)
[546.517907] Subtest psr-cursor-mmap-gtt: SUCCESS (9.719s)
[627.505149] Killing the test because the kernel is tainted.
[747.526432] Timeout. Killing the current test with SIGKILL.
[747.529784] Child refuses to die, tainted 0x4244. Aborting.
[747.531426] Closing watchdogs
[747.565522] [FACT kms_psr (psr-cursor-mmap-gtt)] new: kernel.is_tainted.taint_warn: true
[747.566512] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: i915_pm_rps
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_panel_fitting
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: api_intel_allocator
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_await
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: prime_self_import
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_exec_create
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: sriov_basic
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_plane_lowres
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_ctx_shared
results: parsing output: 59/ for test: gem_exec_parallel
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_compute
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_scaling_modes
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: i915_pm_freq_api
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: kms_prop_blob
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_exec_parallel
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_gtt_cpu_tlb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_debugfs
results: parsing output: 95/ for test: kms_vblank
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_chamelium_audio
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: sysfs_preempt_timeout
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: gen3_render_mixed_blits
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: kms_color_pipeline
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_busy
results: parsing output: 116/ for test: gem_reg_read
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_mmap_offset
results: no output, setting notrun
results: parsing output: 125/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 127/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 129/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 130/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 131/ for test: gem_eio
results: no output, setting notrun
Done.