[58.964708] Initializing watchdogs
[58.964760]   /dev/watchdog0
[58.980252] [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]
[58.984819] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.987143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.989452] [001/154] (960s left) gem_exec_balancer (parallel)
[59.274669] Starting subtest: parallel
[60.288304] Subtest parallel: SUCCESS (1.035s)
[61.316403] [002/154] (958s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[61.419521] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[61.421307] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.515349] [003/154] (958s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[61.620788] Starting subtest: psr-rgb565-draw-pwrite
[68.986354] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.446s)
[69.111265] [004/154] (950s left) prime_mmap (test_dup)
[69.164084] Starting subtest: test_dup
[69.164918] Starting dynamic subtest: test_dup-smem
[69.199936] Dynamic subtest test_dup-smem: SUCCESS (0.035s)
[69.201286] Subtest test_dup: SUCCESS (0.037s)
[69.278428] [005/154] (950s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt)
[69.371063] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt
[69.372857] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[69.465484] [006/154] (950s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[69.518500] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[69.627216] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[69.693324] [007/154] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[69.777533] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[74.579084] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.823s)
[75.736215] [008/154] (943s left) gem_pread (exhaustion)
[75.778955] Subtest exhaustion: SKIP (0.000s)
[75.833476] [009/154] (943s left) i915_pm_freq_mult (media-freq)
[75.872833] Starting subtest: media-freq
[75.873633] Starting dynamic subtest: gt0
[75.875423] Dynamic subtest gt0: SKIP (0.000s)
[75.881722] Starting dynamic subtest: gt1
[75.883347] Dynamic subtest gt1: SKIP (0.000s)
[75.884861] Subtest media-freq: SKIP (0.001s)
[75.982612] [010/154] (943s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[76.065506] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[76.066476] Starting dynamic subtest: pipe-A-eDP-1
[76.075267] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.085609] Starting dynamic subtest: pipe-B-eDP-1
[76.093699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.100342] Starting dynamic subtest: pipe-C-eDP-1
[76.108669] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.115027] Starting dynamic subtest: pipe-D-eDP-1
[76.123353] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.124889] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[78.401776] [011/154] (941s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[78.501117] Starting subtest: fbc-rgb565-draw-pwrite
[83.285867] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.792s)
[84.421646] [012/154] (935s left) kms_plane_alpha_blend (constant-alpha-mid)
[84.517550] Starting subtest: constant-alpha-mid
[84.812504] Starting dynamic subtest: pipe-A-eDP-1
[85.776816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.965s)
[85.783958] Starting dynamic subtest: pipe-D-eDP-1
[87.407443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.627s)
[87.408986] Subtest constant-alpha-mid: SUCCESS (2.888s)
[88.308865] [013/154] (931s left) vgem_basic (sysfs)
[88.377290] Starting subtest: sysfs
[88.378202] Subtest sysfs: SUCCESS (0.001s)
[88.430163] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[88.432038] [014/154] (931s left) gem_ctx_persistence (legacy-engines-hang)
[88.485354] Starting subtest: legacy-engines-hang
[88.486309] Starting dynamic subtest: render
[88.606851] Dynamic subtest render: SUCCESS (0.121s)
[88.617125] Starting dynamic subtest: bsd1
[88.704354] Dynamic subtest bsd1: SUCCESS (0.096s)
[88.716393] Starting dynamic subtest: bsd2
[88.783587] Dynamic subtest bsd2: SUCCESS (0.076s)
[88.793910] Starting dynamic subtest: blt
[88.924959] Dynamic subtest blt: SUCCESS (0.139s)
[88.934733] Starting dynamic subtest: vebox
[89.019621] Dynamic subtest vebox: SUCCESS (0.093s)
[89.020983] Subtest legacy-engines-hang: SUCCESS (0.534s)
[89.096054] [015/154] (930s left) kms_color (invalid-ctm-matrix-sizes)
[89.182306] Starting subtest: invalid-ctm-matrix-sizes
[89.183257] Starting dynamic subtest: pipe-A
[89.184134] Dynamic subtest pipe-A: SUCCESS (0.002s)
[89.191419] Starting dynamic subtest: pipe-B
[89.192331] Dynamic subtest pipe-B: SUCCESS (0.003s)
[89.199450] Starting dynamic subtest: pipe-C
[89.200364] Dynamic subtest pipe-C: SUCCESS (0.004s)
[89.206888] Starting dynamic subtest: pipe-D
[89.207797] Dynamic subtest pipe-D: SUCCESS (0.004s)
[89.208775] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[89.263321] [016/154] (930s left) kms_cursor_crc (cursor-sliding-512x512)
[89.519177] Starting subtest: cursor-sliding-512x512
[89.521263] Subtest cursor-sliding-512x512: SKIP (0.001s)
[89.680984] [017/154] (930s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[89.774060] Starting subtest: plane-primary-toggle-with-vblank-wait
[89.774964] Starting dynamic subtest: pipe-A-eDP-1
[89.949118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[90.259103] Starting dynamic subtest: pipe-B-eDP-1
[91.189848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.937s)
[91.488489] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.714s)
[92.342877] [018/154] (927s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[92.446921] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[92.448820] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[92.538402] [019/154] (927s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[92.620742] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[92.622350] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[92.703215] [020/154] (927s left) gem_ctx_isolation (preservation-s3)
[92.750251] Starting subtest: preservation-S3
[92.751131] Starting dynamic subtest: rcs0
[110.047480] Dynamic subtest rcs0: SUCCESS (1.819s)
[110.055841] Starting dynamic subtest: bcs0
[127.047860] Dynamic subtest bcs0: SUCCESS (1.723s)
[127.056183] Starting dynamic subtest: vcs0
[144.032386] Dynamic subtest vcs0: SUCCESS (3.531s)
[144.040971] Starting dynamic subtest: vcs1
[162.022334] Dynamic subtest vcs1: SUCCESS (4.956s)
[162.030895] Starting dynamic subtest: vecs0
[180.034242] Dynamic subtest vecs0: SUCCESS (4.988s)
[180.042337] Starting dynamic subtest: ccs0
[198.033636] Dynamic subtest ccs0: SUCCESS (3.227s)
[198.034587] Subtest preservation-S3: SUCCESS (20.246s)
[204.288655] [021/154] (821s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[204.381576] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[204.383402] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[204.464356] [022/154] (821s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[204.577792] Starting subtest: cursorB-vs-flipB-atomic
[204.579458] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[204.711286] [023/154] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[204.801342] Starting subtest: psr-1p-primscrn-cur-indfb-move
[212.065125] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.475s)
[212.207163] [024/154] (814s left) vgem_basic (setversion)
[212.248874] Starting subtest: setversion
[212.250539] Subtest setversion: SUCCESS (0.000s)
[212.300624] [025/154] (814s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[212.389162] Starting subtest: fbc-psr2-primary-mmap-gtt
[212.390118] Starting dynamic subtest: eDP-1
[212.391994] Dynamic subtest eDP-1: SKIP (0.000s)
[212.393693] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[212.454273] [026/154] (813s left) gem_exec_flush (basic-batch-kernel-default-wb)
[212.518800] Starting subtest: basic-batch-kernel-default-wb
[219.638835] Subtest basic-batch-kernel-default-wb: SUCCESS (7.194s)
[219.817129] [027/154] (806s left) kms_frontbuffer_tracking (psrhdr-suspend)
[219.911705] Starting subtest: psrhdr-suspend
[219.913518] Subtest psrhdr-suspend: SKIP (0.000s)
[220.011104] [028/154] (806s left) kms_psr (psr-no-drrs)
[220.105056] Starting subtest: psr-no-drrs
[220.106057] Starting dynamic subtest: eDP-1
[221.766300] Dynamic subtest eDP-1: SUCCESS (1.670s)
[221.767509] Subtest psr-no-drrs: SUCCESS (1.670s)
[222.642939] [029/154] (803s left) api_intel_bb (blit-noreloc-purge-cache)
[222.692348] Starting subtest: blit-noreloc-purge-cache
[222.702098] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[222.809720] [030/154] (803s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[222.905779] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[222.907499] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[223.014265] [031/154] (803s left) kms_addfb_basic (legacy-format)
[223.069931] Starting subtest: legacy-format
[223.098449] Subtest legacy-format: SUCCESS (0.027s)
[223.240411] [032/154] (803s left) kms_async_flips (invalid-async-flip)
[223.331061] Starting subtest: invalid-async-flip
[223.702402] Starting dynamic subtest: pipe-A-eDP-1
[224.564058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[224.921481] Starting dynamic subtest: pipe-B-eDP-1
[225.803357] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.891s)
[226.160105] Starting dynamic subtest: pipe-C-eDP-1
[227.015805] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.867s)
[227.368912] Starting dynamic subtest: pipe-D-eDP-1
[228.219025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.861s)
[228.221014] Subtest invalid-async-flip: SUCCESS (4.905s)
[229.376244] [033/154] (797s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[229.472803] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[229.473752] Starting dynamic subtest: pipe-A-eDP-1
[229.482666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.491717] Starting dynamic subtest: pipe-B-eDP-1
[229.499613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.507413] Starting dynamic subtest: pipe-C-eDP-1
[229.515305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.522859] Starting dynamic subtest: pipe-D-eDP-1
[229.532371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.534207] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[231.730460] [034/154] (794s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[231.828290] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[231.830132] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[231.898476] [035/154] (794s left) syncobj_wait (single-wait-all-for-submit-submitted)
[231.946450] Starting subtest: single-wait-all-for-submit-submitted
[232.052545] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[232.145367] [036/154] (794s left) gem_exec_reloc (basic-wc-gtt-active)
[232.197358] Subtest basic-wc-gtt-active: SKIP (0.000s)
[232.262625] [037/154] (794s left) gem_exec_whisper (basic-fds-forked-all)
[232.322976] Starting subtest: basic-fds-forked-all
[252.940705] Subtest basic-fds-forked-all: SUCCESS (20.607s)
[253.114949] [038/154] (773s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[253.207664] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[253.209373] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[253.314378] [039/154] (773s left) gem_workarounds (reset-context)
[253.377357] Starting subtest: reset-context
[253.551887] Subtest reset-context: SUCCESS (0.175s)
[253.666708] [040/154] (773s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[253.755351] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[253.757115] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[253.857846] [041/154] (773s left) syncobj_timeline (single-wait-all-available-submitted)
[253.900722] Starting subtest: single-wait-all-available-submitted
[253.901875] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[253.987348] [042/154] (772s left) prime_vgem (shrink)
[254.049780] Starting subtest: shrink
[254.096208] Subtest shrink: SUCCESS (0.046s)
[254.227465] [043/154] (772s left) gem_render_copy (linear-to-vebox-y-tiled)
[254.278747] Starting subtest: linear-to-vebox-y-tiled
[254.280615] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[254.455462] [044/154] (772s left) gem_set_tiling_vs_pwrite
[254.559130] [045/154] (772s left) gem_exec_balancer (persistence)
[254.828627] Starting subtest: persistence
[255.834886] Subtest persistence: SUCCESS (0.997s)
[255.939032] [046/154] (771s left) kms_plane_scaling (intel-max-src-size)
[256.030212] Starting subtest: intel-max-src-size
[256.032953] Subtest intel-max-src-size: SKIP (0.000s)
[256.133276] [047/154] (770s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[256.219608] Starting subtest: 4-tiled-8bpp-rotate-180
[257.500715] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.282s)
[257.606689] [048/154] (769s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[257.701037] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[257.702676] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[257.786594] [049/154] (769s left) gem_wait (write-busy)
[257.839808] Starting subtest: write-busy
[257.840680] Starting dynamic subtest: all-engines
[258.453539] Dynamic subtest all-engines: SUCCESS (0.615s)
[258.462316] Starting dynamic subtest: rcs0
[259.010780] Dynamic subtest rcs0: SUCCESS (0.556s)
[259.024313] Starting dynamic subtest: bcs0
[259.563529] Dynamic subtest bcs0: SUCCESS (0.552s)
[259.578707] Starting dynamic subtest: vcs0
[261.396125] Dynamic subtest vcs0: SUCCESS (1.817s)
[261.404695] Starting dynamic subtest: vcs1
[263.374377] Dynamic subtest vcs1: SUCCESS (1.982s)
[263.388060] Starting dynamic subtest: vecs0
[265.361224] Dynamic subtest vecs0: SUCCESS (1.981s)
[265.370136] Starting dynamic subtest: ccs0
[265.902441] Dynamic subtest ccs0: SUCCESS (0.550s)
[265.903922] Subtest write-busy: SUCCESS (8.066s)
[266.096689] [050/154] (761s left) gem_exec_parallel (userptr)
[266.158865] Starting subtest: userptr
[266.159867] Starting dynamic subtest: rcs0
[267.736251] Dynamic subtest rcs0: SUCCESS (1.577s)
[267.748170] Starting dynamic subtest: bcs0
[269.286731] Dynamic subtest bcs0: SUCCESS (1.549s)
[269.297387] Starting dynamic subtest: vcs0
[271.376874] Dynamic subtest vcs0: SUCCESS (2.080s)
[271.387674] Starting dynamic subtest: vcs1
[273.359580] Dynamic subtest vcs1: SUCCESS (1.980s)
[273.371601] Starting dynamic subtest: vecs0
[275.357239] Dynamic subtest vecs0: SUCCESS (1.996s)
[275.365996] Starting dynamic subtest: ccs0
[276.863105] Dynamic subtest ccs0: SUCCESS (1.513s)
[276.864213] Subtest userptr: SUCCESS (10.708s)
[277.059012] [051/154] (750s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[277.164728] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[277.166654] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[277.261527] [052/154] (749s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[277.350747] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[277.352531] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[277.450032] [053/154] (749s left) kms_flip (flip-vs-expired-vblank-interruptible)
[277.539231] Starting subtest: flip-vs-expired-vblank-interruptible
[277.541539] Starting dynamic subtest: A-eDP1
[286.252953] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[286.263857] Starting dynamic subtest: B-eDP1
[294.891338] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[294.905361] Starting dynamic subtest: C-eDP1
[303.516556] Dynamic subtest C-eDP1: SUCCESS (8.607s)
[303.527325] Starting dynamic subtest: D-eDP1
[312.148993] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[312.150204] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.574s)
[313.278894] [054/154] (714s left) perf_pmu (init-sema)
[313.318287] Starting subtest: init-sema
[313.319064] Starting dynamic subtest: rcs0
[313.319791] Dynamic subtest rcs0: SUCCESS (0.001s)
[313.328722] Starting dynamic subtest: bcs0
[313.329473] Dynamic subtest bcs0: SUCCESS (0.000s)
[313.338077] Starting dynamic subtest: vcs0
[313.338833] Dynamic subtest vcs0: SUCCESS (0.001s)
[313.347257] Starting dynamic subtest: vcs1
[313.348034] Dynamic subtest vcs1: SUCCESS (0.001s)
[313.356403] Starting dynamic subtest: vecs0
[313.357151] Dynamic subtest vecs0: SUCCESS (0.001s)
[313.365348] Starting dynamic subtest: ccs0
[313.366111] Dynamic subtest ccs0: SUCCESS (0.000s)
[313.366989] Subtest init-sema: SUCCESS (0.008s)
[313.405369] [055/154] (713s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[313.491085] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[313.492015] Starting dynamic subtest: pipe-A-eDP-1
[313.556813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[313.865453] Starting dynamic subtest: pipe-B-eDP-1
[314.691078] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.833s)
[314.987464] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.496s)
[315.832857] [056/154] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[315.923398] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[315.925343] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[316.018417] [057/154] (711s left) gem_exec_params (invalid-ring)
[316.072303] Starting subtest: invalid-ring
[316.073295] Subtest invalid-ring: SUCCESS (0.000s)
[316.189587] [058/154] (711s left) gem_lmem_swapping (parallel-random-engines)
[316.223711] Subtest parallel-random-engines: SKIP (0.000s)
[316.259496] [059/154] (711s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[316.367040] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[316.370027] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[316.504753] [060/154] (711s left) i915_drm_fdinfo (virtual-busy-all)
[316.542718] Starting subtest: virtual-busy-all
[316.544419] Subtest virtual-busy-all: SKIP (0.000s)
[316.609466] [061/154] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[316.691803] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[316.693704] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.793476] [062/154] (710s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[316.879837] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[316.881358] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[316.981719] [063/154] (710s left) kms_fbcon_fbt (psr)
[317.026731] Starting subtest: psr
[324.479231] Subtest psr: SUCCESS (7.440s)
[324.543367] [064/154] (703s left) gem_mmap_gtt (isolation)
[324.588757] Subtest isolation: SKIP (0.000s)
[324.646506] [065/154] (703s left) gem_ctx_exec (basic-close-race)
[324.700188] Starting subtest: basic-close-race
[330.428367] Subtest basic-close-race: SUCCESS (5.682s)
[330.529263] [066/154] (697s left) kms_chamelium_hpd (vga-hpd)
[330.912928] Subtest vga-hpd: SKIP (0.000s)
[331.707787] [067/154] (696s left) kms_invalid_mode (uint-max-clock)
[331.805180] Starting subtest: uint-max-clock
[331.806415] Starting dynamic subtest: pipe-A-eDP-1
[332.101967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[332.112596] Starting dynamic subtest: pipe-B-eDP-1
[332.113609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[332.121894] Starting dynamic subtest: pipe-C-eDP-1
[332.123436] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[332.132431] Starting dynamic subtest: pipe-D-eDP-1
[332.133352] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[332.134299] Subtest uint-max-clock: SUCCESS (0.303s)
[332.968816] [068/154] (694s left) gem_render_copy (x-tiled)
[333.017115] Starting subtest: x-tiled
[333.018043] Starting dynamic subtest: smem
[333.057694] Dynamic subtest smem: SUCCESS (0.042s)
[333.058618] Subtest x-tiled: SUCCESS (0.042s)
[333.274079] [069/154] (694s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[333.364147] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[333.365195] Starting dynamic subtest: pipe-A-eDP-1
[333.524762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.156s)
[333.534666] Starting dynamic subtest: pipe-B-eDP-1
[333.542516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[333.552028] Starting dynamic subtest: pipe-C-eDP-1
[333.559405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[333.567933] Starting dynamic subtest: pipe-D-eDP-1
[333.575748] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.015s)
[333.576496] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.197s)
[335.845024] [070/154] (692s left) kms_chamelium_color (ctm-blue-to-red)
[335.935448] Subtest ctm-blue-to-red: SKIP (0.000s)
[335.977084] [071/154] (691s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[336.070015] Starting subtest: flip-vs-dpms-off-vs-modeset
[336.070840] Starting dynamic subtest: A-eDP1
[339.661738] Dynamic subtest A-eDP1: SUCCESS (3.599s)
[339.671449] Starting dynamic subtest: B-eDP1
[342.886514] Dynamic subtest B-eDP1: SUCCESS (3.224s)
[342.895497] Starting dynamic subtest: C-eDP1
[346.112433] Dynamic subtest C-eDP1: SUCCESS (3.225s)
[346.121918] Starting dynamic subtest: D-eDP1
[349.344717] Dynamic subtest D-eDP1: SUCCESS (3.232s)
[349.348428] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.289s)
[350.148608] [072/154] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[350.241239] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[350.242912] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[350.334433] [073/154] (677s left) gem_ccs (block-copy-compressed)
[350.387857] Starting subtest: block-copy-compressed
[350.389622] Subtest block-copy-compressed: SKIP (0.000s)
[350.486549] [074/154] (677s left) syncobj_timeline (wait-for-submit-delayed-submit)
[350.533890] Starting subtest: wait-for-submit-delayed-submit
[350.637516] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[350.721627] [075/154] (677s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[350.810097] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[350.811860] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[350.910001] [076/154] (677s left) perf (gen12-group-concurrent-oa-buffer-read)
[351.022679] Starting subtest: gen12-group-concurrent-oa-buffer-read
[361.114543] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.048s)
[361.149059] [077/154] (666s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[361.256244] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[361.258102] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[361.353062] [078/154] (666s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[361.434895] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[361.436457] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[361.536250] [079/154] (666s left) i915_query (query-topology-matches-eu-total)
[361.584809] Starting subtest: query-topology-matches-eu-total
[361.585693] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[361.701234] [080/154] (666s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[361.757732] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[361.813159] [081/154] (666s left) gem_exec_fence (syncobj-invalid-flags)
[362.265920] Starting subtest: syncobj-invalid-flags
[362.267225] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[363.408918] [082/154] (664s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[363.492162] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[363.493982] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[363.573803] [083/154] (664s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[363.670184] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[363.672080] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[363.765815] [084/154] (664s left) intel_hwmon (hwmon-read)
[363.811562] Subtest hwmon-read: SKIP (0.000s)
[363.869827] [085/154] (664s left) kms_flip (basic-flip-vs-wf_vblank)
[363.954702] Starting subtest: basic-flip-vs-wf_vblank
[363.956572] Starting dynamic subtest: A-eDP1
[365.889877] Dynamic subtest A-eDP1: SUCCESS (1.934s)
[365.900162] Starting dynamic subtest: B-eDP1
[367.820724] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[367.832862] Starting dynamic subtest: C-eDP1
[369.738512] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[369.750243] Starting dynamic subtest: D-eDP1
[371.674218] Dynamic subtest D-eDP1: SUCCESS (1.936s)
[371.678131] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.726s)
[372.893057] [086/154] (655s left) gem_flink_basic (flink-lifetime)
[372.947381] Starting subtest: flink-lifetime
[372.948298] Subtest flink-lifetime: SUCCESS (0.002s)
[373.068813] [087/154] (655s left) kms_vrr (flip-dpms)
[373.162053] Starting subtest: flip-dpms
[373.164718] Subtest flip-dpms: SKIP (0.000s)
[373.236203] [088/154] (655s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[373.332575] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[375.788095] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.457s)
[376.912824] [089/154] (651s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[377.011070] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[377.012823] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[377.095507] [090/154] (651s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[377.142679] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[377.144172] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[377.320430] [091/154] (651s left) gem_exec_reloc (basic-write-read-noreloc)
[377.368428] Subtest basic-write-read-noreloc: SKIP (0.000s)
[377.434951] [092/154] (651s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[377.557225] Starting subtest: basic-flip-after-cursor-varying-size
[378.496632] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s)
[379.338812] [093/154] (649s left) kms_cursor_crc (cursor-random-512x170)
[379.637589] Starting subtest: cursor-random-512x170
[379.639578] Subtest cursor-random-512x170: SKIP (0.001s)
[379.757756] [094/154] (648s left) kms_pm_rpm (pm-caching)
[381.493009] Starting subtest: pm-caching
[381.495117] Subtest pm-caching: SKIP (0.000s)
[382.086748] [095/154] (646s left) syncobj_wait (wait-all-interrupted)
[382.141785] Starting subtest: wait-all-interrupted
[382.262706] Subtest wait-all-interrupted: SUCCESS (0.109s)
[382.340212] [096/154] (646s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[382.425006] Starting subtest: drrs-dirtyfb-ioctl
[382.429961] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[382.522214] [097/154] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[382.620516] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[386.583818] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.965s)
[387.790714] [098/154] (641s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[387.889286] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[387.890873] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[388.023206] [099/154] (640s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[388.111284] Starting subtest: hdr-modesetfrombusy
[388.113006] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[388.196996] [100/154] (640s left) device_reset (cold-reset-bound)
[388.240676] Starting subtest: cold-reset-bound
[388.242553] Subtest cold-reset-bound: SKIP (0.000s)
[388.300688] [101/154] (640s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[388.417567] Starting subtest: cursorB-vs-flipA-atomic-transitions
[388.419465] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[388.567208] [102/154] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[388.656202] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[396.128671] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.474s)
[396.261805] [103/154] (632s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[396.355243] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[396.356972] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[396.450941] [104/154] (632s left) kms_psr (pr-primary-page-flip)
[396.540098] Starting subtest: pr-primary-page-flip
[396.541673] Subtest pr-primary-page-flip: SKIP (0.000s)
[396.621144] [105/154] (632s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[396.712459] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[400.915540] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.205s)
[402.085820] [106/154] (627s left) kms_chamelium_frames (hdmi-aspect-ratio)
[402.477140] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[403.293651] [107/154] (625s left) syncobj_timeline (invalid-transfer-bad-pad)
[403.336564] Starting subtest: invalid-transfer-bad-pad
[403.337555] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[403.435078] [108/154] (625s left) kms_content_protection (dp-mst-lic-type-1)
[403.570208] Starting subtest: dp-mst-lic-type-1
[403.571823] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[403.704212] [109/154] (625s left) syncobj_wait (invalid-wait-illegal-handle)
[403.746874] Starting subtest: invalid-wait-illegal-handle
[403.748216] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[403.846993] [110/154] (625s left) kms_draw_crc (draw-method-blt)
[403.937204] Starting subtest: draw-method-blt
[403.938190] Starting dynamic subtest: xrgb8888-untiled
[404.203233] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[404.212843] Starting dynamic subtest: rgb565-untiled
[404.437252] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[404.448806] Starting dynamic subtest: xrgb2101010-untiled
[404.658585] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[404.667999] Starting dynamic subtest: xbgr16161616f-untiled
[404.880800] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[404.892415] Starting dynamic subtest: xrgb8888-xtiled
[405.003871] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[405.014583] Starting dynamic subtest: rgb565-xtiled
[405.125188] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[405.135754] Starting dynamic subtest: xrgb2101010-xtiled
[405.236558] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[405.247863] Starting dynamic subtest: xbgr16161616f-xtiled
[405.347487] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[405.358811] Starting dynamic subtest: xrgb8888-4tiled
[405.469623] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[405.480162] Starting dynamic subtest: rgb565-4tiled
[405.592104] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[405.601507] Starting dynamic subtest: xrgb2101010-4tiled
[405.702964] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[405.712575] Starting dynamic subtest: xbgr16161616f-4tiled
[405.814512] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[405.815717] Subtest draw-method-blt: SUCCESS (1.878s)
[405.934126] [111/154] (623s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[406.020417] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[406.021396] Starting dynamic subtest: pipe-A-default-mode
[407.184502] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[407.186593] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.162s)
[407.324793] [112/154] (622s left) gem_madvise (dontneed-before-mmap)
[407.357813] Starting subtest: dontneed-before-mmap
[407.380497] Subtest dontneed-before-mmap: SUCCESS (0.024s)
[407.477128] [113/154] (621s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[407.569730] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[408.284293] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.715s)
[408.440549] [114/154] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[408.535231] Starting subtest: fbcpsr-rgb101010-draw-blt
[413.326405] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.794s)
[413.434516] [115/154] (616s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[413.538743] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[413.540628] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[413.641508] [116/154] (615s left) kms_frontbuffer_tracking (psr-slowdraw)
[413.732677] Starting subtest: psr-slowdraw
[439.108727] Subtest psr-slowdraw: SUCCESS (25.373s)
[439.245306] [117/154] (590s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[439.338296] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[439.340032] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[439.421854] [118/154] (590s left) gen9_exec_parse (batch-without-end)
[439.480773] Subtest batch-without-end: SKIP (0.000s)
[439.544136] [119/154] (590s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[439.640303] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[440.499785] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[440.680166] [120/154] (588s left) kms_lease (page-flip-implicit-plane)
[440.776978] Starting subtest: page-flip-implicit-plane
[440.777993] Starting dynamic subtest: pipe-A-eDP-1
[441.261575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[441.273723] Starting dynamic subtest: pipe-B-eDP-1
[442.450202] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.186s)
[442.461425] Starting dynamic subtest: pipe-C-eDP-1
[443.559907] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[443.573177] Starting dynamic subtest: pipe-D-eDP-1
[444.694112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[444.695073] Subtest page-flip-implicit-plane: SUCCESS (3.916s)
[445.536452] [121/154] (584s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[445.627109] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[445.628794] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[445.724814] [122/154] (584s left) gem_ctx_shared (q-independent)
[445.776972] Starting subtest: Q-independent
[445.778134] Starting dynamic subtest: rcs0
[445.843715] Dynamic subtest rcs0: SUCCESS (0.066s)
[445.858945] Starting dynamic subtest: vcs0
[445.886663] Dynamic subtest vcs0: SUCCESS (0.043s)
[445.897024] Starting dynamic subtest: vcs1
[445.930318] Dynamic subtest vcs1: SUCCESS (0.043s)
[445.940384] Starting dynamic subtest: vecs0
[445.972260] Dynamic subtest vecs0: SUCCESS (0.041s)
[445.982199] Starting dynamic subtest: ccs0
[446.034525] Dynamic subtest ccs0: SUCCESS (0.062s)
[446.035797] Subtest Q-independent: SUCCESS (0.258s)
[447.451471] [123/154] (582s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[447.543894] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[447.544911] Starting dynamic subtest: pipe-A-eDP-1
[447.554205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.564147] Starting dynamic subtest: pipe-B-eDP-1
[447.575415] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.585173] Starting dynamic subtest: pipe-C-eDP-1
[447.596692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.611142] Starting dynamic subtest: pipe-D-eDP-1
[447.621487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.623252] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[449.802132] [124/154] (579s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[449.896063] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[449.898007] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[449.984781] [125/154] (579s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[450.086057] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[450.087684] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[450.180511] [126/154] (579s left) kms_psr (fbc-pr-basic)
[450.273297] Starting subtest: fbc-pr-basic
[450.275128] Subtest fbc-pr-basic: SKIP (0.000s)
[450.342597] [127/154] (579s left) kms_flip (wf_vblank-ts-check-interruptible)
[450.434292] Starting subtest: wf_vblank-ts-check-interruptible
[450.436618] Starting dynamic subtest: A-eDP1
[459.381936] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[459.392000] Starting dynamic subtest: B-eDP1
[468.319638] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[468.331530] Starting dynamic subtest: C-eDP1
[477.254296] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[477.266200] Starting dynamic subtest: D-eDP1
[486.176483] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[486.177525] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.706s)
[487.359126] [128/154] (542s left) kms_psr (pr-cursor-blt)
[487.448016] Starting subtest: pr-cursor-blt
[487.449705] Subtest pr-cursor-blt: SKIP (0.000s)
[487.517886] [129/154] (542s left) gem_exec_flush (basic-uc-ro-default)
[487.574057] Starting subtest: basic-uc-ro-default
[493.031519] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[493.210787] [130/154] (536s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[493.309413] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[493.311130] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[493.400995] [131/154] (536s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[493.488965] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[493.490710] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[493.585332] [132/154] (536s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[493.640408] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[493.641512] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[493.756682] [133/154] (536s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[493.850804] Starting subtest: primary-4-tiled-reflect-x-0
[500.873623] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.023s)
[502.143538] [134/154] (528s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[502.229005] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[502.230743] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.315837] [135/154] (527s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[502.403160] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[502.404839] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[502.498803] [136/154] (527s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[502.587340] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[502.589062] Starting dynamic subtest: pipe-A-eDP-1
[513.276488] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.690s)
[513.285942] Starting dynamic subtest: pipe-B-eDP-1
[524.736144] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.459s)
[524.737069] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.152s)
[525.590532] [137/154] (504s left) gem_exec_schedule (submit-late-slice)
[525.648760] Starting subtest: submit-late-slice
[525.649869] Starting dynamic subtest: rcs0
[525.689574] Dynamic subtest rcs0: SUCCESS (0.040s)
[525.701623] Starting dynamic subtest: bcs0
[525.726304] Dynamic subtest bcs0: SUCCESS (0.036s)
[525.737421] Starting dynamic subtest: vcs0
[525.770192] Dynamic subtest vcs0: SUCCESS (0.035s)
[525.781714] Starting dynamic subtest: vcs1
[525.801122] Dynamic subtest vcs1: SUCCESS (0.039s)
[525.815068] Starting dynamic subtest: vecs0
[525.835845] Dynamic subtest vecs0: SUCCESS (0.034s)
[525.847752] Starting dynamic subtest: ccs0
[525.870779] Dynamic subtest ccs0: SUCCESS (0.034s)
[525.871934] Subtest submit-late-slice: SUCCESS (0.222s)
[527.452466] [138/154] (502s left) gem_exec_create (madvise)
[527.511205] Starting subtest: madvise
[527.512114] Starting dynamic subtest: smem
[547.676041] Dynamic subtest smem: SUCCESS (20.166s)
[547.678137] Subtest madvise: SUCCESS (20.168s)
[548.398953] [139/154] (481s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[548.504120] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[548.506668] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[548.595908] [140/154] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[548.685104] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[548.686724] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[548.791485] [141/154] (481s left) i915_pm_rpm (system-suspend-execbuf)
[550.515797] Starting subtest: system-suspend-execbuf
[610.565271] Subtest system-suspend-execbuf: SUCCESS (44.414s)
[610.951653] [142/154] (419s left) gem_exec_schedule (implicit-write-read)
[611.018905] Starting subtest: implicit-write-read
[611.019919] Starting dynamic subtest: rcs0
[611.131308] Dynamic subtest rcs0: SUCCESS (0.112s)
[611.143847] Starting dynamic subtest: vcs0
[611.215183] Dynamic subtest vcs0: SUCCESS (0.083s)
[611.226540] Starting dynamic subtest: vcs1
[611.297924] Dynamic subtest vcs1: SUCCESS (0.081s)
[611.309668] Starting dynamic subtest: vecs0
[611.372971] Dynamic subtest vecs0: SUCCESS (0.074s)
[611.384990] Starting dynamic subtest: ccs0
[611.452105] Dynamic subtest ccs0: SUCCESS (0.079s)
[611.453166] Subtest implicit-write-read: SUCCESS (0.433s)
[612.444825] [143/154] (418s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[612.547590] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[612.548686] Starting dynamic subtest: pipe-A
[612.569235] Dynamic subtest pipe-A: SKIP (0.020s)
[612.578825] Starting dynamic subtest: pipe-B
[612.604550] Dynamic subtest pipe-B: SKIP (0.035s)
[612.614033] Starting dynamic subtest: pipe-C
[612.639315] Dynamic subtest pipe-C: SKIP (0.034s)
[612.648276] Starting dynamic subtest: pipe-D
[612.674318] Dynamic subtest pipe-D: SKIP (0.034s)
[612.675928] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.127s)
[612.779300] [144/154] (417s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[612.869284] Starting subtest: fbcpsr-2p-rte
[612.870918] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[612.961095] [145/154] (417s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[613.059829] Starting subtest: 2x-flip-vs-rmfb-interruptible
[613.071603] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[613.165991] [146/154] (417s left) gem_softpin (full)
[613.212715] Starting subtest: full
[613.220468] Subtest full: SUCCESS (0.008s)
[613.354311] [147/154] (417s left) kms_big_fb (x-tiled-addfb)
[613.458038] Starting subtest: x-tiled-addfb
[613.459115] Subtest x-tiled-addfb: SUCCESS (0.000s)
[613.556948] [148/154] (417s left) api_intel_bb (lot-of-buffers)
[613.604820] Starting subtest: lot-of-buffers
[614.746509] Subtest lot-of-buffers: SUCCESS (1.132s)
[615.272013] [149/154] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[615.361274] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[622.787644] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.426s)
[622.908299] [150/154] (407s left) perf (create-destroy-userspace-config)
[623.014272] Starting subtest: create-destroy-userspace-config
[623.030159] Subtest create-destroy-userspace-config: SUCCESS (0.014s)
[623.073056] [151/154] (407s left) gem_wait (invalid-buf)
[623.121990] Starting subtest: invalid-buf
[623.122895] Subtest invalid-buf: SUCCESS (0.000s)
[623.336916] [152/154] (407s left) gem_softpin (noreloc-s3)
[623.391028] Starting subtest: noreloc-S3
[643.759771] Subtest noreloc-S3: SUCCESS (5.412s)
[647.924649] [153/154] (386s left) kms_cursor_crc (cursor-onscreen-32x32)
[648.065299] Starting subtest: cursor-onscreen-32x32
[648.108990] Subtest cursor-onscreen-32x32: SKIP (0.045s)
[648.388967] [154/154] (386s left) kms_vblank (query-busy-hang)
[648.473890] Starting subtest: query-busy-hang
[648.474716] Starting dynamic subtest: pipe-A-eDP-1
[675.102582] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.959s)
[675.114179] Starting dynamic subtest: pipe-D-eDP-1
[700.068975] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[700.069892] Subtest query-busy-hang: SUCCESS (51.925s)
[700.959720] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: i915_pm_freq_mult
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: gem_ctx_persistence
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_exec_flush
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_workarounds
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: gem_exec_parallel
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_fbcon_fbt
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_ctx_exec
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ccs
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: intel_hwmon
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_flink_basic
results: parsing output: 86/ for test: kms_vrr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_dirtyfb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: device_reset
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gen9_exec_parse
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_rotation_crc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_psr2_sf
results: parsing output: 136/ for test: gem_exec_schedule
results: parsing output: 137/ for test: gem_exec_create
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: gem_exec_schedule
results: parsing output: 142/ for test: kms_plane_scaling
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: gem_softpin
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: api_intel_bb
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: perf
results: parsing output: 150/ for test: gem_wait
results: parsing output: 151/ for test: gem_softpin
results: parsing output: 152/ for test: kms_cursor_crc
results: parsing output: 153/ for test: kms_vblank
Done.