[58.165942] Initializing watchdogs
[58.166014]   /dev/watchdog0
[58.179952] [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.184395] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.186542] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.190454] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[58.317307] Starting subtest: x-tiled-8bpp-rotate-270
[58.355347] Subtest x-tiled-8bpp-rotate-270: SKIP (0.037s)
[58.473115] [002/133] (960s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[58.555145] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[58.557483] Starting dynamic subtest: pipe-A-default-mode
[61.285880] Dynamic subtest pipe-A-default-mode: SUCCESS (2.731s)
[61.288231] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.732s)
[62.120754] [003/133] (956s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[62.233590] Starting subtest: yf-tiled-addfb-size-offset-overflow
[62.237864] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[62.343621] [004/133] (956s left) syncobj_timeline (wait-delayed-signal)
[62.398871] Starting subtest: wait-delayed-signal
[62.502401] Subtest wait-delayed-signal: SUCCESS (0.103s)
[62.588814] [005/133] (956s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[62.690330] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[62.692777] Starting dynamic subtest: pipe-A
[62.712309] Dynamic subtest pipe-A: SKIP (0.019s)
[62.723528] Starting dynamic subtest: pipe-B
[62.748877] Dynamic subtest pipe-B: SKIP (0.037s)
[62.756082] Starting dynamic subtest: pipe-C
[62.788527] Dynamic subtest pipe-C: SKIP (0.037s)
[62.797274] Starting dynamic subtest: pipe-D
[62.825457] Dynamic subtest pipe-D: SKIP (0.037s)
[62.829675] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.131s)
[62.917511] [006/133] (955s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[63.015812] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[63.020258] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[63.085598] [007/133] (955s left) gem_exec_gttfill (all-engines)
[63.154540] Starting subtest: all-engines
[86.298215] Subtest all-engines: SUCCESS (23.142s)
[86.485619] [008/133] (932s left) gem_mmap_gtt (basic-write-gtt)
[86.594074] Subtest basic-write-gtt: SKIP (0.000s)
[86.664680] [009/133] (932s left) syncobj_wait (wait-for-submit-snapshot)
[86.725764] Starting subtest: wait-for-submit-snapshot
[86.805529] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[86.891657] [010/133] (932s left) kms_plane_lowres (tiling-x)
[86.996943] Starting subtest: tiling-x
[86.999214] Starting dynamic subtest: pipe-A-eDP-1
[87.003598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.293902] Starting dynamic subtest: pipe-B-eDP-1
[87.298284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.305137] Starting dynamic subtest: pipe-C-eDP-1
[87.309550] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.316774] Starting dynamic subtest: pipe-D-eDP-1
[87.321258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.325541] Subtest tiling-x: SKIP (0.295s)
[88.151659] [011/133] (930s left) fbdev (read)
[88.203799] Starting subtest: read
[88.734515] Subtest read: SUCCESS (0.529s)
[88.796306] [012/133] (930s left) kms_joiner (invalid-modeset-force-big-joiner)
[88.904880] Starting subtest: invalid-modeset-force-big-joiner
[88.908908] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[88.981365] [013/133] (930s left) gem_partial_pwrite_pread (reads-display)
[89.037940] Subtest reads-display: SKIP (0.000s)
[89.102550] [014/133] (930s left) gem_exec_schedule (in-order)
[89.175297] Starting subtest: in-order
[89.177433] Starting dynamic subtest: rcs0
[89.267504] Dynamic subtest rcs0: SUCCESS (0.100s)
[89.277928] Starting dynamic subtest: vcs0
[89.346685] Dynamic subtest vcs0: SUCCESS (0.079s)
[89.356564] Starting dynamic subtest: vcs1
[89.421999] Dynamic subtest vcs1: SUCCESS (0.075s)
[89.432262] Starting dynamic subtest: vecs0
[89.500511] Dynamic subtest vecs0: SUCCESS (0.078s)
[89.510312] Starting dynamic subtest: ccs0
[89.584876] Dynamic subtest ccs0: SUCCESS (0.084s)
[89.587229] Subtest in-order: SUCCESS (0.417s)
[90.989766] [015/133] (928s left) gem_userptr_blits (unsync-unmap-after-close)
[91.057612] Subtest unsync-unmap-after-close: SKIP (0.000s)
[91.184433] [016/133] (928s left) syncobj_timeline (invalid-query-one-illegal-handle)
[91.231884] Starting subtest: invalid-query-one-illegal-handle
[91.234313] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[91.322323] [017/133] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[91.426162] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[91.430673] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[91.553489] [018/133] (927s left) gem_exec_schedule (submit-golden-slice)
[91.629982] Starting subtest: submit-golden-slice
[91.631983] Starting dynamic subtest: rcs0
[91.654534] Dynamic subtest rcs0: SUCCESS (0.031s)
[91.662083] Starting dynamic subtest: bcs0
[91.688881] Dynamic subtest bcs0: SUCCESS (0.034s)
[91.696461] Starting dynamic subtest: vcs0
[91.724025] Dynamic subtest vcs0: SUCCESS (0.035s)
[91.733059] Starting dynamic subtest: vcs1
[91.751643] Dynamic subtest vcs1: SUCCESS (0.027s)
[91.759368] Starting dynamic subtest: vecs0
[91.777392] Dynamic subtest vecs0: SUCCESS (0.025s)
[91.785713] Starting dynamic subtest: ccs0
[91.811346] Dynamic subtest ccs0: SUCCESS (0.034s)
[91.813566] Subtest submit-golden-slice: SUCCESS (0.189s)
[92.960498] [019/133] (926s left) kms_addfb_basic (bad-pitch-999)
[93.013842] Starting subtest: bad-pitch-999
[93.015950] Subtest bad-pitch-999: SUCCESS (0.000s)
[93.135803] [020/133] (926s left) perf (blocking)
[93.312347] Starting subtest: blocking
[93.314469] Starting dynamic subtest: 0-rcs0
[103.330568] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[103.338272] Starting dynamic subtest: 1-vcs1
[113.403306] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[113.405960] Subtest blocking: SUCCESS (20.038s)
[113.442223] [021/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[113.560055] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[113.564222] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.648914] [022/133] (905s left) kms_psr (psr2-primary-render)
[113.736085] Starting subtest: psr2-primary-render
[113.738468] Starting dynamic subtest: eDP-1
[115.434658] Dynamic subtest eDP-1: SUCCESS (1.698s)
[115.436928] Subtest psr2-primary-render: SUCCESS (1.699s)
[116.310139] [023/133] (903s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[116.415372] Starting subtest: psr-2p-pri-indfb-multidraw
[116.419399] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[116.516592] [024/133] (903s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[116.613216] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[116.615362] Starting dynamic subtest: pipe-A-eDP-1
[122.499602] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.892s)
[122.508088] Starting dynamic subtest: pipe-B-eDP-1
[129.135511] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.632s)
[129.137924] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.526s)
[130.012147] [025/133] (889s left) gem_exec_balancer (bonded-false-hang)
[130.291925] Starting subtest: bonded-false-hang
[130.297301] Subtest bonded-false-hang: SKIP (0.000s)
[130.396390] [026/133] (889s left) gen9_exec_parse (allowed-single)
[130.464260] Subtest allowed-single: SKIP (0.000s)
[130.543954] [027/133] (889s left) kms_getfb (getfb2-handle-not-fb)
[130.629142] Starting subtest: getfb2-handle-not-fb
[130.631457] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[130.726355] [028/133] (888s left) gem_vm_create (invalid-destroy)
[130.790068] Starting subtest: invalid-destroy
[130.792825] Subtest invalid-destroy: SUCCESS (0.002s)
[130.902252] [029/133] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[130.997578] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[138.072795] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.078s)
[138.205478] [030/133] (881s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[138.311263] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[138.968473] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[139.179055] [031/133] (880s left) gem_softpin (noreloc)
[139.247816] Starting subtest: noreloc
[144.705314] Subtest noreloc: SUCCESS (5.405s)
[144.774663] [032/133] (875s left) kms_flip (busy-flip)
[144.878494] Starting subtest: busy-flip
[144.880940] Starting dynamic subtest: A-eDP1
[146.532747] Dynamic subtest A-eDP1: SUCCESS (1.653s)
[146.543033] Starting dynamic subtest: B-eDP1
[148.270429] Dynamic subtest B-eDP1: SUCCESS (1.736s)
[148.280492] Starting dynamic subtest: C-eDP1
[149.987610] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[149.997597] Starting dynamic subtest: D-eDP1
[151.622494] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[151.624984] Subtest busy-flip: SUCCESS (6.747s)
[152.794406] [033/133] (867s left) perf (sysctl-defaults)
[152.849741] Starting subtest: sysctl-defaults
[152.852290] Subtest sysctl-defaults: SUCCESS (0.000s)
[152.914314] [034/133] (867s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[152.993202] Starting subtest: fb-8bpc-vs-panel-6bpc
[152.995528] Starting dynamic subtest: pipe-A-eDP-1
[154.370475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.376s)
[154.372746] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.379s)
[155.158914] [035/133] (864s left) kms_content_protection (dp-mst-type-1)
[155.296666] Starting subtest: dp-mst-type-1
[155.300958] Subtest dp-mst-type-1: SKIP (0.000s)
[155.410898] [036/133] (864s left) kms_rotation_crc (primary-rotation-90)
[155.500291] Starting subtest: primary-rotation-90
[155.504264] Subtest primary-rotation-90: SKIP (0.001s)
[155.570912] [037/133] (864s left) gem_lmem_swapping (parallel-random-verify)
[155.615991] Subtest parallel-random-verify: SKIP (0.000s)
[155.655271] [038/133] (864s left) kms_psr (fbc-psr-cursor-plane-move)
[155.745823] Starting subtest: fbc-psr-cursor-plane-move
[155.748091] Starting dynamic subtest: eDP-1
[155.752433] Dynamic subtest eDP-1: SKIP (0.000s)
[155.756885] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[155.814869] [039/133] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[155.940665] Starting subtest: basic-busy-flip-before-cursor-legacy
[155.945050] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[156.085542] [040/133] (864s left) perf_pmu (enable-race)
[156.122301] Starting subtest: enable-race
[156.124182] Starting dynamic subtest: rcs0
[168.911501] Dynamic subtest rcs0: SUCCESS (12.768s)
[168.922072] Starting dynamic subtest: bcs0
[181.652968] Dynamic subtest bcs0: SUCCESS (12.741s)
[181.662262] Starting dynamic subtest: vcs0
[196.886549] Dynamic subtest vcs0: SUCCESS (15.248s)
[196.904102] Starting dynamic subtest: vcs1
[212.885556] Dynamic subtest vcs1: SUCCESS (15.996s)
[212.902798] Starting dynamic subtest: vecs0
[228.885613] Dynamic subtest vecs0: SUCCESS (15.998s)
[228.895555] Starting dynamic subtest: ccs0
[241.644006] Dynamic subtest ccs0: SUCCESS (12.741s)
[241.646097] Subtest enable-race: SUCCESS (85.502s)
[241.724969] [041/133] (778s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[241.819260] Starting subtest: fbc-pr-sprite-mmap-cpu
[241.823789] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[241.889371] [042/133] (778s left) kms_async_flips (crc)
[241.982075] Starting subtest: crc
[242.358708] Starting dynamic subtest: pipe-A-eDP-1
[245.271073] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[245.651424] Starting dynamic subtest: pipe-B-eDP-1
[248.593026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[248.979623] Starting dynamic subtest: pipe-C-eDP-1
[251.905511] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.935s)
[252.282043] Starting dynamic subtest: pipe-D-eDP-1
[255.135100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s)
[255.137552] Subtest crc: SUCCESS (13.155s)
[256.305414] [043/133] (764s left) kms_cursor_crc (cursor-onscreen-128x128)
[256.534000] Starting subtest: cursor-onscreen-128x128
[256.538915] Starting dynamic subtest: pipe-A-eDP-1
[258.658796] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[258.691908] Starting dynamic subtest: pipe-D-eDP-1
[261.486904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.804s)
[261.489292] Subtest cursor-onscreen-128x128: SUCCESS (4.951s)
[262.289093] [044/133] (758s left) gem_mmap_wc (write-cpu-read-wc)
[262.349235] Subtest write-cpu-read-wc: SKIP (0.000s)
[262.404568] [045/133] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[262.521667] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[266.900668] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.382s)
[268.102403] [046/133] (752s left) gem_exec_params (invalid-bsd2-flag-on-render)
[268.154260] Starting subtest: invalid-bsd2-flag-on-render
[268.156673] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[268.253815] [047/133] (752s left) gem_pipe_control_store_loop (reused-buffer)
[268.303264] Starting subtest: reused-buffer
[270.509808] Subtest reused-buffer: SUCCESS (2.152s)
[270.580712] [048/133] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[270.675678] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[270.679777] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[270.768609] [049/133] (749s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[270.862313] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[270.866593] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[270.973795] [050/133] (749s left) kms_cursor_crc (cursor-sliding-64x21)
[271.169818] Starting subtest: cursor-sliding-64x21
[271.220260] Subtest cursor-sliding-64x21: SKIP (0.046s)
[271.484753] [051/133] (749s left) i915_hangman (error-state-basic)
[271.554639] Starting subtest: error-state-basic
[271.714295] Subtest error-state-basic: SUCCESS (0.160s)
[271.787321] [052/133] (748s left) device_reset (unbind-reset-rebind)
[271.835201] Starting subtest: unbind-reset-rebind
[275.209066] Subtest unbind-reset-rebind: SUCCESS (3.368s)
[275.248694] [053/133] (745s left) gem_ctx_engines (none)
[275.326273] Starting subtest: none
[275.328681] Subtest none: SUCCESS (0.001s)
[275.510196] [054/133] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[275.604174] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[279.716605] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.115s)
[280.847423] [055/133] (739s left) kms_chamelium_hpd (dp-hpd-fast)
[281.248518] Subtest dp-hpd-fast: SKIP (0.000s)
[282.062623] [056/133] (738s left) api_intel_allocator (fork-simple-once)
[282.119472] Starting subtest: fork-simple-once
[282.135034] Subtest fork-simple-once: SUCCESS (0.018s)
[282.254631] [057/133] (738s left) kms_flip (2x-busy-flip)
[282.345657] Starting subtest: 2x-busy-flip
[282.357098] Subtest 2x-busy-flip: SKIP (0.011s)
[282.445393] [058/133] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[282.543219] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[282.547579] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[282.625180] [059/133] (738s left) kms_chamelium_frames (dp-crc-fast)
[283.008067] Subtest dp-crc-fast: SKIP (0.000s)
[283.785657] [060/133] (737s left) gem_userptr_blits (input-checking)
[283.849114] Starting subtest: input-checking
[283.851437] Subtest input-checking: SUCCESS (0.000s)
[283.979704] [061/133] (737s left) kms_pm_dc (dc5-dpms)
[285.087688] Starting subtest: dc5-dpms
[287.193731] Subtest dc5-dpms: SUCCESS (2.106s)
[287.271702] [062/133] (733s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[287.378483] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[291.952780] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.570s)
[293.056436] [063/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[293.151133] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[293.155065] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[293.241803] [064/133] (727s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[293.335208] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[293.339064] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[293.427276] [065/133] (727s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[293.537132] Starting subtest: y-tiled-32bpp-rotate-0
[293.541134] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[293.634867] [066/133] (727s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[293.693284] Starting subtest: yf-tiled-ccs-to-yf-tiled
[293.697602] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[293.873580] [067/133] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[293.978501] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[293.982841] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[294.080271] [068/133] (727s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[294.168730] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[294.172794] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[294.235497] [069/133] (727s left) gem_exec_fence (parallel)
[294.408129] Starting subtest: parallel
[294.410634] Starting dynamic subtest: rcs0
[296.560152] Dynamic subtest rcs0: SUCCESS (2.152s)
[296.568832] Starting dynamic subtest: bcs0
[298.709042] Dynamic subtest bcs0: SUCCESS (2.148s)
[298.719100] Starting dynamic subtest: vcs0
[300.866100] Dynamic subtest vcs0: SUCCESS (2.156s)
[300.876334] Starting dynamic subtest: vcs1
[303.018187] Dynamic subtest vcs1: SUCCESS (2.151s)
[303.027964] Starting dynamic subtest: vecs0
[305.167728] Dynamic subtest vecs0: SUCCESS (2.149s)
[305.176522] Starting dynamic subtest: ccs0
[307.317106] Dynamic subtest ccs0: SUCCESS (2.149s)
[307.318915] Subtest parallel: SUCCESS (12.910s)
[308.008247] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[308.012414] [070/133] (713s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[308.076191] Starting subtest: multi-wait-available-unsubmitted-signaled
[308.078597] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[308.190372] [071/133] (713s left) gem_mmap_offset (mmap-unmap)
[308.255727] Starting subtest: mmap-unmap
[308.258066] Starting dynamic subtest: smem0
[330.986434] Dynamic subtest smem0: SUCCESS (22.729s)
[330.989529] Subtest mmap-unmap: SUCCESS (22.731s)
[331.108697] [072/133] (690s left) kms_psr (psr-primary-page-flip)
[331.215938] Starting subtest: psr-primary-page-flip
[331.218243] Starting dynamic subtest: eDP-1
[332.963852] Dynamic subtest eDP-1: SUCCESS (1.746s)
[332.966142] Subtest psr-primary-page-flip: SUCCESS (1.747s)
[333.831106] [073/133] (687s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[333.929616] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[333.933616] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[334.001604] [074/133] (687s left) syncobj_wait (single-wait-all-signaled)
[334.065521] Starting subtest: single-wait-all-signaled
[334.067815] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[334.173415] [075/133] (687s left) i915_query (engine-info-invalid)
[334.235892] Starting subtest: engine-info-invalid
[334.238264] Subtest engine-info-invalid: SUCCESS (0.000s)
[334.334168] [076/133] (687s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[334.388592] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[334.390620] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[334.491374] [077/133] (687s left) gem_exec_whisper (basic-sync-all)
[334.551419] Starting subtest: basic-sync-all
[341.534776] Subtest basic-sync-all: SUCCESS (6.981s)
[341.719487] [078/133] (679s left) kms_getfb (getfb-handle-valid)
[341.835139] Starting subtest: getfb-handle-valid
[341.837447] Subtest getfb-handle-valid: SUCCESS (0.000s)
[341.918842] [079/133] (679s left) gem_ctx_persistence (heartbeat-hang)
[341.978092] Starting subtest: heartbeat-hang
[341.982686] Subtest heartbeat-hang: SKIP (0.000s)
[342.094608] [080/133] (679s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[342.156325] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[342.160824] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[342.352671] [081/133] (679s left) kms_vblank (query-forked-busy-hang)
[342.437088] Starting subtest: query-forked-busy-hang
[342.439338] Starting dynamic subtest: pipe-A-eDP-1
[368.661446] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.222s)
[368.675823] Starting dynamic subtest: pipe-D-eDP-1
[383.655587] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.990s)
[383.657545] Subtest query-forked-busy-hang: SUCCESS (41.217s)
[384.471833] [082/133] (637s left) i915_drm_fdinfo (virtual-busy-all)
[384.520086] Starting subtest: virtual-busy-all
[384.524614] Subtest virtual-busy-all: SKIP (0.000s)
[384.582501] [083/133] (637s left) vgem_basic (bad-pad)
[384.633915] Starting subtest: bad-pad
[384.635824] Subtest bad-pad: SUCCESS (0.000s)
[384.695399] [084/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[384.788928] Starting subtest: fbcpsr-2p-rte
[384.793308] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[384.891508] [085/133] (637s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[384.988239] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[384.990147] Starting dynamic subtest: pipe-A-eDP-1
[417.960063] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.076s)
[417.969443] Starting dynamic subtest: pipe-B-eDP-1
[450.891067] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.713s)
[450.903785] Starting dynamic subtest: pipe-C-eDP-1
[483.890812] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.752s)
[483.912230] Starting dynamic subtest: pipe-D-eDP-1
[516.880310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.634s)
[516.882566] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.181s)
[518.115623] [086/133] (503s left) gem_mmap_offset (pf-nonblock)
[518.170113] Starting subtest: pf-nonblock
[518.175277] Subtest pf-nonblock: SUCCESS (0.006s)
[518.312912] [087/133] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[518.402784] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[522.655440] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.251s)
[523.814335] [088/133] (498s left) perf (blocking-parameterized)
[523.936585] Starting subtest: blocking-parameterized
[544.007102] Subtest blocking-parameterized: SUCCESS (20.008s)
[544.047651] [089/133] (478s left) kms_cursor_crc (cursor-size-change)
[544.147492] Starting subtest: cursor-size-change
[544.149827] Starting dynamic subtest: pipe-A-eDP-1
[544.959182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[544.975228] Starting dynamic subtest: pipe-D-eDP-1
[546.393252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s)
[546.395624] Subtest cursor-size-change: SUCCESS (2.244s)
[547.198241] [090/133] (475s left) kms_selftest (drm_damage_helper)
[547.243450] Starting subtest: drm_damage_helper
[547.265981] Starting dynamic subtest: drm_test_damage_iter_no_damage
[547.367502] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.099s)
[547.377031] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[547.462677] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.093s)
[547.472878] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[547.558741] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.095s)
[547.576444] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[547.661478] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.103s)
[547.671659] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[547.748851] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.087s)
[547.758305] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[547.857790] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.106s)
[547.868674] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[547.947521] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.090s)
[547.958486] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[548.027773] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.080s)
[548.037221] Starting dynamic subtest: drm_test_damage_iter_single_damage
[548.123828] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.094s)
[548.134209] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[548.231221] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.106s)
[548.241563] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[548.312939] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.082s)
[548.323389] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[548.404499] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.090s)
[548.413330] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[548.489111] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.085s)
[548.498467] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[548.583955] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.091s)
[548.594918] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[548.670970] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.087s)
[548.680915] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[548.759026] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.087s)
[548.769905] Starting dynamic subtest: drm_test_damage_iter_damage
[548.848601] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s)
[548.868955] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[548.937223] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.087s)
[548.957818] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[549.024679] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.086s)
[549.045333] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[549.129915] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.104s)
[549.150800] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[549.227535] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.098s)
[549.229166] Subtest drm_damage_helper: SUCCESS (1.986s)
[549.418809] [091/133] (472s left) syncobj_basic (illegal-fd-to-handle)
[549.468130] Starting subtest: illegal-fd-to-handle
[549.469868] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[549.562831] [092/133] (472s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[549.656266] Starting subtest: crc-primary-basic-y-tiled-ccs
[549.658311] Starting dynamic subtest: pipe-A-eDP-1
[549.677472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.699056] Starting dynamic subtest: pipe-B-eDP-1
[549.717577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.737150] Starting dynamic subtest: pipe-C-eDP-1
[549.756708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.777467] Starting dynamic subtest: pipe-D-eDP-1
[549.797057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.800711] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[551.970856] [093/133] (470s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[552.053548] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[552.055872] Starting dynamic subtest: pipe-A-eDP-1
[552.075465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[552.090152] Starting dynamic subtest: pipe-B-eDP-1
[552.109238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[552.118940] Starting dynamic subtest: pipe-C-eDP-1
[552.137663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[552.147068] Starting dynamic subtest: pipe-D-eDP-1
[552.166220] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[552.168458] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[554.331633] [094/133] (468s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[554.574137] Starting subtest: cursor-rapid-movement-64x21
[554.622885] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[554.864325] [095/133] (467s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[554.962707] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[554.967021] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[555.068641] [096/133] (467s left) prime_mmap (test_userptr)
[555.130667] Starting subtest: test_userptr
[555.132606] Starting dynamic subtest: test_userptr-smem
[555.134505] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[555.136433] Subtest test_userptr: SUCCESS (0.001s)
[555.240805] [097/133] (467s left) kms_big_fb (linear-32bpp-rotate-270)
[555.330660] Starting subtest: linear-32bpp-rotate-270
[555.349793] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[555.458013] [098/133] (467s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[555.550051] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[555.553745] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.648616] [099/133] (466s left) kms_fb_coherency (memset-crc)
[555.748619] Starting subtest: memset-crc
[555.750672] Starting dynamic subtest: mmap-offset-wc
[556.147350] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s)
[556.453101] Starting dynamic subtest: mmap-offset-uc
[562.502464] Dynamic subtest mmap-offset-uc: SUCCESS (6.057s)
[562.784892] Subtest memset-crc: SUCCESS (7.034s)
[563.585085] [100/133] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[563.682476] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[563.686539] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[563.791492] [101/133] (458s left) gem_softpin (reverse)
[563.839980] Starting subtest: reverse
[563.846112] Subtest reverse: SUCCESS (0.005s)
[563.974723] [102/133] (458s left) kms_atomic_transition (modeset-transition-nonblocking)
[564.066800] Starting subtest: modeset-transition-nonblocking
[564.069130] Starting dynamic subtest: 1x-outputs
[575.264466] Dynamic subtest 1x-outputs: SUCCESS (11.197s)
[575.266975] Subtest modeset-transition-nonblocking: SUCCESS (11.199s)
[576.118136] [103/133] (446s left) kms_plane (pixel-format-linear-modifier)
[576.219405] Starting subtest: pixel-format-linear-modifier
[576.248051] Starting dynamic subtest: pipe-A-plane-0
[579.981765] Dynamic subtest pipe-A-plane-0: SUCCESS (3.733s)
[579.993354] Starting dynamic subtest: pipe-A-plane-3
[581.670189] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[581.680233] Starting dynamic subtest: pipe-A-plane-5
[581.881344] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[583.004465] Starting dynamic subtest: pipe-B-plane-0
[586.661339] Dynamic subtest pipe-B-plane-0: SUCCESS (3.666s)
[586.671071] Starting dynamic subtest: pipe-B-plane-3
[588.428319] Dynamic subtest pipe-B-plane-3: SUCCESS (1.765s)
[588.438269] Starting dynamic subtest: pipe-B-plane-5
[588.639171] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[588.960932] Subtest pixel-format-linear-modifier: SUCCESS (12.742s)
[589.785905] [104/133] (433s left) vgem_basic (unload)
[589.822846] Starting subtest: unload
[618.878504] Subtest unload: SUCCESS (29.000s)
[618.925556] [105/133] (403s left) kms_rmfb (close-fd)
[619.024494] Starting subtest: close-fd
[619.026464] Starting dynamic subtest: pipe-A-eDP-1
[619.132768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[619.144057] Starting dynamic subtest: pipe-B-eDP-1
[620.355031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[620.366608] Starting dynamic subtest: pipe-C-eDP-1
[621.487595] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[621.498510] Starting dynamic subtest: pipe-D-eDP-1
[622.620596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[622.622744] Subtest close-fd: SUCCESS (3.595s)
[623.749070] [106/133] (399s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[623.847464] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[623.849610] Starting dynamic subtest: pipe-A-eDP-1
[623.871523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[623.883984] Starting dynamic subtest: pipe-B-eDP-1
[623.904863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[623.914266] Starting dynamic subtest: pipe-C-eDP-1
[623.935215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[623.945110] Starting dynamic subtest: pipe-D-eDP-1
[623.966941] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[623.970995] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[626.123210] [107/133] (396s left) kms_lease (invalid-create-leases)
[626.217466] Starting subtest: invalid-create-leases
[626.222157] Subtest invalid-create-leases: SUCCESS (0.005s)
[626.333338] [108/133] (396s left) gem_exec_fence (basic-wait)
[626.509311] Starting subtest: basic-wait
[626.511700] Starting dynamic subtest: rcs0
[626.590331] Dynamic subtest rcs0: SUCCESS (0.080s)
[626.603521] Starting dynamic subtest: bcs0
[626.650449] Dynamic subtest bcs0: SUCCESS (0.059s)
[626.660579] Starting dynamic subtest: vcs0
[626.708648] Dynamic subtest vcs0: SUCCESS (0.057s)
[626.720943] Starting dynamic subtest: vcs1
[626.769494] Dynamic subtest vcs1: SUCCESS (0.059s)
[626.782041] Starting dynamic subtest: vecs0
[626.829648] Dynamic subtest vecs0: SUCCESS (0.058s)
[626.841625] Starting dynamic subtest: ccs0
[626.890109] Dynamic subtest ccs0: SUCCESS (0.058s)
[626.892476] Subtest basic-wait: SUCCESS (0.382s)
[628.725968] [109/133] (394s left) gem_exec_whisper (basic-forked-all)
[628.794844] Starting subtest: basic-forked-all
[642.240177] Subtest basic-forked-all: SUCCESS (13.442s)
[642.427354] [110/133] (380s left) syncobj_timeline (signal)
[642.484568] Starting subtest: signal
[642.486812] Subtest signal: SUCCESS (0.000s)
[642.589512] [111/133] (380s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[642.644148] Subtest writes-after-reads: SKIP (0.000s)
[642.723621] [112/133] (380s left) kms_flip (2x-plain-flip-interruptible)
[642.822702] Starting subtest: 2x-plain-flip-interruptible
[642.834878] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[642.930032] [113/133] (380s left) kms_color (legacy-gamma-reset)
[643.023778] Starting subtest: legacy-gamma-reset
[643.025958] Starting dynamic subtest: pipe-A-eDP-1
[643.407894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[643.419220] Starting dynamic subtest: pipe-B-eDP-1
[643.421363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[643.431202] Starting dynamic subtest: pipe-C-eDP-1
[643.435824] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[643.445591] Starting dynamic subtest: pipe-D-eDP-1
[643.447810] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[643.450072] Subtest legacy-gamma-reset: SUCCESS (0.426s)
[644.249827] [114/133] (378s left) i915_pm_rpm (gem-mmap-type)
[645.786658] Starting subtest: gem-mmap-type
[645.789015] Starting dynamic subtest: wb-smem0
[649.626183] Dynamic subtest wb-smem0: SUCCESS (3.843s)
[649.636248] Starting dynamic subtest: wc-smem0
[652.505173] Dynamic subtest wc-smem0: SUCCESS (2.879s)
[652.516221] Starting dynamic subtest: uc-smem0
[655.696183] Dynamic subtest uc-smem0: SUCCESS (3.190s)
[655.698468] Subtest gem-mmap-type: SUCCESS (9.916s)
[655.807317] [115/133] (367s left) gem_ctx_param (invalid-ctx-get)
[655.867370] Starting subtest: invalid-ctx-get
[655.869804] Subtest invalid-ctx-get: SUCCESS (0.000s)
[655.940974] [116/133] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[656.028436] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[656.032362] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[656.148537] [117/133] (367s left) gem_exec_reloc (basic-wc)
[656.210762] Subtest basic-wc: SKIP (0.000s)
[656.287643] [118/133] (367s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[656.376644] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[656.379006] Starting dynamic subtest: pipe-A
[657.558781] Dynamic subtest pipe-A: SUCCESS (1.184s)
[657.569575] Starting dynamic subtest: pipe-B
[659.775778] Dynamic subtest pipe-B: SUCCESS (2.216s)
[659.786073] Starting dynamic subtest: pipe-C
[660.965803] Dynamic subtest pipe-C: SUCCESS (1.189s)
[660.976484] Starting dynamic subtest: pipe-D
[662.201054] Dynamic subtest pipe-D: SUCCESS (1.234s)
[662.203509] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.828s)
[663.405384] [119/133] (360s left) gem_mmap_wc (set-cache-level)
[663.466839] Subtest set-cache-level: SKIP (0.000s)
[663.553807] [120/133] (359s left) kms_cdclk (mode-transition)
[663.658467] Starting subtest: mode-transition
[663.660713] Starting dynamic subtest: pipe-A-eDP-1
[663.950004] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[663.960808] Starting dynamic subtest: pipe-B-eDP-1
[663.965491] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[663.975742] Starting dynamic subtest: pipe-C-eDP-1
[663.980955] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[663.990594] Starting dynamic subtest: pipe-D-eDP-1
[663.994913] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[663.999223] Subtest mode-transition: SKIP (0.295s)
[664.840220] [121/133] (358s left) gem_ctx_persistence (engines-hostile-preempt)
[664.887795] Starting subtest: engines-hostile-preempt
[664.890310] Starting dynamic subtest: rcs0
[664.955839] Dynamic subtest rcs0: SUCCESS (0.068s)
[664.969197] Starting dynamic subtest: bcs0
[664.974241] Dynamic subtest bcs0: SUCCESS (0.017s)
[664.986009] Starting dynamic subtest: vcs0
[666.563786] Dynamic subtest vcs0: SUCCESS (1.587s)
[666.576089] Starting dynamic subtest: vcs1
[668.607507] Dynamic subtest vcs1: SUCCESS (2.041s)
[668.620741] Starting dynamic subtest: vecs0
[670.611733] Dynamic subtest vecs0: SUCCESS (2.002s)
[670.624292] Starting dynamic subtest: ccs0
[670.674332] Dynamic subtest ccs0: SUCCESS (0.061s)
[670.677007] Subtest engines-hostile-preempt: SUCCESS (5.788s)
[670.768645] [122/133] (352s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[670.870891] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[677.713611] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.847s)
[677.855777] [123/133] (345s left) gem_ctx_shared (single-timeline)
[677.911159] Starting subtest: single-timeline
[677.933169] Subtest single-timeline: SUCCESS (0.015s)
[678.157564] [124/133] (345s left) kms_flip (plain-flip-ts-check)
[678.245934] Starting subtest: plain-flip-ts-check
[678.248352] Starting dynamic subtest: A-eDP1
[687.194176] Dynamic subtest A-eDP1: SUCCESS (8.914s)
[687.206906] Starting dynamic subtest: B-eDP1
[696.033789] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[696.047832] Starting dynamic subtest: C-eDP1
[704.860856] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[704.872739] Starting dynamic subtest: D-eDP1
[713.657875] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[713.662926] Subtest plain-flip-ts-check: SUCCESS (35.417s)
[714.846192] [125/133] (308s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[714.947688] Starting subtest: primary-y-tiled-reflect-x-180
[715.021314] Subtest primary-y-tiled-reflect-x-180: SKIP (0.072s)
[715.138875] [126/133] (308s left) api_intel_bb (intel-bb-blit-x)
[715.201953] Starting subtest: intel-bb-blit-x
[718.647130] Subtest intel-bb-blit-x: SUCCESS (3.444s)
[718.768965] [127/133] (305s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[718.874739] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[718.878868] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[718.950619] [128/133] (304s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[719.042353] Starting subtest: stress-xrgb8888-ytiled
[719.046767] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[719.131033] [129/133] (304s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[719.188391] Starting subtest: etime-multi-wait-all-available-unsubmitted
[719.293979] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[719.372893] [130/133] (304s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[719.425550] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[719.533461] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[719.622290] [131/133] (304s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[719.730931] Starting subtest: 4-tiled-64bpp-rotate-270
[719.754720] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[719.878845] [132/133] (304s left) kms_psr (pr-no-drrs)
[719.970344] Starting subtest: pr-no-drrs
[719.974641] Subtest pr-no-drrs: SKIP (0.000s)
[720.043848] [133/133] (304s left) perf_pmu (rc6-suspend)
[720.080876] Starting subtest: rc6-suspend
[742.864158] Subtest rc6-suspend: SUCCESS (7.481s)
[743.874481] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: gem_exec_gttfill
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_plane_lowres
results: parsing output: 10/ for test: fbdev
results: parsing output: 11/ for test: kms_joiner
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: gem_vm_create
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_dither
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: gem_pipe_control_store_loop
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: device_reset
results: parsing output: 52/ for test: gem_ctx_engines
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_pm_dc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: i915_query
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: kms_vblank
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: vgem_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_selftest
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_fb_coherency
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_rmfb
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: kms_cdclk
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_shared
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: api_intel_bb
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_pipe_stress
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: perf_pmu
Done.