[57.631030] Initializing watchdogs
[57.631071]   /dev/watchdog0
[57.645292] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.649365] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.651292] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.654410] [001/133] (960s left) kms_plane_lowres (tiling-yf)
[57.751493] Starting subtest: tiling-yf
[57.755627] Subtest tiling-yf: SKIP (0.000s)
[57.834656] [002/133] (960s left) kms_psr (psr-sprite-plane-onoff)
[57.901693] Starting subtest: psr-sprite-plane-onoff
[57.903996] Starting dynamic subtest: eDP-1
[59.722556] Dynamic subtest eDP-1: SUCCESS (1.836s)
[59.724980] Subtest psr-sprite-plane-onoff: SUCCESS (1.837s)
[60.524182] [003/133] (957s left) kms_vblank (ts-continuation-dpms-suspend)
[60.606247] Starting subtest: ts-continuation-dpms-suspend
[60.608372] Starting dynamic subtest: pipe-A-eDP-1
[77.675028] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.038s)
[77.694747] Starting dynamic subtest: pipe-D-eDP-1
[95.664524] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[95.667036] Subtest ts-continuation-dpms-suspend: SUCCESS (4.565s)
[96.459375] [004/133] (921s left) sysfs_preempt_timeout (idempotent)
[96.527614] Starting subtest: idempotent
[96.530102] Starting dynamic subtest: vecs0
[96.532553] Dynamic subtest vecs0: SUCCESS (0.000s)
[96.542014] Starting dynamic subtest: ccs0
[96.544299] Dynamic subtest ccs0: SUCCESS (0.000s)
[96.552481] Starting dynamic subtest: vcs0
[96.554784] Dynamic subtest vcs0: SUCCESS (0.000s)
[96.562450] Starting dynamic subtest: bcs0
[96.564401] Dynamic subtest bcs0: SUCCESS (0.000s)
[96.571647] Starting dynamic subtest: rcs0
[96.574045] Dynamic subtest rcs0: SUCCESS (0.000s)
[96.581445] Starting dynamic subtest: vcs1
[96.583754] Dynamic subtest vcs1: SUCCESS (0.000s)
[96.586013] Subtest idempotent: SUCCESS (0.004s)
[96.620025] [005/133] (921s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[96.689390] Starting subtest: fbc-psr2-primary-mmap-cpu
[96.691547] Starting dynamic subtest: eDP-1
[96.695260] Dynamic subtest eDP-1: SKIP (0.000s)
[96.699207] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[96.759423] [006/133] (921s left) gem_lmem_swapping (massive)
[96.799810] Subtest massive: SKIP (0.000s)
[96.842614] [007/133] (921s left) kms_frontbuffer_tracking (fbc-2p-rte)
[96.926130] Starting subtest: fbc-2p-rte
[96.930076] Subtest fbc-2p-rte: SKIP (0.000s)
[97.027115] [008/133] (921s left) syncobj_timeline (single-wait-available-submitted)
[97.083610] Starting subtest: single-wait-available-submitted
[97.086007] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[97.189098] [009/133] (921s left) gem_exec_schedule (preempt)
[97.258017] Starting subtest: preempt
[97.260243] Starting dynamic subtest: rcs0
[97.275374] Dynamic subtest rcs0: SUCCESS (0.023s)
[97.283500] Starting dynamic subtest: bcs0
[97.293780] Dynamic subtest bcs0: SUCCESS (0.019s)
[97.301775] Starting dynamic subtest: vcs0
[97.314657] Dynamic subtest vcs0: SUCCESS (0.021s)
[97.323358] Starting dynamic subtest: vcs1
[97.335029] Dynamic subtest vcs1: SUCCESS (0.020s)
[97.343110] Starting dynamic subtest: vecs0
[97.357171] Dynamic subtest vecs0: SUCCESS (0.022s)
[97.365007] Starting dynamic subtest: ccs0
[97.377234] Dynamic subtest ccs0: SUCCESS (0.020s)
[97.379233] Subtest preempt: SUCCESS (0.128s)
[98.841939] [010/133] (919s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[98.911394] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[98.915082] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[98.989228] [011/133] (919s left) gem_mmap_offset (bad-object)
[99.040570] Starting subtest: bad-object
[99.042809] Subtest bad-object: SUCCESS (0.001s)
[99.134347] [012/133] (919s left) kms_getfb (getfb-handle-not-fb)
[99.202007] Starting subtest: getfb-handle-not-fb
[99.204181] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[99.288874] [013/133] (919s left) i915_pm_rpm (gem-evict-pwrite)
[100.937417] Starting subtest: gem-evict-pwrite
[100.942978] Subtest gem-evict-pwrite: SKIP (0.000s)
[101.568948] [014/133] (917s left) gem_spin_batch (user-each)
[101.631429] Starting subtest: user-each
[104.892386] Subtest user-each: SUCCESS (3.274s)
[106.856533] [015/133] (911s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[106.941183] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[106.943648] Starting dynamic subtest: pipe-A-default-mode
[108.081280] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[108.085768] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.141s)
[108.233947] [016/133] (910s left) perf (gen12-group-exclusive-stream-ctx-handle)
[108.354267] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[108.376476] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[108.419287] [017/133] (910s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[109.793939] Starting subtest: short-busy-flip-before-cursor-toggle
[109.798495] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[109.950538] [018/133] (908s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[110.158958] Starting subtest: cursor-rapid-movement-256x256
[110.165634] Starting dynamic subtest: pipe-A-eDP-1
[110.717752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[110.743241] Starting dynamic subtest: pipe-D-eDP-1
[111.939697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[111.942455] Subtest cursor-rapid-movement-256x256: SUCCESS (1.784s)
[112.807783] [019/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[112.896286] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[120.011005] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.131s)
[120.157423] [020/133] (898s left) gem_eio (context-create)
[120.358802] Starting subtest: context-create
[120.642102] Subtest context-create: SUCCESS (0.283s)
[120.759672] [021/133] (898s left) gem_pipe_control_store_loop (reused-buffer)
[120.821856] Starting subtest: reused-buffer
[122.973939] Subtest reused-buffer: SUCCESS (2.152s)
[123.083939] [022/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[123.169649] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[124.212570] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.045s)
[124.331172] [023/133] (894s left) sriov_basic (enable-vfs-autoprobe-on)
[124.386852] Starting subtest: enable-vfs-autoprobe-on
[124.388520] Starting dynamic subtest: numvfs-1
[124.448603] Dynamic subtest numvfs-1: FAIL (0.012s)
[124.457163] Starting dynamic subtest: numvfs-2
[124.517072] Dynamic subtest numvfs-2: FAIL (0.003s)
[124.526321] Starting dynamic subtest: numvfs-3
[124.585884] Dynamic subtest numvfs-3: FAIL (0.003s)
[124.595102] Starting dynamic subtest: numvfs-4
[124.653850] Dynamic subtest numvfs-4: FAIL (0.003s)
[124.664470] Starting dynamic subtest: numvfs-5
[124.725250] Dynamic subtest numvfs-5: FAIL (0.004s)
[124.734682] Starting dynamic subtest: numvfs-6
[124.794154] Dynamic subtest numvfs-6: FAIL (0.004s)
[124.803773] Starting dynamic subtest: numvfs-7
[124.863977] Dynamic subtest numvfs-7: FAIL (0.003s)
[124.872834] Starting dynamic subtest: numvfs-random
[124.931863] Dynamic subtest numvfs-random: FAIL (0.004s)
[124.942904] Starting dynamic subtest: numvfs-all
[125.003784] Dynamic subtest numvfs-all: FAIL (0.426s)
[125.005958] Subtest enable-vfs-autoprobe-on: FAIL (0.466s)
[125.042124] [024/133] (894s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[125.114073] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[125.116150] Starting dynamic subtest: pipe-A-eDP-1
[125.170543] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[125.180654] Starting dynamic subtest: pipe-B-eDP-1
[125.226474] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[125.236259] Starting dynamic subtest: pipe-C-eDP-1
[125.283390] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[125.294665] Starting dynamic subtest: pipe-D-eDP-1
[125.342064] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[125.345613] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[127.387550] [025/133] (891s left) kms_flip (2x-flip-vs-suspend)
[127.481969] Starting subtest: 2x-flip-vs-suspend
[127.486774] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[127.580312] [026/133] (891s left) kms_big_fb (linear-32bpp-rotate-270)
[127.650768] Starting subtest: linear-32bpp-rotate-270
[127.669199] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[127.767110] [027/133] (891s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[127.841010] Starting subtest: plane-downscale-factor-0-5-with-rotation
[127.843121] Starting dynamic subtest: pipe-A
[127.859810] Dynamic subtest pipe-A: SKIP (0.015s)
[127.869558] Starting dynamic subtest: pipe-B
[127.893327] Dynamic subtest pipe-B: SKIP (0.032s)
[127.902330] Starting dynamic subtest: pipe-C
[127.924033] Dynamic subtest pipe-C: SKIP (0.032s)
[127.932968] Starting dynamic subtest: pipe-D
[127.951789] Dynamic subtest pipe-D: SKIP (0.028s)
[127.955460] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s)
[128.043608] [028/133] (891s left) kms_content_protection (mei-interface)
[128.158407] Starting subtest: mei-interface
[128.162847] Subtest mei-interface: SKIP (0.001s)
[128.260748] [029/133] (891s left) kms_lease (lease-unleased-crtc)
[128.334490] Starting subtest: lease-unleased-crtc
[128.336678] Starting dynamic subtest: pipe-A-eDP-1
[128.628318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[128.638323] Starting dynamic subtest: pipe-B-eDP-1
[129.345636] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.715s)
[129.357943] Starting dynamic subtest: pipe-C-eDP-1
[129.360109] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[129.370593] Starting dynamic subtest: pipe-D-eDP-1
[129.372804] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[129.374935] Subtest lease-unleased-crtc: SUCCESS (1.021s)
[129.723462] [030/133] (889s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[129.813560] Starting subtest: y-tiled-8bpp-rotate-90
[129.817702] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[129.907013] [031/133] (889s left) gem_exec_schedule (u-semaphore-codependency)
[129.992977] Starting subtest: u-semaphore-codependency
[130.014605] Subtest u-semaphore-codependency: SUCCESS (0.024s)
[130.356564] [032/133] (889s left) perf_pmu (rc6)
[130.400773] Starting subtest: rc6
[130.402631] Starting dynamic subtest: gt0
[136.822008] Dynamic subtest gt0: SUCCESS (6.367s)
[136.834710] Starting dynamic subtest: runtime-pm-gt0
[144.535626] Dynamic subtest runtime-pm-gt0: SUCCESS (7.768s)
[144.548575] Starting dynamic subtest: runtime-pm-long-gt0
[157.027128] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.494s)
[157.040708] Starting dynamic subtest: other-idle-gt0
[163.369049] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[163.382263] Starting dynamic subtest: gt1
[169.709416] Dynamic subtest gt1: SUCCESS (6.341s)
[169.721528] Starting dynamic subtest: runtime-pm-gt1
[177.214751] Dynamic subtest runtime-pm-gt1: SUCCESS (7.507s)
[177.227069] Starting dynamic subtest: runtime-pm-long-gt1
[189.652585] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.441s)
[189.665628] Starting dynamic subtest: other-idle-gt1
[195.996709] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[195.999998] Subtest rc6: SUCCESS (65.612s)
[197.202270] [033/133] (822s left) gem_softpin (32b-excludes-last-page)
[197.277520] Starting subtest: 32b-excludes-last-page
[197.283171] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[197.371799] [034/133] (822s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[197.428267] Starting subtest: stress-mm-invalidate-close-overlap
[199.576792] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[199.665989] [035/133] (819s left) kms_draw_crc (draw-method-blt)
[199.746929] Starting subtest: draw-method-blt
[199.749128] Starting dynamic subtest: xrgb8888-untiled
[199.968067] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[199.977889] Starting dynamic subtest: rgb565-untiled
[200.169644] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[200.189971] Starting dynamic subtest: xrgb2101010-untiled
[200.379442] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[200.388820] Starting dynamic subtest: xbgr16161616f-untiled
[200.590585] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.209s)
[200.600567] Starting dynamic subtest: xrgb8888-xtiled
[200.701311] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[200.710566] Starting dynamic subtest: rgb565-xtiled
[200.812624] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[200.821939] Starting dynamic subtest: xrgb2101010-xtiled
[200.912566] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[200.921905] Starting dynamic subtest: xbgr16161616f-xtiled
[201.023759] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[201.033096] Starting dynamic subtest: xrgb8888-4tiled
[201.134949] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[201.143931] Starting dynamic subtest: rgb565-4tiled
[201.245957] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[201.255325] Starting dynamic subtest: xrgb2101010-4tiled
[201.368290] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[201.378518] Starting dynamic subtest: xbgr16161616f-4tiled
[201.490555] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[201.492465] Subtest draw-method-blt: SUCCESS (1.744s)
[201.573235] [036/133] (818s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[201.624665] Starting subtest: multi-wait-available-unsubmitted-submitted
[201.626673] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[201.708919] [037/133] (817s left) kms_pm_rpm (modeset-pc8-residency-stress)
[203.911326] Starting subtest: modeset-pc8-residency-stress
[203.916289] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[204.264323] [038/133] (815s left) gem_exec_reloc (basic-write-cpu-noreloc)
[204.321128] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[204.392941] [039/133] (815s left) kms_psr (pr-primary-mmap-cpu)
[204.458415] Starting subtest: pr-primary-mmap-cpu
[204.462515] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[204.544301] [040/133] (815s left) vgem_basic (debugfs)
[204.647953] Starting subtest: debugfs
[204.650345] Subtest debugfs: SUCCESS (0.000s)
[204.685320] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[204.688412] [041/133] (815s left) gem_ctx_exec (basic-close-race)
[204.740332] Starting subtest: basic-close-race
[210.392900] Subtest basic-close-race: SUCCESS (5.595s)
[210.445848] [042/133] (809s left) kms_cursor_edge_walk (256x256-top-bottom)
[210.531099] Starting subtest: 256x256-top-bottom
[210.533519] Starting dynamic subtest: pipe-A-eDP-1
[213.952851] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[213.962666] Starting dynamic subtest: pipe-D-eDP-1
[217.078427] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[217.080771] Subtest 256x256-top-bottom: SUCCESS (6.548s)
[217.864254] [043/133] (802s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[217.946134] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[217.950242] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[218.031014] [044/133] (801s left) i915_suspend (forcewake)
[218.078076] Starting subtest: forcewake
[250.124483] Subtest forcewake: SUCCESS (3.023s)
[251.194480] [045/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[251.286872] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[251.291528] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[251.348097] [046/133] (769s left) kms_addfb_basic (bad-pitch-63)
[251.401860] Starting subtest: bad-pitch-63
[251.403926] Subtest bad-pitch-63: SUCCESS (0.000s)
[251.500968] [047/133] (769s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[251.592196] Starting subtest: pr-primary-plane-update-sf-dmg-area
[251.596654] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[251.634568] [048/133] (769s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[252.176482] Starting subtest: syncobj-timeline-invalid-flags
[252.179663] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[253.851959] [049/133] (767s left) kms_atomic (plane-overlay-legacy)
[253.930143] Starting subtest: plane-overlay-legacy
[253.932523] Starting dynamic subtest: pipe-A-eDP-1
[254.354770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[254.357715] Subtest plane-overlay-legacy: SUCCESS (0.425s)
[255.175063] [050/133] (765s left) kms_properties (crtc-properties-atomic)
[255.254178] Starting subtest: crtc-properties-atomic
[255.256665] Starting dynamic subtest: pipe-A-eDP-1
[255.694082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[255.705032] Starting dynamic subtest: pipe-B-eDP-1
[256.846657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[256.857194] Starting dynamic subtest: pipe-C-eDP-1
[257.946474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[257.957475] Starting dynamic subtest: pipe-D-eDP-1
[259.067410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[259.070083] Subtest crtc-properties-atomic: SUCCESS (3.865s)
[259.849887] [051/133] (761s left) kms_flip (2x-flip-vs-wf_vblank)
[259.930584] Starting subtest: 2x-flip-vs-wf_vblank
[259.938633] Subtest 2x-flip-vs-wf_vblank: SKIP (0.008s)
[260.001310] [052/133] (761s left) syncobj_eventfd (binary-wait-before-signal)
[260.065521] Starting subtest: binary-wait-before-signal
[260.094793] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[260.147798] [053/133] (761s left) gem_mmap_gtt (basic-read)
[260.210347] Subtest basic-read: SKIP (0.000s)
[260.266962] [054/133] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[260.344003] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[260.349178] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.408919] [055/133] (760s left) kms_cursor_crc (cursor-onscreen-256x256)
[260.682560] Starting subtest: cursor-onscreen-256x256
[260.685785] Starting dynamic subtest: pipe-A-eDP-1
[262.768881] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[262.798082] Starting dynamic subtest: pipe-D-eDP-1
[265.573613] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.801s)
[265.576438] Subtest cursor-onscreen-256x256: SUCCESS (4.925s)
[266.358296] [056/133] (755s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[266.432622] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[266.435041] Starting dynamic subtest: pipe-A-eDP-1
[266.495455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[266.812284] Starting dynamic subtest: pipe-B-eDP-1
[267.580978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[267.892299] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.465s)
[268.723663] [057/133] (752s left) kms_addfb_basic (unused-handle)
[268.773162] Starting subtest: unused-handle
[268.775906] Subtest unused-handle: SUCCESS (0.000s)
[268.852451] [058/133] (752s left) gem_fenced_exec_thrash (no-spare-fences)
[268.909080] Subtest no-spare-fences: SKIP (0.000s)
[268.971240] [059/133] (752s left) kms_getfb (getfb-handle-valid)
[269.045606] Starting subtest: getfb-handle-valid
[269.048227] Subtest getfb-handle-valid: SUCCESS (0.000s)
[269.117640] [060/133] (752s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[269.191393] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[269.196501] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[270.259265] [061/133] (751s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[270.327401] Starting subtest: primary-yf-tiled-reflect-x-180
[270.388824] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[270.471521] [062/133] (751s left) core_getstats (basic)
[270.527530] Starting subtest: basic
[270.530564] Subtest basic: SUCCESS (0.000s)
[270.594671] [063/133] (751s left) kms_busy (extended-modeset-hang-oldfb)
[270.671206] Starting subtest: extended-modeset-hang-oldfb
[270.673635] Starting dynamic subtest: pipe-A
[282.799648] Dynamic subtest pipe-A: SUCCESS (12.147s)
[282.817720] Starting dynamic subtest: pipe-D
[295.270629] Dynamic subtest pipe-D: SUCCESS (12.468s)
[295.273499] Subtest extended-modeset-hang-oldfb: SUCCESS (24.619s)
[296.135116] [064/133] (725s left) kms_flip (modeset-vs-vblank-race-interruptible)
[296.243095] Starting subtest: modeset-vs-vblank-race-interruptible
[296.248670] Starting dynamic subtest: A-eDP1
[301.012403] Dynamic subtest A-eDP1: SUCCESS (4.764s)
[301.023594] Starting dynamic subtest: B-eDP1
[305.921953] Dynamic subtest B-eDP1: SUCCESS (4.906s)
[305.933948] Starting dynamic subtest: C-eDP1
[310.523203] Dynamic subtest C-eDP1: SUCCESS (4.599s)
[310.532814] Starting dynamic subtest: D-eDP1
[314.982334] Dynamic subtest D-eDP1: SUCCESS (4.457s)
[314.984923] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.740s)
[316.123243] [065/133] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[316.215315] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[319.939915] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.732s)
[321.124440] [066/133] (700s left) gem_exec_flush (basic-wb-rw-before-default)
[321.186193] Starting subtest: basic-wb-rw-before-default
[326.682493] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[326.816747] [067/133] (695s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[326.894234] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[326.896591] Starting dynamic subtest: pipe-A-eDP-1
[332.800379] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.912s)
[332.817931] Starting dynamic subtest: pipe-B-eDP-1
[339.441315] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.640s)
[339.443658] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.554s)
[340.294895] [068/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[340.373409] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[340.378023] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[340.450194] [069/133] (681s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[340.534976] Starting subtest: random-ccs-data-yf-tiled-ccs
[340.537342] Starting dynamic subtest: pipe-A-eDP-1
[340.561941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[340.571649] Starting dynamic subtest: pipe-B-eDP-1
[340.597785] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[340.607337] Starting dynamic subtest: pipe-C-eDP-1
[340.634650] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[340.644444] Starting dynamic subtest: pipe-D-eDP-1
[340.673543] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[340.678366] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[342.750128] [070/133] (679s left) gem_userptr_blits (sync-unmap-cycles)
[342.824538] Starting subtest: sync-unmap-cycles
[348.199870] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[348.292883] [071/133] (673s left) kms_sequence (get-idle)
[348.366799] Starting subtest: get-idle
[348.368376] Starting dynamic subtest: pipe-A-eDP-1
[350.169942] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s)
[350.180368] Starting dynamic subtest: pipe-B-eDP-1
[352.642711] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.471s)
[352.654327] Starting dynamic subtest: pipe-C-eDP-1
[355.142934] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.499s)
[355.158619] Starting dynamic subtest: pipe-D-eDP-1
[357.617548] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.471s)
[357.620540] Subtest get-idle: SUCCESS (9.250s)
[358.463437] [072/133] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[358.551957] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[358.557244] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[358.630984] [073/133] (663s left) kms_chamelium_frames (hdmi-crc-multiple)
[358.995664] Subtest hdmi-crc-multiple: SKIP (0.000s)
[359.807778] [074/133] (662s left) vgem_basic (second-client)
[359.852542] Starting subtest: second-client
[359.874032] Subtest second-client: SUCCESS (0.022s)
[359.914614] [075/133] (662s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[359.971489] Starting subtest: mixed-tiled-to-y-tiled-ccs
[359.977537] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[360.136630] [076/133] (662s left) kms_chamelium_hpd (common-hpd-after-suspend)
[360.501340] Subtest common-hpd-after-suspend: SKIP (0.000s)
[361.343277] [077/133] (660s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[361.420644] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[361.422993] Starting dynamic subtest: pipe-A-eDP-1
[361.445843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.456886] Starting dynamic subtest: pipe-B-eDP-1
[361.482221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.491761] Starting dynamic subtest: pipe-C-eDP-1
[361.516875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.526480] Starting dynamic subtest: pipe-D-eDP-1
[361.553349] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.558132] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[363.696660] [078/133] (658s left) prime_vgem (basic-fence-flip)
[363.773344] Starting subtest: basic-fence-flip
[364.075105] Subtest basic-fence-flip: SUCCESS (0.302s)
[364.163398] [079/133] (658s left) kms_flip (wf_vblank-ts-check-interruptible)
[364.245083] Starting subtest: wf_vblank-ts-check-interruptible
[364.252547] Starting dynamic subtest: A-eDP1
[373.194152] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[373.206447] Starting dynamic subtest: B-eDP1
[382.122505] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[382.139127] Starting dynamic subtest: C-eDP1
[391.058323] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[391.068269] Starting dynamic subtest: D-eDP1
[399.994636] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[399.997190] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.704s)
[401.157327] [080/133] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[401.230879] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[401.235221] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[401.302887] [081/133] (621s left) kms_invalid_mode (clock-too-high)
[401.377164] Starting subtest: clock-too-high
[401.379662] Starting dynamic subtest: pipe-A-eDP-1
[401.385062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.396414] Starting dynamic subtest: pipe-B-eDP-1
[401.401248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.410962] Starting dynamic subtest: pipe-C-eDP-1
[401.415572] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.424644] Starting dynamic subtest: pipe-D-eDP-1
[401.429485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.434407] Subtest clock-too-high: SKIP (0.004s)
[401.473112] [082/133] (621s left) gem_userptr_blits (coherency-unsync)
[401.540074] Subtest coherency-unsync: SKIP (0.000s)
[401.637947] [083/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[401.719434] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[401.724408] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[401.795051] [084/133] (620s left) kms_addfb_basic (unused-offsets)
[401.847336] Starting subtest: unused-offsets
[401.849516] Subtest unused-offsets: SUCCESS (0.000s)
[401.947696] [085/133] (620s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[402.018314] Starting subtest: plane-all-modeset-transition-internal-panels
[402.020530] Starting dynamic subtest: pipe-A-eDP-1
[403.298052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.280s)
[403.589830] Starting dynamic subtest: pipe-B-eDP-1
[404.627804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[404.895670] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.878s)
[405.711737] [086/133] (616s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[405.794446] Starting subtest: fbc-tiling-linear
[409.486918] Subtest fbc-tiling-linear: SUCCESS (3.698s)
[410.639816] [087/133] (612s left) gem_ctx_isolation (clean)
[410.697762] Starting subtest: clean
[410.700436] Starting dynamic subtest: rcs0
[410.745185] Dynamic subtest rcs0: SUCCESS (0.047s)
[410.757391] Starting dynamic subtest: bcs0
[410.803155] Dynamic subtest bcs0: SUCCESS (0.057s)
[410.814737] Starting dynamic subtest: vcs0
[410.839183] Dynamic subtest vcs0: SUCCESS (0.035s)
[410.849534] Starting dynamic subtest: vcs1
[412.774562] Dynamic subtest vcs1: SUCCESS (1.934s)
[412.786516] Starting dynamic subtest: vecs0
[414.760521] Dynamic subtest vecs0: SUCCESS (1.986s)
[414.771190] Starting dynamic subtest: ccs0
[416.872501] Dynamic subtest ccs0: SUCCESS (2.072s)
[416.875487] Subtest clean: SUCCESS (6.136s)
[417.042813] [088/133] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[417.135192] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[417.140418] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[417.193268] [089/133] (605s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[417.249590] Starting subtest: saturated-hostile-nopreempt
[417.252348] Starting dynamic subtest: rcs0
[417.315497] Dynamic subtest rcs0: SKIP (0.063s)
[417.327640] Starting dynamic subtest: bcs0
[417.336874] Dynamic subtest bcs0: SKIP (0.020s)
[417.347176] Starting dynamic subtest: vcs0
[417.354404] Dynamic subtest vcs0: SKIP (0.016s)
[417.364375] Starting dynamic subtest: vcs1
[417.369462] Dynamic subtest vcs1: SKIP (0.011s)
[417.379626] Starting dynamic subtest: vecs0
[417.384504] Dynamic subtest vecs0: SKIP (0.012s)
[417.394073] Starting dynamic subtest: ccs0
[417.398944] Dynamic subtest ccs0: SKIP (0.012s)
[417.403406] Subtest saturated-hostile-nopreempt: SKIP (0.141s)
[417.442186] [090/133] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[417.534480] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[422.804972] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.274s)
[423.934522] [091/133] (598s left) gem_busy (busy)
[423.997485] Starting subtest: busy
[424.000231] Starting dynamic subtest: all-engines
[424.031244] Dynamic subtest all-engines: SUCCESS (0.037s)
[424.042043] Starting dynamic subtest: rcs0
[425.776319] Dynamic subtest rcs0: SUCCESS (1.744s)
[425.788525] Starting dynamic subtest: bcs0
[425.816641] Dynamic subtest bcs0: SUCCESS (0.038s)
[425.826417] Starting dynamic subtest: vcs0
[425.856662] Dynamic subtest vcs0: SUCCESS (0.039s)
[425.867285] Starting dynamic subtest: vcs1
[427.822891] Dynamic subtest vcs1: SUCCESS (1.963s)
[427.836182] Starting dynamic subtest: vecs0
[429.808062] Dynamic subtest vecs0: SUCCESS (1.985s)
[429.820674] Starting dynamic subtest: ccs0
[431.728368] Dynamic subtest ccs0: SUCCESS (1.918s)
[431.731457] Subtest busy: SUCCESS (7.734s)
[432.061584] [092/133] (590s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[432.136402] Starting subtest: plane-upscale-20x20-with-modifiers
[432.138952] Starting dynamic subtest: pipe-A
[432.472583] Dynamic subtest pipe-A: SUCCESS (0.338s)
[432.483011] Starting dynamic subtest: pipe-B
[433.836944] Dynamic subtest pipe-B: SUCCESS (1.364s)
[433.847427] Starting dynamic subtest: pipe-C
[435.255461] Dynamic subtest pipe-C: SUCCESS (1.417s)
[435.265636] Starting dynamic subtest: pipe-D
[436.685388] Dynamic subtest pipe-D: SUCCESS (1.429s)
[436.687986] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.552s)
[437.850418] [093/133] (585s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[437.943589] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[437.949518] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[438.021706] [094/133] (585s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[438.106142] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[444.569587] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.467s)
[444.665980] [095/133] (578s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[444.755834] Starting subtest: x-tiled-32bpp-rotate-0
[446.111119] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.357s)
[446.280408] [096/133] (576s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[446.366448] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[446.369395] Starting dynamic subtest: pipe-A-eDP-1
[446.395491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.407197] Starting dynamic subtest: pipe-B-eDP-1
[446.432787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.443231] Starting dynamic subtest: pipe-C-eDP-1
[446.469464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.479783] Starting dynamic subtest: pipe-D-eDP-1
[446.506170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.511076] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[448.542642] [097/133] (574s left) gen7_exec_parse (bitmasks)
[448.601454] Subtest bitmasks: SKIP (0.000s)
[448.671395] [098/133] (574s left) dumb_buffer (create-clear)
[448.723450] Starting subtest: create-clear
[482.741977] Subtest create-clear: SUCCESS (33.972s)
[482.789114] [099/133] (540s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[482.888564] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[482.894297] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.970431] [100/133] (540s left) kms_plane_alpha_blend (coverage-7efc)
[483.044308] Starting subtest: coverage-7efc
[483.342997] Starting dynamic subtest: pipe-A-eDP-1
[483.920480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[483.951591] Starting dynamic subtest: pipe-D-eDP-1
[485.264406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[485.267466] Subtest coverage-7efc: SUCCESS (2.218s)
[486.090979] [101/133] (537s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[486.146654] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[486.253452] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[486.309120] [102/133] (537s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[486.398780] Starting subtest: plane-lut1d-post-ctm3x4
[486.558815] Starting dynamic subtest: pipe-A-plane-0
[486.724643] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[486.735488] Starting dynamic subtest: pipe-A-plane-1
[486.891498] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[486.902672] Starting dynamic subtest: pipe-A-plane-2
[487.058460] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[488.254355] Starting dynamic subtest: pipe-B-plane-0
[488.446575] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[488.457228] Starting dynamic subtest: pipe-B-plane-1
[488.591002] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[488.603618] Starting dynamic subtest: pipe-B-plane-2
[488.769953] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[489.960422] Starting dynamic subtest: pipe-C-plane-0
[490.116837] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[490.127037] Starting dynamic subtest: pipe-C-plane-1
[490.271884] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[490.282657] Starting dynamic subtest: pipe-C-plane-2
[490.427620] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[491.579496] Starting dynamic subtest: pipe-D-plane-0
[491.703469] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[491.713658] Starting dynamic subtest: pipe-D-plane-1
[491.837181] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[491.848359] Starting dynamic subtest: pipe-D-plane-2
[491.981669] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[492.282970] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.880s)
[493.139422] [103/133] (530s left) gem_exec_capture (capture-recoverable)
[493.195765] Starting subtest: capture-recoverable
[493.198312] Subtest capture-recoverable: SUCCESS (0.003s)
[493.282777] [104/133] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[493.368670] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[493.373359] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[493.423565] [105/133] (530s left) gem_exec_params (larger-than-life-batch)
[493.482439] Starting subtest: larger-than-life-batch
[495.704390] Subtest larger-than-life-batch: SUCCESS (2.220s)
[496.841308] [106/133] (526s left) kms_addfb_basic (bad-pitch-999)
[496.938821] Starting subtest: bad-pitch-999
[496.941401] Subtest bad-pitch-999: SUCCESS (0.000s)
[497.044338] [107/133] (526s left) prime_self_import (basic-with_two_bos)
[497.080293] Starting subtest: basic-with_two_bos
[497.099589] Subtest basic-with_two_bos: SUCCESS (0.019s)
[497.179694] [108/133] (526s left) gem_close_race (basic-process)
[497.243468] Starting subtest: basic-process
[497.291889] Subtest basic-process: SUCCESS (0.048s)
[497.457656] [109/133] (526s left) perf_pmu (enable-race)
[497.499679] Starting subtest: enable-race
[497.502280] Starting dynamic subtest: rcs0
[510.282923] Dynamic subtest rcs0: SUCCESS (12.763s)
[510.295930] Starting dynamic subtest: bcs0
[523.023651] Dynamic subtest bcs0: SUCCESS (12.736s)
[523.035776] Starting dynamic subtest: vcs0
[538.793661] Dynamic subtest vcs0: SUCCESS (15.784s)
[538.807540] Starting dynamic subtest: vcs1
[554.793441] Dynamic subtest vcs1: SUCCESS (15.996s)
[554.807463] Starting dynamic subtest: vecs0
[570.793064] Dynamic subtest vecs0: SUCCESS (15.998s)
[570.805543] Starting dynamic subtest: ccs0
[583.584370] Dynamic subtest ccs0: SUCCESS (12.770s)
[583.586886] Subtest enable-race: SUCCESS (86.061s)
[583.658733] [110/133] (440s left) i915_query (query-topology-matches-eu-total)
[583.714511] Starting subtest: query-topology-matches-eu-total
[583.716890] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[583.797172] [111/133] (439s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[583.858676] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[583.861626] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[583.912252] [112/133] (439s left) gem_vm_create (execbuf)
[583.967241] Starting subtest: execbuf
[583.977479] Subtest execbuf: SUCCESS (0.011s)
[584.072235] [113/133] (439s left) i915_drm_fdinfo (virtual-busy-idle)
[584.114304] Starting subtest: virtual-busy-idle
[584.119258] Subtest virtual-busy-idle: SKIP (0.000s)
[584.158978] [114/133] (439s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[584.253555] Starting subtest: 4-tiled-addfb-size-offset-overflow
[584.256479] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[584.329868] [115/133] (439s left) gem_mmap (pf-nonblock)
[584.385360] Subtest pf-nonblock: SKIP (0.000s)
[584.461993] [116/133] (439s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[584.545651] Starting subtest: fbc-psr2-sprite-mmap-gtt
[584.547893] Starting dynamic subtest: eDP-1
[584.552006] Dynamic subtest eDP-1: SKIP (0.000s)
[584.555927] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[584.597675] [117/133] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[584.668814] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[591.894373] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.228s)
[591.996781] [118/133] (432s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[592.047545] Starting subtest: multi-wait-all-for-submit-unsubmitted
[592.148074] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[592.203264] [119/133] (431s left) gem_exec_balancer (hang)
[592.463713] Starting subtest: hang
[594.095629] Subtest hang: SUCCESS (1.634s)
[594.198199] [120/133] (429s left) i915_drm_fdinfo (busy-check-all)
[594.240651] Starting subtest: busy-check-all
[594.243568] Starting dynamic subtest: rcs0
[594.249430] Dynamic subtest rcs0: SKIP (0.003s)
[594.262073] Starting dynamic subtest: bcs0
[594.267538] Dynamic subtest bcs0: SKIP (0.000s)
[594.279501] Starting dynamic subtest: vcs0
[594.284687] Dynamic subtest vcs0: SKIP (0.000s)
[594.295560] Starting dynamic subtest: vcs1
[594.301408] Dynamic subtest vcs1: SKIP (0.000s)
[594.312912] Starting dynamic subtest: vecs0
[594.318573] Dynamic subtest vecs0: SKIP (0.001s)
[594.331258] Starting dynamic subtest: ccs0
[594.336557] Dynamic subtest ccs0: SKIP (0.000s)
[594.342074] Subtest busy-check-all: SKIP (0.009s)
[594.381863] [121/133] (429s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[594.475349] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[594.480069] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[594.530735] [122/133] (429s left) kms_psr (psr2-sprite-plane-move)
[594.604822] Starting subtest: psr2-sprite-plane-move
[594.607082] Starting dynamic subtest: eDP-1
[596.406542] Dynamic subtest eDP-1: SUCCESS (1.802s)
[596.409453] Subtest psr2-sprite-plane-move: SUCCESS (1.803s)
[597.242125] [123/133] (427s left) gem_caching (read-writes)
[597.310674] Subtest read-writes: SKIP (0.000s)
[597.391946] [124/133] (426s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[597.471245] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[597.475711] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[597.537242] [125/133] (426s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[597.605111] Starting subtest: basic-batch-kernel-default-cmd
[597.610496] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[597.786037] [126/133] (426s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[597.842433] Starting subtest: multi-wait-all-for-submit-available-submitted
[597.845361] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[597.926925] [127/133] (426s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[597.997497] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[598.069115] [128/133] (426s left) gem_exec_store (dword)
[598.131668] Starting subtest: dword
[598.134472] Starting dynamic subtest: rcs0
[598.196186] Dynamic subtest rcs0: SUCCESS (0.066s)
[598.209548] Starting dynamic subtest: bcs0
[598.238936] Dynamic subtest bcs0: SUCCESS (0.041s)
[598.250947] Starting dynamic subtest: vcs0
[598.281401] Dynamic subtest vcs0: SUCCESS (0.040s)
[598.292960] Starting dynamic subtest: vcs1
[598.324565] Dynamic subtest vcs1: SUCCESS (0.041s)
[598.335668] Starting dynamic subtest: vecs0
[598.367111] Dynamic subtest vecs0: SUCCESS (0.040s)
[598.379447] Starting dynamic subtest: ccs0
[598.411178] Dynamic subtest ccs0: SUCCESS (0.042s)
[598.413997] Subtest dword: SUCCESS (0.283s)
[598.593272] [129/133] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[598.674440] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[598.679642] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[598.735032] [130/133] (425s left) gem_partial_pwrite_pread (writes-after-reads-display)
[598.800685] Subtest writes-after-reads-display: SKIP (0.000s)
[598.870728] [131/133] (425s left) prime_vgem (fence-read-hang)
[598.951276] Subtest fence-read-hang: SKIP (0.000s)
[599.029425] [132/133] (425s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[599.111170] Starting subtest: async-flip-with-page-flip-events-linear
[599.498498] Starting dynamic subtest: pipe-A-eDP-1
[602.227329] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.730s)
[602.592384] Starting dynamic subtest: pipe-B-eDP-1
[605.399391] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[605.719341] Starting dynamic subtest: pipe-C-eDP-1
[608.475130] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[608.842164] Starting dynamic subtest: pipe-D-eDP-1
[611.595681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[611.598305] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.486s)
[612.769019] [133/133] (412s left) kms_pm_rpm (basic-rte)
[612.816811] Starting subtest: basic-rte
[616.316490] Subtest basic-rte: SUCCESS (3.501s)
[617.772981] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_lowres
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: sysfs_preempt_timeout
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: i915_pm_rpm
results: parsing output: 13/ for test: gem_spin_batch
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: gem_pipe_control_store_loop
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: sriov_basic
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: gem_ctx_exec
results: parsing output: 41/ for test: kms_cursor_edge_walk
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: i915_suspend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_properties
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_eventfd
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: gem_fenced_exec_thrash
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: core_getstats
results: parsing output: 62/ for test: kms_busy
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_busy
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: dumb_buffer
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane_alpha_blend
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: gem_exec_capture
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: prime_self_import
results: parsing output: 107/ for test: gem_close_race
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: i915_query
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_vm_create
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_mmap
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_caching
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_exec_store
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_partial_pwrite_pread
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_pm_rpm
Done.