[57.100858] Initializing watchdogs
[57.100899]   /dev/watchdog0
[57.115240] [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.119808] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.122195] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.125484] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[57.243387] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[57.245665] Starting dynamic subtest: pipe-A-default-mode
[58.413746] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[58.418060] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.173s)
[58.565381] [002/133] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[58.662572] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[58.666911] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[58.792181] [003/133] (958s left) kms_dp_link_training (uhbr-sst)
[58.896251] Starting subtest: uhbr-sst
[58.904740] Subtest uhbr-sst: SKIP (0.000s)
[58.965587] [004/133] (958s left) prime_busy (after)
[59.034571] Starting subtest: after
[59.039706] Starting dynamic subtest: rcs0
[59.065794] Dynamic subtest rcs0: SUCCESS (0.027s)
[59.074833] Starting dynamic subtest: bcs0
[59.116402] Dynamic subtest bcs0: SUCCESS (0.050s)
[59.125098] Starting dynamic subtest: vcs0
[59.156909] Dynamic subtest vcs0: SUCCESS (0.040s)
[59.164606] Starting dynamic subtest: vcs1
[59.198463] Dynamic subtest vcs1: SUCCESS (0.040s)
[59.207614] Starting dynamic subtest: vecs0
[59.238095] Dynamic subtest vecs0: SUCCESS (0.040s)
[59.246065] Starting dynamic subtest: ccs0
[59.277368] Dynamic subtest ccs0: SUCCESS (0.040s)
[59.384940] Subtest after: SUCCESS (0.349s)
[59.458895] [005/133] (958s left) kms_lease (multimaster-lease)
[59.565205] Starting subtest: multimaster-lease
[59.567514] Subtest multimaster-lease: SUCCESS (0.004s)
[59.687610] [006/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[59.795290] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[59.799265] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.891306] [007/133] (957s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[59.986751] Starting subtest: blocking-absolute-wf_vblank-interruptible
[59.989124] Starting dynamic subtest: A-eDP1
[68.718297] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[68.728717] Starting dynamic subtest: B-eDP1
[77.449892] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[77.462833] Starting dynamic subtest: C-eDP1
[86.175682] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[86.183118] Starting dynamic subtest: D-eDP1
[94.902201] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[94.907388] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.937s)
[96.114188] [008/133] (921s left) syncobj_timeline (invalid-signal-bad-pad)
[96.175790] Starting subtest: invalid-signal-bad-pad
[96.177751] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[96.255698] [009/133] (921s left) gem_ctx_persistence (legacy-engines-cleanup)
[96.306225] Starting subtest: legacy-engines-cleanup
[96.308527] Starting dynamic subtest: render
[96.362478] Dynamic subtest render: SUCCESS (0.056s)
[96.371524] Starting dynamic subtest: bsd1
[96.430347] Dynamic subtest bsd1: SUCCESS (0.067s)
[96.440867] Starting dynamic subtest: bsd2
[96.475763] Dynamic subtest bsd2: SUCCESS (0.043s)
[96.485983] Starting dynamic subtest: blt
[96.521860] Dynamic subtest blt: SUCCESS (0.045s)
[96.530955] Starting dynamic subtest: vebox
[96.574959] Dynamic subtest vebox: SUCCESS (0.052s)
[96.577885] Subtest legacy-engines-cleanup: SUCCESS (0.269s)
[96.656095] [010/133] (921s left) kms_pm_rpm (i2c)
[98.175324] Starting subtest: i2c
[103.637451] Subtest i2c: SUCCESS (5.465s)
[103.719728] [011/133] (914s left) api_intel_bb (destroy-bb)
[103.777724] Starting subtest: destroy-bb
[103.783933] Subtest destroy-bb: SUCCESS (0.009s)
[103.911213] [012/133] (914s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[104.001791] Starting subtest: primary-yf-tiled-reflect-x-90
[104.006393] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[104.076908] [013/133] (914s left) gem_exec_reloc (basic-write-wc)
[104.148866] Subtest basic-write-wc: SKIP (0.000s)
[104.204229] [014/133] (913s left) gem_mmap_wc (pf-nonblock)
[104.260969] Subtest pf-nonblock: SKIP (0.000s)
[104.319752] [015/133] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[104.410854] Starting subtest: bo-too-small-due-to-tiling
[104.414951] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[104.514100] [016/133] (913s left) i915_drm_fdinfo (idle)
[104.553819] Starting subtest: idle
[104.556127] Starting dynamic subtest: rcs0
[105.105750] Dynamic subtest rcs0: SUCCESS (0.553s)
[105.115432] Starting dynamic subtest: bcs0
[105.612187] Dynamic subtest bcs0: SUCCESS (0.503s)
[105.622052] Starting dynamic subtest: vcs0
[106.117491] Dynamic subtest vcs0: SUCCESS (0.504s)
[106.127266] Starting dynamic subtest: vcs1
[106.621898] Dynamic subtest vcs1: SUCCESS (0.503s)
[106.631892] Starting dynamic subtest: vecs0
[107.127036] Dynamic subtest vecs0: SUCCESS (0.504s)
[107.137050] Starting dynamic subtest: ccs0
[107.632202] Dynamic subtest ccs0: SUCCESS (0.504s)
[107.634889] Subtest idle: SUCCESS (3.079s)
[107.705214] [017/133] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[107.760552] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[107.762790] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[107.867108] [018/133] (910s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[107.969693] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[107.981255] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[108.087220] [019/133] (910s left) dumb_buffer (create-clear)
[108.150481] Starting subtest: create-clear
[142.139373] Subtest create-clear: SUCCESS (33.985s)
[142.233658] [020/133] (876s left) gem_exec_params (no-blt)
[142.292937] Starting subtest: no-blt
[142.298052] Subtest no-blt: SUCCESS (0.005s)
[142.420341] [021/133] (875s left) perf (blocking)
[142.562338] Starting subtest: blocking
[142.565922] Starting dynamic subtest: 0-rcs0
[152.590317] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[152.598475] Starting dynamic subtest: 1-vcs0
[162.609057] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[162.611888] Subtest blocking: SUCCESS (20.043s)
[162.652769] [022/133] (855s left) perf (blocking-parameterized)
[162.738516] Starting subtest: blocking-parameterized
[182.755859] Subtest blocking-parameterized: SUCCESS (20.015s)
[182.802434] [023/133] (835s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[182.894927] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[182.897238] Starting dynamic subtest: pipe-A-default-mode
[184.072840] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[184.077117] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.177s)
[184.214576] [024/133] (834s left) gem_exec_reloc (basic-write-wc-active)
[184.277483] Subtest basic-write-wc-active: SKIP (0.000s)
[184.353676] [025/133] (834s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[184.442350] Starting subtest: 4-tiled-16bpp-rotate-270
[184.462883] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[184.569196] [026/133] (833s left) kms_frontbuffer_tracking (fbc-tiling-y)
[184.681085] Starting subtest: fbc-tiling-y
[184.685345] Subtest fbc-tiling-y: SKIP (0.000s)
[184.790250] [027/133] (833s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[184.891453] Starting subtest: fbc-rgb565-draw-blt
[188.979231] Subtest fbc-rgb565-draw-blt: SUCCESS (4.091s)
[190.152752] [028/133] (828s left) kms_busy (basic)
[190.239598] Starting subtest: basic
[190.241691] Starting dynamic subtest: flip
[190.830287] Dynamic subtest flip: SUCCESS (0.591s)
[190.841998] Starting dynamic subtest: modeset
[194.265913] Dynamic subtest modeset: SUCCESS (3.433s)
[194.268210] Subtest basic: SUCCESS (4.025s)
[195.060088] [029/133] (823s left) gem_exec_suspend (basic-s0)
[195.114520] Starting subtest: basic-S0
[195.116794] Starting dynamic subtest: smem
[215.182691] Dynamic subtest smem: SUCCESS (6.782s)
[215.185552] Subtest basic-S0: SUCCESS (6.784s)
[215.362495] [030/133] (803s left) kms_addfb_basic (clobberred-modifier)
[215.441071] Starting subtest: clobberred-modifier
[215.445295] Subtest clobberred-modifier: SKIP (0.000s)
[215.580437] [031/133] (803s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[215.669836] Starting subtest: fbc-rgb565-draw-mmap-cpu
[219.653083] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.030s)
[220.814081] [032/133] (797s left) gem_exec_reloc (basic-cpu-gtt-active)
[220.865146] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[220.930653] [033/133] (797s left) kms_psr (psr2-suspend)
[221.017303] Starting subtest: psr2-suspend
[221.019423] Starting dynamic subtest: eDP-1
[238.807354] Dynamic subtest eDP-1: SUCCESS (2.816s)
[238.809737] Subtest psr2-suspend: SUCCESS (2.817s)
[239.670673] [034/133] (779s left) gem_eio (wait-wedge-immediate)
[239.922017] Starting subtest: wait-wedge-immediate
[241.256218] Subtest wait-wedge-immediate: SUCCESS (1.350s)
[241.365549] [035/133] (777s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[241.466186] Starting subtest: x-tiled-32bpp-rotate-0
[242.828876] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.379s)
[242.948503] [036/133] (775s left) gem_close_race (multigpu-basic-threads)
[243.021529] Starting subtest: multigpu-basic-threads
[243.025150] Subtest multigpu-basic-threads: SKIP (0.000s)
[243.250590] [037/133] (775s left) kms_debugfs (display-on-read-all)
[243.354936] Starting subtest: display-on-read-all
[243.519859] Subtest display-on-read-all: SUCCESS (0.167s)
[243.632629] [038/133] (775s left) perf (i915-ref-count)
[243.696117] Starting subtest: i915-ref-count
[243.736726] Subtest i915-ref-count: SUCCESS (0.038s)
[243.791864] [039/133] (775s left) kms_scaling_modes (scaling-mode-center)
[243.875910] Starting subtest: scaling-mode-center
[243.878040] Starting dynamic subtest: pipe-A-eDP-1
[243.967486] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[243.977499] Starting dynamic subtest: pipe-B-eDP-1
[245.146336] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.187s)
[245.156532] Starting dynamic subtest: pipe-C-eDP-1
[246.252328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[246.261719] Starting dynamic subtest: pipe-D-eDP-1
[247.374223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[247.376787] Subtest scaling-mode-center: SUCCESS (3.525s)
[248.516395] [040/133] (770s left) kms_plane_cursor (viewport)
[248.611030] Starting subtest: viewport
[248.615585] Starting dynamic subtest: pipe-A-eDP-1-size-64
[251.063888] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.463s)
[251.124621] Starting dynamic subtest: pipe-A-eDP-1-size-128
[253.645498] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[253.705782] Starting dynamic subtest: pipe-A-eDP-1-size-256
[256.163324] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[256.518727] Starting dynamic subtest: pipe-B-eDP-1-size-64
[259.636378] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.137s)
[259.696228] Starting dynamic subtest: pipe-B-eDP-1-size-128
[262.135209] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[262.194910] Starting dynamic subtest: pipe-B-eDP-1-size-256
[264.599322] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.415s)
[264.950835] Starting dynamic subtest: pipe-C-eDP-1-size-64
[267.759620] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.821s)
[267.797272] Starting dynamic subtest: pipe-C-eDP-1-size-128
[269.935515] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[269.973393] Starting dynamic subtest: pipe-C-eDP-1-size-256
[272.134547] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[272.469561] Starting dynamic subtest: pipe-D-eDP-1-size-64
[275.283475] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.822s)
[275.321975] Starting dynamic subtest: pipe-D-eDP-1-size-128
[277.551458] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.235s)
[277.593521] Starting dynamic subtest: pipe-D-eDP-1-size-256
[279.730577] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[280.051228] Subtest viewport: SUCCESS (31.479s)
[280.913952] [041/133] (738s left) gem_exec_params (invalid-bsd1-flag-on-render)
[280.970532] Starting subtest: invalid-bsd1-flag-on-render
[280.972771] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[281.063867] [042/133] (738s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[281.126527] Starting subtest: invalid-multi-wait-unsubmitted
[281.128759] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[281.215571] [043/133] (737s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[281.312746] Starting subtest: 2x-flip-vs-rmfb-interruptible
[281.324614] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[281.401148] [044/133] (737s left) gem_readwrite (beyond-eob)
[281.453309] Subtest beyond-EOB: SKIP (0.000s)
[281.536031] [045/133] (737s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[281.585734] Starting subtest: multi-wait-all-for-submit-submitted
[281.689693] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[281.764713] [046/133] (737s left) gem_ctx_shared (single-timeline)
[281.818579] Starting subtest: single-timeline
[281.839334] Subtest single-timeline: SUCCESS (0.014s)
[282.078342] [047/133] (737s left) kms_big_fb (linear-addfb)
[282.167614] Starting subtest: linear-addfb
[282.169812] Subtest linear-addfb: SUCCESS (0.000s)
[282.261221] [048/133] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[282.359628] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[288.825791] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.469s)
[288.924690] [049/133] (730s left) perf_pmu (busy-no-semaphores)
[288.968079] Starting subtest: busy-no-semaphores
[288.970456] Starting dynamic subtest: rcs0
[289.514119] Dynamic subtest rcs0: SUCCESS (0.547s)
[289.526372] Starting dynamic subtest: bcs0
[290.065784] Dynamic subtest bcs0: SUCCESS (0.549s)
[290.075982] Starting dynamic subtest: vcs0
[290.617055] Dynamic subtest vcs0: SUCCESS (0.548s)
[290.629346] Starting dynamic subtest: vcs1
[291.741353] Dynamic subtest vcs1: SUCCESS (1.121s)
[291.753716] Starting dynamic subtest: vecs0
[293.729326] Dynamic subtest vecs0: SUCCESS (1.985s)
[293.740209] Starting dynamic subtest: ccs0
[295.712894] Dynamic subtest ccs0: SUCCESS (1.981s)
[295.715962] Subtest busy-no-semaphores: SUCCESS (6.747s)
[295.830402] [050/133] (723s left) gem_exec_balancer (nop)
[295.893965] Starting subtest: nop
[342.687170] Subtest nop: SUCCESS (46.800s)
[342.979436] [051/133] (676s left) perf_pmu (all-busy-check-all)
[343.021749] Starting subtest: all-busy-check-all
[344.222166] Subtest all-busy-check-all: SUCCESS (1.200s)
[344.325059] [052/133] (675s left) gem_mmap_gtt (medium-copy-odd)
[344.392996] Subtest medium-copy-odd: SKIP (0.000s)
[344.458993] [053/133] (675s left) syncobj_eventfd (binary-wait-signaled)
[344.519511] Starting subtest: binary-wait-signaled
[344.521816] Subtest binary-wait-signaled: SUCCESS (0.000s)
[344.614466] [054/133] (675s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[344.713999] Starting subtest: crc-primary-basic-y-tiled-ccs
[344.716092] Starting dynamic subtest: pipe-A-eDP-1
[344.739611] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.748969] Starting dynamic subtest: pipe-B-eDP-1
[344.770902] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.781843] Starting dynamic subtest: pipe-C-eDP-1
[344.803712] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[344.812203] Starting dynamic subtest: pipe-D-eDP-1
[344.834040] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[344.838417] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.012s)
[346.883315] [055/133] (672s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[346.943695] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[346.948390] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[347.127606] [056/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[347.230761] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[347.234914] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[347.340483] [057/133] (672s left) sw_sync (timeline_closed_signaled)
[347.378516] Starting subtest: timeline_closed_signaled
[347.380721] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[347.426005] [058/133] (672s left) kms_prop_blob (blob-prop-lifetime)
[347.483379] Starting subtest: blob-prop-lifetime
[347.485665] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[347.596080] [059/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[347.690494] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[355.335935] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.645s)
[355.470801] [060/133] (664s left) kms_psr (fbc-psr-primary-mmap-cpu)
[355.563267] Starting subtest: fbc-psr-primary-mmap-cpu
[355.565548] Starting dynamic subtest: eDP-1
[355.569826] Dynamic subtest eDP-1: SKIP (0.000s)
[355.574087] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[355.632973] [061/133] (664s left) i915_hangman (hangcheck-unterminated)
[355.693075] Starting subtest: hangcheck-unterminated
[367.164091] Subtest hangcheck-unterminated: SUCCESS (11.469s)
[367.315742] [062/133] (652s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[367.429251] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[367.431536] Starting dynamic subtest: pipe-A-eDP-1
[367.454224] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.464417] Starting dynamic subtest: pipe-B-eDP-1
[367.486183] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.495307] Starting dynamic subtest: pipe-C-eDP-1
[367.516890] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.527586] Starting dynamic subtest: pipe-D-eDP-1
[367.549588] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.553655] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[369.671804] [063/133] (650s left) kms_universal_plane (disable-primary-vs-flip)
[369.767563] Starting subtest: disable-primary-vs-flip
[369.769453] Starting dynamic subtest: pipe-A-eDP-1
[371.340190] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.572s)
[371.350421] Starting dynamic subtest: pipe-B-eDP-1
[373.521726] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.182s)
[373.534381] Starting dynamic subtest: pipe-C-eDP-1
[375.684326] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.156s)
[375.693959] Starting dynamic subtest: pipe-D-eDP-1
[377.852375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[377.854773] Subtest disable-primary-vs-flip: SUCCESS (8.087s)
[378.649138] [064/133] (641s left) kms_flip (dpms-vs-vblank-race)
[378.742896] Starting subtest: dpms-vs-vblank-race
[378.745145] Starting dynamic subtest: A-eDP1
[383.756140] Dynamic subtest A-eDP1: SUCCESS (5.014s)
[383.768965] Starting dynamic subtest: B-eDP1
[387.376625] Dynamic subtest B-eDP1: SUCCESS (3.619s)
[387.391902] Starting dynamic subtest: C-eDP1
[390.883232] Dynamic subtest C-eDP1: SUCCESS (3.503s)
[390.892532] Starting dynamic subtest: D-eDP1
[395.514823] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[395.517032] Subtest dpms-vs-vblank-race: SUCCESS (16.778s)
[396.390356] [065/133] (623s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[396.502938] Starting subtest: psr-rgb565-draw-mmap-cpu
[403.284456] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.786s)
[403.395425] [066/133] (616s left) gem_userptr_blits (sync-unmap-cycles)
[403.470637] Starting subtest: sync-unmap-cycles
[408.845692] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[408.985849] [067/133] (611s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[409.582399] Starting subtest: syncobj-backward-timeline-chain-engines
[409.776392] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.194s)
[411.331418] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[411.335176] [068/133] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[411.443241] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[411.447550] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[411.528656] [069/133] (608s left) kms_pm_rpm (dpms-lpsp)
[413.352563] Starting subtest: dpms-lpsp
[413.696650] Subtest dpms-lpsp: SUCCESS (0.346s)
[413.793180] [070/133] (606s left) gem_fenced_exec_thrash (2-spare-fences)
[413.854345] Subtest 2-spare-fences: SKIP (0.000s)
[413.937026] [071/133] (606s left) kms_color (ctm-negative)
[414.028479] Starting subtest: ctm-negative
[414.030366] Starting dynamic subtest: pipe-A-eDP-1
[414.736324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[414.747113] Starting dynamic subtest: pipe-B-eDP-1
[416.165490] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[416.175821] Starting dynamic subtest: pipe-C-eDP-1
[417.536951] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[417.547281] Starting dynamic subtest: pipe-D-eDP-1
[418.876177] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[418.878531] Subtest ctm-negative: SUCCESS (4.851s)
[419.680643] [072/133] (600s left) kms_hdr (static-swap)
[419.786186] Starting subtest: static-swap
[419.792955] Subtest static-swap: SKIP (0.000s)
[419.871451] [073/133] (600s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[419.975499] Starting subtest: y-tiled-16bpp-rotate-270
[419.979944] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[420.081545] [074/133] (600s left) gem_mmap_offset (bad-flags)
[420.139443] Starting subtest: bad-flags
[420.141367] Subtest bad-flags: SUCCESS (0.000s)
[420.235511] [075/133] (600s left) kms_atomic_transition (modeset-transition-fencing)
[420.330765] Starting subtest: modeset-transition-fencing
[420.332693] Starting dynamic subtest: 1x-outputs
[431.165279] Dynamic subtest 1x-outputs: SUCCESS (10.838s)
[431.167961] Subtest modeset-transition-fencing: SUCCESS (10.840s)
[432.022708] [076/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[432.129559] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[432.133469] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[432.215115] [077/133] (588s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[432.311623] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[432.313907] Starting dynamic subtest: pipe-A-eDP-1
[432.335916] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[432.346253] Starting dynamic subtest: pipe-B-eDP-1
[432.367049] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.375940] Starting dynamic subtest: pipe-C-eDP-1
[432.396491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.405392] Starting dynamic subtest: pipe-D-eDP-1
[432.427154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.431338] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[434.567601] [078/133] (586s left) gem_exec_reloc (basic-write-cpu-noreloc)
[434.641906] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[434.710933] [079/133] (586s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[434.843375] Starting subtest: cursor-vs-flip-atomic
[464.229891] Subtest cursor-vs-flip-atomic: SUCCESS (29.390s)
[465.078883] [080/133] (555s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[465.183266] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[465.187561] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[465.266011] [081/133] (555s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[465.357585] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[465.361852] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[465.442018] [082/133] (555s left) syncobj_wait (wait-all-interrupted)
[465.505880] Starting subtest: wait-all-interrupted
[465.605893] Subtest wait-all-interrupted: SUCCESS (0.102s)
[465.686153] [083/133] (555s left) kms_plane_scaling (planes-scaler-unity-scaling)
[465.770817] Starting subtest: planes-scaler-unity-scaling
[465.772933] Starting dynamic subtest: pipe-A
[465.836671] Dynamic subtest pipe-A: SUCCESS (0.067s)
[465.848094] Starting dynamic subtest: pipe-B
[466.996062] Dynamic subtest pipe-B: SUCCESS (1.158s)
[467.009202] Starting dynamic subtest: pipe-C
[468.094154] Dynamic subtest pipe-C: SUCCESS (1.097s)
[468.103413] Starting dynamic subtest: pipe-D
[469.222266] Dynamic subtest pipe-D: SUCCESS (1.127s)
[469.224582] Subtest planes-scaler-unity-scaling: SUCCESS (3.452s)
[470.384757] [084/133] (550s left) gem_watchdog (default-physical)
[470.464879] Starting subtest: default-physical
[472.221259] Subtest default-physical: SUCCESS (1.768s)
[472.317579] [085/133] (548s left) kms_content_protection (atomic-dpms)
[472.455992] Starting subtest: atomic-dpms
[472.460356] Subtest atomic-dpms: SKIP (0.000s)
[472.588462] [086/133] (548s left) kms_flip (basic-flip-vs-modeset)
[472.695198] Starting subtest: basic-flip-vs-modeset
[472.697533] Starting dynamic subtest: A-eDP1
[475.312701] Dynamic subtest A-eDP1: SUCCESS (2.616s)
[475.322459] Starting dynamic subtest: B-eDP1
[477.474365] Dynamic subtest B-eDP1: SUCCESS (2.158s)
[477.484569] Starting dynamic subtest: C-eDP1
[479.633781] Dynamic subtest C-eDP1: SUCCESS (2.160s)
[479.643266] Starting dynamic subtest: D-eDP1
[481.797183] Dynamic subtest D-eDP1: SUCCESS (2.161s)
[481.799446] Subtest basic-flip-vs-modeset: SUCCESS (9.103s)
[482.596902] [087/133] (538s left) i915_suspend (debugfs-reader)
[482.654677] Starting subtest: debugfs-reader
[501.366819] Subtest debugfs-reader: SUCCESS (3.148s)
[501.529171] [088/133] (519s left) gem_mmap_wc (close)
[501.597809] Subtest close: SKIP (0.000s)
[501.667593] [089/133] (519s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[501.747710] Starting subtest: fbc-psr2-cursor-plane-onoff
[501.749975] Starting dynamic subtest: eDP-1
[501.754285] Dynamic subtest eDP-1: SKIP (0.000s)
[501.758638] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[501.819978] [090/133] (519s left) kms_vrr (flip-basic-fastset)
[501.909660] Starting subtest: flip-basic-fastset
[501.915848] Subtest flip-basic-fastset: SKIP (0.000s)
[501.990505] [091/133] (519s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[502.214661] Starting subtest: cursor-rapid-movement-128x42
[502.260774] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[502.470127] [092/133] (518s left) gem_exec_balancer (parallel-out-fence)
[502.724283] Starting subtest: parallel-out-fence
[503.821493] Subtest parallel-out-fence: SUCCESS (1.111s)
[503.924261] [093/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[504.024325] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[504.028706] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[504.133087] [094/133] (517s left) kms_cursor_crc (cursor-offscreen-512x512)
[504.410328] Starting subtest: cursor-offscreen-512x512
[504.414926] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[504.573037] [095/133] (516s left) drm_read (empty-block)
[504.702080] Starting subtest: empty-block
[505.702018] Subtest empty-block: SUCCESS (1.010s)
[505.835455] [096/133] (515s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[505.932339] Starting subtest: stress-xrgb8888-4tiled
[511.769161] Subtest stress-xrgb8888-4tiled: SUCCESS (5.874s)
[511.820400] [097/133] (509s left) gem_exec_schedule (fifo)
[511.897006] Starting subtest: fifo
[511.898608] Starting dynamic subtest: rcs0
[511.990090] Dynamic subtest rcs0: SUCCESS (0.099s)
[512.000193] Starting dynamic subtest: vcs0
[512.069494] Dynamic subtest vcs0: SUCCESS (0.078s)
[512.081112] Starting dynamic subtest: vcs1
[512.154176] Dynamic subtest vcs1: SUCCESS (0.085s)
[512.163235] Starting dynamic subtest: vecs0
[512.237771] Dynamic subtest vecs0: SUCCESS (0.083s)
[512.250107] Starting dynamic subtest: ccs0
[512.322831] Dynamic subtest ccs0: SUCCESS (0.084s)
[512.324946] Subtest fifo: SUCCESS (0.434s)
[513.852649] [098/133] (507s left) gem_exec_schedule (preempt-other)
[513.916907] Starting subtest: preempt-other
[513.918780] Starting dynamic subtest: rcs0
[513.977346] Dynamic subtest rcs0: SUCCESS (0.067s)
[513.988178] Starting dynamic subtest: bcs0
[514.049358] Dynamic subtest bcs0: SUCCESS (0.072s)
[514.063617] Starting dynamic subtest: vcs0
[514.121229] Dynamic subtest vcs0: SUCCESS (0.071s)
[514.131282] Starting dynamic subtest: vcs1
[514.189772] Dynamic subtest vcs1: SUCCESS (0.068s)
[514.201093] Starting dynamic subtest: vecs0
[514.252661] Dynamic subtest vecs0: SUCCESS (0.062s)
[514.267580] Starting dynamic subtest: ccs0
[514.317545] Dynamic subtest ccs0: SUCCESS (0.064s)
[514.320272] Subtest preempt-other: SUCCESS (0.409s)
[515.875318] [099/133] (505s left) api_intel_allocator (fork-simple-stress-signal)
[515.927660] Starting subtest: fork-simple-stress-signal
[521.317844] Subtest fork-simple-stress-signal: SUCCESS (5.401s)
[521.431983] [100/133] (500s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[521.544884] Starting subtest: plane-all-modeset-transition-fencing
[521.549345] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[521.628022] [101/133] (500s left) kms_psr (pr-cursor-render)
[521.736048] Starting subtest: pr-cursor-render
[521.740063] Subtest pr-cursor-render: SKIP (0.000s)
[521.810370] [102/133] (500s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[521.935519] Starting subtest: fbc-rgb101010-draw-mmap-wc
[526.499404] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.572s)
[527.607293] [103/133] (494s left) syncobj_timeline (wait-all-for-submit-snapshot)
[527.662511] Starting subtest: wait-all-for-submit-snapshot
[527.744223] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[527.822923] [104/133] (494s left) gen7_exec_parse (basic-offset)
[527.884738] Subtest basic-offset: SKIP (0.000s)
[527.966617] [105/133] (493s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[528.083196] Starting subtest: 2x-long-flip-vs-cursor-legacy
[528.087773] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[528.230879] [106/133] (493s left) gem_exercise_blt (fast-copy)
[528.289068] Starting subtest: fast-copy
[528.291450] Starting dynamic subtest: linear-smem-smem
[528.312837] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[528.323185] Starting dynamic subtest: xmajor-smem-smem
[528.330307] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[528.339605] Starting dynamic subtest: tile4-smem-smem
[528.348632] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[528.357702] Starting dynamic subtest: tile64-smem-smem
[528.366769] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[528.369078] Subtest fast-copy: SUCCESS (0.078s)
[528.473790] [107/133] (493s left) kms_cursor_edge_walk (256x256-top-bottom)
[528.557931] Starting subtest: 256x256-top-bottom
[528.559699] Starting dynamic subtest: pipe-A-eDP-1
[532.060230] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[532.070186] Starting dynamic subtest: pipe-D-eDP-1
[535.192157] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[535.194479] Subtest 256x256-top-bottom: SUCCESS (6.639s)
[536.000234] [108/133] (486s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[536.384423] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[537.196475] [109/133] (484s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[537.300335] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[537.304344] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[537.398080] [110/133] (484s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[537.480512] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[537.482668] Starting dynamic subtest: pipe-A
[538.651989] Dynamic subtest pipe-A: SUCCESS (1.173s)
[538.663701] Starting dynamic subtest: pipe-B
[540.906424] Dynamic subtest pipe-B: SUCCESS (2.252s)
[540.915736] Starting dynamic subtest: pipe-C
[542.133471] Dynamic subtest pipe-C: SUCCESS (1.225s)
[542.143425] Starting dynamic subtest: pipe-D
[543.378339] Dynamic subtest pipe-D: SUCCESS (1.243s)
[543.380656] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.899s)
[544.559621] [111/133] (477s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[544.656350] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[545.624589] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.967s)
[545.733402] [112/133] (476s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[545.843782] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[545.848226] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[545.955342] [113/133] (476s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[546.063272] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[546.067019] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[546.157448] [114/133] (476s left) kms_invalid_mode (bad-vsync-end)
[546.258968] Starting subtest: bad-vsync-end
[546.260748] Starting dynamic subtest: pipe-A-eDP-1
[546.557859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[546.571830] Starting dynamic subtest: pipe-B-eDP-1
[546.573784] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[546.583064] Starting dynamic subtest: pipe-C-eDP-1
[546.585318] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[546.594519] Starting dynamic subtest: pipe-D-eDP-1
[546.596796] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[546.599070] Subtest bad-vsync-end: SUCCESS (0.307s)
[547.394115] [115/133] (474s left) gem_softpin (allocator-basic)
[547.453356] Starting subtest: allocator-basic
[547.532680] Subtest allocator-basic: SUCCESS (0.078s)
[547.648016] [116/133] (474s left) gem_ctx_isolation (nonpriv)
[547.716309] Starting subtest: nonpriv
[547.718760] Starting dynamic subtest: rcs0
[547.952897] Dynamic subtest rcs0: SUCCESS (0.236s)
[547.962727] Starting dynamic subtest: bcs0
[548.172952] Dynamic subtest bcs0: SUCCESS (0.219s)
[548.184229] Starting dynamic subtest: vcs0
[548.437194] Dynamic subtest vcs0: SUCCESS (0.264s)
[548.446284] Starting dynamic subtest: vcs1
[549.988191] Dynamic subtest vcs1: SUCCESS (1.549s)
[549.997738] Starting dynamic subtest: vecs0
[552.033822] Dynamic subtest vecs0: SUCCESS (2.044s)
[552.046401] Starting dynamic subtest: ccs0
[554.033050] Dynamic subtest ccs0: SUCCESS (1.999s)
[554.035400] Subtest nonpriv: SUCCESS (6.317s)
[554.272051] [117/133] (468s left) kms_chamelium_color (ctm-green-to-red)
[554.385766] Subtest ctm-green-to-red: SKIP (0.000s)
[554.430964] [118/133] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[554.539823] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[561.856057] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.320s)
[561.983756] [119/133] (460s left) perf (invalid-oa-exponent)
[562.077360] Starting subtest: invalid-oa-exponent
[562.097060] Subtest invalid-oa-exponent: SUCCESS (0.019s)
[562.147889] [120/133] (460s left) kms_async_flips (async-flip-dpms)
[562.234664] Starting subtest: async-flip-dpms
[562.613755] Starting dynamic subtest: pipe-A-eDP-1
[566.529648] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.916s)
[566.928518] Starting dynamic subtest: pipe-B-eDP-1
[569.700646] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.779s)
[570.077950] Starting dynamic subtest: pipe-C-eDP-1
[572.876459] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.807s)
[573.270905] Starting dynamic subtest: pipe-D-eDP-1
[576.043531] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[576.045844] Subtest async-flip-dpms: SUCCESS (13.814s)
[577.238085] [121/133] (445s left) gem_busy (extended)
[577.427042] Starting subtest: extended
[577.429440] Starting dynamic subtest: rcs0
[577.528837] Dynamic subtest rcs0: SUCCESS (0.102s)
[577.540968] Starting dynamic subtest: bcs0
[577.570787] Dynamic subtest bcs0: SUCCESS (0.040s)
[577.580973] Starting dynamic subtest: vcs0
[578.804998] Dynamic subtest vcs0: SUCCESS (1.230s)
[578.818405] Starting dynamic subtest: vcs1
[580.788011] Dynamic subtest vcs1: SUCCESS (1.981s)
[580.799460] Starting dynamic subtest: vecs0
[582.771982] Dynamic subtest vecs0: SUCCESS (1.981s)
[582.784872] Starting dynamic subtest: ccs0
[582.817494] Dynamic subtest ccs0: SUCCESS (0.045s)
[582.819898] Subtest extended: SUCCESS (5.394s)
[583.066031] [122/133] (439s left) gem_exec_schedule (semaphore-resolve)
[583.128939] Starting subtest: semaphore-resolve
[583.210996] Subtest semaphore-resolve: SUCCESS (0.090s)
[583.565228] [123/133] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[583.686556] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[583.690954] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.790401] [124/133] (438s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[583.877621] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[583.879909] Starting dynamic subtest: pipe-A-eDP-1
[583.901741] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[583.912775] Starting dynamic subtest: pipe-B-eDP-1
[583.933756] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[583.948057] Starting dynamic subtest: pipe-C-eDP-1
[583.969054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[583.978463] Starting dynamic subtest: pipe-D-eDP-1
[584.000542] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[584.004934] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[586.193187] [125/133] (436s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[586.300089] Starting subtest: fbc-modesetfrombusy
[590.142940] Subtest fbc-modesetfrombusy: SUCCESS (3.848s)
[591.320499] [126/133] (431s left) gem_eio (execbuf)
[591.547140] Starting subtest: execbuf
[591.871555] Subtest execbuf: SUCCESS (0.324s)
[592.032130] [127/133] (430s left) i915_pm_rpm (gem-execbuf)
[593.968748] Starting subtest: gem-execbuf
[593.970901] Starting dynamic subtest: smem0
[596.205538] Dynamic subtest smem0: SUCCESS (2.239s)
[596.207815] Subtest gem-execbuf: SUCCESS (2.240s)
[596.290902] [128/133] (426s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[596.392334] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[596.394523] Starting dynamic subtest: pipe-A-eDP-1
[607.723781] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.330s)
[607.734235] Starting dynamic subtest: pipe-B-eDP-1
[619.771088] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.042s)
[619.773252] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.376s)
[620.613877] [129/133] (402s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[620.688930] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[620.693484] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[620.871483] [130/133] (402s left) gem_media_vme
[621.017160] [131/133] (402s left) sw_sync (sync_busy_fork_unixsocket)
[621.060442] Starting subtest: sync_busy_fork_unixsocket
[621.064995] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[621.124934] [132/133] (401s left) sysfs_timeslice_duration (duration)
[621.177138] Starting subtest: duration
[621.179620] Starting dynamic subtest: vecs0
[634.709034] Dynamic subtest vecs0: SUCCESS (13.527s)
[634.721699] Starting dynamic subtest: ccs0
[647.844879] Dynamic subtest ccs0: SUCCESS (13.135s)
[647.857239] Starting dynamic subtest: vcs0
[661.714329] Dynamic subtest vcs0: SUCCESS (13.867s)
[661.726445] Starting dynamic subtest: bcs0
[674.861240] Dynamic subtest bcs0: SUCCESS (13.147s)
[674.875029] Starting dynamic subtest: rcs0
[688.004544] Dynamic subtest rcs0: SUCCESS (13.144s)
[688.017753] Starting dynamic subtest: vcs1
[701.714298] Dynamic subtest vcs1: SUCCESS (13.709s)
[701.717198] Subtest duration: SUCCESS (80.545s)
[701.791567] [133/133] (321s left) kms_chamelium_frames (dp-crc-fast)
[702.192421] Subtest dp-crc-fast: SKIP (0.000s)
[703.018293] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_dp_link_training
results: parsing output: 3/ for test: prime_busy
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_busy
results: parsing output: 28/ for test: gem_exec_suspend
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_close_race
results: parsing output: 36/ for test: kms_debugfs
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_scaling_modes
results: parsing output: 39/ for test: kms_plane_cursor
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_readwrite
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: gem_ctx_shared
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: syncobj_eventfd
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: i915_hangman
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_universal_plane
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_fenced_exec_thrash
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_watchdog
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_vrr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: kms_pipe_stress
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_atomic_transition
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gen7_exec_parse
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exercise_blt
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: gem_ctx_isolation
results: parsing output: 116/ for test: kms_chamelium_color
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: gem_busy
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_media_vme
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: kms_chamelium_frames
Done.