[54.050280] Initializing watchdogs
[54.050334]   /dev/watchdog0
[54.067136] [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]
[54.071289] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.073390] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.076711] [001/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[54.184100] Starting subtest: plane-downscale-factor-0-5-with-rotation
[54.186519] Starting dynamic subtest: pipe-A
[54.195827] Dynamic subtest pipe-A: SKIP (0.005s)
[54.203259] Starting dynamic subtest: pipe-B
[54.215299] Dynamic subtest pipe-B: SKIP (0.019s)
[54.222997] Starting dynamic subtest: pipe-C
[54.237832] Dynamic subtest pipe-C: SKIP (0.020s)
[54.245095] Starting dynamic subtest: pipe-D
[54.253996] Dynamic subtest pipe-D: SKIP (0.020s)
[54.258317] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.064s)
[54.349304] [002/131] (960s left) gem_exec_reloc (basic-gtt-cpu)
[54.410963] Subtest basic-gtt-cpu: SKIP (0.000s)
[54.493470] [003/131] (960s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[54.602992] Starting subtest: cursorA-vs-flipA-toggle
[65.809881] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.167s)
[66.645044] [004/131] (948s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[66.710167] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[66.816594] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[66.888754] [005/131] (947s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[66.973874] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[66.976350] Starting dynamic subtest: pipe-A-eDP-1
[66.997359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[67.006614] Starting dynamic subtest: pipe-B-eDP-1
[67.026273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[67.033430] Starting dynamic subtest: pipe-C-eDP-1
[67.052499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[67.059187] Starting dynamic subtest: pipe-D-eDP-1
[67.079955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[67.082347] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.003s)
[69.197337] [006/131] (945s left) gem_ctx_shared (q-smoketest)
[69.269677] Starting subtest: Q-smoketest
[69.272176] Starting dynamic subtest: rcs0
[74.817884] Dynamic subtest rcs0: SUCCESS (5.501s)
[74.825385] Starting dynamic subtest: bcs0
[80.335681] Dynamic subtest bcs0: SUCCESS (5.514s)
[80.342336] Starting dynamic subtest: vcs0
[85.812287] Dynamic subtest vcs0: SUCCESS (5.471s)
[85.819251] Starting dynamic subtest: vcs1
[91.280966] Dynamic subtest vcs1: SUCCESS (5.472s)
[91.287908] Starting dynamic subtest: vecs0
[96.767934] Dynamic subtest vecs0: SUCCESS (5.486s)
[96.775866] Starting dynamic subtest: ccs0
[102.268265] Dynamic subtest ccs0: SUCCESS (5.498s)
[102.270430] Subtest Q-smoketest: SUCCESS (32.944s)
[102.412581] [007/131] (912s left) kms_addfb_basic (too-high)
[102.514978] Starting subtest: too-high
[102.517428] Subtest too-high: SUCCESS (0.000s)
[102.600459] [008/131] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[102.703157] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[102.707829] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.813689] [009/131] (912s left) prime_busy (before-wait)
[102.873839] Starting subtest: before-wait
[102.878726] Starting dynamic subtest: rcs0
[102.918129] Dynamic subtest rcs0: SUCCESS (0.041s)
[102.924809] Starting dynamic subtest: bcs0
[102.991083] Dynamic subtest bcs0: SUCCESS (0.072s)
[102.999873] Starting dynamic subtest: vcs0
[103.033758] Dynamic subtest vcs0: SUCCESS (0.043s)
[103.040421] Starting dynamic subtest: vcs1
[103.075239] Dynamic subtest vcs1: SUCCESS (0.041s)
[103.081909] Starting dynamic subtest: vecs0
[103.114508] Dynamic subtest vecs0: SUCCESS (0.039s)
[103.121075] Starting dynamic subtest: ccs0
[103.154519] Dynamic subtest ccs0: SUCCESS (0.039s)
[103.260486] Subtest before-wait: SUCCESS (0.385s)
[103.326206] [010/131] (911s left) drm_read (empty-block)
[103.479769] Starting subtest: empty-block
[104.482188] Subtest empty-block: SUCCESS (1.001s)
[104.642550] [011/131] (910s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[109.652378] Starting subtest: psr2-cursor-plane-move-continuous-sf
[109.654755] Starting dynamic subtest: pipe-A-eDP-1
[120.741399] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.089s)
[120.750131] Starting dynamic subtest: pipe-B-eDP-1
[131.759264] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.017s)
[131.761775] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.109s)
[132.542189] [012/131] (882s left) gem_exec_balancer (full-pulse)
[132.609510] Starting subtest: full-pulse
[137.794812] Subtest full-pulse: SUCCESS (5.185s)
[138.122928] [013/131] (876s left) gem_exec_schedule (preempt-queue)
[138.203943] Subtest preempt-queue: SKIP (0.000s)
[138.486017] [014/131] (876s left) gem_busy (close-race)
[138.556155] Starting subtest: close-race
[161.877595] Subtest close-race: SUCCESS (23.320s)
[162.252167] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[162.256919] [015/131] (852s left) kms_selftest (drm_dp_mst_helper)
[162.328018] Starting subtest: drm_dp_mst_helper
[162.378259] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[162.513233] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.134s)
[162.522085] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[162.612488] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.098s)
[162.620047] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[162.721508] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.110s)
[162.723645] Subtest drm_dp_mst_helper: SUCCESS (0.392s)
[162.874860] [016/131] (852s left) gem_exec_basic (basic)
[162.938509] Starting subtest: basic
[162.940576] Starting dynamic subtest: rcs0-smem
[162.945023] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[162.954795] Starting dynamic subtest: bcs0-smem
[162.956663] Dynamic subtest bcs0-smem: SUCCESS (0.005s)
[162.964428] Starting dynamic subtest: vcs0-smem
[162.966666] Dynamic subtest vcs0-smem: SUCCESS (0.004s)
[162.973600] Starting dynamic subtest: vcs1-smem
[162.975492] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[162.982523] Starting dynamic subtest: vecs0-smem
[162.984448] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[162.991474] Starting dynamic subtest: ccs0-smem
[162.993342] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[162.995245] Subtest basic: SUCCESS (0.027s)
[164.925840] [017/131] (850s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[165.024022] Starting subtest: primary-yf-tiled-reflect-x-270
[165.028637] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[165.094647] [018/131] (850s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[165.159490] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[165.161859] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[165.272733] [019/131] (849s left) kms_psr (psr2-primary-mmap-cpu)
[165.369330] Starting subtest: psr2-primary-mmap-cpu
[165.371700] Starting dynamic subtest: eDP-1
[167.112525] Dynamic subtest eDP-1: SUCCESS (1.742s)
[167.114863] Subtest psr2-primary-mmap-cpu: SUCCESS (1.743s)
[167.984176] [020/131] (847s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[168.088473] Starting subtest: 4-tiled-32bpp-rotate-180
[169.720689] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.634s)
[169.912234] [021/131] (845s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[170.038089] Starting subtest: extended-modeset-hang-newfb-with-reset
[170.040658] Starting dynamic subtest: pipe-A
[183.941739] Dynamic subtest pipe-A: SUCCESS (13.901s)
[183.950534] Starting dynamic subtest: pipe-D
[199.807736] Dynamic subtest pipe-D: SUCCESS (15.866s)
[199.810353] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.770s)
[200.603470] [022/131] (814s left) gem_busy (semaphore)
[200.799679] Subtest semaphore: SKIP (0.000s)
[201.040177] [023/131] (814s left) perf (missing-sample-flags)
[201.170499] Starting subtest: missing-sample-flags
[201.172795] Subtest missing-sample-flags: SUCCESS (0.000s)
[201.212036] [024/131] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[201.311257] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[205.247515] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.940s)
[206.389240] [025/131] (809s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[206.497547] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[207.918201] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.421s)
[208.719321] [026/131] (806s left) kms_color (ctm-0-50)
[208.810232] Starting subtest: ctm-0-50
[208.812674] Starting dynamic subtest: pipe-A-eDP-1
[212.188925] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s)
[212.199254] Starting dynamic subtest: pipe-B-eDP-1
[216.178804] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.989s)
[216.188046] Starting dynamic subtest: pipe-C-eDP-1
[220.100671] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.917s)
[220.110545] Starting dynamic subtest: pipe-D-eDP-1
[224.066292] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.969s)
[224.068631] Subtest ctm-0-50: SUCCESS (15.254s)
[224.920588] [027/131] (790s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[224.986479] Starting subtest: invalid-multi-wait-unsubmitted
[224.988848] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[225.105854] [028/131] (790s left) kms_getfb (getfb-handle-closed)
[225.196259] Starting subtest: getfb-handle-closed
[225.198612] Subtest getfb-handle-closed: SUCCESS (0.000s)
[225.310866] [029/131] (790s left) perf_pmu (render-node-busy)
[225.374668] Starting subtest: render-node-busy
[225.377038] Starting dynamic subtest: rcs0
[225.984853] Dynamic subtest rcs0: SUCCESS (0.609s)
[225.994607] Starting dynamic subtest: bcs0
[226.548572] Dynamic subtest bcs0: SUCCESS (0.562s)
[226.560076] Starting dynamic subtest: vcs0
[227.923973] Dynamic subtest vcs0: SUCCESS (1.372s)
[227.936212] Starting dynamic subtest: vcs1
[229.909047] Dynamic subtest vcs1: SUCCESS (1.983s)
[229.920337] Starting dynamic subtest: vecs0
[231.891499] Dynamic subtest vecs0: SUCCESS (1.982s)
[231.902940] Starting dynamic subtest: ccs0
[232.456578] Dynamic subtest ccs0: SUCCESS (0.565s)
[232.459103] Subtest render-node-busy: SUCCESS (7.082s)
[232.531617] [030/131] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[232.642080] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[232.646657] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.753683] [031/131] (782s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[232.844685] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[232.847056] Starting dynamic subtest: pipe-A-eDP-1
[232.914213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.069s)
[233.202686] Starting dynamic subtest: pipe-B-eDP-1
[234.011110] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.817s)
[234.285812] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.441s)
[235.150634] [032/131] (780s left) kms_addfb_basic (bad-pitch-1024)
[235.213935] Starting subtest: bad-pitch-1024
[235.216689] Subtest bad-pitch-1024: SUCCESS (0.000s)
[235.372240] [033/131] (780s left) prime_mmap (test_aperture_limit)
[235.434893] Starting subtest: test_aperture_limit
[235.437331] Starting dynamic subtest: test_aperture_limit-smem
[235.446539] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[235.451243] Subtest test_aperture_limit: SKIP (0.012s)
[235.515486] [034/131] (780s left) kms_cursor_crc (cursor-random-128x128)
[235.723164] Starting subtest: cursor-random-128x128
[235.728182] Starting dynamic subtest: pipe-A-eDP-1
[239.427219] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.700s)
[239.455211] Starting dynamic subtest: pipe-D-eDP-1
[243.855607] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.408s)
[243.858201] Subtest cursor-random-128x128: SUCCESS (8.132s)
[244.698347] [035/131] (771s left) gem_gpgpu_fill (offset-16x16)
[244.759335] Starting subtest: offset-16x16
[244.765202] Subtest offset-16x16: SUCCESS (0.008s)
[244.904851] [036/131] (770s left) kms_flip (flip-vs-suspend-interruptible)
[245.008230] Starting subtest: flip-vs-suspend-interruptible
[245.010572] Starting dynamic subtest: A-eDP1
[294.311396] Dynamic subtest A-eDP1: SUCCESS (4.588s)
[294.326787] Starting dynamic subtest: B-eDP1
[343.305506] Dynamic subtest B-eDP1: SUCCESS (4.225s)
[343.322371] Starting dynamic subtest: C-eDP1
[392.317809] Dynamic subtest C-eDP1: SUCCESS (4.263s)
[392.329043] Starting dynamic subtest: D-eDP1
[441.294275] Dynamic subtest D-eDP1: SUCCESS (4.305s)
[441.320770] Subtest flip-vs-suspend-interruptible: SUCCESS (17.392s)
[442.447526] [037/131] (573s left) intel_sysfs_debugfs (i915-sysfs-read-all-entries)
[442.499986] Starting subtest: i915-sysfs-read-all-entries
[442.694921] Subtest i915-sysfs-read-all-entries: SUCCESS (0.192s)
[442.848064] [038/131] (573s left) kms_vblank (wait-busy)
[442.941825] Starting subtest: wait-busy
[442.944345] Starting dynamic subtest: pipe-A-eDP-1
[444.847855] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[444.871915] Starting dynamic subtest: pipe-D-eDP-1
[447.448523] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.580s)
[447.451098] Subtest wait-busy: SUCCESS (4.467s)
[448.244382] [039/131] (567s left) kms_pm_rpm (modeset-pc8-residency-stress)
[449.893548] Starting subtest: modeset-pc8-residency-stress
[449.898907] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[450.496919] [040/131] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[450.609495] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[457.043248] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.420s)
[457.159210] [041/131] (558s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[457.225411] Starting subtest: yf-tiled-ccs-to-yf-tiled
[457.230536] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[457.410155] [042/131] (558s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[457.510874] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[457.513610] Starting dynamic subtest: pipe-A
[457.530289] Dynamic subtest pipe-A: SKIP (0.012s)
[457.540684] Starting dynamic subtest: pipe-B
[457.553068] Dynamic subtest pipe-B: SKIP (0.023s)
[457.562927] Starting dynamic subtest: pipe-C
[457.578866] Dynamic subtest pipe-C: SKIP (0.025s)
[457.588452] Starting dynamic subtest: pipe-D
[457.601418] Dynamic subtest pipe-D: SKIP (0.024s)
[457.605814] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.086s)
[457.691097] [043/131] (558s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[457.798280] Starting subtest: x-tiled-32bpp-rotate-0
[459.400229] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.600s)
[459.727587] [044/131] (556s left) gem_exec_fence (syncobj-timeline-signal)
[460.284883] Starting subtest: syncobj-timeline-signal
[460.293521] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[461.745582] [045/131] (554s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[461.854767] Starting subtest: fbcpsr-slowdraw
[486.899593] Subtest fbcpsr-slowdraw: SUCCESS (25.041s)
[487.034353] [046/131] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[487.145731] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[487.150719] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[487.259082] [047/131] (529s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[487.320982] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[487.323441] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[487.432626] [048/131] (528s left) gem_exec_schedule (u-independent)
[487.507351] Starting subtest: u-independent
[487.509593] Starting dynamic subtest: rcs0
[488.681620] Dynamic subtest rcs0: SUCCESS (1.190s)
[488.695877] Starting dynamic subtest: vcs0
[490.703096] Dynamic subtest vcs0: SUCCESS (2.018s)
[490.716356] Starting dynamic subtest: vcs1
[492.660917] Dynamic subtest vcs1: SUCCESS (1.956s)
[492.674792] Starting dynamic subtest: vecs0
[494.713855] Dynamic subtest vecs0: SUCCESS (2.051s)
[494.727858] Starting dynamic subtest: ccs0
[496.681278] Dynamic subtest ccs0: SUCCESS (1.965s)
[496.684405] Subtest u-independent: SUCCESS (9.188s)
[496.987756] [049/131] (519s left) kms_psr (pr-cursor-plane-onoff)
[497.093549] Starting subtest: pr-cursor-plane-onoff
[497.098090] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[497.163595] [050/131] (519s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[497.262133] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[497.266678] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.371410] [051/131] (519s left) gen9_exec_parse (basic-rejected-ctx-param)
[497.428265] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[497.487150] [052/131] (519s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[497.608973] Starting subtest: async-cursor-crc-framebuffer-change
[497.611662] Starting dynamic subtest: pipe-A-eDP-1
[498.196168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[498.207495] Starting dynamic subtest: pipe-D-eDP-1
[499.421645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[499.424070] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.811s)
[500.246682] [053/131] (516s left) kms_flip (plain-flip-fb-recreate-interruptible)
[500.351076] Starting subtest: plain-flip-fb-recreate-interruptible
[500.353368] Starting dynamic subtest: A-eDP1
[509.227946] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[509.238248] Starting dynamic subtest: B-eDP1
[518.053979] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[518.066809] Starting dynamic subtest: C-eDP1
[526.874003] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[526.884989] Starting dynamic subtest: D-eDP1
[535.693600] Dynamic subtest D-eDP1: SUCCESS (8.816s)
[535.695879] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.333s)
[536.870066] [054/131] (479s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[536.973902] Starting subtest: fbc-dirtyfb-ioctl
[536.976869] Starting dynamic subtest: A-eDP-1
[539.672272] Dynamic subtest A-eDP-1: SUCCESS (2.696s)
[539.674598] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.697s)
[540.512785] [055/131] (476s left) i915_drm_fdinfo (most-busy-idle-check-all)
[540.550869] Starting subtest: most-busy-idle-check-all
[540.554214] Starting dynamic subtest: rcs0
[540.559992] Dynamic subtest rcs0: SKIP (0.004s)
[540.572126] Starting dynamic subtest: bcs0
[540.576775] Dynamic subtest bcs0: SKIP (0.000s)
[540.586380] Starting dynamic subtest: vcs0
[540.591613] Dynamic subtest vcs0: SKIP (0.000s)
[540.601115] Starting dynamic subtest: vcs1
[540.606103] Dynamic subtest vcs1: SKIP (0.000s)
[540.616025] Starting dynamic subtest: vecs0
[540.621377] Dynamic subtest vecs0: SKIP (0.000s)
[540.631021] Starting dynamic subtest: ccs0
[540.636616] Dynamic subtest ccs0: SKIP (0.000s)
[540.641708] Subtest most-busy-idle-check-all: SKIP (0.008s)
[540.679441] [056/131] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[540.829920] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[540.834917] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[540.922792] [057/131] (475s left) kms_flip (2x-busy-flip)
[541.007574] Starting subtest: 2x-busy-flip
[541.018120] Subtest 2x-busy-flip: SKIP (0.010s)
[541.128161] [058/131] (475s left) gem_ctx_param (basic-default)
[541.181827] Starting subtest: basic-default
[541.184371] Subtest basic-default: SUCCESS (0.000s)
[541.257695] [059/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[541.359606] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[546.032971] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.680s)
[547.214610] [060/131] (469s left) syncobj_timeline (single-wait-available-submitted)
[547.273964] Starting subtest: single-wait-available-submitted
[547.276730] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[547.387311] [061/131] (469s left) gem_partial_pwrite_pread (writes-after-reads)
[547.455114] Subtest writes-after-reads: SKIP (0.000s)
[547.534438] [062/131] (469s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[552.569209] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[552.574647] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[553.422673] [063/131] (463s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[553.532670] Starting subtest: x-tiled-addfb-size-offset-overflow
[553.534721] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[553.645480] [064/131] (463s left) gem_pread (bench)
[553.699082] Subtest bench: SKIP (0.000s)
[553.764565] [065/131] (463s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[553.828314] Starting subtest: basic-batch-kernel-default-cmd
[553.832918] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[554.015537] [066/131] (463s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[554.121312] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[554.131843] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[554.251588] [067/131] (462s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[554.505738] Starting subtest: cursor-rapid-movement-512x512
[554.510926] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[554.673300] [068/131] (462s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[554.781751] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[554.784323] Starting dynamic subtest: pipe-A-eDP-1
[555.229391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[555.239989] Starting dynamic subtest: pipe-B-eDP-1
[556.658248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[556.669965] Starting dynamic subtest: pipe-C-eDP-1
[558.004075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[558.014124] Starting dynamic subtest: pipe-D-eDP-1
[559.333978] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[559.336882] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.522s)
[560.516932] [069/131] (456s left) kms_chamelium_frames (hdmi-aspect-ratio)
[560.892529] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[561.725918] [070/131] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[561.831229] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[568.424882] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.597s)
[568.570952] [071/131] (448s left) kms_flip (dpms-vs-vblank-race-interruptible)
[568.675906] Starting subtest: dpms-vs-vblank-race-interruptible
[568.678517] Starting dynamic subtest: A-eDP1
[573.603888] Dynamic subtest A-eDP1: SUCCESS (4.927s)
[573.616032] Starting dynamic subtest: B-eDP1
[578.202194] Dynamic subtest B-eDP1: SUCCESS (4.594s)
[578.213179] Starting dynamic subtest: C-eDP1
[582.784422] Dynamic subtest C-eDP1: SUCCESS (4.582s)
[582.795811] Starting dynamic subtest: D-eDP1
[587.398732] Dynamic subtest D-eDP1: SUCCESS (4.612s)
[587.401646] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.723s)
[588.269697] [072/131] (429s left) kms_psr (pr-cursor-mmap-cpu)
[588.367927] Starting subtest: pr-cursor-mmap-cpu
[588.372717] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[588.468459] [073/131] (428s left) api_intel_bb (intel-bb-blit-x)
[588.517302] Starting subtest: intel-bb-blit-x
[592.322818] Subtest intel-bb-blit-x: SUCCESS (3.805s)
[592.457430] [074/131] (425s left) i915_query (query-topology-matches-eu-total)
[592.516934] Starting subtest: query-topology-matches-eu-total
[592.519839] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[592.642461] [075/131] (424s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[592.745619] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[592.747883] Starting dynamic subtest: pipe-A-eDP-1
[592.771023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[592.781026] Starting dynamic subtest: pipe-B-eDP-1
[592.806008] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[592.815912] Starting dynamic subtest: pipe-C-eDP-1
[592.841411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[592.851000] Starting dynamic subtest: pipe-D-eDP-1
[592.877353] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[592.881645] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[594.925417] [076/131] (422s left) gem_eio (execbuf)
[595.151918] Starting subtest: execbuf
[595.489949] Subtest execbuf: SUCCESS (0.339s)
[595.643599] [077/131] (421s left) i915_pm_rps (min-max-config-loaded)
[595.705576] Starting subtest: min-max-config-loaded
[595.710837] Subtest min-max-config-loaded: SKIP (0.001s)
[595.798346] [078/131] (421s left) kms_lease (lessee-list)
[595.893562] Starting subtest: lessee-list
[595.895819] Starting dynamic subtest: pipe-A-eDP-1
[595.898089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[595.910361] Starting dynamic subtest: pipe-B-eDP-1
[595.912492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[595.921736] Starting dynamic subtest: pipe-C-eDP-1
[595.923763] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[595.933136] Starting dynamic subtest: pipe-D-eDP-1
[595.935371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[595.937294] Subtest lessee-list: SUCCESS (0.009s)
[596.021265] [079/131] (421s left) device_reset (unbind-reset-rebind)
[596.072157] Starting subtest: unbind-reset-rebind
[599.196545] Subtest unbind-reset-rebind: SUCCESS (3.118s)
[599.240212] [080/131] (418s left) syncobj_wait (wait-any-snapshot)
[599.305370] Starting subtest: wait-any-snapshot
[599.385141] Subtest wait-any-snapshot: SUCCESS (0.082s)
[599.482635] [081/131] (418s left) gen9_exec_parse (unaligned-jump)
[599.546107] Subtest unaligned-jump: SKIP (0.000s)
[599.638533] [082/131] (418s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[599.763953] Starting subtest: flip-vs-cursor-atomic
[606.775159] Subtest flip-vs-cursor-atomic: SUCCESS (7.009s)
[607.566344] [083/131] (410s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[607.666773] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[607.669115] Starting dynamic subtest: pipe-A-default-mode
[608.821467] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[608.825914] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.150s)
[608.997852] [084/131] (408s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[609.046013] Starting subtest: multi-wait-all-for-submit-available-signaled
[609.049091] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[609.144171] [085/131] (408s left) gem_exec_schedule (lateslice)
[609.204682] Starting subtest: lateslice
[609.207019] Starting dynamic subtest: rcs0
[609.215890] Dynamic subtest rcs0: SUCCESS (0.022s)
[609.227268] Starting dynamic subtest: bcs0
[609.232687] Dynamic subtest bcs0: SUCCESS (0.017s)
[609.244126] Starting dynamic subtest: vcs0
[609.249759] Dynamic subtest vcs0: SUCCESS (0.015s)
[609.260559] Starting dynamic subtest: vcs1
[609.265861] Dynamic subtest vcs1: SUCCESS (0.017s)
[609.276466] Starting dynamic subtest: vecs0
[609.281759] Dynamic subtest vecs0: SUCCESS (0.015s)
[609.292166] Starting dynamic subtest: ccs0
[609.298724] Dynamic subtest ccs0: SUCCESS (0.016s)
[609.300988] Subtest lateslice: SUCCESS (0.105s)
[610.769880] [086/131] (407s left) gem_exec_reloc (basic-gtt)
[610.836691] Subtest basic-gtt: SKIP (0.000s)
[610.924171] [087/131] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[611.027730] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[611.032718] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[611.134673] [088/131] (406s left) perf (non-zero-reason)
[611.237099] Starting subtest: non-zero-reason
[611.239831] Starting dynamic subtest: 0-rcs0
[616.643969] Dynamic subtest 0-rcs0: SUCCESS (5.407s)
[616.656052] Starting dynamic subtest: 1-vcs1
[620.568583] Dynamic subtest 1-vcs1: SUCCESS (3.922s)
[620.571965] Subtest non-zero-reason: SUCCESS (9.331s)
[620.621168] [089/131] (397s left) kms_plane_cursor (viewport)
[620.731835] Starting subtest: viewport
[620.736767] Starting dynamic subtest: pipe-A-eDP-1-size-64
[623.704964] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.971s)
[623.771936] Starting dynamic subtest: pipe-A-eDP-1-size-128
[626.817575] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (3.060s)
[626.878946] Starting dynamic subtest: pipe-A-eDP-1-size-256
[629.864006] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.993s)
[630.210799] Starting dynamic subtest: pipe-B-eDP-1-size-64
[633.788121] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.586s)
[633.849079] Starting dynamic subtest: pipe-B-eDP-1-size-128
[636.822468] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.982s)
[636.883119] Starting dynamic subtest: pipe-B-eDP-1-size-256
[639.856826] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.981s)
[640.208239] Starting dynamic subtest: pipe-C-eDP-1-size-64
[643.392375] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.195s)
[643.436631] Starting dynamic subtest: pipe-C-eDP-1-size-128
[645.937213] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.514s)
[645.975577] Starting dynamic subtest: pipe-C-eDP-1-size-256
[648.404264] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.435s)
[648.735939] Starting dynamic subtest: pipe-D-eDP-1-size-64
[651.892654] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.170s)
[651.937513] Starting dynamic subtest: pipe-D-eDP-1-size-128
[654.427719] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.502s)
[654.465498] Starting dynamic subtest: pipe-D-eDP-1-size-256
[656.950867] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.491s)
[657.266353] Subtest viewport: SUCCESS (36.523s)
[658.085501] [090/131] (360s left) kms_flip (nonexisting-fb-interruptible)
[658.186126] Starting subtest: nonexisting-fb-interruptible
[658.188571] Starting dynamic subtest: A-eDP1
[659.378949] Dynamic subtest A-eDP1: SUCCESS (1.192s)
[659.396910] Starting dynamic subtest: B-eDP1
[660.500842] Dynamic subtest B-eDP1: SUCCESS (1.118s)
[660.514091] Starting dynamic subtest: C-eDP1
[661.624742] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[661.635824] Starting dynamic subtest: D-eDP1
[662.753862] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[662.756660] Subtest nonexisting-fb-interruptible: SUCCESS (4.570s)
[663.913452] [091/131] (354s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[664.014111] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[664.019356] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[664.104862] [092/131] (354s left) kms_tiled_display (basic-test-pattern)
[664.215766] Subtest basic-test-pattern: SKIP (0.000s)
[664.266606] [093/131] (354s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[664.361711] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[664.363987] Starting dynamic subtest: pipe-A-default-mode
[667.005114] Dynamic subtest pipe-A-default-mode: SUCCESS (2.640s)
[667.007745] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.642s)
[667.877907] [094/131] (350s left) gem_exec_endless (dispatch)
[667.948591] Starting subtest: dispatch
[667.951531] Starting dynamic subtest: rcs0
[667.962144] Dynamic subtest rcs0: SUCCESS (0.007s)
[667.974544] Starting dynamic subtest: bcs0
[667.978983] Dynamic subtest bcs0: SUCCESS (0.005s)
[667.990317] Starting dynamic subtest: vcs0
[667.994936] Dynamic subtest vcs0: SUCCESS (0.005s)
[668.004952] Starting dynamic subtest: vcs1
[668.009776] Dynamic subtest vcs1: SUCCESS (0.005s)
[668.019707] Starting dynamic subtest: vecs0
[668.024396] Dynamic subtest vecs0: SUCCESS (0.006s)
[668.034209] Starting dynamic subtest: ccs0
[668.039848] Dynamic subtest ccs0: SUCCESS (0.004s)
[668.042686] Subtest dispatch: SUCCESS (0.035s)
[669.716706] [095/131] (348s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[669.802841] Starting subtest: plane-all-transition-nonblocking-fencing
[669.805579] Starting dynamic subtest: pipe-A-eDP-1
[672.307023] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[672.599133] Starting dynamic subtest: pipe-B-eDP-1
[675.801975] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[676.083699] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.279s)
[676.917872] [096/131] (341s left) gem_mmap_gtt (cpuset-big-copy)
[676.984262] Subtest cpuset-big-copy: SKIP (0.000s)
[677.062751] [097/131] (341s left) kms_frontbuffer_tracking (basic)
[677.160099] Starting subtest: basic
[680.337018] Subtest basic: SUCCESS (3.185s)
[680.455286] [098/131] (338s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[680.512872] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[680.515064] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[680.622532] [099/131] (337s left) sysfs_heartbeat_interval (nopreempt)
[680.677615] Starting subtest: nopreempt
[680.679834] Starting dynamic subtest: vecs0
[690.686921] Dynamic subtest vecs0: SUCCESS (10.010s)
[690.700230] Starting dynamic subtest: ccs0
[694.781040] Dynamic subtest ccs0: SUCCESS (4.092s)
[694.794648] Starting dynamic subtest: vcs0
[704.697941] Dynamic subtest vcs0: SUCCESS (9.914s)
[704.709702] Starting dynamic subtest: bcs0
[708.601420] Dynamic subtest bcs0: SUCCESS (3.902s)
[708.619110] Starting dynamic subtest: rcs0
[712.657309] Dynamic subtest rcs0: SUCCESS (4.056s)
[712.671654] Starting dynamic subtest: vcs1
[722.683494] Dynamic subtest vcs1: SUCCESS (10.023s)
[722.685963] Subtest nopreempt: SUCCESS (42.006s)
[722.759727] [100/131] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[722.868618] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[722.872863] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[722.986420] [101/131] (295s left) syncobj_timeline (multi-wait-available-submitted)
[723.033553] Starting subtest: multi-wait-available-submitted
[723.036024] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[723.127478] [102/131] (295s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[723.217248] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[723.221684] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[723.323884] [103/131] (295s left) kms_psr (fbc-psr2-no-drrs)
[723.413940] Starting subtest: fbc-psr2-no-drrs
[723.416497] Starting dynamic subtest: eDP-1
[723.420740] Dynamic subtest eDP-1: SKIP (0.000s)
[723.425731] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[723.490460] [104/131] (295s left) fbdev (unaligned-read)
[723.528122] Starting subtest: unaligned-read
[723.543531] Subtest unaligned-read: SUCCESS (0.015s)
[723.599783] [105/131] (295s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[723.698692] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[723.702405] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[723.801471] [106/131] (295s left) kms_async_flips (invalid-async-flip-atomic)
[723.900121] Starting subtest: invalid-async-flip-atomic
[723.904503] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[725.146264] [107/131] (293s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[725.245670] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[729.831977] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.590s)
[731.016317] [108/131] (287s left) gem_exec_flush (basic-wb-ro-before-default)
[731.088692] Starting subtest: basic-wb-ro-before-default
[736.535662] Subtest basic-wb-ro-before-default: SUCCESS (5.449s)
[736.720556] [109/131] (282s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[736.813329] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[736.815352] Starting dynamic subtest: pipe-A-eDP-1
[736.864891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.053s)
[736.876135] Starting dynamic subtest: pipe-B-eDP-1
[736.921953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.056s)
[736.933107] Starting dynamic subtest: pipe-C-eDP-1
[736.975784] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.053s)
[736.987078] Starting dynamic subtest: pipe-D-eDP-1
[737.026789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.050s)
[737.029277] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.216s)
[739.153747] [110/131] (279s left) kms_invalid_mode (zero-clock)
[739.252595] Starting subtest: zero-clock
[739.255002] Starting dynamic subtest: pipe-A-eDP-1
[739.539966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[739.553362] Starting dynamic subtest: pipe-B-eDP-1
[739.555379] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[739.566998] Starting dynamic subtest: pipe-C-eDP-1
[739.570111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[739.582955] Starting dynamic subtest: pipe-D-eDP-1
[739.585661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[739.588109] Subtest zero-clock: SUCCESS (0.294s)
[740.375808] [111/131] (278s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[740.435224] Starting subtest: y-tiled-to-vebox-yf-tiled
[740.440386] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[740.621431] [112/131] (278s left) kms_pm_dc (dc5-psr)
[741.729137] Starting subtest: dc5-psr
[744.606375] Subtest dc5-psr: SUCCESS (2.878s)
[745.394339] [113/131] (273s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[745.501843] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[752.217386] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.719s)
[752.340966] [114/131] (266s left) gem_ctx_isolation (dirty-switch)
[752.398231] Starting subtest: dirty-switch
[752.401235] Starting dynamic subtest: rcs0
[752.829123] Dynamic subtest rcs0: SUCCESS (0.430s)
[752.843104] Starting dynamic subtest: bcs0
[753.266967] Dynamic subtest bcs0: SUCCESS (0.438s)
[753.280029] Starting dynamic subtest: vcs0
[753.701676] Dynamic subtest vcs0: SUCCESS (0.434s)
[753.714444] Starting dynamic subtest: vcs1
[755.102294] Dynamic subtest vcs1: SUCCESS (1.399s)
[755.114116] Starting dynamic subtest: vecs0
[757.123088] Dynamic subtest vecs0: SUCCESS (2.020s)
[757.134435] Starting dynamic subtest: ccs0
[759.176994] Dynamic subtest ccs0: SUCCESS (2.053s)
[759.179741] Subtest dirty-switch: SUCCESS (6.778s)
[759.427550] [115/131] (259s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[759.526884] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[759.531943] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[759.616719] [116/131] (259s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[759.715862] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[759.718458] Starting dynamic subtest: pipe-A-eDP-1
[759.744908] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[759.755585] Starting dynamic subtest: pipe-B-eDP-1
[759.782968] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[759.794121] Starting dynamic subtest: pipe-C-eDP-1
[759.821225] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[759.832073] Starting dynamic subtest: pipe-D-eDP-1
[759.860658] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[759.865092] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[761.912900] [117/131] (257s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[762.017650] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[762.884864] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.870s)
[763.068829] [118/131] (256s left) kms_big_fb (yf-tiled-addfb)
[763.163890] Starting subtest: yf-tiled-addfb
[763.169032] Subtest yf-tiled-addfb: SKIP (0.000s)
[763.271346] [119/131] (256s left) perf (invalid-oa-metric-set-id)
[763.344065] Starting subtest: invalid-oa-metric-set-id
[763.359904] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s)
[763.399780] [120/131] (256s left) kms_psr2_su (page_flip-p010)
[763.459362] Subtest page_flip-P010: SKIP (0.000s)
[763.514964] [121/131] (255s left) gem_lmem_swapping (smem-oom)
[763.558728] Subtest smem-oom: SKIP (0.000s)
[763.603255] [122/131] (255s left) kms_cursor_crc (cursor-suspend)
[763.736987] Starting subtest: cursor-suspend
[763.740004] Starting dynamic subtest: pipe-A-eDP-1
[796.778774] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.020s)
[796.796563] Starting dynamic subtest: pipe-D-eDP-1
[829.749801] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.597s)
[829.751873] Subtest cursor-suspend: SUCCESS (6.620s)
[830.532576] [123/131] (189s left) gem_pxp (create-regular-context-2)
[830.660600] Starting subtest: create-regular-context-2
[830.663482] Subtest create-regular-context-2: SUCCESS (0.002s)
[830.770334] [124/131] (188s left) gem_ctx_persistence (legacy-engines-hang)
[830.835873] Starting subtest: legacy-engines-hang
[830.838633] Starting dynamic subtest: render
[831.009724] Dynamic subtest render: SUCCESS (0.173s)
[831.023778] Starting dynamic subtest: bsd1
[831.132303] Dynamic subtest bsd1: SUCCESS (0.120s)
[831.146701] Starting dynamic subtest: bsd2
[831.252239] Dynamic subtest bsd2: SUCCESS (0.118s)
[831.267208] Starting dynamic subtest: blt
[831.371389] Dynamic subtest blt: SUCCESS (0.117s)
[831.383837] Starting dynamic subtest: vebox
[831.452540] Dynamic subtest vebox: SUCCESS (0.078s)
[831.455390] Subtest legacy-engines-hang: SUCCESS (0.619s)
[831.599041] [125/131] (188s left) kms_plane_alpha_blend (alpha-7efc)
[831.682878] Starting subtest: alpha-7efc
[832.110514] Starting dynamic subtest: pipe-A-eDP-1
[832.687298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[832.712838] Starting dynamic subtest: pipe-D-eDP-1
[834.009365] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[834.012069] Subtest alpha-7efc: SUCCESS (2.328s)
[834.871300] [126/131] (184s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[834.979734] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[834.984944] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[835.082398] [127/131] (184s left) gem_userptr_blits (userfault)
[835.144744] Starting subtest: userfault
[835.146844] Subtest userfault: SUCCESS (0.005s)
[835.273220] [128/131] (184s left) i915_module_load (reload-no-display)
[835.301712] Starting subtest: reload-no-display
[841.984047] Subtest reload-no-display: SUCCESS (6.692s)
[842.016479] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[842.017266] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[842.020933] [129/131] (177s left) kms_chamelium_color (ctm-max)
[843.769557] Subtest ctm-max: SKIP (0.000s)
[843.813526] [FACT kms_chamelium_color (ctm-max)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[843.815387] [FACT kms_chamelium_color (ctm-max)] new: kernel.kmod_is_loaded.i915: true
[843.819509] [130/131] (176s left) kms_atomic_interruptible (legacy-pageflip)
[843.914048] Starting subtest: legacy-pageflip
[843.916825] Starting dynamic subtest: pipe-A-eDP-1
[851.314937] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.408s)
[851.317608] Subtest legacy-pageflip: SUCCESS (7.410s)
[852.141413] [131/131] (167s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[852.209508] Starting subtest: map-fixed-invalidate-overlap-busy
[852.214498] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[852.332086] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_busy
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_busy
results: parsing output: 14/ for test: kms_selftest
results: parsing output: 15/ for test: gem_exec_basic
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_getfb
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: intel_sysfs_debugfs
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_dirtyfb
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_pread
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: device_reset
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_tiled_display
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_exec_endless
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_async_flips
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_psr2_su
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_plane_alpha_blend
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: gem_userptr_blits
Done.