[57.133475] Initializing watchdogs
[57.133521]   /dev/watchdog0
[57.145769] [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]
[57.149446] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.151559] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.154740] [001/131] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[57.269478] Starting subtest: multi-wait-for-submit-unsubmitted
[57.373727] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[57.440321] [002/131] (960s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[62.493796] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[62.496156] Starting dynamic subtest: pipe-A-eDP-1
[69.011339] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.514s)
[69.019824] Starting dynamic subtest: pipe-B-eDP-1
[75.439791] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.428s)
[75.442195] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.945s)
[76.301818] [003/131] (941s left) kms_pm_lpsp (screens-disabled)
[77.418958] Starting subtest: screens-disabled
[77.423155] Subtest screens-disabled: SKIP (0.000s)
[77.478198] [004/131] (940s left) perf (invalid-open-flags)
[77.588454] Starting subtest: invalid-open-flags
[77.590654] Subtest invalid-open-flags: SUCCESS (0.000s)
[77.620641] [005/131] (940s left) kms_feature_discovery (psr2)
[77.731127] Starting subtest: psr2
[77.733072] Subtest psr2: SUCCESS (0.000s)
[77.794377] [006/131] (940s left) kms_writeback (writeback-pixel-formats)
[77.897234] Subtest writeback-pixel-formats: SKIP (0.000s)
[77.933779] [007/131] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[78.024824] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[78.029067] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[78.123930] [008/131] (939s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[78.214096] Starting subtest: fbc-pr-cursor-mmap-gtt
[78.218557] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[78.279746] [009/131] (939s left) kms_chamelium_hpd (vga-hpd)
[78.655089] Subtest vga-hpd: SKIP (0.000s)
[79.406854] [010/131] (938s left) i915_pm_freq_api (freq-reset)
[79.462314] Starting subtest: freq-reset
[79.464175] Starting dynamic subtest: gt0
[79.659025] Dynamic subtest gt0: SUCCESS (0.194s)
[79.667225] Starting dynamic subtest: gt1
[79.805432] Dynamic subtest gt1: SUCCESS (0.146s)
[79.808561] Subtest freq-reset: SUCCESS (0.341s)
[79.869599] [011/131] (938s left) kms_vblank (ts-continuation-modeset-rpm)
[79.972596] Starting subtest: ts-continuation-modeset-rpm
[79.974878] Starting dynamic subtest: pipe-A-eDP-1
[82.524715] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.548s)
[82.538081] Starting dynamic subtest: pipe-D-eDP-1
[84.759157] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.235s)
[84.761573] Subtest ts-continuation-modeset-rpm: SUCCESS (4.785s)
[85.543199] [012/131] (932s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[85.606723] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[85.720161] [013/131] (932s left) gem_exec_schedule (pi-distinct-iova)
[85.896545] Starting subtest: pi-distinct-iova
[85.898635] Starting dynamic subtest: rcs0
[85.965330] Dynamic subtest rcs0: SUCCESS (0.071s)
[85.972863] Starting dynamic subtest: vcs0
[86.011761] Dynamic subtest vcs0: SUCCESS (0.046s)
[86.019972] Starting dynamic subtest: vcs1
[86.061618] Dynamic subtest vcs1: SUCCESS (0.049s)
[86.071233] Starting dynamic subtest: vecs0
[86.111902] Dynamic subtest vecs0: SUCCESS (0.050s)
[86.121721] Starting dynamic subtest: ccs0
[86.163458] Dynamic subtest ccs0: SUCCESS (0.051s)
[86.165812] Subtest pi-distinct-iova: SUCCESS (0.269s)
[87.981339] [014/131] (930s left) kms_cursor_crc (cursor-sliding-32x10)
[88.118817] Starting subtest: cursor-sliding-32x10
[88.158797] Subtest cursor-sliding-32x10: SKIP (0.034s)
[88.407836] [015/131] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[88.514701] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[88.519291] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.619342] [016/131] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[88.716415] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[88.720826] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[88.803565] [017/131] (929s left) gem_exec_flush (basic-uc-prw-default)
[88.870461] Starting subtest: basic-uc-prw-default
[94.349511] Subtest basic-uc-prw-default: SUCCESS (5.480s)
[94.534210] [018/131] (923s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[99.614617] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[99.616920] Starting dynamic subtest: pipe-A-eDP-1
[100.399072] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[100.406500] Starting dynamic subtest: pipe-B-eDP-1
[101.523531] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[101.527828] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.906s)
[102.697994] [019/131] (915s left) prime_vgem (basic-write)
[102.845291] Starting subtest: basic-write
[102.853921] Subtest basic-write: SKIP (0.009s)
[102.952388] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[102.955754] [020/131] (915s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[103.066634] Starting subtest: y-tiled-8bpp-rotate-180
[103.070959] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[103.177558] [021/131] (915s left) gem_linear_blits (interruptible)
[103.535449] Starting subtest: interruptible
[107.528714] Subtest interruptible: SUCCESS (3.991s)
[107.639191] [022/131] (910s left) gen3_mixed_blits
[107.771038] [023/131] (910s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[107.877057] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[107.879488] Starting dynamic subtest: pipe-A-eDP-1
[107.902503] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.910302] Starting dynamic subtest: pipe-B-eDP-1
[107.933556] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.942444] Starting dynamic subtest: pipe-C-eDP-1
[107.969862] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.978083] Starting dynamic subtest: pipe-D-eDP-1
[108.001351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.005616] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[110.054945] [024/131] (908s left) syncobj_wait (invalid-signal-illegal-handle)
[110.121457] Starting subtest: invalid-signal-illegal-handle
[110.123964] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[110.200485] [025/131] (908s left) perf (disabled-read-error)
[110.286075] Starting subtest: disabled-read-error
[110.315619] Subtest disabled-read-error: SUCCESS (0.030s)
[110.351525] [026/131] (908s left) kms_pipe_crc_basic (suspend-read-crc)
[110.441044] Starting subtest: suspend-read-crc
[110.443329] Starting dynamic subtest: pipe-A-eDP-1
[127.704813] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.566s)
[127.717912] Starting dynamic subtest: pipe-B-eDP-1
[145.367345] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.738s)
[145.375535] Starting dynamic subtest: pipe-C-eDP-1
[163.366189] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.712s)
[163.376310] Starting dynamic subtest: pipe-D-eDP-1
[181.347189] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.705s)
[181.349710] Subtest suspend-read-crc: SUCCESS (10.726s)
[182.181590] [027/131] (896s left) drm_fdinfo (virtual-busy-all)
[182.228085] Starting subtest: virtual-busy-all
[182.232346] Subtest virtual-busy-all: SKIP (0.000s)
[182.291449] [028/131] (896s left) prime_self_import (reimport-vs-gem_close-race)
[182.328102] Starting subtest: reimport-vs-gem_close-race
[187.408978] Subtest reimport-vs-gem_close-race: SUCCESS (5.078s)
[187.477633] [029/131] (891s left) kms_chamelium_frames (hdmi-frame-dump)
[187.868486] Subtest hdmi-frame-dump: SKIP (0.000s)
[188.683649] [030/131] (890s left) gem_exec_whisper (basic-fds-priority-all)
[188.755740] Starting subtest: basic-fds-priority-all
[210.365046] Subtest basic-fds-priority-all: SUCCESS (21.603s)
[210.547327] [031/131] (868s left) kms_flip (dpms-vs-vblank-race)
[210.648860] Starting subtest: dpms-vs-vblank-race
[210.651014] Starting dynamic subtest: A-eDP1
[215.670550] Dynamic subtest A-eDP1: SUCCESS (5.020s)
[215.680379] Starting dynamic subtest: B-eDP1
[220.269858] Dynamic subtest B-eDP1: SUCCESS (4.598s)
[220.280269] Starting dynamic subtest: C-eDP1
[224.860973] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[224.869844] Starting dynamic subtest: D-eDP1
[229.472009] Dynamic subtest D-eDP1: SUCCESS (4.611s)
[229.474452] Subtest dpms-vs-vblank-race: SUCCESS (18.825s)
[230.341039] [032/131] (848s left) gem_ctx_persistence (smoketest)
[230.396323] Starting subtest: smoketest
[271.003133] Subtest smoketest: SUCCESS (40.600s)
[271.076602] [033/131] (807s left) kms_psr (psr-dpms)
[271.179514] Starting subtest: psr-dpms
[271.182130] Starting dynamic subtest: eDP-1
[274.164821] Dynamic subtest eDP-1: SUCCESS (2.984s)
[274.167145] Subtest psr-dpms: SUCCESS (2.985s)
[275.003004] [034/131] (803s left) gem_exec_fence (syncobj-timeline-unused-fence)
[275.599271] Starting subtest: syncobj-timeline-unused-fence
[275.605443] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[277.206310] [035/131] (801s left) gem_softpin (32b-excludes-last-page)
[277.268744] Starting subtest: 32b-excludes-last-page
[277.271689] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[277.418483] [036/131] (801s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[277.531026] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[282.379027] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.851s)
[282.487455] [037/131] (796s left) gem_exec_balancer (waits)
[282.553470] Starting subtest: waits
[288.885153] Subtest waits: SUCCESS (6.329s)
[289.158877] [038/131] (789s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[289.256960] Starting subtest: primary-y-tiled-reflect-x-180
[289.318375] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[289.416079] [039/131] (789s left) kms_hdr (bpc-switch-dpms)
[289.516601] Starting subtest: bpc-switch-dpms
[290.573986] Starting dynamic subtest: pipe-A-eDP-1
[295.076044] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.502s)
[295.078209] Subtest bpc-switch-dpms: SUCCESS (5.559s)
[295.216531] [040/131] (783s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[295.266015] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[295.366951] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[295.442101] [041/131] (783s left) kms_getfb (getfb-handle-not-fb)
[295.494280] Starting subtest: getfb-handle-not-fb
[295.533572] Subtest getfb-handle-not-fb: SUCCESS (0.042s)
[295.628238] [042/131] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[295.723948] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[300.595567] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.874s)
[300.726534] [043/131] (778s left) gem_userptr_blits (dmabuf-unsync)
[300.796164] Subtest dmabuf-unsync: SKIP (0.000s)
[300.916759] [044/131] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[301.021055] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[301.025424] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[301.117207] [045/131] (778s left) kms_psr (fbc-psr-cursor-plane-move)
[301.214070] Starting subtest: fbc-psr-cursor-plane-move
[301.216250] Starting dynamic subtest: eDP-1
[301.220217] Dynamic subtest eDP-1: SKIP (0.000s)
[301.224231] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[301.281262] [046/131] (778s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[301.380144] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[301.382382] Starting dynamic subtest: pipe-A-default-mode
[301.699388] Dynamic subtest pipe-A-default-mode: SKIP (0.316s)
[301.704044] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.317s)
[302.505002] [047/131] (776s left) i915_hangman (detector)
[302.585529] Starting subtest: detector
[302.587379] Starting dynamic subtest: rcs0
[313.050263] Dynamic subtest rcs0: SUCCESS (10.463s)
[313.062299] Starting dynamic subtest: bcs0
[325.082066] Dynamic subtest bcs0: SUCCESS (12.029s)
[325.093666] Starting dynamic subtest: vcs0
[337.049836] Dynamic subtest vcs0: SUCCESS (11.965s)
[337.061641] Starting dynamic subtest: vcs1
[349.018475] Dynamic subtest vcs1: SUCCESS (11.965s)
[349.030620] Starting dynamic subtest: vecs0
[360.087232] Dynamic subtest vecs0: SUCCESS (11.067s)
[360.103258] Starting dynamic subtest: ccs0
[372.058137] Dynamic subtest ccs0: SUCCESS (11.966s)
[372.060868] Subtest detector: SUCCESS (69.469s)
[372.132144] [048/131] (707s left) kms_setmode (invalid-clone-single-crtc)
[372.193855] Starting subtest: invalid-clone-single-crtc
[372.201178] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[372.306157] [049/131] (707s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[372.425677] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[373.660841] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.237s)
[374.017458] [050/131] (705s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[374.147503] Starting subtest: cursorB-vs-flipB-legacy
[374.151970] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[374.275075] [051/131] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[374.380034] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[378.606730] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.229s)
[378.736161] [052/131] (700s left) i915_pm_rpm (system-suspend-devices)
[380.276668] Starting subtest: system-suspend-devices
[387.827687] Subtest system-suspend-devices: SUCCESS (7.550s)
[388.192435] [053/131] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[388.293969] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[388.298131] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.399765] [054/131] (691s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[388.506567] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[388.508872] Starting dynamic subtest: pipe-A-eDP-1
[388.529886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[388.539391] Starting dynamic subtest: pipe-B-eDP-1
[388.559130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[388.567604] Starting dynamic subtest: pipe-C-eDP-1
[388.587451] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[388.595935] Starting dynamic subtest: pipe-D-eDP-1
[388.616013] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[388.618237] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[390.641655] [055/131] (689s left) syncobj_timeline (multi-wait-all-available-submitted)
[390.703511] Starting subtest: multi-wait-all-available-submitted
[390.705767] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[390.793653] [056/131] (688s left) kms_flip (2x-flip-vs-wf_vblank)
[390.891910] Starting subtest: 2x-flip-vs-wf_vblank
[390.902380] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[390.973867] [057/131] (688s left) kms_cursor_edge_walk (64x64-right-edge)
[391.075572] Starting subtest: 64x64-right-edge
[391.077942] Starting dynamic subtest: pipe-A-eDP-1
[394.492468] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.415s)
[394.502546] Starting dynamic subtest: pipe-D-eDP-1
[397.599874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.105s)
[397.602251] Subtest 64x64-right-edge: SUCCESS (6.522s)
[398.417296] [058/131] (681s left) gem_busy (semaphore)
[398.605093] Subtest semaphore: SKIP (0.000s)
[398.830836] [059/131] (680s left) kms_chamelium_color (ctm-blue-to-red)
[398.933012] Subtest ctm-blue-to-red: SKIP (0.000s)
[398.972768] [060/131] (680s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[399.025154] Subtest no-spare-fences-busy: SKIP (0.000s)
[399.084528] [061/131] (680s left) kms_dp_linktrain_fallback (dsc-fallback)
[399.186516] Starting subtest: dsc-fallback
[399.193264] Subtest dsc-fallback: SKIP (0.000s)
[399.254249] [062/131] (680s left) syncobj_timeline (wait-for-submit-complex)
[399.300658] Starting subtest: wait-for-submit-complex
[399.361288] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[399.430478] [063/131] (680s left) perf_pmu (most-busy-check-all)
[399.468263] Starting subtest: most-busy-check-all
[399.470747] Starting dynamic subtest: rcs0
[401.084192] Dynamic subtest rcs0: SUCCESS (1.615s)
[401.097307] Starting dynamic subtest: bcs0
[403.132300] Dynamic subtest bcs0: SUCCESS (2.045s)
[403.144675] Starting dynamic subtest: vcs0
[405.115996] Dynamic subtest vcs0: SUCCESS (1.981s)
[405.125834] Starting dynamic subtest: vcs1
[407.098589] Dynamic subtest vcs1: SUCCESS (1.980s)
[407.110278] Starting dynamic subtest: vecs0
[409.084494] Dynamic subtest vecs0: SUCCESS (1.983s)
[409.096538] Starting dynamic subtest: ccs0
[411.066896] Dynamic subtest ccs0: SUCCESS (1.980s)
[411.069373] Subtest most-busy-check-all: SUCCESS (11.598s)
[411.187246] [064/131] (668s left) gem_lmem_swapping (parallel-random-engines)
[411.227848] Subtest parallel-random-engines: SKIP (0.000s)
[411.270235] [065/131] (668s left) kms_psr (pr-cursor-blt)
[411.377085] Starting subtest: pr-cursor-blt
[411.381522] Subtest pr-cursor-blt: SKIP (0.000s)
[411.447073] [066/131] (668s left) gem_mmap_offset (partial-remap)
[411.507773] Starting subtest: partial-remap
[411.510213] Starting dynamic subtest: smem0
[411.519401] Dynamic subtest smem0: SUCCESS (0.004s)
[411.521743] Subtest partial-remap: SUCCESS (0.005s)
[411.628496] [067/131] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[411.736704] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[411.741179] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[411.840885] [068/131] (668s left) kms_properties (plane-properties-legacy)
[411.926905] Starting subtest: plane-properties-legacy
[411.929131] Starting dynamic subtest: pipe-A-eDP-1
[412.483268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[412.493348] Starting dynamic subtest: pipe-B-eDP-1
[413.781395] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s)
[413.791481] Starting dynamic subtest: pipe-C-eDP-1
[415.006106] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[415.016087] Starting dynamic subtest: pipe-D-eDP-1
[416.236262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[416.238624] Subtest plane-properties-legacy: SUCCESS (4.308s)
[417.018654] [069/131] (663s left) api_intel_bb (object-reloc-keep-cache)
[417.080026] Starting subtest: object-reloc-keep-cache
[417.084309] Subtest object-reloc-keep-cache: SKIP (0.002s)
[417.209107] [070/131] (662s left) gem_unfence_active_buffers
[417.358341] [071/131] (662s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[417.469038] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[417.473122] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[417.573458] [072/131] (662s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[417.682078] Starting subtest: yf-tiled-8bpp-rotate-0
[417.686116] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[417.787670] [073/131] (662s left) gem_render_copy (linear-to-vebox-yf-tiled)
[417.848120] Starting subtest: linear-to-vebox-yf-tiled
[417.852838] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[418.025253] [074/131] (662s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[418.133064] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[418.135386] Starting dynamic subtest: pipe-A-eDP-1
[418.144235] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.153898] Starting dynamic subtest: pipe-B-eDP-1
[418.162381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.171156] Starting dynamic subtest: pipe-C-eDP-1
[418.179739] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.188059] Starting dynamic subtest: pipe-D-eDP-1
[418.196704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.200902] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[420.274116] [075/131] (660s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[420.369862] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[420.372031] Starting dynamic subtest: pipe-A-default-mode
[420.667417] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[420.672529] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.295s)
[421.504435] [076/131] (658s left) vgem_basic (busy-fence)
[421.552576] Starting subtest: busy-fence
[421.554680] Subtest busy-fence: SUCCESS (0.000s)
[421.600544] [077/131] (658s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[421.704064] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[421.706375] Starting dynamic subtest: pipe-A-eDP-1
[422.139148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[422.149730] Starting dynamic subtest: pipe-B-eDP-1
[423.489102] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s)
[423.500210] Starting dynamic subtest: pipe-C-eDP-1
[424.897467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[424.908846] Starting dynamic subtest: pipe-D-eDP-1
[426.218352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[426.220739] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.484s)
[427.398153] [078/131] (653s left) gem_create (hog-create)
[427.461054] Starting subtest: hog-create
[427.463444] Starting dynamic subtest: smem0
[461.130054] Dynamic subtest smem0: SUCCESS (33.664s)
[461.132729] Subtest hog-create: SUCCESS (33.666s)
[461.312898] [079/131] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[461.413584] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[461.417945] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[461.520935] [080/131] (619s left) kms_cursor_crc (cursor-onscreen-32x10)
[461.679158] Starting subtest: cursor-onscreen-32x10
[461.719290] Subtest cursor-onscreen-32x10: SKIP (0.035s)
[461.982784] [081/131] (618s left) kms_atomic_transition (modeset-transition)
[462.077124] Starting subtest: modeset-transition
[462.079432] Starting dynamic subtest: 1x-outputs
[472.597724] Dynamic subtest 1x-outputs: SUCCESS (10.517s)
[472.873589] Subtest modeset-transition: SUCCESS (10.793s)
[473.724381] [082/131] (606s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[473.820873] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[473.823110] Starting dynamic subtest: pipe-A
[473.840498] Dynamic subtest pipe-A: SKIP (0.014s)
[473.850019] Starting dynamic subtest: pipe-B
[473.867559] Dynamic subtest pipe-B: SKIP (0.025s)
[473.876872] Starting dynamic subtest: pipe-C
[473.892025] Dynamic subtest pipe-C: SKIP (0.025s)
[473.900968] Starting dynamic subtest: pipe-D
[473.918031] Dynamic subtest pipe-D: SKIP (0.025s)
[473.921931] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.091s)
[474.022676] [083/131] (606s left) gem_exec_suspend (basic-s0)
[474.084913] Starting subtest: basic-S0
[474.087348] Starting dynamic subtest: smem
[494.739019] Dynamic subtest smem: SUCCESS (6.993s)
[494.742235] Subtest basic-S0: SUCCESS (6.995s)
[494.919571] [084/131] (599s left) perf (sysctl-defaults)
[494.981853] Starting subtest: sysctl-defaults
[494.984385] Subtest sysctl-defaults: SUCCESS (0.000s)
[495.025838] [085/131] (599s left) api_intel_bb (full-batch)
[495.097538] Starting subtest: full-batch
[495.103834] Subtest full-batch: SUCCESS (0.007s)
[495.239369] [086/131] (599s left) drm_fdinfo (idle)
[495.277307] Starting subtest: idle
[495.279867] Starting dynamic subtest: rcs0
[495.864708] Dynamic subtest rcs0: SUCCESS (0.585s)
[495.874927] Starting dynamic subtest: bcs0
[496.372335] Dynamic subtest bcs0: SUCCESS (0.503s)
[496.382045] Starting dynamic subtest: vcs0
[496.878212] Dynamic subtest vcs0: SUCCESS (0.502s)
[496.887518] Starting dynamic subtest: vcs1
[497.383272] Dynamic subtest vcs1: SUCCESS (0.502s)
[497.392878] Starting dynamic subtest: vecs0
[497.889291] Dynamic subtest vecs0: SUCCESS (0.503s)
[497.899005] Starting dynamic subtest: ccs0
[498.395236] Dynamic subtest ccs0: SUCCESS (0.503s)
[498.398329] Subtest idle: SUCCESS (3.113s)
[498.473774] [087/131] (595s left) gem_fenced_exec_thrash (2-spare-fences)
[498.539298] Subtest 2-spare-fences: SKIP (0.000s)
[498.601510] [088/131] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[498.704796] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[498.708995] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[498.798541] [089/131] (595s left) gem_exec_async (forked-writes)
[498.864331] Starting subtest: forked-writes
[498.866823] Starting dynamic subtest: rcs0
[498.898390] Dynamic subtest rcs0: SUCCESS (0.034s)
[498.911332] Starting dynamic subtest: bcs0
[498.929758] Dynamic subtest bcs0: SUCCESS (0.030s)
[498.939233] Starting dynamic subtest: vcs0
[498.954649] Dynamic subtest vcs0: SUCCESS (0.024s)
[498.964276] Starting dynamic subtest: vcs1
[498.980618] Dynamic subtest vcs1: SUCCESS (0.025s)
[498.990162] Starting dynamic subtest: vecs0
[499.007040] Dynamic subtest vecs0: SUCCESS (0.026s)
[499.017575] Starting dynamic subtest: ccs0
[499.035973] Dynamic subtest ccs0: SUCCESS (0.028s)
[499.038187] Subtest forked-writes: SUCCESS (0.172s)
[499.285244] [090/131] (595s left) perf (oa-formats)
[499.360476] Starting subtest: oa-formats
[499.362682] Starting dynamic subtest: 0-rcs0
[499.375754] Dynamic subtest 0-rcs0: SUCCESS (0.019s)
[499.387250] Starting dynamic subtest: 1-vecs0
[499.414443] Dynamic subtest 1-vecs0: SUCCESS (0.036s)
[499.416312] Subtest oa-formats: SUCCESS (0.056s)
[499.454213] [091/131] (595s left) gem_ctx_persistence (heartbeat-close)
[499.502654] Starting subtest: heartbeat-close
[499.506707] Subtest heartbeat-close: SKIP (0.000s)
[499.614257] [092/131] (595s left) gem_caching (read-writes)
[499.668382] Subtest read-writes: SKIP (0.000s)
[499.750057] [093/131] (594s left) i915_query (query-garbage)
[499.812580] Starting subtest: query-garbage
[499.814514] Subtest query-garbage: SUCCESS (0.000s)
[499.936572] [094/131] (594s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[500.026007] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[500.027983] Starting dynamic subtest: pipe-A
[500.042942] Dynamic subtest pipe-A: SKIP (0.011s)
[500.052815] Starting dynamic subtest: pipe-B
[500.063567] Dynamic subtest pipe-B: SKIP (0.022s)
[500.072572] Starting dynamic subtest: pipe-C
[500.085796] Dynamic subtest pipe-C: SKIP (0.021s)
[500.094628] Starting dynamic subtest: pipe-D
[500.107962] Dynamic subtest pipe-D: SKIP (0.021s)
[500.111324] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.078s)
[500.200792] [095/131] (594s left) perf_pmu (busy-check-all)
[500.239938] Starting subtest: busy-check-all
[500.241970] Starting dynamic subtest: rcs0
[500.825888] Dynamic subtest rcs0: SUCCESS (0.585s)
[500.842088] Starting dynamic subtest: bcs0
[501.377084] Dynamic subtest bcs0: SUCCESS (0.550s)
[501.388520] Starting dynamic subtest: vcs0
[502.739964] Dynamic subtest vcs0: SUCCESS (1.358s)
[502.752960] Starting dynamic subtest: vcs1
[504.787084] Dynamic subtest vcs1: SUCCESS (2.043s)
[504.800099] Starting dynamic subtest: vecs0
[506.771949] Dynamic subtest vecs0: SUCCESS (1.981s)
[506.783043] Starting dynamic subtest: ccs0
[507.325482] Dynamic subtest ccs0: SUCCESS (0.552s)
[507.327971] Subtest busy-check-all: SUCCESS (7.082s)
[507.445064] [096/131] (587s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[507.555355] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[507.560177] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[507.657630] [097/131] (587s left) gen7_exec_parse (oacontrol-tracking)
[507.718653] Subtest oacontrol-tracking: SKIP (0.000s)
[507.774867] [098/131] (587s left) gem_pxp (create-protected-buffer)
[507.904377] Starting subtest: create-protected-buffer
[507.906482] Subtest create-protected-buffer: SUCCESS (0.000s)
[508.019407] [099/131] (586s left) gem_exec_schedule (implicit-boths)
[508.091394] Starting subtest: implicit-boths
[508.093470] Starting dynamic subtest: rcs0
[508.173879] Dynamic subtest rcs0: SUCCESS (0.092s)
[508.185916] Starting dynamic subtest: vcs0
[508.244273] Dynamic subtest vcs0: SUCCESS (0.070s)
[508.255280] Starting dynamic subtest: vcs1
[508.313489] Dynamic subtest vcs1: SUCCESS (0.069s)
[508.325310] Starting dynamic subtest: vecs0
[508.383790] Dynamic subtest vecs0: SUCCESS (0.070s)
[508.395507] Starting dynamic subtest: ccs0
[508.461895] Dynamic subtest ccs0: SUCCESS (0.077s)
[508.464146] Subtest implicit-boths: SUCCESS (0.381s)
[509.885844] [100/131] (585s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[509.998041] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[510.002121] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[510.097896] [101/131] (584s left) gem_exec_await (wide-all)
[510.315760] Starting subtest: wide-all
[533.527196] Subtest wide-all: SUCCESS (23.206s)
[533.726731] [102/131] (561s left) gem_exec_balancer (invalid-bonds)
[533.825843] Starting subtest: invalid-bonds
[533.830248] Subtest invalid-bonds: SKIP (0.000s)
[534.105234] [103/131] (560s left) kms_flip (wf_vblank-ts-check-interruptible)
[534.217333] Starting subtest: wf_vblank-ts-check-interruptible
[534.219695] Starting dynamic subtest: A-eDP1
[543.192276] Dynamic subtest A-eDP1: SUCCESS (8.971s)
[543.202963] Starting dynamic subtest: B-eDP1
[552.120750] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[552.131336] Starting dynamic subtest: C-eDP1
[561.037126] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[561.047547] Starting dynamic subtest: D-eDP1
[569.963842] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[569.966072] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.739s)
[571.180104] [104/131] (523s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[571.305045] Starting subtest: 2x-flip-vs-cursor-atomic
[571.309494] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[571.430494] [105/131] (523s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[571.533898] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[572.725058] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.192s)
[573.014467] [106/131] (522s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[573.116178] Starting subtest: fbc-rgb101010-draw-pwrite
[577.458729] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (4.346s)
[577.567873] [107/131] (517s left) i915_query (test-query-geometry-subslices)
[577.622299] Starting subtest: test-query-geometry-subslices
[577.624671] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[577.705583] [108/131] (517s left) kms_async_flips (alternate-sync-async-flip-atomic)
[577.804797] Starting subtest: alternate-sync-async-flip-atomic
[578.177475] Starting dynamic subtest: pipe-A-eDP-1
[580.993607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.818s)
[581.362138] Starting dynamic subtest: pipe-B-eDP-1
[584.116719] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[584.492624] Starting dynamic subtest: pipe-C-eDP-1
[587.244988] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[587.605784] Starting dynamic subtest: pipe-D-eDP-1
[590.371694] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[590.373745] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.566s)
[591.533524] [109/131] (503s left) kms_invalid_mode (bad-hsync-end)
[591.647633] Starting subtest: bad-hsync-end
[591.649984] Starting dynamic subtest: pipe-A-eDP-1
[591.927482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.279s)
[591.938155] Starting dynamic subtest: pipe-B-eDP-1
[591.940210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[591.950059] Starting dynamic subtest: pipe-C-eDP-1
[591.952427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[591.962188] Starting dynamic subtest: pipe-D-eDP-1
[591.964550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[591.966829] Subtest bad-hsync-end: SUCCESS (0.285s)
[592.753876] [110/131] (502s left) kms_psr (psr2-sprite-mmap-cpu)
[592.855309] Starting subtest: psr2-sprite-mmap-cpu
[592.857612] Starting dynamic subtest: eDP-1
[594.535329] Dynamic subtest eDP-1: SUCCESS (1.682s)
[594.537734] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.683s)
[595.398365] [111/131] (499s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[595.459827] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[595.566866] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[595.639014] [112/131] (499s left) kms_plane_scaling (planes-upscale-20x20)
[595.735491] Starting subtest: planes-upscale-20x20
[595.737661] Starting dynamic subtest: pipe-A
[595.801627] Dynamic subtest pipe-A: SUCCESS (0.066s)
[595.819014] Starting dynamic subtest: pipe-B
[596.924759] Dynamic subtest pipe-B: SUCCESS (1.122s)
[596.936873] Starting dynamic subtest: pipe-C
[598.030489] Dynamic subtest pipe-C: SUCCESS (1.105s)
[598.040593] Starting dynamic subtest: pipe-D
[599.150218] Dynamic subtest pipe-D: SUCCESS (1.120s)
[599.152595] Subtest planes-upscale-20x20: SUCCESS (3.416s)
[600.294584] [113/131] (495s left) kms_content_protection (type1)
[600.472359] Starting subtest: type1
[603.830197] Subtest type1: SKIP (3.357s)
[604.999942] [114/131] (490s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[605.114724] Starting subtest: fbcpsr-suspend
[643.084077] Subtest fbcpsr-suspend: SUCCESS (7.655s)
[643.205728] [115/131] (482s left) kms_flip (flip-vs-rmfb-interruptible)
[643.316784] Starting subtest: flip-vs-rmfb-interruptible
[643.319216] Starting dynamic subtest: A-eDP1
[652.005856] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[652.017717] Starting dynamic subtest: B-eDP1
[660.642516] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[660.658908] Starting dynamic subtest: C-eDP1
[669.262118] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[669.272815] Starting dynamic subtest: D-eDP1
[677.921957] Dynamic subtest D-eDP1: SUCCESS (8.661s)
[677.924508] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.584s)
[679.061833] [116/131] (446s left) kms_lease (lease-revoke)
[679.162122] Starting subtest: lease-revoke
[679.164762] Starting dynamic subtest: pipe-A-eDP-1
[679.207983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.044s)
[679.221287] Starting dynamic subtest: pipe-B-eDP-1
[679.252995] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.041s)
[679.263089] Starting dynamic subtest: pipe-C-eDP-1
[679.297165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.046s)
[679.308319] Starting dynamic subtest: pipe-D-eDP-1
[679.347938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.050s)
[679.350618] Subtest lease-revoke: SUCCESS (0.186s)
[679.475953] [117/131] (446s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[679.577088] Starting subtest: x-tiled-64bpp-rotate-270
[679.596247] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[679.706151] [118/131] (446s left) gem_readwrite (write-bad-handle)
[679.770496] Subtest write-bad-handle: SKIP (0.000s)
[679.819811] [119/131] (446s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[679.931856] Starting subtest: cursor-vs-flip-varying-size
[710.235783] Subtest cursor-vs-flip-varying-size: SUCCESS (30.297s)
[711.087895] [120/131] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[711.185281] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[711.190770] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[711.267051] [121/131] (414s left) gem_mmap_gtt (bad-object)
[711.326147] Subtest bad-object: SKIP (0.000s)
[711.389438] [122/131] (414s left) sw_sync (alloc_fence)
[711.427082] Starting subtest: alloc_fence
[711.429376] Subtest alloc_fence: SUCCESS (0.000s)
[711.479307] [123/131] (414s left) syncobj_wait (wait-any-complex)
[711.536204] Starting subtest: wait-any-complex
[711.596401] Subtest wait-any-complex: SUCCESS (0.063s)
[711.670545] [124/131] (414s left) core_getstats
[711.835343] [125/131] (414s left) kms_sequence (get-idle)
[711.934491] Starting subtest: get-idle
[711.936746] Starting dynamic subtest: pipe-A-eDP-1
[713.751472] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[713.761788] Starting dynamic subtest: pipe-B-eDP-1
[716.251100] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.498s)
[716.266736] Starting dynamic subtest: pipe-C-eDP-1
[718.659810] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.404s)
[718.670516] Starting dynamic subtest: pipe-D-eDP-1
[721.081786] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[721.084454] Subtest get-idle: SUCCESS (9.142s)
[721.886167] [126/131] (404s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[726.928962] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[726.934238] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[727.779457] [127/131] (398s left) sriov_basic (enable-vfs-bind-unbind-each)
[727.844468] Starting subtest: enable-vfs-bind-unbind-each
[727.847217] Starting dynamic subtest: numvfs-1
[727.938661] Dynamic subtest numvfs-1: FAIL (0.032s)
[727.949256] Starting dynamic subtest: numvfs-2
[728.039983] Dynamic subtest numvfs-2: FAIL (0.003s)
[728.051076] Starting dynamic subtest: numvfs-3
[728.137833] Dynamic subtest numvfs-3: FAIL (0.003s)
[728.148124] Starting dynamic subtest: numvfs-4
[728.233915] Dynamic subtest numvfs-4: FAIL (0.003s)
[728.243796] Starting dynamic subtest: numvfs-5
[728.328897] Dynamic subtest numvfs-5: FAIL (0.003s)
[728.339538] Starting dynamic subtest: numvfs-6
[728.425724] Dynamic subtest numvfs-6: FAIL (0.003s)
[728.435984] Starting dynamic subtest: numvfs-7
[728.521029] Dynamic subtest numvfs-7: FAIL (0.003s)
[728.532057] Starting dynamic subtest: numvfs-random
[728.617521] Dynamic subtest numvfs-random: FAIL (0.003s)
[728.620045] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[728.654940] [128/131] (397s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[728.762729] Starting subtest: fbc-rgb565-draw-pwrite
[732.244232] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.482s)
[732.353225] [129/131] (393s left) kms_chamelium_color (ctm-0-50)
[732.444205] Subtest ctm-0-50: SKIP (0.000s)
[732.483879] [130/131] (393s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[732.536117] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[732.538096] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[732.642555] [131/131] (393s left) gem_mmap_gtt (basic-write-read)
[732.702713] Subtest basic-write-read: SKIP (0.000s)
[732.760415] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_pm_lpsp
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_writeback
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: i915_pm_freq_api
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_flush
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_linear_blits
results: parsing output: 21/ for test: gen3_mixed_blits
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: drm_fdinfo
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_hdr
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_setmode
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_cursor_edge_walk
results: parsing output: 57/ for test: gem_busy
results: parsing output: 58/ for test: kms_chamelium_color
results: parsing output: 59/ for test: gem_fenced_exec_thrash
results: parsing output: 60/ for test: kms_dp_linktrain_fallback
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_unfence_active_buffers
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_create
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: drm_fdinfo
results: parsing output: 86/ for test: gem_fenced_exec_thrash
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_async
results: parsing output: 89/ for test: perf
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_caching
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: gem_pxp
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_await
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_query
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_readwrite
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: core_getstats
results: parsing output: 124/ for test: kms_sequence
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: sriov_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_mmap_gtt
Done.