[59.690085] Initializing watchdogs
[59.690134]   /dev/watchdog0
[59.705292] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.710782] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.713372] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.715249] [001/133] (960s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[59.843906] Starting subtest: short-flip-after-cursor-atomic-transitions
[60.858429] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.011s)
[61.702211] [002/133] (958s left) gem_exec_parallel (fds)
[61.774833] Starting subtest: fds
[61.775887] Starting dynamic subtest: rcs0
[64.216631] Dynamic subtest rcs0: SUCCESS (2.436s)
[64.225342] Starting dynamic subtest: bcs0
[67.798567] Dynamic subtest bcs0: SUCCESS (3.568s)
[67.807184] Starting dynamic subtest: vcs0
[72.203719] Dynamic subtest vcs0: SUCCESS (4.401s)
[72.211396] Starting dynamic subtest: vcs1
[76.190385] Dynamic subtest vcs1: SUCCESS (3.984s)
[76.200893] Starting dynamic subtest: vecs0
[80.167858] Dynamic subtest vecs0: SUCCESS (3.976s)
[80.174452] Starting dynamic subtest: ccs0
[83.735766] Dynamic subtest ccs0: SUCCESS (3.565s)
[83.738552] Subtest fds: SUCCESS (21.936s)
[83.908310] [003/133] (936s left) kms_flip (modeset-vs-vblank-race)
[84.001456] Starting subtest: modeset-vs-vblank-race
[84.002380] Starting dynamic subtest: A-eDP1
[88.710138] Dynamic subtest A-eDP1: SUCCESS (4.707s)
[88.718262] Starting dynamic subtest: B-eDP1
[93.439827] Dynamic subtest B-eDP1: SUCCESS (4.727s)
[93.449919] Starting dynamic subtest: C-eDP1
[98.122939] Dynamic subtest C-eDP1: SUCCESS (4.681s)
[98.131401] Starting dynamic subtest: D-eDP1
[102.746613] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[102.750537] Subtest modeset-vs-vblank-race: SUCCESS (18.749s)
[103.904387] [004/133] (916s left) gem_madvise (dontneed-before-pwrite)
[103.937306] Starting subtest: dontneed-before-pwrite
[103.959603] Subtest dontneed-before-pwrite: SKIP (0.021s)
[104.016241] [005/133] (916s left) kms_flip (bo-too-big)
[104.110268] Starting subtest: bo-too-big
[104.111160] Starting dynamic subtest: A-eDP1
[105.463359] Dynamic subtest A-eDP1: SUCCESS (1.352s)
[105.471487] Starting dynamic subtest: B-eDP1
[106.816237] Dynamic subtest B-eDP1: SUCCESS (1.350s)
[106.825359] Starting dynamic subtest: C-eDP1
[108.146311] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[108.152542] Starting dynamic subtest: D-eDP1
[109.475962] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[109.477226] Subtest bo-too-big: SUCCESS (5.368s)
[110.668265] [006/133] (909s left) kms_vrr (flip-basic-fastset)
[110.751797] Starting subtest: flip-basic-fastset
[110.754433] Subtest flip-basic-fastset: SKIP (0.000s)
[110.821610] [007/133] (909s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[110.911505] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[111.715288] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.804s)
[111.880948] [008/133] (908s left) kms_plane_lowres (tiling-4)
[111.968903] Starting subtest: tiling-4
[111.969834] Starting dynamic subtest: pipe-A-eDP-1
[111.971677] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[112.265263] Starting dynamic subtest: pipe-B-eDP-1
[112.267383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.277590] Starting dynamic subtest: pipe-C-eDP-1
[112.279499] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.285721] Starting dynamic subtest: pipe-D-eDP-1
[112.287762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.289582] Subtest tiling-4: SKIP (0.295s)
[113.096741] [009/133] (907s left) gem_busy (parallel)
[113.280404] Starting subtest: parallel
[113.281402] Starting dynamic subtest: rcs0
[114.910781] Dynamic subtest rcs0: SUCCESS (1.625s)
[114.919269] Starting dynamic subtest: bcs0
[116.896066] Dynamic subtest bcs0: SUCCESS (1.983s)
[116.905186] Starting dynamic subtest: vcs0
[118.943241] Dynamic subtest vcs0: SUCCESS (2.046s)
[118.952307] Starting dynamic subtest: vcs1
[120.927738] Dynamic subtest vcs1: SUCCESS (1.983s)
[120.937189] Starting dynamic subtest: vecs0
[122.910549] Dynamic subtest vecs0: SUCCESS (1.981s)
[122.919555] Starting dynamic subtest: ccs0
[124.895325] Dynamic subtest ccs0: SUCCESS (1.983s)
[124.896662] Subtest parallel: SUCCESS (11.611s)
[125.121171] [010/133] (895s left) syncobj_timeline (signal-point-0)
[125.175830] Starting subtest: signal-point-0
[125.177262] Subtest signal-point-0: SUCCESS (0.000s)
[125.265403] [011/133] (895s left) gem_exec_fence (syncobj-signal)
[125.758109] Starting subtest: syncobj-signal
[125.767339] Subtest syncobj-signal: SUCCESS (0.010s)
[127.020996] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[127.022920] [012/133] (893s left) gem_exec_balancer (noheartbeat)
[127.296350] Starting subtest: noheartbeat
[127.297893] Subtest noheartbeat: SKIP (0.000s)
[127.384963] [013/133] (893s left) kms_cursor_crc (cursor-sliding-256x256)
[127.641319] Starting subtest: cursor-sliding-256x256
[127.644239] Starting dynamic subtest: pipe-A-eDP-1
[130.919143] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.274s)
[130.946170] Starting dynamic subtest: pipe-D-eDP-1
[134.794531] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.854s)
[134.795523] Subtest cursor-sliding-256x256: SUCCESS (7.152s)
[135.654734] [014/133] (884s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[135.767379] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[135.769092] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[135.908295] [015/133] (884s left) kms_color (degamma)
[135.995425] Starting subtest: degamma
[135.996431] Starting dynamic subtest: pipe-A-eDP-1
[136.728067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[136.735158] Starting dynamic subtest: pipe-B-eDP-1
[138.189772] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[138.196408] Starting dynamic subtest: pipe-C-eDP-1
[139.570914] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[139.577332] Starting dynamic subtest: pipe-D-eDP-1
[140.901565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[140.902454] Subtest degamma: SUCCESS (4.907s)
[141.709806] [016/133] (879s left) kms_psr (psr-dpms)
[141.802499] Starting subtest: psr-dpms
[141.803379] Starting dynamic subtest: eDP-1
[144.751281] Dynamic subtest eDP-1: SUCCESS (2.949s)
[144.752017] Subtest psr-dpms: SUCCESS (2.949s)
[145.628729] [017/133] (875s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[145.677145] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[145.784797] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[145.867844] [018/133] (874s left) sriov_basic (bind-unbind-vf)
[145.914456] Starting subtest: bind-unbind-vf
[145.915306] Starting dynamic subtest: vf-1
[145.941571] Dynamic subtest vf-1: FAIL (0.009s)
[145.948721] Starting dynamic subtest: vf-2
[145.975898] Dynamic subtest vf-2: FAIL (0.004s)
[145.983264] Starting dynamic subtest: vf-3
[146.009620] Dynamic subtest vf-3: FAIL (0.004s)
[146.015954] Starting dynamic subtest: vf-4
[146.041729] Dynamic subtest vf-4: FAIL (0.004s)
[146.048135] Starting dynamic subtest: vf-5
[146.074842] Dynamic subtest vf-5: FAIL (0.004s)
[146.081342] Starting dynamic subtest: vf-6
[146.106692] Dynamic subtest vf-6: FAIL (0.004s)
[146.113102] Starting dynamic subtest: vf-7
[146.138161] Dynamic subtest vf-7: FAIL (0.004s)
[146.144379] Starting dynamic subtest: vf-random
[146.169512] Dynamic subtest vf-random: FAIL (0.004s)
[146.176755] Starting dynamic subtest: vf-last
[146.212359] Dynamic subtest vf-last: FAIL (0.004s)
[146.213311] Subtest bind-unbind-vf: FAIL (0.045s)
[146.241503] [019/133] (874s left) gem_exec_reloc (basic-gtt)
[146.304216] Subtest basic-gtt: SKIP (0.000s)
[146.373531] [020/133] (874s left) kms_psr (fbc-psr2-primary-page-flip)
[146.461272] Starting subtest: fbc-psr2-primary-page-flip
[146.462066] Starting dynamic subtest: eDP-1
[146.463801] Dynamic subtest eDP-1: SKIP (0.000s)
[146.465428] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[146.586943] [021/133] (874s left) gem_madvise (dontneed-before-exec)
[146.621546] Starting subtest: dontneed-before-exec
[146.640231] Subtest dontneed-before-exec: SKIP (0.019s)
[146.731204] [022/133] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[146.819767] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[146.821433] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[146.920573] [023/133] (874s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[146.975999] Starting subtest: yf-tiled-to-vebox-y-tiled
[146.977755] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[147.167731] [024/133] (873s left) gem_lmem_swapping (verify-random-ccs)
[147.202980] Subtest verify-random-ccs: SKIP (0.000s)
[147.260576] [025/133] (873s left) gem_create (create-ext-cpu-access-sanity-check)
[147.421014] Starting subtest: create-ext-cpu-access-sanity-check
[147.423942] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[147.501817] [026/133] (873s left) gem_exec_capture (pi)
[147.549962] Starting subtest: pi
[147.550991] Starting dynamic subtest: rcs0
[152.081305] Dynamic subtest rcs0: SUCCESS (4.531s)
[152.092342] Starting dynamic subtest: bcs0
[156.267123] Dynamic subtest bcs0: SUCCESS (4.183s)
[156.277103] Starting dynamic subtest: vcs0
[160.506264] Dynamic subtest vcs0: SUCCESS (4.238s)
[160.516410] Starting dynamic subtest: vcs1
[164.787371] Dynamic subtest vcs1: SUCCESS (4.279s)
[164.797738] Starting dynamic subtest: vecs0
[169.026249] Dynamic subtest vecs0: SUCCESS (4.237s)
[169.036379] Starting dynamic subtest: ccs0
[173.240767] Dynamic subtest ccs0: SUCCESS (4.212s)
[173.242017] Subtest pi: SUCCESS (25.691s)
[173.324211] [027/133] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[173.469307] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[180.803661] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.335s)
[180.936474] [028/133] (840s left) kms_psr (psr2-primary-mmap-cpu)
[181.029064] Starting subtest: psr2-primary-mmap-cpu
[181.029840] Starting dynamic subtest: eDP-1
[182.741592] Dynamic subtest eDP-1: SUCCESS (1.712s)
[182.742510] Subtest psr2-primary-mmap-cpu: SUCCESS (1.713s)
[183.616532] [029/133] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[183.707079] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[183.708848] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[183.785718] [030/133] (837s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[183.895567] Starting subtest: yf-tiled-8bpp-rotate-270
[183.897641] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[184.013477] [031/133] (837s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[184.066640] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[184.168201] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[184.238937] [032/133] (837s left) gem_ctx_shared (detached-shared-gtt)
[184.295582] Starting subtest: detached-shared-gtt
[186.447017] Subtest detached-shared-gtt: SUCCESS (2.151s)
[186.855760] [033/133] (834s left) gem_exec_gttfill (engines)
[186.910678] Starting subtest: engines
[186.911791] Starting dynamic subtest: rcs0
[210.267474] Dynamic subtest rcs0: SUCCESS (23.355s)
[210.277802] Starting dynamic subtest: bcs0
[233.687661] Dynamic subtest bcs0: SUCCESS (23.408s)
[233.694991] Starting dynamic subtest: vcs0
[257.053739] Dynamic subtest vcs0: SUCCESS (23.373s)
[257.063730] Starting dynamic subtest: vcs1
[280.384833] Dynamic subtest vcs1: SUCCESS (23.329s)
[280.394952] Starting dynamic subtest: vecs0
[303.793599] Dynamic subtest vecs0: SUCCESS (23.404s)
[303.804926] Starting dynamic subtest: ccs0
[327.153771] Dynamic subtest ccs0: SUCCESS (23.355s)
[327.156573] Subtest engines: SUCCESS (140.238s)
[327.341252] [034/133] (694s left) gen9_exec_parse (batch-without-end)
[327.428713] Subtest batch-without-end: SKIP (0.000s)
[327.490640] [035/133] (694s left) kms_pipe_stress (stress-xrgb8888-untiled)
[327.585775] Starting subtest: stress-xrgb8888-untiled
[333.612396] Subtest stress-xrgb8888-untiled: SUCCESS (6.026s)
[333.669918] [036/133] (687s left) prime_vgem (fence-flip-hang)
[333.752928] Subtest fence-flip-hang: SKIP (0.000s)
[333.836940] [037/133] (687s left) gem_exec_schedule (pi-common)
[334.024083] Starting subtest: pi-common
[334.024959] Starting dynamic subtest: rcs0
[334.067293] Dynamic subtest rcs0: SUCCESS (0.049s)
[334.074771] Starting dynamic subtest: bcs0
[334.116303] Dynamic subtest bcs0: SUCCESS (0.048s)
[334.124111] Starting dynamic subtest: vcs0
[334.156880] Dynamic subtest vcs0: SUCCESS (0.040s)
[334.164186] Starting dynamic subtest: vcs1
[334.192159] Dynamic subtest vcs1: SUCCESS (0.034s)
[334.199275] Starting dynamic subtest: vecs0
[334.223922] Dynamic subtest vecs0: SUCCESS (0.031s)
[334.231127] Starting dynamic subtest: ccs0
[334.253518] Dynamic subtest ccs0: SUCCESS (0.029s)
[334.254407] Subtest pi-common: SUCCESS (0.236s)
[334.481417] [038/133] (687s left) gem_exec_suspend (basic-s3-devices)
[334.537695] Starting subtest: basic-S3-devices
[334.538877] Starting dynamic subtest: smem
[345.885040] Dynamic subtest smem: SUCCESS (11.337s)
[345.886112] Subtest basic-S3-devices: SUCCESS (11.339s)
[353.077995] [039/133] (675s left) gem_exec_schedule (u-fairslice-all)
[353.154250] Starting subtest: u-fairslice-all
[355.235189] Subtest u-fairslice-all: SUCCESS (2.081s)
[355.543632] [040/133] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[355.637170] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[363.195730] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.559s)
[363.304559] [041/133] (665s left) kms_debugfs (display-on-read-all)
[363.391391] Starting subtest: display-on-read-all
[363.557077] Subtest display-on-read-all: SUCCESS (0.166s)
[363.662879] [042/133] (665s left) gem_watchdog (default-physical)
[363.718797] Starting subtest: default-physical
[365.483028] Subtest default-physical: SUCCESS (1.766s)
[365.593295] [043/133] (663s left) kms_joiner (basic-big-joiner)
[365.677361] Starting subtest: basic-big-joiner
[365.678969] Subtest basic-big-joiner: SKIP (0.000s)
[365.746741] [044/133] (663s left) kms_sequence (get-busy)
[365.838742] Starting subtest: get-busy
[365.839723] Starting dynamic subtest: pipe-A-eDP-1
[367.773854] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[367.783146] Starting dynamic subtest: pipe-B-eDP-1
[370.421918] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.646s)
[370.431190] Starting dynamic subtest: pipe-C-eDP-1
[373.029206] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[373.037226] Starting dynamic subtest: pipe-D-eDP-1
[375.671028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.640s)
[375.671843] Subtest get-busy: SUCCESS (9.832s)
[376.471881] [045/133] (652s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[376.562655] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[376.590298] Starting dynamic subtest: pipe-A-plane-0
[376.890031] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[376.897939] Starting dynamic subtest: pipe-A-plane-3
[377.123371] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[377.132841] Starting dynamic subtest: pipe-A-plane-5
[377.134525] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[378.248256] Starting dynamic subtest: pipe-B-plane-0
[378.552024] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[378.562318] Starting dynamic subtest: pipe-B-plane-3
[378.785245] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[378.792989] Starting dynamic subtest: pipe-B-plane-5
[378.794748] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[379.096337] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.534s)
[379.915728] [046/133] (649s left) syncobj_eventfd (timeline-wait-signaled)
[379.971107] Starting subtest: timeline-wait-signaled
[379.971923] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[380.063681] [047/133] (648s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[380.157870] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[380.159548] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[380.247789] [048/133] (648s left) gem_wait (invalid-buf)
[380.303899] Starting subtest: invalid-buf
[380.304907] Subtest invalid-buf: SUCCESS (0.000s)
[380.530450] [049/133] (648s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[380.644418] Starting subtest: flip-vs-cursor-busy-crc-legacy
[381.457773] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.813s)
[382.250869] [050/133] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[382.346708] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[389.053197] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.705s)
[389.179404] [051/133] (639s left) kms_plane_scaling (planes-upscale-factor-0-25)
[389.278057] Starting subtest: planes-upscale-factor-0-25
[389.279091] Starting dynamic subtest: pipe-A
[389.340376] Dynamic subtest pipe-A: SUCCESS (0.062s)
[389.351518] Starting dynamic subtest: pipe-B
[390.485501] Dynamic subtest pipe-B: SUCCESS (1.143s)
[390.496714] Starting dynamic subtest: pipe-C
[391.591962] Dynamic subtest pipe-C: SUCCESS (1.104s)
[391.603924] Starting dynamic subtest: pipe-D
[392.735021] Dynamic subtest pipe-D: SUCCESS (1.142s)
[392.735999] Subtest planes-upscale-factor-0-25: SUCCESS (3.457s)
[393.880729] [052/133] (635s left) kms_pm_backlight (fade)
[393.980407] Starting subtest: fade
[394.029530] Starting dynamic subtest: eDP-1
[396.513020] Dynamic subtest eDP-1: SUCCESS (2.484s)
[396.513986] Subtest fade: SUCCESS (2.533s)
[397.320405] [053/133] (631s left) perf_pmu (render-node-busy)
[397.401861] Starting subtest: render-node-busy
[397.402930] Starting dynamic subtest: rcs0
[397.989880] Dynamic subtest rcs0: SUCCESS (0.587s)
[398.002879] Starting dynamic subtest: bcs0
[398.564941] Dynamic subtest bcs0: SUCCESS (0.573s)
[398.577640] Starting dynamic subtest: vcs0
[399.892464] Dynamic subtest vcs0: SUCCESS (1.325s)
[399.905018] Starting dynamic subtest: vcs1
[401.886344] Dynamic subtest vcs1: SUCCESS (1.981s)
[401.897582] Starting dynamic subtest: vecs0
[403.934338] Dynamic subtest vecs0: SUCCESS (2.045s)
[403.945726] Starting dynamic subtest: ccs0
[404.487821] Dynamic subtest ccs0: SUCCESS (0.561s)
[404.489404] Subtest render-node-busy: SUCCESS (7.086s)
[404.559556] [054/133] (624s left) i915_query (engine-info)
[404.610417] Starting subtest: engine-info
[404.613692] Subtest engine-info: SUCCESS (0.004s)
[404.737790] [055/133] (624s left) core_getversion (basic)
[404.781612] Starting subtest: basic
[404.783559] Subtest basic: SUCCESS (0.000s)
[404.846639] [056/133] (624s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[404.946920] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[404.948840] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[405.017278] [057/133] (624s left) gem_ctx_persistence (engines-persistence)
[405.087281] Starting subtest: engines-persistence
[405.088211] Starting dynamic subtest: rcs0
[405.912461] Dynamic subtest rcs0: SUCCESS (0.824s)
[405.925298] Starting dynamic subtest: bcs0
[406.655107] Dynamic subtest bcs0: SUCCESS (0.737s)
[406.665031] Starting dynamic subtest: vcs0
[407.422712] Dynamic subtest vcs0: SUCCESS (0.766s)
[407.432741] Starting dynamic subtest: vcs1
[408.207366] Dynamic subtest vcs1: SUCCESS (0.784s)
[408.219261] Starting dynamic subtest: vecs0
[408.979339] Dynamic subtest vecs0: SUCCESS (0.770s)
[408.991221] Starting dynamic subtest: ccs0
[409.753658] Dynamic subtest ccs0: SUCCESS (0.772s)
[409.754757] Subtest engines-persistence: SUCCESS (4.667s)
[409.833099] [058/133] (619s left) gem_exec_whisper (basic-contexts-priority-all)
[409.905736] Starting subtest: basic-contexts-priority-all
[433.185879] Subtest basic-contexts-priority-all: SUCCESS (23.270s)
[433.364204] [059/133] (596s left) kms_atomic (plane-immutable-zpos)
[433.458082] Starting subtest: plane-immutable-zpos
[433.458889] Starting dynamic subtest: pipe-A-eDP-1
[434.099910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[434.100671] Subtest plane-immutable-zpos: SUCCESS (0.642s)
[434.930765] [060/133] (594s left) kms_vrr (seamless-rr-switch-drrs)
[435.020347] Starting subtest: seamless-rr-switch-drrs
[435.022921] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[435.091543] [061/133] (594s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[435.150647] Starting subtest: yf-tiled-ccs-to-x-tiled
[435.152587] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[435.339399] [062/133] (594s left) syncobj_wait (invalid-reset-one-illegal-handle)
[435.397761] Starting subtest: invalid-reset-one-illegal-handle
[435.398859] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[435.497094] [063/133] (594s left) i915_drm_fdinfo (virtual-busy-hang-all)
[435.532603] Starting subtest: virtual-busy-hang-all
[435.534391] Subtest virtual-busy-hang-all: SKIP (0.000s)
[435.598930] [064/133] (593s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[435.689011] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[442.819990] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.131s)
[442.904590] [065/133] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[442.999689] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[443.001426] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.099192] [066/133] (586s left) kms_psr (fbc-psr2-sprite-render)
[443.187475] Starting subtest: fbc-psr2-sprite-render
[443.188346] Starting dynamic subtest: eDP-1
[443.189831] Dynamic subtest eDP-1: SKIP (0.000s)
[443.191570] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[443.261468] [067/133] (586s left) gem_userptr_blits (readonly-pwrite-unsync)
[443.317350] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[443.447453] [068/133] (586s left) gem_eio (reset-stress)
[443.680467] Starting subtest: reset-stress
[443.681695] Starting dynamic subtest: render
[448.909414] Dynamic subtest render: SUCCESS (5.227s)
[448.919342] Starting dynamic subtest: bsd1
[467.437436] Dynamic subtest bsd1: SUCCESS (18.527s)
[467.447040] Starting dynamic subtest: bsd2
[485.450860] Dynamic subtest bsd2: SUCCESS (18.011s)
[485.466581] Starting dynamic subtest: blt
[485.468708] Dynamic subtest blt: SKIP (0.000s)
[485.477278] Starting dynamic subtest: vebox
[503.570713] Dynamic subtest vebox: SUCCESS (18.118s)
[503.572026] Subtest reset-stress: SUCCESS (59.888s)
[504.888027] [069/133] (524s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[505.004095] Starting subtest: flip-vs-cursor-atomic
[512.653836] Subtest flip-vs-cursor-atomic: SUCCESS (7.650s)
[513.447269] [070/133] (516s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[513.536869] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[513.537958] Starting dynamic subtest: pipe-A-eDP-1
[530.004594] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.467s)
[530.014583] Starting dynamic subtest: pipe-B-eDP-1
[547.218591] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.211s)
[547.219493] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.682s)
[548.031345] [071/133] (481s left) kms_addfb_basic (invalid-set-prop-any)
[548.074333] Starting subtest: invalid-set-prop-any
[548.075200] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[548.199763] [072/133] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[548.286412] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[548.288108] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[548.396775] [073/133] (481s left) kms_chamelium_color (ctm-green-to-red)
[548.484691] Subtest ctm-green-to-red: SKIP (0.000s)
[548.527427] [074/133] (481s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[548.604530] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[548.605372] Starting dynamic subtest: pipe-A-eDP-1
[548.608577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[548.617069] Starting dynamic subtest: pipe-B-eDP-1
[548.620351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[548.633462] Starting dynamic subtest: pipe-C-eDP-1
[548.636754] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[548.645173] Starting dynamic subtest: pipe-D-eDP-1
[548.648343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[548.649831] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[550.867651] [075/133] (479s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[550.960746] Starting subtest: fbc-rgb565-draw-mmap-wc
[555.078559] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.118s)
[556.269983] [076/133] (473s left) kms_addfb_basic (legacy-format)
[556.315060] Starting subtest: legacy-format
[556.338480] Subtest legacy-format: SUCCESS (0.023s)
[556.476986] [077/133] (473s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[556.583352] Starting subtest: y-tiled-16bpp-rotate-270
[556.585194] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[556.682327] [078/133] (473s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[556.774154] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[557.908719] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.135s)
[558.028790] [079/133] (472s left) gem_workarounds (basic-read-context)
[558.093753] Starting subtest: basic-read-context
[558.111316] Subtest basic-read-context: SUCCESS (0.018s)
[558.233388] [080/133] (471s left) sysfs_timeslice_duration (idempotent)
[558.291741] Starting subtest: idempotent
[558.292719] Starting dynamic subtest: vecs0
[558.293676] Dynamic subtest vecs0: SUCCESS (0.000s)
[558.303208] Starting dynamic subtest: ccs0
[558.304039] Dynamic subtest ccs0: SUCCESS (0.000s)
[558.312312] Starting dynamic subtest: vcs0
[558.313200] Dynamic subtest vcs0: SUCCESS (0.000s)
[558.321657] Starting dynamic subtest: bcs0
[558.322555] Dynamic subtest bcs0: SUCCESS (0.000s)
[558.330786] Starting dynamic subtest: rcs0
[558.331698] Dynamic subtest rcs0: SUCCESS (0.000s)
[558.339950] Starting dynamic subtest: vcs1
[558.340873] Dynamic subtest vcs1: SUCCESS (0.000s)
[558.341783] Subtest idempotent: SUCCESS (0.006s)
[558.391750] [081/133] (471s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[558.506137] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[576.348365] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.841s)
[577.185107] [082/133] (453s left) kms_psr (pr-cursor-render)
[577.267662] Starting subtest: pr-cursor-render
[577.269461] Subtest pr-cursor-render: SKIP (0.000s)
[577.352228] [083/133] (452s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[577.440642] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[577.442662] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[578.567192] [084/133] (451s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[578.656116] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[578.657887] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[578.755795] [085/133] (451s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[579.022935] Starting subtest: cursor-rapid-movement-256x85
[579.068865] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[579.242379] [086/133] (451s left) i915_drm_fdinfo (memory-info-idle)
[579.280538] Starting subtest: memory-info-idle
[579.281576] Starting dynamic subtest: smem0
[579.346049] Dynamic subtest smem0: SUCCESS (0.065s)
[579.347536] Subtest memory-info-idle: SUCCESS (0.065s)
[579.414426] [087/133] (450s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[579.467772] Starting subtest: wait-all-for-submit-delayed-submit
[579.570813] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[579.644107] [088/133] (450s left) gem_pxp (create-protected-buffer)
[579.760331] Starting subtest: create-protected-buffer
[579.761611] Subtest create-protected-buffer: SUCCESS (0.000s)
[579.874681] [089/133] (450s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[579.972548] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[579.974425] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[580.042667] [090/133] (450s left) kms_plane_scaling (invalid-num-scalers)
[580.134398] Starting subtest: invalid-num-scalers
[580.135243] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[580.153709] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[580.164031] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[580.187887] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[580.197995] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[580.222857] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[580.232595] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[580.257446] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[580.258270] Subtest invalid-num-scalers: SUCCESS (0.123s)
[580.355553] [091/133] (450s left) gem_exec_capture (userptr)
[580.409540] Starting subtest: userptr
[581.251935] Subtest userptr: SUCCESS (0.844s)
[581.364839] [092/133] (449s left) kms_draw_crc (draw-method-mmap-cpu)
[581.454375] Starting subtest: draw-method-mmap-cpu
[581.455251] Starting dynamic subtest: xrgb8888-untiled
[581.689243] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[581.700170] Starting dynamic subtest: rgb565-untiled
[581.889236] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[581.900289] Starting dynamic subtest: xrgb2101010-untiled
[582.100125] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[582.109200] Starting dynamic subtest: xbgr16161616f-untiled
[582.322569] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[582.331616] Starting dynamic subtest: xrgb8888-xtiled
[582.466937] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[582.475813] Starting dynamic subtest: rgb565-xtiled
[582.589072] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[582.598050] Starting dynamic subtest: xrgb2101010-xtiled
[582.722637] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[582.731986] Starting dynamic subtest: xbgr16161616f-xtiled
[582.844667] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[582.853988] Starting dynamic subtest: xrgb8888-4tiled
[582.989048] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[582.998897] Starting dynamic subtest: rgb565-4tiled
[583.122289] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[583.131103] Starting dynamic subtest: xrgb2101010-4tiled
[583.266860] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[583.276843] Starting dynamic subtest: xbgr16161616f-4tiled
[583.400335] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[583.401115] Subtest draw-method-mmap-cpu: SUCCESS (1.946s)
[583.481361] [093/133] (447s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[583.565242] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[583.567141] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[583.663185] [094/133] (446s left) gem_softpin (noreloc-s3)
[583.720361] Starting subtest: noreloc-S3
[604.411729] Subtest noreloc-S3: SUCCESS (5.415s)
[606.523913] [095/133] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[606.637559] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[606.639166] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[606.757196] [096/133] (425s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[606.844994] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[606.846805] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[607.944197] [097/133] (424s left) api_intel_bb (misplaced-blitter)
[607.997336] Starting subtest: misplaced-blitter
[608.004090] Subtest misplaced-blitter: SUCCESS (0.007s)
[608.112238] [098/133] (424s left) gem_exec_reloc (basic-wc-read-active)
[608.178545] Subtest basic-wc-read-active: SKIP (0.000s)
[608.241974] [099/133] (424s left) api_intel_allocator (standalone)
[608.294327] Starting subtest: standalone
[608.309835] Subtest standalone: SUCCESS (0.016s)
[608.412078] [100/133] (424s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[608.505466] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[608.507271] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[608.575277] [101/133] (424s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[608.973393] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[609.765864] [102/133] (423s left) gem_exec_reloc (basic-gtt-cpu-active)
[609.830911] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[609.908342] [103/133] (423s left) kms_rotation_crc (primary-rotation-90)
[610.008778] Starting subtest: primary-rotation-90
[610.010426] Subtest primary-rotation-90: SKIP (0.001s)
[610.080273] [104/133] (422s left) syncobj_basic (illegal-fd-to-handle)
[610.137775] Starting subtest: illegal-fd-to-handle
[610.138734] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[610.243819] [105/133] (422s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[610.334060] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[610.335964] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[610.431174] [106/133] (422s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[610.483702] Starting subtest: y-tiled-ccs-to-x-tiled
[610.486434] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[610.678397] [107/133] (422s left) kms_feature_discovery (psr2)
[610.766661] Starting subtest: psr2
[610.767502] Subtest psr2: SUCCESS (0.000s)
[610.864252] [108/133] (422s left) syncobj_wait (wait-any-interrupted)
[610.914824] Starting subtest: wait-any-interrupted
[611.018856] Subtest wait-any-interrupted: SUCCESS (0.102s)
[611.093418] [109/133] (422s left) gem_spin_batch (legacy-resubmit-new)
[611.147853] Starting subtest: legacy-resubmit-new
[611.148766] Starting dynamic subtest: default
[611.154992] Dynamic subtest default: SUCCESS (0.008s)
[611.164628] Starting dynamic subtest: render
[611.165460] Dynamic subtest render: SUCCESS (0.003s)
[611.174337] Starting dynamic subtest: bsd
[611.175274] Dynamic subtest bsd: SUCCESS (0.007s)
[611.184304] Starting dynamic subtest: bsd1
[611.185238] Dynamic subtest bsd1: SUCCESS (0.004s)
[611.193930] Starting dynamic subtest: bsd2
[611.194848] Dynamic subtest bsd2: SUCCESS (0.003s)
[611.206595] Starting dynamic subtest: blt
[611.207447] Dynamic subtest blt: SUCCESS (0.004s)
[611.216489] Starting dynamic subtest: vebox
[611.217365] Dynamic subtest vebox: SUCCESS (0.004s)
[611.218451] Subtest legacy-resubmit-new: SUCCESS (0.041s)
[613.225800] [110/133] (420s left) kms_cursor_crc (cursor-onscreen-32x10)
[613.377530] Starting subtest: cursor-onscreen-32x10
[613.421483] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[613.682891] [111/133] (419s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[613.783507] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[613.785932] Starting dynamic subtest: A-eDP1
[622.711425] Dynamic subtest A-eDP1: SUCCESS (8.887s)
[622.723263] Starting dynamic subtest: B-eDP1
[631.658135] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[631.669822] Starting dynamic subtest: C-eDP1
[640.618982] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[640.630914] Starting dynamic subtest: D-eDP1
[649.549669] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[649.550587] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.677s)
[650.753561] [112/133] (382s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[650.855483] Starting subtest: 4-tiled-addfb-size-offset-overflow
[650.856418] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[650.960838] [113/133] (382s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[651.059481] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[652.058338] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.999s)
[652.200205] [114/133] (381s left) kms_busy (extended-pageflip-hang-oldfb)
[652.304457] Starting subtest: extended-pageflip-hang-oldfb
[652.305459] Starting dynamic subtest: pipe-A
[652.696361] Dynamic subtest pipe-A: SUCCESS (0.390s)
[652.707089] Starting dynamic subtest: pipe-D
[653.880439] Dynamic subtest pipe-D: SUCCESS (1.181s)
[653.881271] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.576s)
[654.698347] [115/133] (378s left) gem_mmap_offset (partial-remap)
[654.762283] Starting subtest: partial-remap
[654.763240] Starting dynamic subtest: smem0
[654.770742] Dynamic subtest smem0: SUCCESS (0.007s)
[654.771562] Subtest partial-remap: SUCCESS (0.010s)
[654.892637] [116/133] (378s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[654.979533] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[654.980353] Starting dynamic subtest: pipe-A-eDP-1
[654.988847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[654.998193] Starting dynamic subtest: pipe-B-eDP-1
[655.007203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[655.017926] Starting dynamic subtest: pipe-C-eDP-1
[655.025945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[655.035219] Starting dynamic subtest: pipe-D-eDP-1
[655.043921] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[655.045548] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[657.175629] [117/133] (376s left) kms_lease (multimaster-lease)
[657.259947] Starting subtest: multimaster-lease
[657.262434] Subtest multimaster-lease: SUCCESS (0.003s)
[657.366828] [118/133] (376s left) gem_ctx_persistence (legacy-engines-cleanup)
[657.421000] Starting subtest: legacy-engines-cleanup
[657.422048] Starting dynamic subtest: render
[657.470548] Dynamic subtest render: SUCCESS (0.049s)
[657.481754] Starting dynamic subtest: bsd1
[657.541670] Dynamic subtest bsd1: SUCCESS (0.070s)
[657.554614] Starting dynamic subtest: bsd2
[657.582514] Dynamic subtest bsd2: SUCCESS (0.038s)
[657.593100] Starting dynamic subtest: blt
[657.626589] Dynamic subtest blt: SUCCESS (0.041s)
[657.637711] Starting dynamic subtest: vebox
[657.670484] Dynamic subtest vebox: SUCCESS (0.041s)
[657.673013] Subtest legacy-engines-cleanup: SUCCESS (0.251s)
[657.749834] [119/133] (375s left) kms_chamelium_frames (dp-crc-fast)
[658.128331] Subtest dp-crc-fast: SKIP (0.000s)
[658.986731] [120/133] (374s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[659.085103] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[666.547626] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.461s)
[666.667796] [121/133] (367s left) kms_flip (dpms-off-confusion)
[666.764238] Starting subtest: dpms-off-confusion
[666.766936] Starting dynamic subtest: A-eDP1
[675.487068] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[675.498759] Starting dynamic subtest: B-eDP1
[684.126395] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[684.137603] Starting dynamic subtest: C-eDP1
[692.755982] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[692.767003] Starting dynamic subtest: D-eDP1
[701.390520] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[701.391332] Subtest dpms-off-confusion: SUCCESS (34.581s)
[702.516991] [122/133] (331s left) gem_exec_whisper (basic-queues-priority-all)
[702.571079] Starting subtest: basic-queues-priority-all
[722.557783] Subtest basic-queues-priority-all: SUCCESS (19.980s)
[722.731907] [123/133] (311s left) syncobj_timeline (invalid-query-zero-handles)
[722.784544] Starting subtest: invalid-query-zero-handles
[722.785459] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[722.894569] [124/133] (310s left) gem_sync (basic-each)
[722.959897] Starting subtest: basic-each
[725.481602] Subtest basic-each: SUCCESS (2.522s)
[725.664487] [125/133] (308s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[725.764357] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[725.766097] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[725.834846] [126/133] (308s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[725.959391] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[725.960962] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[726.099090] [127/133] (307s left) kms_content_protection (lic-type-1)
[726.248438] Starting subtest: lic-type-1
[726.250508] Subtest lic-type-1: SKIP (0.000s)
[726.365174] [128/133] (307s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[726.452750] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[733.779244] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.326s)
[733.901277] [129/133] (300s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[733.953731] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[733.954801] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[734.043892] [130/133] (299s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[736.373361] Starting subtest: modeset-non-lpsp-stress-no-wait
[736.414751] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.041s)
[736.750375] [131/133] (297s left) i915_pm_rpm (gem-mmap-type)
[738.372980] Starting subtest: gem-mmap-type
[738.374575] Starting dynamic subtest: wb-smem0
[742.415862] Dynamic subtest wb-smem0: SUCCESS (4.045s)
[742.426576] Starting dynamic subtest: wc-smem0
[745.285995] Dynamic subtest wc-smem0: SUCCESS (2.868s)
[745.297709] Starting dynamic subtest: uc-smem0
[748.146420] Dynamic subtest uc-smem0: SUCCESS (2.858s)
[748.147397] Subtest gem-mmap-type: SUCCESS (9.776s)
[748.264624] [132/133] (285s left) gem_exec_reloc (basic-cpu-read-noreloc)
[748.327442] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[748.405876] [133/133] (285s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[748.523831] Starting subtest: 2x-long-flip-vs-cursor-atomic
[748.526760] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[748.663389] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: gem_exec_parallel
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: gem_madvise
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: gem_busy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: sriov_basic
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_madvise
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_create
results: parsing output: 25/ for test: gem_exec_capture
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: gem_exec_gttfill
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_pipe_stress
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_exec_suspend
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_debugfs
results: parsing output: 41/ for test: gem_watchdog
results: parsing output: 42/ for test: kms_joiner
results: parsing output: 43/ for test: kms_sequence
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_pm_backlight
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: core_getversion
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_atomic
results: parsing output: 59/ for test: kms_vrr
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_workarounds
results: parsing output: 79/ for test: sysfs_timeslice_duration
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: gem_exec_capture
results: parsing output: 91/ for test: kms_draw_crc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_spin_batch
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_sync
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_content_protection
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: kms_cursor_legacy
Done.