[57.751357] Initializing watchdogs
[57.751473]   /dev/watchdog0
[57.769226] [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.774075] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.776572] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.779922] [001/133] (960s left) gem_exec_reloc (basic-gtt-cpu-active)
[57.875844] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[57.940531] [002/133] (960s left) kms_chamelium_color (ctm-0-75)
[58.050728] Subtest ctm-0-75: SKIP (0.000s)
[58.091081] [003/133] (960s left) gem_mmap (bad-object)
[58.150157] Subtest bad-object: SKIP (0.000s)
[58.206201] [004/133] (960s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[58.301485] Starting subtest: psr2-cursor-plane-update-sf
[58.303619] Starting dynamic subtest: pipe-A-eDP-1
[58.910670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[58.920266] Starting dynamic subtest: pipe-B-eDP-1
[60.229628] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s)
[60.232022] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.921s)
[61.096753] [005/133] (957s left) gem_pread (display)
[61.152988] Subtest display: SKIP (0.000s)
[61.214574] [006/133] (957s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[61.598966] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[62.405700] [007/133] (956s left) i915_pm_rpm (reg-read-ioctl)
[63.965694] Starting subtest: reg-read-ioctl
[66.358811] Subtest reg-read-ioctl: SUCCESS (2.388s)
[66.735992] [008/133] (951s left) kms_content_protection (content-type-change)
[66.961556] Starting subtest: content-type-change
[66.966194] Subtest content-type-change: SKIP (0.000s)
[67.326275] [009/133] (951s left) i915_query (query-topology-matches-eu-total)
[67.560793] Starting subtest: query-topology-matches-eu-total
[67.563520] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[67.727879] [010/133] (950s left) sw_sync (sync_merge_invalid)
[67.777597] Starting subtest: sync_merge_invalid
[67.809169] Subtest sync_merge_invalid: SUCCESS (0.032s)
[67.948722] [011/133] (950s left) kms_cursor_crc (cursor-sliding-32x10)
[68.143606] Starting subtest: cursor-sliding-32x10
[68.197581] Subtest cursor-sliding-32x10: SKIP (0.049s)
[68.459508] [012/133] (950s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[68.518701] Starting subtest: etime-single-wait-for-submit-submitted
[68.627790] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[68.711837] [013/133] (950s left) gem_create (create-clear)
[68.780235] Starting subtest: create-clear
[68.784203] Starting dynamic subtest: smem0
[101.792605] Dynamic subtest smem0: SUCCESS (32.991s)
[101.794955] Subtest create-clear: SUCCESS (32.992s)
[101.993587] [014/133] (916s left) gen9_exec_parse (valid-registers)
[102.058554] Subtest valid-registers: SKIP (0.000s)
[102.129050] [015/133] (916s left) perf (invalid-oa-exponent)
[102.241073] Starting subtest: invalid-oa-exponent
[102.255740] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[102.294558] [016/133] (916s left) kms_feature_discovery (display-1x)
[102.402866] Starting subtest: display-1x
[102.405186] Subtest display-1x: SUCCESS (0.000s)
[102.496388] [017/133] (916s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[102.606829] Starting subtest: addfb25-yf-tiled-legacy
[102.608962] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[102.704910] [018/133] (916s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[102.896055] Starting subtest: cursor-rapid-movement-64x64
[102.900832] Starting dynamic subtest: pipe-A-eDP-1
[103.443964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[103.476061] Starting dynamic subtest: pipe-D-eDP-1
[104.644076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.172s)
[104.646507] Subtest cursor-rapid-movement-64x64: SUCCESS (1.746s)
[105.503658] [019/133] (913s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[105.610641] Starting subtest: fbcpsr-shrfb-scaledprimary
[111.411388] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.804s)
[111.532248] [020/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[111.630268] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[111.634389] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[111.718554] [021/133] (907s left) gem_mmap_offset (basic-uaf)
[111.781640] Starting subtest: basic-uaf
[111.783950] Subtest basic-uaf: SUCCESS (0.001s)
[111.891739] [022/133] (907s left) gem_userptr_blits (probe)
[111.995488] Starting subtest: probe
[112.075297] Subtest probe: SUCCESS (0.080s)
[112.201911] [023/133] (906s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[112.321210] Starting subtest: flip-vs-cursor-atomic-transitions
[120.306118] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.981s)
[121.155450] [024/133] (898s left) perf (invalid-open-flags)
[121.247801] Starting subtest: invalid-open-flags
[121.250342] Subtest invalid-open-flags: SUCCESS (0.000s)
[121.287287] [025/133] (897s left) kms_psr (fbc-psr-sprite-render)
[121.387206] Starting subtest: fbc-psr-sprite-render
[121.389108] Starting dynamic subtest: eDP-1
[121.393279] Dynamic subtest eDP-1: SKIP (0.000s)
[121.397442] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[121.455212] [026/133] (897s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[121.527032] Starting subtest: multi-wait-all-for-submit-available-submitted
[121.529443] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[121.628176] [027/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[121.723740] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[121.728244] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[121.808762] [028/133] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[121.911094] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[128.682356] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.772s)
[128.835045] [029/133] (890s left) gem_lmem_swapping (random)
[128.879074] Subtest random: SKIP (0.000s)
[128.931781] [030/133] (890s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[128.981984] Starting subtest: y-tiled-ccs-to-yf-tiled
[128.986354] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[129.160660] [031/133] (890s left) api_intel_bb (object-noreloc-keep-cache-simple)
[129.221022] Starting subtest: object-noreloc-keep-cache-simple
[129.225620] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[129.338868] [032/133] (890s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[131.063802] Starting subtest: dpms-mode-unset-lpsp
[135.098472] Subtest dpms-mode-unset-lpsp: SUCCESS (4.037s)
[135.494546] [033/133] (884s left) kms_chamelium_edid (dp-edid-resolution-list)
[135.905295] Subtest dp-edid-resolution-list: SKIP (0.000s)
[136.692453] [034/133] (882s left) gem_ctx_shared (single-timeline)
[136.747888] Starting subtest: single-timeline
[136.768080] Subtest single-timeline: SUCCESS (0.011s)
[136.987486] [035/133] (882s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[137.081697] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[137.086217] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[137.174846] [036/133] (882s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[137.270090] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[137.274274] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[137.338039] [037/133] (882s left) api_intel_allocator (reopen)
[137.393174] Starting subtest: reopen
[137.398327] Subtest reopen: SUCCESS (0.004s)
[137.533965] [038/133] (882s left) syncobj_timeline (signal-point-0)
[137.591721] Starting subtest: signal-point-0
[137.594055] Subtest signal-point-0: SUCCESS (0.000s)
[137.683064] [039/133] (882s left) gem_exec_whisper (basic-queues-all)
[137.735531] Starting subtest: basic-queues-all
[148.856052] Subtest basic-queues-all: SUCCESS (11.116s)
[149.043840] [040/133] (870s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[149.102152] Starting subtest: multi-wait-all-for-submit-signaled
[149.104554] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[149.194505] [041/133] (870s left) gem_bad_reloc (negative-reloc-bltcopy)
[149.252205] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[149.308703] [042/133] (870s left) gem_exec_store (pages)
[149.368608] Starting subtest: pages
[149.370960] Starting dynamic subtest: rcs0
[149.450620] Dynamic subtest rcs0: SUCCESS (0.082s)
[149.459405] Starting dynamic subtest: bcs0
[149.520212] Dynamic subtest bcs0: SUCCESS (0.068s)
[149.530913] Starting dynamic subtest: vcs0
[149.590080] Dynamic subtest vcs0: SUCCESS (0.069s)
[149.601431] Starting dynamic subtest: vcs1
[149.654847] Dynamic subtest vcs1: SUCCESS (0.064s)
[149.666153] Starting dynamic subtest: vecs0
[149.720783] Dynamic subtest vecs0: SUCCESS (0.066s)
[149.730427] Starting dynamic subtest: ccs0
[149.789077] Dynamic subtest ccs0: SUCCESS (0.068s)
[149.791516] Subtest pages: SUCCESS (0.421s)
[149.984777] [043/133] (869s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[150.069396] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[150.071799] Starting dynamic subtest: pipe-A-eDP-1
[150.095661] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.105111] Starting dynamic subtest: pipe-B-eDP-1
[150.127880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.136196] Starting dynamic subtest: pipe-C-eDP-1
[150.158721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.167078] Starting dynamic subtest: pipe-D-eDP-1
[150.190999] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[150.195876] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[152.380695] [044/133] (867s left) i915_pciid
[152.544932] [045/133] (867s left) gem_spin_batch (resubmit-new-all)
[152.611379] Starting subtest: resubmit-new-all
[152.613900] Starting dynamic subtest: rcs0
[152.629052] Dynamic subtest rcs0: SUCCESS (0.017s)
[152.641051] Starting dynamic subtest: bcs0
[152.643427] Dynamic subtest bcs0: SUCCESS (0.012s)
[152.653060] Starting dynamic subtest: vcs0
[152.655380] Dynamic subtest vcs0: SUCCESS (0.009s)
[152.663741] Starting dynamic subtest: vcs1
[152.665967] Dynamic subtest vcs1: SUCCESS (0.009s)
[152.674401] Starting dynamic subtest: vecs0
[152.676835] Dynamic subtest vecs0: SUCCESS (0.011s)
[152.684700] Starting dynamic subtest: ccs0
[152.687062] Dynamic subtest ccs0: SUCCESS (0.010s)
[152.689669] Subtest resubmit-new-all: SUCCESS (0.074s)
[153.916742] [046/133] (866s left) kms_dp_linktrain_fallback (dsc-fallback)
[154.010195] Starting subtest: dsc-fallback
[154.017054] Subtest dsc-fallback: SKIP (0.000s)
[154.123048] [047/133] (866s left) kms_flip (dpms-off-confusion)
[154.220370] Starting subtest: dpms-off-confusion
[154.222412] Starting dynamic subtest: A-eDP1
[162.877603] Dynamic subtest A-eDP1: SUCCESS (8.659s)
[162.888330] Starting dynamic subtest: B-eDP1
[171.529653] Dynamic subtest B-eDP1: SUCCESS (8.650s)
[171.540810] Starting dynamic subtest: C-eDP1
[180.151065] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[180.165178] Starting dynamic subtest: D-eDP1
[188.780631] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[188.785820] Subtest dpms-off-confusion: SUCCESS (34.567s)
[189.949245] [048/133] (830s left) gem_exec_schedule (semaphore-power)
[190.146216] Subtest semaphore-power: SKIP (0.000s)
[190.346106] [049/133] (829s left) gem_softpin (softpin)
[190.411615] Starting subtest: softpin
[222.773687] Subtest softpin: SUCCESS (32.356s)
[222.904871] [050/133] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[223.026607] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[229.755628] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.731s)
[229.900897] [051/133] (790s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[230.012386] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[230.016941] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[230.120517] [052/133] (790s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[230.216187] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[230.220821] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[231.314936] [053/133] (789s left) kms_addfb_basic (bad-pitch-256)
[231.380338] Starting subtest: bad-pitch-256
[231.382726] Subtest bad-pitch-256: SUCCESS (0.000s)
[231.513413] [054/133] (788s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[231.642156] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[231.646930] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[231.807686] [055/133] (788s left) kms_rotation_crc (primary-rotation-90)
[231.895301] Starting subtest: primary-rotation-90
[231.899406] Subtest primary-rotation-90: SKIP (0.001s)
[231.968727] [056/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[232.065582] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[239.528068] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.464s)
[239.638878] [057/133] (780s left) kms_panel_fitting (legacy)
[239.737378] Starting subtest: legacy
[239.739607] Starting dynamic subtest: pipe-A-eDP-1
[240.277639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[240.310574] Starting dynamic subtest: pipe-B-eDP-1
[241.801517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s)
[241.828380] Starting dynamic subtest: pipe-C-eDP-1
[243.318273] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[243.343169] Starting dynamic subtest: pipe-D-eDP-1
[244.859714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[244.862061] Subtest legacy: SUCCESS (5.125s)
[246.084857] [058/133] (774s left) gem_exec_fence (basic-wait)
[246.268276] Starting subtest: basic-wait
[246.270738] Starting dynamic subtest: rcs0
[246.351507] Dynamic subtest rcs0: SUCCESS (0.086s)
[246.363279] Starting dynamic subtest: bcs0
[246.408319] Dynamic subtest bcs0: SUCCESS (0.055s)
[246.418468] Starting dynamic subtest: vcs0
[246.465608] Dynamic subtest vcs0: SUCCESS (0.055s)
[246.476870] Starting dynamic subtest: vcs1
[246.520080] Dynamic subtest vcs1: SUCCESS (0.052s)
[246.532924] Starting dynamic subtest: vecs0
[246.575646] Dynamic subtest vecs0: SUCCESS (0.054s)
[246.586547] Starting dynamic subtest: ccs0
[246.629824] Dynamic subtest ccs0: SUCCESS (0.052s)
[246.632614] Subtest basic-wait: SUCCESS (0.366s)
[247.966327] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[247.969561] [059/133] (772s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[248.032121] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[248.090721] [060/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.187178] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.191567] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.281238] [061/133] (772s left) gem_exec_balancer (bonded-dual)
[248.354513] Starting subtest: bonded-dual
[248.359099] Subtest bonded-dual: SKIP (0.000s)
[248.664876] [062/133] (772s left) kms_big_fb (linear-addfb)
[248.774095] Starting subtest: linear-addfb
[248.776444] Subtest linear-addfb: SUCCESS (0.000s)
[248.874740] [063/133] (771s left) perf_pmu (busy-accuracy-50)
[248.919417] Starting subtest: busy-accuracy-50
[248.921752] Starting dynamic subtest: rcs0
[250.451766] Dynamic subtest rcs0: SUCCESS (1.532s)
[250.462973] Starting dynamic subtest: bcs0
[251.995885] Dynamic subtest bcs0: SUCCESS (1.542s)
[252.007147] Starting dynamic subtest: vcs0
[253.541305] Dynamic subtest vcs0: SUCCESS (1.543s)
[253.550466] Starting dynamic subtest: vcs1
[255.084722] Dynamic subtest vcs1: SUCCESS (1.541s)
[255.093767] Starting dynamic subtest: vecs0
[256.621952] Dynamic subtest vecs0: SUCCESS (1.535s)
[256.632433] Starting dynamic subtest: ccs0
[258.166987] Dynamic subtest ccs0: SUCCESS (1.543s)
[258.169864] Subtest busy-accuracy-50: SUCCESS (9.248s)
[258.283647] [064/133] (762s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[258.412052] Starting subtest: cursorA-vs-flipB-atomic-transitions
[258.416698] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s)
[258.563268] [065/133] (762s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[258.614960] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[258.617266] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[258.734047] [066/133] (762s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[258.860874] Starting subtest: basic-flip-before-cursor-legacy
[259.777732] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[260.607581] [067/133] (760s left) gem_partial_pwrite_pread (reads)
[260.669635] Subtest reads: SKIP (0.000s)
[260.732998] [068/133] (760s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[260.833251] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[260.835572] Starting dynamic subtest: pipe-A
[260.856601] Dynamic subtest pipe-A: SKIP (0.019s)
[260.866227] Starting dynamic subtest: pipe-B
[260.889355] Dynamic subtest pipe-B: SKIP (0.032s)
[260.898028] Starting dynamic subtest: pipe-C
[260.919862] Dynamic subtest pipe-C: SKIP (0.032s)
[260.928488] Starting dynamic subtest: pipe-D
[260.952942] Dynamic subtest pipe-D: SKIP (0.032s)
[260.957234] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.117s)
[261.064913] [069/133] (759s left) vgem_basic (dmabuf-export)
[261.105655] Starting subtest: dmabuf-export
[261.133616] Subtest dmabuf-export: SUCCESS (0.030s)
[261.229849] [070/133] (759s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[261.329599] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[261.333615] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[261.428853] [071/133] (759s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[261.534075] Starting subtest: y-tiled-16bpp-rotate-90
[261.537379] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[261.621008] [072/133] (759s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[261.730224] Starting subtest: fbc-shrfb-scaledprimary
[264.693913] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.966s)
[265.820753] [073/133] (755s left) gem_ctx_persistence (legacy-engines-cleanup)
[265.879300] Starting subtest: legacy-engines-cleanup
[265.881525] Starting dynamic subtest: render
[265.953034] Dynamic subtest render: SUCCESS (0.076s)
[265.964522] Starting dynamic subtest: bsd1
[266.003838] Dynamic subtest bsd1: SUCCESS (0.048s)
[266.014748] Starting dynamic subtest: bsd2
[266.051761] Dynamic subtest bsd2: SUCCESS (0.045s)
[266.062773] Starting dynamic subtest: blt
[266.096717] Dynamic subtest blt: SUCCESS (0.042s)
[266.107067] Starting dynamic subtest: vebox
[266.149739] Dynamic subtest vebox: SUCCESS (0.051s)
[266.152160] Subtest legacy-engines-cleanup: SUCCESS (0.274s)
[266.230096] [074/133] (755s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[266.319076] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[266.323119] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[266.393564] [075/133] (754s left) perf_pmu (rc6)
[266.438200] Starting subtest: rc6
[266.440367] Starting dynamic subtest: gt0
[272.807533] Dynamic subtest gt0: SUCCESS (6.368s)
[272.820054] Starting dynamic subtest: runtime-pm-gt0
[280.613580] Dynamic subtest runtime-pm-gt0: SUCCESS (7.804s)
[280.624958] Starting dynamic subtest: runtime-pm-long-gt0
[293.108561] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.493s)
[293.118299] Starting dynamic subtest: other-idle-gt0
[299.453076] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[299.465072] Starting dynamic subtest: gt1
[305.796366] Dynamic subtest gt1: SUCCESS (6.340s)
[305.807664] Starting dynamic subtest: runtime-pm-gt1
[313.221061] Dynamic subtest runtime-pm-gt1: SUCCESS (7.422s)
[313.232756] Starting dynamic subtest: runtime-pm-long-gt1
[325.644873] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.421s)
[325.656590] Starting dynamic subtest: other-idle-gt1
[331.987212] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[331.990021] Subtest rc6: SUCCESS (65.548s)
[333.132849] [076/133] (688s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[333.242494] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[333.244787] Starting dynamic subtest: pipe-A-eDP-1
[344.222827] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.982s)
[344.234294] Starting dynamic subtest: pipe-B-eDP-1
[355.952682] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.730s)
[355.954855] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.716s)
[356.793419] [077/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[356.895645] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[356.900147] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.954237] [078/133] (664s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[357.052871] Starting subtest: 4-tiled-8bpp-rotate-180
[358.266540] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[358.369629] [079/133] (663s left) gem_userptr_blits (forbidden-operations)
[358.437456] Starting subtest: forbidden-operations
[358.441178] Subtest forbidden-operations: SKIP (0.000s)
[358.542379] [080/133] (662s left) kms_addfb_basic (basic)
[358.609125] Starting subtest: basic
[358.611065] Subtest basic: SUCCESS (0.000s)
[358.711853] [081/133] (662s left) gem_exec_reloc (basic-active)
[358.777900] Subtest basic-active: SKIP (0.000s)
[358.850358] [082/133] (662s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[358.957045] Starting subtest: x-tiled-64bpp-rotate-0
[360.459897] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.501s)
[360.603493] [083/133] (661s left) kms_cursor_crc (cursor-onscreen-128x42)
[360.844128] Starting subtest: cursor-onscreen-128x42
[360.893553] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[361.070329] [084/133] (660s left) gen9_exec_parse (bb-secure)
[361.144072] Subtest bb-secure: SKIP (0.000s)
[361.213912] [085/133] (660s left) kms_invalid_mode (bad-vsync-start)
[361.305455] Starting subtest: bad-vsync-start
[361.307677] Starting dynamic subtest: pipe-A-eDP-1
[361.592327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[361.602218] Starting dynamic subtest: pipe-B-eDP-1
[361.604388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[361.613109] Starting dynamic subtest: pipe-C-eDP-1
[361.615270] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[361.626446] Starting dynamic subtest: pipe-D-eDP-1
[361.628639] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[361.630879] Subtest bad-vsync-start: SUCCESS (0.293s)
[362.414868] [086/133] (659s left) fbdev (pan)
[362.448025] Starting subtest: pan
[362.471376] Subtest pan: SUCCESS (0.027s)
[362.524353] [087/133] (659s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[362.620857] Starting subtest: fbc-pr-sprite-mmap-cpu
[362.624843] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[362.669753] [088/133] (659s left) kms_vblank (ts-continuation-modeset-hang)
[362.758141] Starting subtest: ts-continuation-modeset-hang
[362.759986] Starting dynamic subtest: pipe-A-eDP-1
[389.663709] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.905s)
[389.678172] Starting dynamic subtest: pipe-D-eDP-1
[414.688538] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[414.690465] Subtest ts-continuation-modeset-hang: SUCCESS (51.928s)
[415.544834] [089/133] (606s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[415.644108] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[415.646423] Starting dynamic subtest: pipe-A
[415.995406] Dynamic subtest pipe-A: SUCCESS (0.353s)
[416.004423] Starting dynamic subtest: pipe-B
[417.460324] Dynamic subtest pipe-B: SUCCESS (1.464s)
[417.469649] Starting dynamic subtest: pipe-C
[418.918816] Dynamic subtest pipe-C: SUCCESS (1.458s)
[418.928270] Starting dynamic subtest: pipe-D
[420.333409] Dynamic subtest pipe-D: SUCCESS (1.414s)
[420.335712] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.692s)
[421.487838] [090/133] (600s left) gem_ctx_persistence (engines-hang)
[421.550665] Starting subtest: engines-hang
[421.552894] Starting dynamic subtest: rcs0
[421.681671] Dynamic subtest rcs0: SUCCESS (0.131s)
[421.693610] Starting dynamic subtest: bcs0
[421.759665] Dynamic subtest bcs0: SUCCESS (0.076s)
[421.770575] Starting dynamic subtest: vcs0
[421.882746] Dynamic subtest vcs0: SUCCESS (0.121s)
[421.894562] Starting dynamic subtest: vcs1
[421.967603] Dynamic subtest vcs1: SUCCESS (0.083s)
[421.978813] Starting dynamic subtest: vecs0
[422.061554] Dynamic subtest vecs0: SUCCESS (0.092s)
[422.072995] Starting dynamic subtest: ccs0
[422.151671] Dynamic subtest ccs0: SUCCESS (0.088s)
[422.154129] Subtest engines-hang: SUCCESS (0.602s)
[422.208965] [091/133] (599s left) kms_busy (basic-hang)
[422.307058] Starting subtest: basic-hang
[422.309277] Starting dynamic subtest: flip-pipe-A
[422.920042] Dynamic subtest flip-pipe-A: SUCCESS (0.611s)
[422.930228] Starting dynamic subtest: modeset-pipe-A
[426.589781] Dynamic subtest modeset-pipe-A: SUCCESS (3.668s)
[426.599758] Starting dynamic subtest: flip-pipe-D
[427.798400] Dynamic subtest flip-pipe-D: SUCCESS (1.205s)
[427.807518] Starting dynamic subtest: modeset-pipe-D
[431.216863] Dynamic subtest modeset-pipe-D: SUCCESS (3.419s)
[431.219093] Subtest basic-hang: SUCCESS (8.910s)
[432.000557] [092/133] (589s left) sysfs_heartbeat_interval (precise)
[432.058875] Starting subtest: precise
[432.061069] Starting dynamic subtest: vecs0
[439.894863] Dynamic subtest vecs0: SUCCESS (7.832s)
[439.906257] Starting dynamic subtest: ccs0
[442.903244] Dynamic subtest ccs0: SUCCESS (3.007s)
[442.912788] Starting dynamic subtest: vcs0
[450.904930] Dynamic subtest vcs0: SUCCESS (7.997s)
[450.916081] Starting dynamic subtest: bcs0
[451.995228] Dynamic subtest bcs0: SUCCESS (1.090s)
[452.005796] Starting dynamic subtest: rcs0
[453.157068] Dynamic subtest rcs0: SUCCESS (1.161s)
[453.168475] Starting dynamic subtest: vcs1
[459.932328] Dynamic subtest vcs1: SUCCESS (6.771s)
[459.934924] Subtest precise: SUCCESS (27.871s)
[459.986458] [093/133] (562s left) gem_exec_schedule (out-order)
[460.067471] Starting subtest: out-order
[460.069514] Starting dynamic subtest: rcs0
[460.224284] Dynamic subtest rcs0: SUCCESS (0.164s)
[460.236174] Starting dynamic subtest: vcs0
[460.328873] Dynamic subtest vcs0: SUCCESS (0.105s)
[460.340554] Starting dynamic subtest: vcs1
[460.440759] Dynamic subtest vcs1: SUCCESS (0.111s)
[460.456901] Starting dynamic subtest: vecs0
[460.552848] Dynamic subtest vecs0: SUCCESS (0.112s)
[460.565174] Starting dynamic subtest: ccs0
[460.687881] Dynamic subtest ccs0: SUCCESS (0.134s)
[460.690352] Subtest out-order: SUCCESS (0.629s)
[461.979686] [094/133] (560s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[462.085061] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[462.087335] Starting dynamic subtest: pipe-A-eDP-1
[462.144358] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[462.154715] Starting dynamic subtest: pipe-B-eDP-1
[462.210333] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[462.222437] Starting dynamic subtest: pipe-C-eDP-1
[462.279971] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[462.289939] Starting dynamic subtest: pipe-D-eDP-1
[462.345962] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[462.350036] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[464.362288] [095/133] (557s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[464.447387] Starting subtest: bad-pixel-format-yf-tiled-ccs
[464.449784] Starting dynamic subtest: pipe-A-eDP-1
[464.473498] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.483743] Starting dynamic subtest: pipe-B-eDP-1
[464.505717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.514144] Starting dynamic subtest: pipe-C-eDP-1
[464.536070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[464.544438] Starting dynamic subtest: pipe-D-eDP-1
[464.566881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[464.571295] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[466.738634] [096/133] (555s left) gem_pxp (create-regular-context-1)
[466.867583] Starting subtest: create-regular-context-1
[466.870063] Subtest create-regular-context-1: SUCCESS (0.002s)
[466.951553] [097/133] (555s left) kms_getfb (getfb-handle-valid)
[467.049400] Starting subtest: getfb-handle-valid
[467.051627] Subtest getfb-handle-valid: SUCCESS (0.000s)
[467.127039] [098/133] (555s left) kms_psr (psr2-sprite-blt)
[467.223338] Starting subtest: psr2-sprite-blt
[467.225651] Starting dynamic subtest: eDP-1
[468.948180] Dynamic subtest eDP-1: SUCCESS (1.723s)
[468.950554] Subtest psr2-sprite-blt: SUCCESS (1.725s)
[469.788482] [099/133] (552s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[469.881248] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[469.883639] Starting dynamic subtest: pipe-A-default-mode
[472.658292] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[472.660260] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.776s)
[473.471994] [100/133] (548s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[475.101862] Starting subtest: modeset-lpsp-stress-no-wait
[485.153579] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.054s)
[485.233248] [101/133] (537s left) kms_lease (possible-crtcs-filtering)
[485.323912] Starting subtest: possible-crtcs-filtering
[485.328722] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[485.420787] [102/133] (536s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[485.521200] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[485.525094] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[485.568222] [103/133] (536s left) gem_exec_params (invalid-bsd2-flag-on-render)
[485.621545] Starting subtest: invalid-bsd2-flag-on-render
[485.623674] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[485.701415] [104/133] (536s left) vgem_basic (unload)
[485.742998] Starting subtest: unload
[514.805839] Subtest unload: SUCCESS (29.060s)
[514.881230] [105/133] (507s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[514.980055] Starting subtest: primary-4-tiled-reflect-x-0
[521.944066] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.964s)
[523.153306] [106/133] (499s left) gem_exec_fence (syncobj-invalid-wait)
[523.593918] Starting subtest: syncobj-invalid-wait
[523.596613] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[524.963133] [107/133] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[525.050136] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[525.054709] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[525.129337] [108/133] (497s left) kms_color (invalid-ctm-matrix-sizes)
[525.216743] Starting subtest: invalid-ctm-matrix-sizes
[525.218877] Starting dynamic subtest: pipe-A
[525.221143] Dynamic subtest pipe-A: SUCCESS (0.002s)
[525.230535] Starting dynamic subtest: pipe-B
[525.232752] Dynamic subtest pipe-B: SUCCESS (0.003s)
[525.241292] Starting dynamic subtest: pipe-C
[525.243425] Dynamic subtest pipe-C: SUCCESS (0.003s)
[525.252238] Starting dynamic subtest: pipe-D
[525.254405] Dynamic subtest pipe-D: SUCCESS (0.004s)
[525.256576] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[525.295618] [109/133] (497s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[525.408718] Starting subtest: cursor-vs-flip-legacy
[555.242629] Subtest cursor-vs-flip-legacy: SUCCESS (29.834s)
[556.072312] [110/133] (466s left) kms_plane_alpha_blend (constant-alpha-max)
[556.162309] Starting subtest: constant-alpha-max
[556.461061] Starting dynamic subtest: pipe-A-eDP-1
[557.622814] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.160s)
[557.632568] Starting dynamic subtest: pipe-D-eDP-1
[559.231639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.603s)
[559.234035] Subtest constant-alpha-max: SUCCESS (3.066s)
[560.034085] [111/133] (462s left) kms_psr (fbc-psr-sprite-blt)
[560.142584] Starting subtest: fbc-psr-sprite-blt
[560.144596] Starting dynamic subtest: eDP-1
[560.148659] Dynamic subtest eDP-1: SKIP (0.000s)
[560.152741] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[560.192427] [112/133] (462s left) gem_sync (basic-each)
[560.256374] Starting subtest: basic-each
[562.630727] Subtest basic-each: SUCCESS (2.384s)
[562.792954] [113/133] (460s left) perf_pmu (most-busy-check-all)
[562.837148] Starting subtest: most-busy-check-all
[562.839629] Starting dynamic subtest: rcs0
[563.928403] Dynamic subtest rcs0: SUCCESS (1.093s)
[563.939416] Starting dynamic subtest: bcs0
[565.848511] Dynamic subtest bcs0: SUCCESS (1.917s)
[565.860574] Starting dynamic subtest: vcs0
[567.895923] Dynamic subtest vcs0: SUCCESS (2.044s)
[567.908362] Starting dynamic subtest: vcs1
[569.880292] Dynamic subtest vcs1: SUCCESS (1.981s)
[569.892890] Starting dynamic subtest: vecs0
[571.928556] Dynamic subtest vecs0: SUCCESS (2.045s)
[571.940812] Starting dynamic subtest: ccs0
[573.912234] Dynamic subtest ccs0: SUCCESS (1.981s)
[573.914994] Subtest most-busy-check-all: SUCCESS (11.079s)
[573.989803] [114/133] (448s left) gem_ctx_exec (basic)
[574.053175] Starting subtest: basic
[574.062343] Subtest basic: SUCCESS (0.010s)
[574.162470] [115/133] (448s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[574.269569] Starting subtest: 4-tiled-16bpp-rotate-180
[575.593589] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.324s)
[575.686106] [116/133] (447s left) gem_mmap_wc (fault-concurrent)
[575.735686] Subtest fault-concurrent: SKIP (0.000s)
[575.806112] [117/133] (447s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[575.895984] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[575.899351] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[575.964681] [118/133] (447s left) drm_mm (drm_mm)
[576.006570] Starting subtest: drm_mm
[576.022102] Starting dynamic subtest: drm_test_mm_init
[576.117585] Dynamic subtest drm_test_mm_init: SUCCESS (0.093s)
[576.127790] Starting dynamic subtest: drm_test_mm_debug
[576.221357] Dynamic subtest drm_test_mm_debug: SUCCESS (0.103s)
[576.231284] Starting dynamic subtest: drm_test_mm_align32
[576.323457] Dynamic subtest drm_test_mm_align32: SUCCESS (0.102s)
[576.332991] Starting dynamic subtest: drm_test_mm_align64
[576.425879] Dynamic subtest drm_test_mm_align64: SUCCESS (0.100s)
[576.435090] Starting dynamic subtest: drm_test_mm_lowest
[576.521117] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.094s)
[576.529213] Starting dynamic subtest: drm_test_mm_highest
[576.625512] Dynamic subtest drm_test_mm_highest: SUCCESS (0.103s)
[576.627279] Subtest drm_mm: SUCCESS (0.620s)
[576.764696] [119/133] (446s left) perf (non-system-wide-paranoid)
[576.828639] Starting subtest: non-system-wide-paranoid
[576.848796] Subtest non-system-wide-paranoid: SUCCESS (0.023s)
[576.896804] [120/133] (446s left) gem_pxp (verify-pxp-stale-buf-execution)
[576.996912] Starting subtest: verify-pxp-stale-buf-execution
[578.059094] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.061s)
[578.152745] [121/133] (445s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[578.249618] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[578.253941] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[578.318217] [122/133] (444s left) prime_busy (hang)
[578.375838] Starting subtest: hang
[578.378464] Starting dynamic subtest: rcs0
[604.401921] Dynamic subtest rcs0: SUCCESS (26.021s)
[604.410783] Starting dynamic subtest: bcs0
[611.559331] Dynamic subtest bcs0: SUCCESS (7.156s)
[611.568271] Starting dynamic subtest: vcs0
[618.529431] Dynamic subtest vcs0: SUCCESS (6.972s)
[618.541131] Starting dynamic subtest: vcs1
[625.570058] Dynamic subtest vcs1: SUCCESS (7.039s)
[625.581926] Starting dynamic subtest: vecs0
[632.548682] Dynamic subtest vecs0: SUCCESS (6.974s)
[632.559441] Starting dynamic subtest: ccs0
[646.448801] Dynamic subtest ccs0: SUCCESS (13.899s)
[646.451433] Subtest hang: SUCCESS (68.068s)
[646.533676] [123/133] (376s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[646.649860] Starting subtest: yf-tiled-16bpp-rotate-270
[646.654368] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[646.721859] [124/133] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[646.815702] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[653.911701] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.099s)
[654.003310] [125/133] (369s left) i915_suspend (debugfs-reader)
[654.068459] Starting subtest: debugfs-reader
[672.263727] Subtest debugfs-reader: SUCCESS (3.262s)
[672.439773] [126/133] (351s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[672.568026] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[672.579978] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[672.636750] [127/133] (350s left) gem_eio (in-flight-internal-1us)
[672.847229] Starting subtest: in-flight-internal-1us
[673.883722] Subtest in-flight-internal-1us: SUCCESS (1.005s)
[673.980577] [128/133] (349s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[674.061825] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[674.168977] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[674.226858] [129/133] (349s left) gem_exec_params (no-vebox)
[674.295144] Starting subtest: no-vebox
[674.297601] Subtest no-vebox: SUCCESS (0.002s)
[675.838208] [130/133] (347s left) kms_plane_cursor (overlay)
[675.926630] Starting subtest: overlay
[675.931149] Starting dynamic subtest: pipe-A-eDP-1-size-64
[678.617772] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.641s)
[678.681291] Starting dynamic subtest: pipe-A-eDP-1-size-128
[681.206752] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.505s)
[681.268971] Starting dynamic subtest: pipe-A-eDP-1-size-256
[683.831300] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s)
[684.184236] Starting dynamic subtest: pipe-B-eDP-1-size-64
[687.422454] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.230s)
[687.484273] Starting dynamic subtest: pipe-B-eDP-1-size-128
[690.101487] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.616s)
[690.163580] Starting dynamic subtest: pipe-B-eDP-1-size-256
[692.686773] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[693.042740] Starting dynamic subtest: pipe-C-eDP-1-size-64
[695.966467] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.929s)
[696.005478] Starting dynamic subtest: pipe-C-eDP-1-size-128
[698.170173] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[698.208976] Starting dynamic subtest: pipe-C-eDP-1-size-256
[700.395856] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[700.725176] Starting dynamic subtest: pipe-D-eDP-1-size-64
[703.622974] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.907s)
[703.665634] Starting dynamic subtest: pipe-D-eDP-1-size-128
[705.901452] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.248s)
[705.951412] Starting dynamic subtest: pipe-D-eDP-1-size-256
[708.155603] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[708.473706] Subtest overlay: SUCCESS (32.384s)
[709.376691] [131/133] (314s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[709.537780] Starting subtest: cursorA-vs-flipB-toggle
[709.542080] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[709.679543] [132/133] (314s left) kms_vblank (invalid)
[709.785696] Starting subtest: invalid
[709.787582] Starting dynamic subtest: pipe-A-eDP-1
[710.188790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[710.191209] Subtest invalid: SUCCESS (0.405s)
[710.972895] [133/133] (312s left) kms_flip (blocking-absolute-wf_vblank)
[711.077080] Starting subtest: blocking-absolute-wf_vblank
[711.079413] Starting dynamic subtest: A-eDP1
[719.851760] Dynamic subtest A-eDP1: SUCCESS (8.773s)
[719.862268] Starting dynamic subtest: B-eDP1
[728.585450] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[728.595886] Starting dynamic subtest: C-eDP1
[737.311155] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[737.329241] Starting dynamic subtest: D-eDP1
[746.039014] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[746.044227] Subtest blocking-absolute-wf_vblank: SUCCESS (34.956s)
[747.244827] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_chamelium_color
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_pread
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: i915_query
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_chamelium_edid
results: parsing output: 33/ for test: gem_ctx_shared
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_bad_reloc
results: parsing output: 41/ for test: gem_exec_store
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: i915_pciid
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_dp_linktrain_fallback
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_panel_fitting
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_partial_pwrite_pread
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: kms_invalid_mode
results: parsing output: 85/ for test: fbdev
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_busy
results: parsing output: 91/ for test: sysfs_heartbeat_interval
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_pxp
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: gem_exec_params
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_sync
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: gem_ctx_exec
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_mmap_wc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: drm_mm
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_busy
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_suspend
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: kms_plane_cursor
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_flip
Done.