[57.451437] Initializing watchdogs
[57.451720]   /dev/watchdog0
[57.465964] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.470135] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.472565] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.476777] [001/133] (960s left) gem_mmap_wc (write-prefaulted)
[57.557431] Subtest write-prefaulted: SKIP (0.000s)
[57.608626] [002/133] (960s left) gem_wait (busy)
[57.678449] Starting subtest: busy
[57.681718] Starting dynamic subtest: all-engines
[58.901804] Dynamic subtest all-engines: SUCCESS (1.209s)
[58.912426] Starting dynamic subtest: rcs0
[59.445161] Dynamic subtest rcs0: SUCCESS (0.539s)
[59.455093] Starting dynamic subtest: bcs0
[59.985879] Dynamic subtest bcs0: SUCCESS (0.535s)
[59.995807] Starting dynamic subtest: vcs0
[61.909643] Dynamic subtest vcs0: SUCCESS (1.909s)
[61.917867] Starting dynamic subtest: vcs1
[63.893975] Dynamic subtest vcs1: SUCCESS (1.973s)
[63.904248] Starting dynamic subtest: vecs0
[65.877226] Dynamic subtest vecs0: SUCCESS (1.974s)
[65.887582] Starting dynamic subtest: ccs0
[66.417629] Dynamic subtest ccs0: SUCCESS (0.539s)
[66.420353] Subtest busy: SUCCESS (8.684s)
[66.647801] [003/133] (951s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[66.802644] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[66.804540] Starting dynamic subtest: pipe-A-eDP-1
[66.976334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.165s)
[66.985326] Starting dynamic subtest: pipe-B-eDP-1
[67.008889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[67.016189] Starting dynamic subtest: pipe-C-eDP-1
[67.037821] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[67.045203] Starting dynamic subtest: pipe-D-eDP-1
[67.065839] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[67.068525] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.172s)
[69.239275] [004/133] (948s left) kms_chamelium_color (ctm-0-75)
[69.343474] Subtest ctm-0-75: SKIP (0.000s)
[69.385450] [005/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[69.479103] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[76.253828] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.767s)
[76.366984] [006/133] (941s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[76.456941] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[76.461217] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[76.547024] [007/133] (941s left) kms_vrr (seamless-rr-switch-vrr)
[76.634054] Starting subtest: seamless-rr-switch-vrr
[76.640753] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[76.704389] [008/133] (941s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[76.750771] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[76.753159] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[76.845923] [009/133] (941s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[76.951582] Starting subtest: 4-tiled-16bpp-rotate-180
[78.187449] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[78.316630] [010/133] (940s left) gem_exec_reloc (basic-cpu-wc-active)
[78.387337] Subtest basic-cpu-wc-active: SKIP (0.000s)
[78.454399] [011/133] (939s left) gem_exec_reloc (basic-cpu-gtt-active)
[78.513938] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[78.584343] [012/133] (939s left) gem_render_copy (linear-to-vebox-y-tiled)
[78.645183] Starting subtest: linear-to-vebox-y-tiled
[78.649196] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[78.837293] [013/133] (939s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[78.928657] Starting subtest: basic-modeset-with-all-modifiers-formats
[79.305400] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[80.114402] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.810s)
[80.121158] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[80.136009] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[80.142766] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[80.158365] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[80.165061] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[80.314431] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[80.324391] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[80.336538] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[80.343420] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[80.358438] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[80.365371] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[80.380730] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[80.387863] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[80.402967] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[80.409995] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[80.425289] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[80.432158] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[80.447350] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[80.454246] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[80.469751] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[80.476720] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[80.491969] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[80.499055] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[80.636637] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[80.645689] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[80.658808] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[80.665581] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[80.681055] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[80.687782] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[80.703387] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[80.709971] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[80.725607] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[80.732600] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[80.747738] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[80.754324] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[80.770193] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[80.776776] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[80.792485] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[80.799518] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[80.814176] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[80.820443] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[80.970371] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[80.979059] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[80.992579] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[80.999311] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[81.015206] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[81.022022] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[81.036901] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[81.046075] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[81.059138] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[81.065583] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[81.081450] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[81.088167] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[81.103385] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[81.109791] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[81.126052] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[81.132246] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[81.148250] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[81.555088] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.626s)
[82.396319] [014/133] (936s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[82.795832] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[83.609066] [015/133] (934s left) i915_pm_rps (thresholds-park)
[83.674650] Starting subtest: thresholds-park
[83.678991] Subtest thresholds-park: SKIP (0.000s)
[83.762206] [016/133] (934s left) i915_fb_tiling (basic-x-tiling)
[83.811724] Subtest basic-x-tiling: SKIP (0.000s)
[83.871439] [017/133] (934s left) gem_exec_schedule (preempt-user)
[83.947507] Starting subtest: preempt-user
[83.949496] Starting dynamic subtest: rcs0
[83.965982] Dynamic subtest rcs0: SUCCESS (0.026s)
[83.973172] Starting dynamic subtest: bcs0
[83.986454] Dynamic subtest bcs0: SUCCESS (0.020s)
[84.000335] Starting dynamic subtest: vcs0
[84.005483] Dynamic subtest vcs0: SUCCESS (0.019s)
[84.013869] Starting dynamic subtest: vcs1
[84.025464] Dynamic subtest vcs1: SUCCESS (0.019s)
[84.034861] Starting dynamic subtest: vecs0
[84.045223] Dynamic subtest vecs0: SUCCESS (0.020s)
[84.052096] Starting dynamic subtest: ccs0
[84.066355] Dynamic subtest ccs0: SUCCESS (0.021s)
[84.068667] Subtest preempt-user: SUCCESS (0.127s)
[85.982332] [018/133] (932s left) kms_lease (lease-unleased-connector)
[86.069278] Starting subtest: lease-unleased-connector
[86.071513] Starting dynamic subtest: pipe-A-eDP-1
[86.079088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[86.086895] Starting dynamic subtest: pipe-B-eDP-1
[86.089171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[86.096519] Starting dynamic subtest: pipe-C-eDP-1
[86.098815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[86.106060] Starting dynamic subtest: pipe-D-eDP-1
[86.108443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[86.110656] Subtest lease-unleased-connector: SUCCESS (0.035s)
[86.252125] [019/133] (932s left) gem_mmap_gtt (hang-busy)
[86.312581] Subtest hang-busy: SKIP (0.000s)
[86.385707] [020/133] (932s left) gem_mmap_gtt (big-copy)
[86.443017] Subtest big-copy: SKIP (0.000s)
[86.519497] [021/133] (932s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[86.603223] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[86.605543] Starting dynamic subtest: pipe-A
[86.623558] Dynamic subtest pipe-A: SKIP (0.017s)
[86.632098] Starting dynamic subtest: pipe-B
[86.657685] Dynamic subtest pipe-B: SKIP (0.035s)
[86.665253] Starting dynamic subtest: pipe-C
[86.695281] Dynamic subtest pipe-C: SKIP (0.038s)
[86.702560] Starting dynamic subtest: pipe-D
[86.727176] Dynamic subtest pipe-D: SKIP (0.030s)
[86.731483] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.121s)
[86.839165] [022/133] (932s left) gem_ctx_param (get-priority-new-ctx)
[86.894656] Starting subtest: get-priority-new-ctx
[86.897030] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[86.998744] [023/133] (931s left) gem_create (create-ext-cpu-access-big)
[87.152997] Starting subtest: create-ext-cpu-access-big
[87.157904] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[87.221919] [024/133] (931s left) gem_softpin (overlap)
[87.272580] Starting subtest: overlap
[88.109053] Subtest overlap: SUCCESS (0.836s)
[88.216209] [025/133] (930s left) syncobj_timeline (invalid-signal-illegal-point)
[88.275169] Starting subtest: invalid-signal-illegal-point
[88.277558] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[88.379305] [026/133] (930s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[88.487719] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[88.491878] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[88.582113] [027/133] (930s left) kms_flip (plain-flip-interruptible)
[88.687260] Starting subtest: plain-flip-interruptible
[88.689631] Starting dynamic subtest: A-eDP1
[90.337112] Dynamic subtest A-eDP1: SUCCESS (1.648s)
[90.346946] Starting dynamic subtest: B-eDP1
[91.973732] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[91.981566] Starting dynamic subtest: C-eDP1
[93.582523] Dynamic subtest C-eDP1: SUCCESS (1.606s)
[93.590144] Starting dynamic subtest: D-eDP1
[95.219358] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[95.221917] Subtest plain-flip-interruptible: SUCCESS (6.531s)
[96.395595] [028/133] (922s left) gem_exec_capture (userptr)
[96.448218] Starting subtest: userptr
[97.285255] Subtest userptr: SUCCESS (0.836s)
[97.387660] [029/133] (921s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[97.444779] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[97.447052] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[97.534088] [030/133] (921s left) sw_sync (alloc_timeline)
[97.577812] Starting subtest: alloc_timeline
[97.579617] Subtest alloc_timeline: SUCCESS (0.000s)
[97.629676] [031/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[97.751245] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[97.755183] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[97.850539] [032/133] (921s left) kms_psr (psr2-primary-page-flip)
[97.936027] Starting subtest: psr2-primary-page-flip
[97.938181] Starting dynamic subtest: eDP-1
[99.670274] Dynamic subtest eDP-1: SUCCESS (1.733s)
[99.672562] Subtest psr2-primary-page-flip: SUCCESS (1.733s)
[100.543786] [033/133] (918s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[100.635442] Starting subtest: fbcpsr-stridechange
[106.901881] Subtest fbcpsr-stridechange: SUCCESS (6.268s)
[107.013838] [034/133] (912s left) kms_scaling_modes (scaling-mode-none)
[107.106935] Starting subtest: scaling-mode-none
[107.109226] Starting dynamic subtest: pipe-A-eDP-1
[107.201888] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[107.211591] Starting dynamic subtest: pipe-B-eDP-1
[107.235273] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[107.242556] Starting dynamic subtest: pipe-C-eDP-1
[107.276709] Dynamic subtest pipe-C-eDP-1: SKIP (0.039s)
[107.290840] Starting dynamic subtest: pipe-D-eDP-1
[107.311363] Dynamic subtest pipe-D-eDP-1: SKIP (0.035s)
[107.315570] Subtest scaling-mode-none: SKIP (0.205s)
[107.426103] [035/133] (911s left) gem_mmap_gtt (cpuset-big-copy-odd)
[107.486239] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[107.549027] [036/133] (911s left) kms_psr (psr2-cursor-blt)
[107.645192] Starting subtest: psr2-cursor-blt
[107.647406] Starting dynamic subtest: eDP-1
[109.374225] Dynamic subtest eDP-1: SUCCESS (1.730s)
[109.376418] Subtest psr2-cursor-blt: SUCCESS (1.730s)
[110.253175] [037/133] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[110.340756] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[110.345000] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[110.421690] [038/133] (909s left) gem_exec_whisper (basic-contexts-priority-all)
[110.483105] Starting subtest: basic-contexts-priority-all
[132.819994] Subtest basic-contexts-priority-all: SUCCESS (22.329s)
[132.998927] [039/133] (886s left) gem_barrier_race (remote-request)
[133.061288] Starting subtest: remote-request
[133.063674] Starting dynamic subtest: rcs0
[138.225610] Dynamic subtest rcs0: SUCCESS (5.165s)
[138.233822] Subtest remote-request: SUCCESS (5.167s)
[138.378910] [040/133] (881s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[138.482837] Starting subtest: pr-plane-move-sf-dmg-area
[138.486473] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[138.563256] [041/133] (880s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[138.656807] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[145.523915] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.866s)
[145.657357] [042/133] (873s left) kms_flip (flip-vs-blocking-wf-vblank)
[145.757492] Starting subtest: flip-vs-blocking-wf-vblank
[145.759699] Starting dynamic subtest: A-eDP1
[154.730910] Dynamic subtest A-eDP1: SUCCESS (8.976s)
[154.740635] Starting dynamic subtest: B-eDP1
[163.668481] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[163.678481] Starting dynamic subtest: C-eDP1
[172.589716] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[172.599689] Starting dynamic subtest: D-eDP1
[181.522227] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[181.527612] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.772s)
[182.754476] [043/133] (836s left) gem_eio (in-flight-1us)
[183.003608] Starting subtest: in-flight-1us
[191.797076] Subtest in-flight-1us: SUCCESS (8.792s)
[191.958787] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[191.961877] [044/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[192.063701] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[198.924814] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.861s)
[199.077808] [045/133] (820s left) gem_exec_balancer (full-pulse)
[199.154073] Starting subtest: full-pulse
[203.723808] Subtest full-pulse: SUCCESS (4.572s)
[204.013278] [046/133] (815s left) gem_ctx_persistence (hostile)
[204.064324] Starting subtest: hostile
[214.214536] Subtest hostile: SUCCESS (10.144s)
[214.348954] [047/133] (805s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[214.456624] Starting subtest: psr-rgb565-draw-mmap-gtt
[214.461143] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[214.552735] [048/133] (805s left) prime_busy (before)
[214.608431] Starting subtest: before
[214.613143] Starting dynamic subtest: rcs0
[214.646629] Dynamic subtest rcs0: SUCCESS (0.035s)
[214.657367] Starting dynamic subtest: bcs0
[214.698304] Dynamic subtest bcs0: SUCCESS (0.051s)
[214.708431] Starting dynamic subtest: vcs0
[214.738581] Dynamic subtest vcs0: SUCCESS (0.040s)
[214.747620] Starting dynamic subtest: vcs1
[214.779618] Dynamic subtest vcs1: SUCCESS (0.040s)
[214.788730] Starting dynamic subtest: vecs0
[214.819416] Dynamic subtest vecs0: SUCCESS (0.039s)
[214.828596] Starting dynamic subtest: ccs0
[214.860233] Dynamic subtest ccs0: SUCCESS (0.040s)
[214.969637] Subtest before: SUCCESS (0.359s)
[215.060295] [049/133] (804s left) kms_cursor_edge_walk (256x256-right-edge)
[215.151200] Starting subtest: 256x256-right-edge
[215.153657] Starting dynamic subtest: pipe-A-eDP-1
[218.628748] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[218.638382] Starting dynamic subtest: pipe-D-eDP-1
[221.756335] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[221.758631] Subtest 256x256-right-edge: SUCCESS (6.604s)
[222.551914] [050/133] (797s left) kms_pipe_crc_basic (hang-read-crc)
[222.644080] Starting subtest: hang-read-crc
[222.646420] Starting dynamic subtest: pipe-A-eDP-1
[224.735184] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[224.744429] Starting dynamic subtest: pipe-B-eDP-1
[227.499244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[227.508484] Starting dynamic subtest: pipe-C-eDP-1
[230.124146] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s)
[230.132484] Starting dynamic subtest: pipe-D-eDP-1
[232.798607] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[232.800967] Subtest hang-read-crc: SUCCESS (10.153s)
[233.619835] [051/133] (786s left) kms_dp_link_training (uhbr-mst)
[233.719319] Starting subtest: uhbr-mst
[233.728225] Subtest uhbr-mst: SKIP (0.000s)
[233.803538] [052/133] (786s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[233.908496] Starting subtest: x-tiled-addfb-size-offset-overflow
[233.910400] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[233.997430] [053/133] (786s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[234.091512] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[234.095930] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[234.185534] [054/133] (785s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[234.323047] Starting subtest: 2x-long-flip-vs-cursor-legacy
[234.327270] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[234.473334] [055/133] (785s left) syncobj_eventfd (binary-wait-before-signal)
[234.523319] Starting subtest: binary-wait-before-signal
[234.552385] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[234.623651] [056/133] (785s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[234.722366] Starting subtest: primary-y-tiled-reflect-x-0
[234.781864] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[234.883758] [057/133] (785s left) gem_exec_flush (basic-wb-rw-default)
[234.946417] Starting subtest: basic-wb-rw-default
[240.396982] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[240.582535] [058/133] (779s left) gem_exec_reloc (basic-active)
[240.631408] Subtest basic-active: SKIP (0.000s)
[240.697086] [059/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[240.794851] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[240.798873] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.890920] [060/133] (779s left) gem_exec_fence (syncobj-timeline-export)
[241.430581] Starting subtest: syncobj-timeline-export
[241.437519] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[242.975056] [061/133] (777s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[243.075078] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[243.086165] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[243.162115] [062/133] (777s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[243.276042] Starting subtest: cursor-vs-flip-varying-size
[274.107736] Subtest cursor-vs-flip-varying-size: SUCCESS (30.828s)
[274.953252] [063/133] (745s left) syncobj_wait (invalid-wait-bad-flags)
[275.002976] Starting subtest: invalid-wait-bad-flags
[275.005302] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[275.097107] [064/133] (745s left) kms_color_pipeline (plane-ctm3x4)
[275.184995] Starting subtest: plane-ctm3x4
[275.342257] Starting dynamic subtest: pipe-A-plane-0
[275.671191] Dynamic subtest pipe-A-plane-0: FAIL (0.161s)
[275.681696] Starting dynamic subtest: pipe-A-plane-1
[275.886686] Dynamic subtest pipe-A-plane-1: FAIL (0.135s)
[275.896474] Starting dynamic subtest: pipe-A-plane-2
[276.096219] Dynamic subtest pipe-A-plane-2: FAIL (0.143s)
[276.958348] Starting dynamic subtest: pipe-B-plane-0
[277.351255] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[277.359774] Starting dynamic subtest: pipe-B-plane-1
[277.655952] Dynamic subtest pipe-B-plane-1: FAIL (0.136s)
[277.666396] Starting dynamic subtest: pipe-B-plane-2
[277.961961] Dynamic subtest pipe-B-plane-2: FAIL (0.606s)
[278.993610] Starting dynamic subtest: pipe-C-plane-0
[279.447487] Dynamic subtest pipe-C-plane-0: FAIL (0.118s)
[279.456967] Starting dynamic subtest: pipe-C-plane-1
[279.829270] Dynamic subtest pipe-C-plane-1: FAIL (0.566s)
[279.838234] Starting dynamic subtest: pipe-C-plane-2
[280.187564] Dynamic subtest pipe-C-plane-2: FAIL (0.146s)
[281.028828] Starting dynamic subtest: pipe-D-plane-0
[281.581990] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[281.592735] Starting dynamic subtest: pipe-D-plane-1
[282.039214] Dynamic subtest pipe-D-plane-1: FAIL (0.591s)
[282.049308] Starting dynamic subtest: pipe-D-plane-2
[282.465738] Dynamic subtest pipe-D-plane-2: FAIL (0.524s)
[282.549461] Subtest plane-ctm3x4: FAIL (7.367s)
[283.415732] [065/133] (737s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[283.517616] Starting subtest: y-tiled-64bpp-rotate-0
[283.521936] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[283.623260] [066/133] (736s left) gem_exec_balancer (parallel-contexts)
[283.876626] Starting subtest: parallel-contexts
[286.985174] Subtest parallel-contexts: SUCCESS (3.109s)
[288.068027] [067/133] (732s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[288.135175] Starting subtest: stress-mm-invalidate-close-overlap
[290.283335] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[290.393512] [068/133] (730s left) prime_mmap (test_invalid_sync_flags)
[290.441748] Starting subtest: test_invalid_sync_flags
[290.443683] Starting dynamic subtest: test_invalid_sync_flags-smem
[290.445610] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[290.447532] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[290.537582] [069/133] (730s left) kms_invalid_mode (bad-vsync-start)
[290.628872] Starting subtest: bad-vsync-start
[290.630999] Starting dynamic subtest: pipe-A-eDP-1
[290.917440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[290.926383] Starting dynamic subtest: pipe-B-eDP-1
[290.928579] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[290.936804] Starting dynamic subtest: pipe-C-eDP-1
[290.939014] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.947276] Starting dynamic subtest: pipe-D-eDP-1
[290.949117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.950979] Subtest bad-vsync-start: SUCCESS (0.297s)
[291.745894] [070/133] (728s left) kms_flip (2x-flip-vs-panning-vs-hang)
[291.845436] Starting subtest: 2x-flip-vs-panning-vs-hang
[291.856831] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[291.930192] [071/133] (728s left) syncobj_wait (multi-wait-submitted)
[291.986687] Starting subtest: multi-wait-submitted
[292.088872] Subtest multi-wait-submitted: SUCCESS (0.102s)
[292.171319] [072/133] (728s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[292.268321] Starting subtest: x-tiled-64bpp-rotate-0
[293.901119] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.634s)
[294.060184] [073/133] (726s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[294.162676] Starting subtest: psr2-overlay-plane-move-continuous-sf
[294.164554] Starting dynamic subtest: pipe-A-eDP-1
[300.157285] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.997s)
[300.165875] Starting dynamic subtest: pipe-B-eDP-1
[306.821937] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s)
[306.824320] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.665s)
[307.692426] [074/133] (713s left) gem_exec_params (secure-non-root)
[307.757167] Starting subtest: secure-non-root
[307.761518] Subtest secure-non-root: SKIP (0.000s)
[307.856412] [075/133] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[307.938581] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[307.942668] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.039985] [076/133] (712s left) kms_vblank (accuracy-idle)
[308.121299] Starting subtest: accuracy-idle
[308.123186] Starting dynamic subtest: pipe-A-eDP-1
[309.890305] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.770s)
[309.904313] Starting dynamic subtest: pipe-D-eDP-1
[312.322264] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[312.324200] Subtest accuracy-idle: SUCCESS (4.201s)
[313.154835] [077/133] (707s left) gem_exec_reloc (basic-write-wc-noreloc)
[313.206155] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[313.275982] [078/133] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[313.372690] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[320.290731] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.920s)
[320.450095] [079/133] (700s left) kms_pm_lpsp (kms-lpsp)
[321.560505] Starting subtest: kms-lpsp
[321.562395] Starting dynamic subtest: pipe-A-eDP-1
[321.713314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.154s)
[322.023355] Subtest kms-lpsp: SUCCESS (0.463s)
[322.826197] [080/133] (698s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[322.922111] Starting subtest: fbc-pr-sprite-mmap-gtt
[322.926489] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[322.998009] [081/133] (698s left) kms_flip (2x-flip-vs-dpms-on-nop)
[323.095166] Starting subtest: 2x-flip-vs-dpms-on-nop
[323.106643] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.013s)
[323.186795] [082/133] (698s left) kms_cursor_crc (cursor-onscreen-64x21)
[323.391097] Starting subtest: cursor-onscreen-64x21
[323.434320] Subtest cursor-onscreen-64x21: SKIP (0.041s)
[323.690112] [083/133] (697s left) dumb_buffer (create-valid-dumb)
[323.749814] Starting subtest: create-valid-dumb
[323.752204] Subtest create-valid-dumb: SUCCESS (0.000s)
[323.868842] [084/133] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[323.966097] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[323.969524] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[324.057177] [085/133] (697s left) kms_big_fb (linear-16bpp-rotate-180)
[324.181871] Starting subtest: linear-16bpp-rotate-180
[325.606120] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s)
[325.736474] [086/133] (695s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[325.837752] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[325.841353] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[326.971776] [087/133] (694s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[327.068406] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[327.070802] Starting dynamic subtest: pipe-A-eDP-1
[327.094595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.106476] Starting dynamic subtest: pipe-B-eDP-1
[327.128276] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.136093] Starting dynamic subtest: pipe-C-eDP-1
[327.157398] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.165242] Starting dynamic subtest: pipe-D-eDP-1
[327.187031] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.191354] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[329.335388] [088/133] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[329.432038] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[329.436115] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[329.535884] [089/133] (691s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[329.629853] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[329.632180] Starting dynamic subtest: pipe-A-eDP-1
[329.717937] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[329.727039] Starting dynamic subtest: pipe-B-eDP-1
[330.810485] Dynamic subtest pipe-B-eDP-1: SKIP (1.089s)
[330.814988] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.182s)
[332.004044] [090/133] (689s left) syncobj_wait (single-wait-signaled)
[332.061708] Starting subtest: single-wait-signaled
[332.063612] Subtest single-wait-signaled: SUCCESS (0.000s)
[332.165725] [091/133] (689s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[332.303995] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[332.951649] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.649s)
[333.103519] [092/133] (688s left) kms_flip (2x-flip-vs-fences)
[333.195265] Starting subtest: 2x-flip-vs-fences
[333.199224] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[333.297640] [093/133] (688s left) syncobj_wait (wait-for-submit-complex)
[333.344795] Starting subtest: wait-for-submit-complex
[333.405515] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[333.487490] [094/133] (688s left) sw_sync (sync_multi_consumer_producer)
[333.526521] Starting subtest: sync_multi_consumer_producer
[333.854020] Subtest sync_multi_consumer_producer: SUCCESS (0.327s)
[333.925903] [095/133] (687s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[334.014826] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[334.017140] Starting dynamic subtest: pipe-A-default-mode
[336.754593] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[336.756715] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.740s)
[337.591563] [096/133] (684s left) gem_spin_batch (engines)
[337.654338] Starting subtest: engines
[337.656586] Starting dynamic subtest: rcs0
[340.893085] Dynamic subtest rcs0: SUCCESS (3.234s)
[340.908850] Starting dynamic subtest: bcs0
[344.131887] Dynamic subtest bcs0: SUCCESS (3.236s)
[344.143172] Starting dynamic subtest: vcs0
[347.369425] Dynamic subtest vcs0: SUCCESS (3.234s)
[347.379568] Starting dynamic subtest: vcs1
[350.607378] Dynamic subtest vcs1: SUCCESS (3.235s)
[350.617060] Starting dynamic subtest: vecs0
[353.845650] Dynamic subtest vecs0: SUCCESS (3.236s)
[353.856410] Starting dynamic subtest: ccs0
[357.082102] Dynamic subtest ccs0: SUCCESS (3.234s)
[357.084570] Subtest engines: SUCCESS (19.425s)
[357.317252] [097/133] (664s left) gem_lmem_swapping (parallel-random-engines)
[357.361336] Subtest parallel-random-engines: SKIP (0.000s)
[357.400876] [098/133] (664s left) kms_plane_multiple (tiling-4)
[357.491759] Starting subtest: tiling-4
[357.494051] Starting dynamic subtest: pipe-A-eDP-1
[361.219341] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.727s)
[361.228255] Starting dynamic subtest: pipe-B-eDP-1
[365.664762] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.445s)
[365.673630] Starting dynamic subtest: pipe-C-eDP-1
[369.997426] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.330s)
[370.007222] Starting dynamic subtest: pipe-D-eDP-1
[374.354459] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.356s)
[374.356844] Subtest tiling-4: SUCCESS (16.863s)
[375.149402] [099/133] (646s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[375.267600] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[375.270021] Starting dynamic subtest: pipe-A
[375.649103] Dynamic subtest pipe-A: SUCCESS (0.384s)
[375.659034] Starting dynamic subtest: pipe-B
[377.122936] Dynamic subtest pipe-B: SUCCESS (1.473s)
[377.131516] Starting dynamic subtest: pipe-C
[378.608393] Dynamic subtest pipe-C: SUCCESS (1.484s)
[378.617659] Starting dynamic subtest: pipe-D
[380.018275] Dynamic subtest pipe-D: SUCCESS (1.408s)
[380.020514] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.754s)
[381.172629] [100/133] (640s left) gen7_exec_parse (basic-offset)
[381.234638] Subtest basic-offset: SKIP (0.000s)
[381.308020] [101/133] (640s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[381.357900] Starting subtest: y-tiled-ccs-to-x-tiled
[381.362393] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[381.545776] [102/133] (640s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[381.665909] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[382.616992] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.949s)
[383.406382] [103/133] (638s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[383.498064] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[383.527407] Starting dynamic subtest: pipe-A-plane-0
[383.812225] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[383.820679] Starting dynamic subtest: pipe-A-plane-3
[384.045742] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[384.055278] Starting dynamic subtest: pipe-A-plane-5
[384.059461] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[385.187915] Starting dynamic subtest: pipe-B-plane-0
[385.491333] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[385.502372] Starting dynamic subtest: pipe-B-plane-3
[385.725364] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[385.733672] Starting dynamic subtest: pipe-B-plane-5
[385.737686] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[386.050518] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.554s)
[386.878940] [104/133] (635s left) gem_workarounds (suspend-resume)
[386.963707] Starting subtest: suspend-resume
[402.392507] Subtest suspend-resume: SUCCESS (2.077s)
[402.537246] [105/133] (619s left) gem_ctx_shared (q-in-order)
[402.609837] Starting subtest: Q-in-order
[402.612146] Starting dynamic subtest: rcs0
[402.707132] Dynamic subtest rcs0: SUCCESS (0.099s)
[402.717921] Starting dynamic subtest: vcs0
[402.791955] Dynamic subtest vcs0: SUCCESS (0.084s)
[402.807710] Starting dynamic subtest: vcs1
[402.871856] Dynamic subtest vcs1: SUCCESS (0.076s)
[402.890829] Starting dynamic subtest: vecs0
[402.950510] Dynamic subtest vecs0: SUCCESS (0.074s)
[402.966849] Starting dynamic subtest: ccs0
[403.030914] Dynamic subtest ccs0: SUCCESS (0.077s)
[403.033720] Subtest Q-in-order: SUCCESS (0.416s)
[404.388821] [106/133] (617s left) kms_cursor_crc (cursor-random-512x170)
[404.680692] Starting subtest: cursor-random-512x170
[404.685501] Subtest cursor-random-512x170: SKIP (0.001s)
[404.873162] [107/133] (617s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[404.986072] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[404.990153] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[405.083802] [108/133] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[405.183248] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[413.832703] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.507s)
[413.949409] [109/133] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[414.052457] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[414.056791] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[414.142136] [110/133] (608s left) gem_ctx_persistence (engines-mixed-process)
[414.205386] Starting subtest: engines-mixed-process
[414.207663] Starting dynamic subtest: rcs0
[416.265587] Dynamic subtest rcs0: SUCCESS (2.044s)
[416.276308] Starting dynamic subtest: bcs0
[418.247028] Dynamic subtest bcs0: SUCCESS (1.967s)
[418.258774] Starting dynamic subtest: vcs0
[420.314866] Dynamic subtest vcs0: SUCCESS (2.057s)
[420.327273] Starting dynamic subtest: vcs1
[422.222783] Dynamic subtest vcs1: SUCCESS (1.899s)
[422.234884] Starting dynamic subtest: vecs0
[424.241715] Dynamic subtest vecs0: SUCCESS (2.008s)
[424.252299] Starting dynamic subtest: ccs0
[426.223561] Dynamic subtest ccs0: SUCCESS (1.977s)
[426.225937] Subtest engines-mixed-process: SUCCESS (11.960s)
[426.344044] [111/133] (596s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[426.407137] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[426.411432] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[426.593582] [112/133] (595s left) i915_pm_freq_mult (media-freq)
[426.656403] Starting subtest: media-freq
[426.658858] Starting dynamic subtest: gt0
[426.663482] Dynamic subtest gt0: SKIP (0.000s)
[426.674988] Starting dynamic subtest: gt1
[426.679300] Dynamic subtest gt1: SKIP (0.000s)
[426.683624] Subtest media-freq: SKIP (0.001s)
[426.766998] [113/133] (595s left) perf_pmu (idle)
[426.804414] Starting subtest: idle
[426.806614] Starting dynamic subtest: rcs0
[427.350817] Dynamic subtest rcs0: SUCCESS (0.546s)
[427.363695] Starting dynamic subtest: bcs0
[427.867868] Dynamic subtest bcs0: SUCCESS (0.513s)
[427.880393] Starting dynamic subtest: vcs0
[428.385266] Dynamic subtest vcs0: SUCCESS (0.513s)
[428.398438] Starting dynamic subtest: vcs1
[428.902278] Dynamic subtest vcs1: SUCCESS (0.513s)
[428.914434] Starting dynamic subtest: vecs0
[429.418765] Dynamic subtest vecs0: SUCCESS (0.513s)
[429.431223] Starting dynamic subtest: ccs0
[429.942870] Dynamic subtest ccs0: SUCCESS (0.520s)
[429.945708] Subtest idle: SUCCESS (3.136s)
[430.047311] [114/133] (592s left) sw_sync (timeline_closed_signaled)
[430.084958] Starting subtest: timeline_closed_signaled
[430.087180] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[430.150589] [115/133] (592s left) kms_addfb_basic (bad-pitch-0)
[430.202656] Starting subtest: bad-pitch-0
[430.204716] Subtest bad-pitch-0: SUCCESS (0.000s)
[430.346220] [116/133] (592s left) gem_exec_schedule (pi-ringfull)
[430.533181] Starting subtest: pi-ringfull
[430.535230] Starting dynamic subtest: rcs0
[430.559683] Dynamic subtest rcs0: SUCCESS (0.029s)
[430.575235] Starting dynamic subtest: bcs0
[430.588638] Dynamic subtest bcs0: SUCCESS (0.028s)
[430.602127] Starting dynamic subtest: vcs0
[430.616920] Dynamic subtest vcs0: SUCCESS (0.027s)
[430.629801] Starting dynamic subtest: vcs1
[430.645102] Dynamic subtest vcs1: SUCCESS (0.027s)
[430.658302] Starting dynamic subtest: vecs0
[430.672979] Dynamic subtest vecs0: SUCCESS (0.027s)
[430.684697] Starting dynamic subtest: ccs0
[430.701334] Dynamic subtest ccs0: SUCCESS (0.027s)
[430.703609] Subtest pi-ringfull: SUCCESS (0.171s)
[430.936045] [117/133] (591s left) api_intel_bb (intel-bb-blit-x)
[430.993512] Starting subtest: intel-bb-blit-x
[434.712906] Subtest intel-bb-blit-x: SUCCESS (3.715s)
[434.879710] [118/133] (587s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[435.039088] Starting subtest: dp-mst-type-0-suspend-resume
[435.043412] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[435.157709] [119/133] (587s left) perf (per-context-mode-unprivileged)
[435.255560] Starting subtest: per-context-mode-unprivileged
[435.260073] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[435.299311] [120/133] (587s left) kms_dsc (dsc-with-bpc-formats)
[435.389895] Starting subtest: dsc-with-bpc-formats
[435.499282] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[435.539513] [121/133] (587s left) vgem_basic (bad-pad)
[435.587680] Starting subtest: bad-pad
[435.589975] Subtest bad-pad: SUCCESS (0.000s)
[435.647870] [122/133] (587s left) syncobj_timeline (wait-all-interrupted)
[435.696787] Starting subtest: wait-all-interrupted
[435.799794] Subtest wait-all-interrupted: SUCCESS (0.103s)
[435.876080] [123/133] (587s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[435.965725] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[435.967589] Starting dynamic subtest: pipe-A-eDP-1
[435.987305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[435.998129] Starting dynamic subtest: pipe-B-eDP-1
[436.018099] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[436.027594] Starting dynamic subtest: pipe-C-eDP-1
[436.046952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[436.056432] Starting dynamic subtest: pipe-D-eDP-1
[436.075563] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[436.077755] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[438.263317] [124/133] (584s left) kms_prime (basic-crc-vgem)
[438.359986] Starting subtest: basic-crc-vgem
[438.362229] Starting dynamic subtest: second-to-first
[439.294530] Dynamic subtest second-to-first: SUCCESS (0.938s)
[439.296457] Subtest basic-crc-vgem: SUCCESS (0.939s)
[439.397575] [125/133] (583s left) kms_vrr (flip-basic-fastset)
[439.483800] Starting subtest: flip-basic-fastset
[439.488949] Subtest flip-basic-fastset: SKIP (0.000s)
[439.559140] [126/133] (583s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[439.656059] Starting subtest: fbc-psr2-sprite-plane-onoff
[439.657927] Starting dynamic subtest: eDP-1
[439.661327] Dynamic subtest eDP-1: SKIP (0.000s)
[439.664785] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[439.751966] [127/133] (583s left) i915_drm_fdinfo (busy-idle)
[439.791657] Starting subtest: busy-idle
[439.793360] Starting dynamic subtest: rcs0
[439.825386] Dynamic subtest rcs0: SKIP (0.033s)
[439.837208] Starting dynamic subtest: bcs0
[439.840731] Dynamic subtest bcs0: SKIP (0.000s)
[439.849952] Starting dynamic subtest: vcs0
[439.853510] Dynamic subtest vcs0: SKIP (0.000s)
[439.862345] Starting dynamic subtest: vcs1
[439.865657] Dynamic subtest vcs1: SKIP (0.000s)
[439.876621] Starting dynamic subtest: vecs0
[439.880337] Dynamic subtest vecs0: SKIP (0.000s)
[439.889013] Starting dynamic subtest: ccs0
[439.892395] Dynamic subtest ccs0: SKIP (0.000s)
[439.895727] Subtest busy-idle: SKIP (0.039s)
[439.931981] [128/133] (583s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[440.026088] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[443.773643] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.748s)
[444.984286] [129/133] (578s left) gem_exec_parallel (contexts)
[445.047587] Starting subtest: contexts
[445.049725] Starting dynamic subtest: rcs0
[448.800523] Dynamic subtest rcs0: SUCCESS (3.750s)
[448.810963] Starting dynamic subtest: bcs0
[452.950693] Dynamic subtest bcs0: SUCCESS (4.146s)
[452.961898] Starting dynamic subtest: vcs0
[456.742405] Dynamic subtest vcs0: SUCCESS (3.788s)
[456.756065] Starting dynamic subtest: vcs1
[462.622673] Dynamic subtest vcs1: SUCCESS (5.876s)
[462.635457] Starting dynamic subtest: vecs0
[466.842203] Dynamic subtest vecs0: SUCCESS (4.215s)
[466.851634] Starting dynamic subtest: ccs0
[470.931391] Dynamic subtest ccs0: SUCCESS (4.084s)
[470.934273] Subtest contexts: SUCCESS (25.871s)
[471.116552] [130/133] (552s left) api_intel_bb (crc32)
[471.163896] Starting subtest: crc32
[471.166116] Starting dynamic subtest: rcs0-smem0
[471.456015] Dynamic subtest rcs0-smem0: SUCCESS (0.292s)
[471.473768] Starting dynamic subtest: bcs0-smem0
[471.787015] Dynamic subtest bcs0-smem0: SUCCESS (0.329s)
[471.798499] Starting dynamic subtest: vcs0-smem0
[472.207768] Dynamic subtest vcs0-smem0: SUCCESS (0.416s)
[472.223713] Starting dynamic subtest: vcs1-smem0
[472.538866] Dynamic subtest vcs1-smem0: SUCCESS (0.329s)
[472.549738] Starting dynamic subtest: vecs0-smem0
[472.864758] Dynamic subtest vecs0-smem0: SUCCESS (0.323s)
[472.875756] Starting dynamic subtest: ccs0-smem0
[473.236415] Dynamic subtest ccs0-smem0: SUCCESS (0.369s)
[473.239268] Subtest crc32: SUCCESS (2.074s)
[473.377036] [131/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[473.490928] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[473.495148] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[473.571511] [132/133] (549s left) kms_chamelium_edid (hdmi-edid-read)
[473.961525] Subtest hdmi-edid-read: SKIP (0.000s)
[474.776672] [133/133] (548s left) syncobj_timeline (signal)
[474.830466] Starting subtest: signal
[474.832447] Subtest signal: SUCCESS (0.000s)
[474.929044] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: gem_wait
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: i915_pm_rps
results: parsing output: 15/ for test: i915_fb_tiling
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: gem_create
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_exec_capture
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_scaling_modes
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: gem_barrier_race
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: kms_pipe_crc_basic
results: parsing output: 50/ for test: kms_dp_link_training
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: gem_exec_flush
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_invalid_mode
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_pm_lpsp
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: dumb_buffer
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_spin_batch
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_plane_multiple
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: gen7_exec_parse
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: gem_ctx_shared
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: i915_pm_freq_mult
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: sw_sync
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_prime
results: parsing output: 124/ for test: kms_vrr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_parallel
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: syncobj_timeline
Done.