[59.588362] Initializing watchdogs
[59.588410]   /dev/watchdog0
[59.602916] [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]
[59.607183] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.609298] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.611361] [001/133] (960s left) syncobj_timeline (wait-all-delayed-signal)
[59.661191] Starting subtest: wait-all-delayed-signal
[59.767271] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[59.850096] [002/133] (960s left) gem_create (busy-create)
[59.900882] Starting subtest: busy-create
[59.901755] Starting dynamic subtest: smem0
[93.886937] Dynamic subtest smem0: SUCCESS (33.958s)
[93.888455] Subtest busy-create: SUCCESS (33.959s)
[94.079920] [003/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[94.193622] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[116.628578] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.435s)
[116.786207] [004/133] (903s left) gem_lmem_swapping (heavy-verify-random)
[116.839158] Subtest heavy-verify-random: SKIP (0.000s)
[116.873077] [005/133] (903s left) gem_exec_balancer (persistence)
[117.126422] Starting subtest: persistence
[118.007536] Subtest persistence: SUCCESS (0.880s)
[118.144073] [006/133] (902s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[118.242978] Starting subtest: yf-tiled-32bpp-rotate-90
[118.244770] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[118.367118] [007/133] (901s left) gem_exec_fence (syncobj-timeline-unused-fence)
[118.961873] Starting subtest: syncobj-timeline-unused-fence
[118.966571] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[120.028168] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[120.032488] [008/133] (900s left) gem_mmap_wc (write-read)
[120.094555] Subtest write-read: SKIP (0.000s)
[120.154819] [009/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[120.244568] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[127.126201] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.882s)
[127.280779] [010/133] (893s left) kms_hdmi_inject (inject-4k)
[127.626143] Starting subtest: inject-4k
[127.937387] Subtest inject-4k: SUCCESS (0.312s)
[128.523628] [011/133] (891s left) gem_mmap_gtt (basic-short)
[128.575268] Subtest basic-short: SKIP (0.000s)
[128.624442] [012/133] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[128.710069] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[128.711719] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[128.814535] [013/133] (891s left) gem_render_linear_blits (basic)
[128.858907] Starting subtest: basic
[128.882033] Subtest basic: SUCCESS (0.023s)
[128.959263] [014/133] (891s left) gem_pxp (verify-pxp-stale-buf-execution)
[129.090092] Starting subtest: verify-pxp-stale-buf-execution
[130.155357] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[130.309922] [015/133] (890s left) sysfs_timeslice_duration (idempotent)
[130.364930] Starting subtest: idempotent
[130.366218] Starting dynamic subtest: vecs0
[130.367190] Dynamic subtest vecs0: SUCCESS (0.001s)
[130.376816] Starting dynamic subtest: ccs0
[130.377934] Dynamic subtest ccs0: SUCCESS (0.001s)
[130.387573] Starting dynamic subtest: vcs0
[130.388799] Dynamic subtest vcs0: SUCCESS (0.001s)
[130.397084] Starting dynamic subtest: bcs0
[130.398075] Dynamic subtest bcs0: SUCCESS (0.001s)
[130.405524] Starting dynamic subtest: rcs0
[130.406412] Dynamic subtest rcs0: SUCCESS (0.001s)
[130.411992] Starting dynamic subtest: vcs1
[130.412903] Dynamic subtest vcs1: SUCCESS (0.001s)
[130.413790] Subtest idempotent: SUCCESS (0.009s)
[130.498101] [016/133] (890s left) i915_query (query-topology-kernel-writes)
[130.555580] Starting subtest: query-topology-kernel-writes
[130.556575] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[130.656672] [017/133] (889s left) gem_exec_balancer (bonded-false-hang)
[130.903357] Starting subtest: bonded-false-hang
[130.905959] Subtest bonded-false-hang: SKIP (0.000s)
[131.020226] [018/133] (889s left) i915_pm_rpm (gem-pread)
[133.053897] Starting subtest: gem-pread
[134.793098] Subtest gem-pread: SUCCESS (1.739s)
[134.884335] [019/133] (885s left) gem_exec_params (invalid-fence-in)
[134.951629] Starting subtest: invalid-fence-in
[134.952602] Subtest invalid-fence-in: SUCCESS (0.000s)
[135.064625] [020/133] (885s left) kms_chamelium_color (ctm-0-25)
[135.151873] Subtest ctm-0-25: SKIP (0.000s)
[135.189534] [021/133] (885s left) kms_chamelium_hpd (dp-hpd-storm)
[135.568958] Subtest dp-hpd-storm: SKIP (0.000s)
[136.354981] [022/133] (884s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[136.405161] Starting subtest: etime-single-wait-for-submit-submitted
[136.508813] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[136.599374] [023/133] (884s left) gem_tiled_blits (interruptible)
[136.661753] Subtest interruptible: SKIP (0.000s)
[136.732344] [024/133] (884s left) perf (create-destroy-userspace-config)
[136.848937] Starting subtest: create-destroy-userspace-config
[136.867400] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[136.901438] [025/133] (883s left) kms_async_flips (async-flip-dpms)
[136.988789] Starting subtest: async-flip-dpms
[137.369035] Starting dynamic subtest: pipe-A-eDP-1
[141.235648] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.867s)
[141.600615] Starting dynamic subtest: pipe-B-eDP-1
[144.424932] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.830s)
[144.811312] Starting dynamic subtest: pipe-C-eDP-1
[147.631403] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.827s)
[148.012837] Starting dynamic subtest: pipe-D-eDP-1
[150.826327] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.819s)
[150.827147] Subtest async-flip-dpms: SUCCESS (13.839s)
[151.991079] [026/133] (868s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[152.097899] Starting subtest: cursorA-vs-flipA-atomic-transitions
[163.281470] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.183s)
[164.082857] [027/133] (856s left) kms_getfb (getfb2-handle-not-fb)
[164.180252] Starting subtest: getfb2-handle-not-fb
[164.181060] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[164.311624] [028/133] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[164.401362] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[168.405796] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.005s)
[169.600171] [029/133] (851s left) prime_busy (after-wait)
[169.648260] Starting subtest: after-wait
[169.651827] Starting dynamic subtest: rcs0
[169.699949] Dynamic subtest rcs0: SUCCESS (0.048s)
[169.708811] Starting dynamic subtest: bcs0
[169.755568] Dynamic subtest bcs0: SUCCESS (0.055s)
[169.763265] Starting dynamic subtest: vcs0
[169.795502] Dynamic subtest vcs0: SUCCESS (0.039s)
[169.801747] Starting dynamic subtest: vcs1
[169.835494] Dynamic subtest vcs1: SUCCESS (0.039s)
[169.841940] Starting dynamic subtest: vecs0
[169.875981] Dynamic subtest vecs0: SUCCESS (0.040s)
[169.882612] Starting dynamic subtest: ccs0
[169.915661] Dynamic subtest ccs0: SUCCESS (0.039s)
[170.025070] Subtest after-wait: SUCCESS (0.374s)
[170.115997] [030/133] (850s left) kms_flip (2x-flip-vs-dpms)
[170.195407] Starting subtest: 2x-flip-vs-dpms
[170.205242] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[170.292108] [031/133] (850s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[170.383285] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[170.384086] Starting dynamic subtest: pipe-A-default-mode
[171.515892] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[171.517622] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.133s)
[171.701371] [032/133] (849s left) perf (blocking-parameterized)
[171.797430] Starting subtest: blocking-parameterized
[191.816425] Subtest blocking-parameterized: SUCCESS (20.016s)
[191.856253] [033/133] (829s left) gem_spin_batch (spin-all)
[191.926168] Starting subtest: spin-all
[191.952537] Subtest spin-all: SUCCESS (0.027s)
[194.002384] [034/133] (827s left) kms_psr (psr2-sprite-mmap-cpu)
[194.105364] Starting subtest: psr2-sprite-mmap-cpu
[194.106258] Starting dynamic subtest: eDP-1
[195.847049] Dynamic subtest eDP-1: SUCCESS (1.741s)
[195.847946] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.743s)
[196.700410] [035/133] (824s left) kms_color (ctm-signed)
[196.792048] Starting subtest: ctm-signed
[196.792865] Starting dynamic subtest: pipe-A-eDP-1
[198.930610] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s)
[198.936779] Starting dynamic subtest: pipe-B-eDP-1
[201.719902] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.789s)
[201.726265] Starting dynamic subtest: pipe-C-eDP-1
[204.367596] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.646s)
[204.374152] Starting dynamic subtest: pipe-D-eDP-1
[207.076356] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[207.077366] Subtest ctm-signed: SUCCESS (10.284s)
[207.885056] [036/133] (813s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[207.995853] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[207.997541] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[208.073881] [037/133] (813s left) gem_exec_schedule (u-submit-late-slice)
[208.129570] Starting subtest: u-submit-late-slice
[208.130475] Starting dynamic subtest: rcs0
[208.166126] Dynamic subtest rcs0: SUCCESS (0.036s)
[208.174928] Starting dynamic subtest: bcs0
[208.193378] Dynamic subtest bcs0: SUCCESS (0.027s)
[208.201525] Starting dynamic subtest: vcs0
[208.223719] Dynamic subtest vcs0: SUCCESS (0.029s)
[208.230239] Starting dynamic subtest: vcs1
[208.251482] Dynamic subtest vcs1: SUCCESS (0.027s)
[208.257967] Starting dynamic subtest: vecs0
[208.279563] Dynamic subtest vecs0: SUCCESS (0.027s)
[208.287383] Starting dynamic subtest: ccs0
[208.310626] Dynamic subtest ccs0: SUCCESS (0.030s)
[208.311502] Subtest u-submit-late-slice: SUCCESS (0.182s)
[210.000941] [038/133] (811s left) gem_eio (in-flight-external)
[210.237032] Starting subtest: in-flight-external
[212.043189] Subtest in-flight-external: SUCCESS (1.806s)
[212.203451] [039/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[212.294591] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[212.296435] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[212.411863] [040/133] (808s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[212.529498] Starting subtest: x-tiled-32bpp-rotate-0
[213.896898] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.368s)
[214.060133] [041/133] (807s left) i915_hangman (engine-engine-error)
[214.145725] Starting subtest: engine-engine-error
[214.146734] Starting dynamic subtest: rcs0
[215.798865] Dynamic subtest rcs0: SUCCESS (1.649s)
[215.808730] Starting dynamic subtest: bcs0
[217.910989] Dynamic subtest bcs0: SUCCESS (2.109s)
[217.919635] Starting dynamic subtest: vcs0
[219.894425] Dynamic subtest vcs0: SUCCESS (1.981s)
[219.906168] Starting dynamic subtest: vcs1
[221.878805] Dynamic subtest vcs1: SUCCESS (1.981s)
[221.888484] Starting dynamic subtest: vecs0
[223.862784] Dynamic subtest vecs0: SUCCESS (1.981s)
[223.872626] Starting dynamic subtest: ccs0
[225.846688] Dynamic subtest ccs0: SUCCESS (1.981s)
[225.848337] Subtest engine-engine-error: SUCCESS (11.699s)
[225.931908] [042/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[226.039853] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[226.041591] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[226.151420] [043/133] (795s left) gem_mmap_gtt (isolation)
[226.218057] Subtest isolation: SKIP (0.000s)
[226.289148] [044/133] (795s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[226.371994] Starting subtest: primary-yf-tiled-reflect-x-180
[226.432073] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[226.539412] [045/133] (794s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[226.638973] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[226.640700] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[226.718763] [046/133] (794s left) kms_flip (wf_vblank-ts-check-interruptible)
[226.813074] Starting subtest: wf_vblank-ts-check-interruptible
[226.814277] Starting dynamic subtest: A-eDP1
[235.691366] Dynamic subtest A-eDP1: SUCCESS (8.877s)
[235.701137] Starting dynamic subtest: B-eDP1
[244.588871] Dynamic subtest B-eDP1: SUCCESS (8.896s)
[244.599088] Starting dynamic subtest: C-eDP1
[253.484255] Dynamic subtest C-eDP1: SUCCESS (8.893s)
[253.492144] Starting dynamic subtest: D-eDP1
[262.369688] Dynamic subtest D-eDP1: SUCCESS (8.884s)
[262.372451] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.559s)
[263.569258] [047/133] (758s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[263.660153] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[263.661124] Starting dynamic subtest: pipe-A
[263.677148] Dynamic subtest pipe-A: SKIP (0.016s)
[263.684116] Starting dynamic subtest: pipe-B
[263.704359] Dynamic subtest pipe-B: SKIP (0.028s)
[263.711271] Starting dynamic subtest: pipe-C
[263.732545] Dynamic subtest pipe-C: SKIP (0.027s)
[263.739161] Starting dynamic subtest: pipe-D
[263.760723] Dynamic subtest pipe-D: SKIP (0.027s)
[263.762396] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.100s)
[263.870575] [048/133] (757s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[263.958310] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[263.959135] Starting dynamic subtest: pipe-A-eDP-1
[263.967554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.974438] Starting dynamic subtest: pipe-B-eDP-1
[263.982738] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.989688] Starting dynamic subtest: pipe-C-eDP-1
[263.998547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.005905] Starting dynamic subtest: pipe-D-eDP-1
[264.014327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.015956] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[266.177939] [049/133] (755s left) perf_pmu (busy-idle-check-all)
[266.213484] Starting subtest: busy-idle-check-all
[266.214305] Starting dynamic subtest: rcs0
[266.866067] Dynamic subtest rcs0: SUCCESS (0.652s)
[266.876878] Starting dynamic subtest: bcs0
[267.518117] Dynamic subtest bcs0: SUCCESS (0.650s)
[267.529386] Starting dynamic subtest: vcs0
[268.888567] Dynamic subtest vcs0: SUCCESS (1.366s)
[268.898539] Starting dynamic subtest: vcs1
[270.936592] Dynamic subtest vcs1: SUCCESS (2.045s)
[270.946574] Starting dynamic subtest: vecs0
[272.920212] Dynamic subtest vecs0: SUCCESS (1.981s)
[272.930234] Starting dynamic subtest: ccs0
[273.572926] Dynamic subtest ccs0: SUCCESS (0.653s)
[273.574236] Subtest busy-idle-check-all: SUCCESS (7.360s)
[273.711307] [050/133] (747s left) gem_softpin (overlap)
[273.785822] Starting subtest: overlap
[274.708241] Subtest overlap: SUCCESS (0.920s)
[274.833223] [051/133] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[274.942214] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[274.944010] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[275.075143] [052/133] (746s left) gem_mmap_gtt (basic-small-copy-odd)
[275.135767] Subtest basic-small-copy-odd: SKIP (0.000s)
[275.199884] [053/133] (746s left) kms_pipe_crc_basic (read-crc)
[275.288354] Starting subtest: read-crc
[275.289245] Starting dynamic subtest: pipe-A-eDP-1
[275.997547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[276.004611] Starting dynamic subtest: pipe-B-eDP-1
[277.413056] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[277.422056] Starting dynamic subtest: pipe-C-eDP-1
[278.778722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[278.785665] Starting dynamic subtest: pipe-D-eDP-1
[280.060418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[280.061204] Subtest read-crc: SUCCESS (4.773s)
[280.885796] [054/133] (740s left) kms_big_fb (linear-16bpp-rotate-90)
[281.002704] Starting subtest: linear-16bpp-rotate-90
[281.024379] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[281.167064] [055/133] (740s left) kms_cursor_edge_walk (128x128-top-bottom)
[281.266457] Starting subtest: 128x128-top-bottom
[281.267379] Starting dynamic subtest: pipe-A-eDP-1
[284.700224] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s)
[284.708848] Starting dynamic subtest: pipe-D-eDP-1
[287.898725] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.197s)
[287.899683] Subtest 128x128-top-bottom: SUCCESS (6.634s)
[288.773040] [056/133] (733s left) kms_setmode (invalid-clone-exclusive-crtc)
[288.834771] Starting subtest: invalid-clone-exclusive-crtc
[288.837619] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[288.933452] [057/133] (733s left) kms_psr (psr-primary-mmap-gtt)
[289.028278] Starting subtest: psr-primary-mmap-gtt
[289.029178] Starting dynamic subtest: eDP-1
[290.434752] Dynamic subtest eDP-1: SKIP (1.403s)
[290.436878] Subtest psr-primary-mmap-gtt: SKIP (1.405s)
[290.624241] [058/133] (731s left) kms_fb_coherency (memset-crc)
[290.712414] Starting subtest: memset-crc
[290.713391] Starting dynamic subtest: mmap-offset-wc
[291.076099] Dynamic subtest mmap-offset-wc: SUCCESS (0.364s)
[291.363697] Starting dynamic subtest: mmap-offset-uc
[297.503940] Dynamic subtest mmap-offset-uc: SUCCESS (6.147s)
[297.793990] Subtest memset-crc: SUCCESS (7.082s)
[298.661965] [059/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[298.770422] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[302.799311] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.029s)
[303.991757] [060/133] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[304.101036] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[310.700715] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.598s)
[310.856138] [061/133] (711s left) kms_pm_rpm (modeset-stress-extra-wait)
[313.072265] Starting subtest: modeset-stress-extra-wait
[367.356793] Subtest modeset-stress-extra-wait: SUCCESS (54.283s)
[367.463130] [062/133] (654s left) kms_frontbuffer_tracking (fbc-2p-rte)
[367.566905] Starting subtest: fbc-2p-rte
[367.568860] Subtest fbc-2p-rte: SKIP (0.000s)
[367.681956] [063/133] (654s left) api_intel_bb (reset-flags)
[367.740505] Starting subtest: reset-flags
[367.747090] Subtest reset-flags: SUCCESS (0.007s)
[367.894927] [064/133] (654s left) gem_ctx_persistence (legacy-engines-mixed-process)
[367.955795] Starting subtest: legacy-engines-mixed-process
[367.957048] Starting dynamic subtest: render
[369.891396] Dynamic subtest render: SUCCESS (1.935s)
[369.901375] Starting dynamic subtest: bsd1
[371.884511] Dynamic subtest bsd1: SUCCESS (1.990s)
[371.895312] Starting dynamic subtest: bsd2
[373.874710] Dynamic subtest bsd2: SUCCESS (1.987s)
[373.886027] Starting dynamic subtest: blt
[375.926811] Dynamic subtest blt: SUCCESS (2.050s)
[375.938309] Starting dynamic subtest: vebox
[377.919772] Dynamic subtest vebox: SUCCESS (1.991s)
[377.921149] Subtest legacy-engines-mixed-process: SUCCESS (9.965s)
[378.005272] [065/133] (644s left) gem_mmap (bad-offset)
[378.064281] Subtest bad-offset: SKIP (0.000s)
[378.130579] [066/133] (644s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[378.244019] Starting subtest: fbc-1p-pri-indfb-multidraw
[391.429229] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.186s)
[392.797825] [067/133] (629s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[392.892764] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[392.894428] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[392.971044] [068/133] (629s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[393.072613] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[393.098729] Starting dynamic subtest: pipe-A-plane-0
[393.100727] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[393.109603] Starting dynamic subtest: pipe-A-plane-3
[393.111446] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[393.118726] Starting dynamic subtest: pipe-A-plane-5
[393.120533] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[394.213202] Starting dynamic subtest: pipe-B-plane-0
[394.214816] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[394.221741] Starting dynamic subtest: pipe-B-plane-3
[394.223467] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[394.230283] Starting dynamic subtest: pipe-B-plane-5
[394.231883] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[394.524206] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.452s)
[395.357435] [069/133] (626s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[395.459171] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[395.459966] Starting dynamic subtest: pipe-A-eDP-1
[395.480534] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[395.488059] Starting dynamic subtest: pipe-B-eDP-1
[395.509379] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[395.516778] Starting dynamic subtest: pipe-C-eDP-1
[395.538596] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[395.546560] Starting dynamic subtest: pipe-D-eDP-1
[395.568667] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[395.570410] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[397.638459] [070/133] (624s left) gem_exec_schedule (pi-userfault)
[397.808237] Starting subtest: pi-userfault
[397.809172] Starting dynamic subtest: rcs0
[397.818102] Dynamic subtest rcs0: SUCCESS (0.010s)
[397.825569] Starting dynamic subtest: bcs0
[397.827864] Dynamic subtest bcs0: SUCCESS (0.008s)
[397.835479] Starting dynamic subtest: vcs0
[397.836301] Dynamic subtest vcs0: SUCCESS (0.008s)
[397.843484] Starting dynamic subtest: vcs1
[397.844306] Dynamic subtest vcs1: SUCCESS (0.008s)
[397.851311] Starting dynamic subtest: vecs0
[397.854369] Dynamic subtest vecs0: SUCCESS (0.010s)
[397.861365] Starting dynamic subtest: ccs0
[397.863244] Dynamic subtest ccs0: SUCCESS (0.008s)
[397.864069] Subtest pi-userfault: SUCCESS (0.056s)
[398.050058] [071/133] (624s left) gen7_exec_parse (load-register-reg)
[398.105663] Subtest load-register-reg: SKIP (0.000s)
[398.173271] [072/133] (624s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[398.281726] Starting subtest: 4-tiled-64bpp-rotate-0
[399.693601] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.412s)
[399.889835] [073/133] (622s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[399.992297] Starting subtest: fbcpsr-modesetfrombusy
[406.179938] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.188s)
[406.337370] [074/133] (616s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[406.433983] Starting subtest: psr-rgb101010-draw-mmap-wc
[413.341524] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.908s)
[413.448957] [075/133] (609s left) kms_plane_multiple (tiling-yf)
[413.532531] Starting subtest: tiling-yf
[413.534389] Subtest tiling-yf: SKIP (0.000s)
[413.626127] [076/133] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[413.710857] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[413.712688] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.808807] [077/133] (608s left) perf (oa-exponents)
[413.891442] Starting subtest: oa-exponents
[413.892420] Starting dynamic subtest: 0-rcs0
[415.669327] Dynamic subtest 0-rcs0: SUCCESS (1.776s)
[415.676948] Starting dynamic subtest: 1-vcs0
[417.467653] Dynamic subtest 1-vcs0: SUCCESS (1.797s)
[417.468770] Subtest oa-exponents: SUCCESS (3.575s)
[417.508230] [078/133] (605s left) gem_exec_fence (parallel)
[417.694071] Starting subtest: parallel
[417.695541] Starting dynamic subtest: rcs0
[419.847043] Dynamic subtest rcs0: SUCCESS (2.153s)
[419.855465] Starting dynamic subtest: bcs0
[421.995952] Dynamic subtest bcs0: SUCCESS (2.148s)
[422.005167] Starting dynamic subtest: vcs0
[424.149922] Dynamic subtest vcs0: SUCCESS (2.153s)
[424.158874] Starting dynamic subtest: vcs1
[426.306502] Dynamic subtest vcs1: SUCCESS (2.156s)
[426.316612] Starting dynamic subtest: vecs0
[428.458910] Dynamic subtest vecs0: SUCCESS (2.150s)
[428.467474] Starting dynamic subtest: ccs0
[430.610663] Dynamic subtest ccs0: SUCCESS (2.150s)
[430.611584] Subtest parallel: SUCCESS (12.917s)
[431.228850] [079/133] (591s left) gem_exec_schedule (u-lateslice)
[431.301647] Starting subtest: u-lateslice
[431.302580] Starting dynamic subtest: rcs0
[431.332816] Dynamic subtest rcs0: SUCCESS (0.032s)
[431.341673] Starting dynamic subtest: bcs0
[431.362595] Dynamic subtest bcs0: SUCCESS (0.029s)
[431.376657] Starting dynamic subtest: vcs0
[431.392051] Dynamic subtest vcs0: SUCCESS (0.028s)
[431.401813] Starting dynamic subtest: vcs1
[431.417566] Dynamic subtest vcs1: SUCCESS (0.025s)
[431.424470] Starting dynamic subtest: vecs0
[431.439964] Dynamic subtest vecs0: SUCCESS (0.022s)
[431.449047] Starting dynamic subtest: ccs0
[431.466992] Dynamic subtest ccs0: SUCCESS (0.026s)
[431.468070] Subtest u-lateslice: SUCCESS (0.167s)
[432.952051] [080/133] (589s left) kms_universal_plane (cursor-fb-leak)
[433.065077] Starting subtest: cursor-fb-leak
[433.065888] Starting dynamic subtest: pipe-A-eDP-1
[433.402855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[433.413844] Starting dynamic subtest: pipe-B-eDP-1
[434.742954] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[434.753879] Starting dynamic subtest: pipe-C-eDP-1
[436.121148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[436.130382] Starting dynamic subtest: pipe-D-eDP-1
[437.440923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[437.442544] Subtest cursor-fb-leak: SUCCESS (4.376s)
[438.653710] [081/133] (584s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[438.708436] Starting subtest: multi-wait-all-for-submit-available-submitted
[438.709428] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[438.840046] [082/133] (583s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[438.895907] Subtest untiled-to-tiled: SKIP (0.000s)
[438.969060] [083/133] (583s left) gem_exec_alignment (pi)
[439.040861] Starting subtest: pi
[488.645204] Subtest pi: SUCCESS (49.601s)
[489.762009] [084/133] (533s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[489.903394] Starting subtest: y-tiled-16bpp-rotate-90
[489.905171] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[490.027511] [085/133] (532s left) syncobj_eventfd (binary-wait-signaled)
[490.091552] Starting subtest: binary-wait-signaled
[490.092510] Subtest binary-wait-signaled: SUCCESS (0.000s)
[490.232937] [086/133] (532s left) kms_flip (2x-flip-vs-fences-interruptible)
[490.324440] Starting subtest: 2x-flip-vs-fences-interruptible
[490.325989] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[490.457374] [087/133] (532s left) syncobj_wait (multi-wait-all-signaled)
[490.514866] Starting subtest: multi-wait-all-signaled
[490.515761] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[490.630802] [088/133] (532s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[490.733298] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[490.735057] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[490.853151] [089/133] (532s left) i915_drm_fdinfo (memory-info-resident)
[490.899684] Starting subtest: memory-info-resident
[490.900829] Starting dynamic subtest: smem0
[493.385986] Dynamic subtest smem0: SUCCESS (2.487s)
[493.387256] Subtest memory-info-resident: SUCCESS (2.488s)
[493.477665] [090/133] (529s left) kms_psr (fbc-pr-suspend)
[493.576579] Starting subtest: fbc-pr-suspend
[493.578303] Subtest fbc-pr-suspend: SKIP (0.000s)
[493.656798] [091/133] (529s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[493.745713] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[494.438542] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[494.616352] [092/133] (528s left) gem_mmap_wc (write-gtt-read-wc)
[494.672169] Subtest write-gtt-read-wc: SKIP (0.000s)
[494.735466] [093/133] (528s left) gem_userptr_blits (stress-purge)
[494.804499] Starting subtest: stress-purge
[500.176088] Subtest stress-purge: SUCCESS (5.371s)
[500.330303] [094/133] (522s left) gem_fenced_exec_thrash (2-spare-fences)
[500.433430] Subtest 2-spare-fences: SKIP (0.000s)
[500.510559] [095/133] (522s left) kms_content_protection (legacy-hdcp14)
[500.672078] Starting subtest: legacy-hdcp14
[500.674060] Subtest legacy-hdcp14: SKIP (0.000s)
[500.820067] [096/133] (522s left) gem_exec_params (rel-constants-invalid)
[500.883456] Starting subtest: rel-constants-invalid
[500.884663] Subtest rel-constants-invalid: SUCCESS (0.000s)
[500.995963] [097/133] (522s left) kms_vrr (flipline)
[501.087093] Starting subtest: flipline
[501.089593] Subtest flipline: SKIP (0.000s)
[501.165168] [098/133] (522s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[501.252103] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[501.252908] Starting dynamic subtest: pipe-A-eDP-1
[501.260292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[501.268095] Starting dynamic subtest: pipe-B-eDP-1
[501.275436] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[501.283189] Starting dynamic subtest: pipe-C-eDP-1
[501.290715] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[501.298404] Starting dynamic subtest: pipe-D-eDP-1
[501.305391] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[501.306242] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[503.441760] [099/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[503.541189] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[503.542861] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[503.643680] [100/133] (519s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[503.687819] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[503.688741] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[503.807321] [101/133] (519s left) kms_flip (bo-too-big-interruptible)
[503.896741] Starting subtest: bo-too-big-interruptible
[503.899423] Starting dynamic subtest: A-eDP1
[505.169594] Dynamic subtest A-eDP1: SUCCESS (1.270s)
[505.179482] Starting dynamic subtest: B-eDP1
[506.461553] Dynamic subtest B-eDP1: SUCCESS (1.291s)
[506.471402] Starting dynamic subtest: C-eDP1
[507.769051] Dynamic subtest C-eDP1: SUCCESS (1.306s)
[507.779627] Starting dynamic subtest: D-eDP1
[509.066916] Dynamic subtest D-eDP1: SUCCESS (1.297s)
[509.072191] Subtest bo-too-big-interruptible: SUCCESS (5.175s)
[510.258212] [102/133] (513s left) gem_mmap_offset (ptrace)
[510.310033] Starting subtest: ptrace
[510.312237] Starting dynamic subtest: smem0-wb
[510.332241] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[510.341917] Starting dynamic subtest: smem0-wc
[510.353529] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[510.360904] Starting dynamic subtest: smem0-uc
[510.379079] Dynamic subtest smem0-uc: SUCCESS (0.025s)
[510.381085] Subtest ptrace: SUCCESS (0.072s)
[510.539269] [103/133] (512s left) gem_exec_flush (basic-batch-kernel-default-uc)
[510.595241] Starting subtest: basic-batch-kernel-default-uc
[517.902506] Subtest basic-batch-kernel-default-uc: SUCCESS (7.306s)
[518.097173] [104/133] (505s left) kms_plane (plane-panning-bottom-right)
[518.189454] Starting subtest: plane-panning-bottom-right
[518.190405] Starting dynamic subtest: pipe-A
[519.889141] Dynamic subtest pipe-A: SUCCESS (1.699s)
[519.896609] Starting dynamic subtest: pipe-B
[522.257756] Dynamic subtest pipe-B: SUCCESS (2.367s)
[522.258593] Subtest plane-panning-bottom-right: SUCCESS (4.069s)
[523.061728] [105/133] (500s left) kms_cursor_legacy (forked-move)
[523.180758] Starting subtest: forked-move
[523.181631] Starting dynamic subtest: pipe-A
[528.643414] Dynamic subtest pipe-A: SUCCESS (5.459s)
[528.653960] Starting dynamic subtest: pipe-B
[534.116774] Dynamic subtest pipe-B: SUCCESS (5.470s)
[534.127963] Starting dynamic subtest: pipe-C
[539.576148] Dynamic subtest pipe-C: SUCCESS (5.457s)
[539.586274] Starting dynamic subtest: pipe-D
[545.049830] Dynamic subtest pipe-D: SUCCESS (5.471s)
[545.059539] Starting dynamic subtest: all-pipes
[550.554321] Dynamic subtest all-pipes: SUCCESS (5.501s)
[550.555567] Subtest forked-move: SUCCESS (27.369s)
[550.700180] [106/133] (472s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[550.802330] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[550.804014] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[550.884638] [107/133] (472s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[550.975391] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[550.976293] Starting dynamic subtest: pipe-A-eDP-1
[567.819853] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.685s)
[567.828765] Starting dynamic subtest: pipe-B-eDP-1
[585.825631] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.852s)
[585.836729] Starting dynamic subtest: pipe-C-eDP-1
[603.769723] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[603.782092] Starting dynamic subtest: pipe-D-eDP-1
[621.785411] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.745s)
[621.786292] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (11.043s)
[628.996816] [108/133] (400s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[629.095715] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[629.107929] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[629.204520] [109/133] (400s left) kms_invalid_mode (zero-clock)
[629.298634] Starting subtest: zero-clock
[629.299461] Starting dynamic subtest: pipe-A-eDP-1
[629.585497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[629.594346] Starting dynamic subtest: pipe-B-eDP-1
[629.595330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[629.603567] Starting dynamic subtest: pipe-C-eDP-1
[629.604553] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[629.613142] Starting dynamic subtest: pipe-D-eDP-1
[629.614035] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[629.614965] Subtest zero-clock: SUCCESS (0.291s)
[630.410161] [110/133] (399s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[630.529903] Starting subtest: 2x-flip-vs-cursor-atomic
[630.531889] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[630.706540] [111/133] (399s left) gem_mmap_gtt (basic-copy)
[630.755930] Subtest basic-copy: SKIP (0.000s)
[630.819561] [112/133] (398s left) i915_pm_rps (thresholds-idle-park)
[630.881909] Starting subtest: thresholds-idle-park
[630.884012] Subtest thresholds-idle-park: SKIP (0.001s)
[630.998851] [113/133] (398s left) gen3_render_tiledy_blits
[631.129422] [114/133] (398s left) gem_reg_read (timestamp-monotonic)
[631.182340] Starting subtest: timestamp-monotonic
[635.673666] Subtest timestamp-monotonic: SUCCESS (4.429s)
[635.753173] [115/133] (394s left) dmabuf_sync_file (export-wait-after-attach)
[635.790065] Starting subtest: export-wait-after-attach
[635.790944] Subtest export-wait-after-attach: SUCCESS (0.001s)
[635.858342] [116/133] (394s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[635.956024] Starting subtest: crc-primary-basic-y-tiled-ccs
[635.957130] Starting dynamic subtest: pipe-A-eDP-1
[635.965984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[635.975417] Starting dynamic subtest: pipe-B-eDP-1
[635.983598] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[635.992751] Starting dynamic subtest: pipe-C-eDP-1
[636.000717] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[636.008922] Starting dynamic subtest: pipe-D-eDP-1
[636.017009] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[636.018614] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[638.192399] [117/133] (391s left) kms_atomic (plane-primary-legacy)
[638.290425] Starting subtest: plane-primary-legacy
[638.291315] Starting dynamic subtest: pipe-A-eDP-1
[638.745489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[638.746471] Subtest plane-primary-legacy: SUCCESS (0.452s)
[639.602620] [118/133] (390s left) syncobj_wait (invalid-signal-one-illegal-handle)
[639.657511] Starting subtest: invalid-signal-one-illegal-handle
[639.658525] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[639.769025] [119/133] (390s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[639.860258] Starting subtest: fbc-psr2-sprite-plane-onoff
[639.861085] Starting dynamic subtest: eDP-1
[639.862775] Dynamic subtest eDP-1: SKIP (0.000s)
[639.864315] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[639.939398] [120/133] (390s left) kms_cursor_crc (cursor-random-128x42)
[640.158829] Starting subtest: cursor-random-128x42
[640.197287] Subtest cursor-random-128x42: SKIP (0.036s)
[640.399321] [121/133] (389s left) prime_mmap (test_errors)
[640.453977] Starting subtest: test_errors
[640.454892] Starting dynamic subtest: test_errors-smem
[640.547515] Dynamic subtest test_errors-smem: SUCCESS (0.093s)
[640.549131] Subtest test_errors: SUCCESS (0.094s)
[640.647013] [122/133] (389s left) kms_psr (fbc-pr-dpms)
[640.729593] Starting subtest: fbc-pr-dpms
[640.731366] Subtest fbc-pr-dpms: SKIP (0.000s)
[640.809285] [123/133] (389s left) kms_cursor_crc (cursor-onscreen-512x512)
[641.075317] Starting subtest: cursor-onscreen-512x512
[641.076990] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[641.273047] [124/133] (388s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[641.380191] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[641.390790] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[641.477908] [125/133] (388s left) kms_psr (pr-primary-mmap-cpu)
[641.583568] Starting subtest: pr-primary-mmap-cpu
[641.585448] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[641.663061] [126/133] (388s left) gem_ctx_param (invalid-get-engines)
[641.718348] Starting subtest: invalid-get-engines
[641.719190] Subtest invalid-get-engines: SUCCESS (0.001s)
[641.842473] [127/133] (388s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[641.908765] Starting subtest: y-tiled-to-vebox-yf-tiled
[641.910570] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[642.097715] [128/133] (388s left) api_intel_allocator (reserve-simple)
[642.141679] Starting subtest: reserve-simple
[642.143904] Subtest reserve-simple: SUCCESS (0.004s)
[642.293344] [129/133] (388s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[642.346973] Starting subtest: wait-all-for-submit-delayed-submit
[642.452835] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[642.535703] [130/133] (387s left) gem_basic (create-close)
[642.592778] Starting subtest: create-close
[642.594508] Subtest create-close: SUCCESS (0.000s)
[642.720871] [131/133] (387s left) gem_busy (extended)
[642.890418] Starting subtest: extended
[642.891798] Starting dynamic subtest: rcs0
[643.004497] Dynamic subtest rcs0: SUCCESS (0.113s)
[643.017893] Starting dynamic subtest: bcs0
[643.047439] Dynamic subtest bcs0: SUCCESS (0.041s)
[643.058335] Starting dynamic subtest: vcs0
[644.687019] Dynamic subtest vcs0: SUCCESS (1.629s)
[644.699794] Starting dynamic subtest: vcs1
[646.671539] Dynamic subtest vcs1: SUCCESS (1.975s)
[646.682907] Starting dynamic subtest: vecs0
[648.655474] Dynamic subtest vecs0: SUCCESS (1.977s)
[648.666780] Starting dynamic subtest: ccs0
[648.701213] Dynamic subtest ccs0: SUCCESS (0.045s)
[648.702138] Subtest extended: SUCCESS (5.795s)
[648.948716] [132/133] (381s left) kms_pm_dc (dc5-retention-flops)
[650.050470] Starting subtest: dc5-retention-flops
[650.052375] Subtest dc5-retention-flops: SKIP (0.000s)
[650.130586] [133/133] (380s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[650.499448] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[651.304572] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_create
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_hdmi_inject
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_render_linear_blits
results: parsing output: 13/ for test: gem_pxp
results: parsing output: 14/ for test: sysfs_timeslice_duration
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_tiled_blits
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_spin_batch
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: kms_joiner
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gem_softpin
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_setmode
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_fb_coherency
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: gem_mmap
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gen7_exec_parse
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_universal_plane
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_set_tiling_vs_blt
results: parsing output: 82/ for test: gem_exec_alignment
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_fenced_exec_thrash
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gen3_render_tiledy_blits
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_atomic
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: api_intel_allocator
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_basic
results: parsing output: 130/ for test: gem_busy
results: parsing output: 131/ for test: kms_pm_dc
results: parsing output: 132/ for test: kms_chamelium_edid
Done.