[56.158883] Initializing watchdogs
[56.158928]   /dev/watchdog0
[56.173259] [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]
[56.177212] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.179468] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.182735] [001/129] (960s left) i915_pm_rpm (system-suspend)
[58.108255] Starting subtest: system-suspend
[76.610976] Subtest system-suspend: SUCCESS (2.947s)
[76.951285] [002/129] (955s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[77.078251] Starting subtest: short-flip-before-cursor-atomic-transitions
[78.030163] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.973s)
[78.823148] [003/129] (953s left) gem_eio (wait-1us)
[78.974436] Starting subtest: wait-1us
[79.153997] Subtest wait-1us: SUCCESS (0.179s)
[79.288599] [004/129] (952s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[79.388879] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[79.394081] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[79.494743] [005/129] (952s left) i915_query (test-query-geometry-subslices)
[79.546090] Starting subtest: test-query-geometry-subslices
[79.548675] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[79.658522] [006/129] (952s left) syncobj_timeline (reset-during-wait-for-submit)
[79.715062] Starting subtest: reset-during-wait-for-submit
[79.819381] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[79.891600] [007/129] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[79.996003] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[80.001197] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[80.078156] [008/129] (952s left) kms_feature_discovery (display-3x)
[80.186289] Starting subtest: display-3x
[80.191528] Subtest display-3x: SKIP (0.000s)
[80.255536] [009/129] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[80.379303] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[80.384332] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[80.488056] [010/129] (951s left) gem_exec_balancer (parallel-ordering)
[80.741868] Starting subtest: parallel-ordering
[81.541523] Subtest parallel-ordering: SUCCESS (0.811s)
[81.658217] [011/129] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[81.762864] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[81.767393] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[81.854203] [012/129] (950s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[82.052776] Starting subtest: cursor-rapid-movement-128x42
[82.090789] Subtest cursor-rapid-movement-128x42: SKIP (0.036s)
[82.301503] [013/129] (950s left) i915_module_load (resize-bar)
[82.335505] Starting subtest: resize-bar
[82.346445] Subtest resize-bar: SKIP (0.007s)
[82.382671] [014/129] (950s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[82.483337] Starting subtest: fbc-rgb565-draw-mmap-cpu
[85.522814] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.073s)
[85.638695] [015/129] (946s left) prime_vgem (sync)
[85.756095] Starting subtest: sync
[85.758329] Starting dynamic subtest: rcs0
[85.787110] Dynamic subtest rcs0: SUCCESS (0.031s)
[85.795294] Starting dynamic subtest: bcs0
[85.856920] Dynamic subtest bcs0: SUCCESS (0.070s)
[85.865347] Starting dynamic subtest: vcs0
[85.903589] Dynamic subtest vcs0: SUCCESS (0.047s)
[85.911448] Starting dynamic subtest: vcs1
[85.952577] Dynamic subtest vcs1: SUCCESS (0.049s)
[85.960600] Starting dynamic subtest: vecs0
[85.999585] Dynamic subtest vecs0: SUCCESS (0.047s)
[86.007694] Starting dynamic subtest: ccs0
[86.044848] Dynamic subtest ccs0: SUCCESS (0.046s)
[86.047098] Subtest sync: SUCCESS (0.290s)
[86.163331] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[86.167336] [016/129] (946s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[86.264304] Starting subtest: plane-primary-overlay-mutable-zpos
[89.673371] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.424s)
[90.836874] [017/129] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[90.947422] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[90.951768] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[91.060627] [018/129] (941s left) gem_eio (in-flight-internal-1us)
[91.237452] Starting subtest: in-flight-internal-1us
[92.534001] Subtest in-flight-internal-1us: SUCCESS (1.300s)
[92.691157] [019/129] (940s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[92.787901] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[92.790403] Starting dynamic subtest: pipe-A
[92.803351] Dynamic subtest pipe-A: SKIP (0.011s)
[92.813161] Starting dynamic subtest: pipe-B
[92.828183] Dynamic subtest pipe-B: SKIP (0.021s)
[92.838056] Starting dynamic subtest: pipe-C
[92.848779] Dynamic subtest pipe-C: SKIP (0.021s)
[92.868453] Starting dynamic subtest: pipe-D
[92.880409] Dynamic subtest pipe-D: SKIP (0.021s)
[92.886545] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.075s)
[92.977113] [020/129] (939s left) syncobj_timeline (wait-all-for-submit-snapshot)
[93.041001] Starting subtest: wait-all-for-submit-snapshot
[93.122006] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[93.197377] [021/129] (939s left) gem_render_copy_redux (flink-interruptible)
[93.254074] Starting subtest: flink-interruptible
[94.332565] Subtest flink-interruptible: SUCCESS (1.084s)
[94.471086] [022/129] (938s left) gem_exec_reloc (basic-range-active)
[94.536528] Subtest basic-range-active: SKIP (0.000s)
[94.592040] [023/129] (938s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[94.706929] Starting subtest: flip-vs-cursor-busy-crc-atomic
[95.471171] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.766s)
[96.349806] [024/129] (936s left) drm_fdinfo (idle)
[96.392712] Starting subtest: idle
[96.394903] Starting dynamic subtest: rcs0
[96.980060] Dynamic subtest rcs0: SUCCESS (0.592s)
[96.990391] Starting dynamic subtest: bcs0
[97.485774] Dynamic subtest bcs0: SUCCESS (0.504s)
[97.496526] Starting dynamic subtest: vcs0
[97.990005] Dynamic subtest vcs0: SUCCESS (0.504s)
[98.001112] Starting dynamic subtest: vcs1
[98.493872] Dynamic subtest vcs1: SUCCESS (0.504s)
[98.503550] Starting dynamic subtest: vecs0
[98.996141] Dynamic subtest vecs0: SUCCESS (0.503s)
[99.004552] Starting dynamic subtest: ccs0
[99.501681] Dynamic subtest ccs0: SUCCESS (0.503s)
[99.504539] Subtest idle: SUCCESS (3.114s)
[99.575393] [025/129] (933s left) gem_exec_schedule (u-semaphore-noskip)
[99.652579] Starting subtest: u-semaphore-noskip
[100.129726] Subtest u-semaphore-noskip: SUCCESS (0.484s)
[101.562211] [026/129] (931s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[101.611521] Starting subtest: wait-all-for-submit-delayed-submit
[101.713422] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[101.793319] [027/129] (931s left) kms_addfb_basic (clobberred-modifier)
[101.849810] Starting subtest: clobberred-modifier
[101.854936] Subtest clobberred-modifier: SKIP (0.000s)
[102.001769] [028/129] (931s left) kms_psr (psr2-cursor-render)
[102.105171] Starting subtest: psr2-cursor-render
[102.107946] Starting dynamic subtest: eDP-1
[104.572643] Dynamic subtest eDP-1: FAIL (1.757s)
[104.575362] Subtest psr2-cursor-render: FAIL (1.758s)
[104.608582] [029/129] (928s left) kms_draw_crc (draw-method-mmap-cpu)
[104.721243] Starting subtest: draw-method-mmap-cpu
[104.723348] Starting dynamic subtest: xrgb8888-untiled
[104.941126] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s)
[104.949533] Starting dynamic subtest: rgb565-untiled
[105.141162] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[105.151289] Starting dynamic subtest: xrgb2101010-untiled
[105.329567] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.189s)
[105.337702] Starting dynamic subtest: xbgr16161616f-untiled
[105.551902] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[105.560309] Starting dynamic subtest: xrgb8888-xtiled
[105.674144] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[105.683139] Starting dynamic subtest: rgb565-xtiled
[105.796265] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[105.805300] Starting dynamic subtest: xrgb2101010-xtiled
[105.907286] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[105.916037] Starting dynamic subtest: xbgr16161616f-xtiled
[106.040058] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[106.048314] Starting dynamic subtest: xrgb8888-4tiled
[106.195772] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.156s)
[106.204993] Starting dynamic subtest: rgb565-4tiled
[106.329104] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[106.347031] Starting dynamic subtest: xrgb2101010-4tiled
[106.462952] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[106.474164] Starting dynamic subtest: xbgr16161616f-4tiled
[106.596198] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[106.598453] Subtest draw-method-mmap-cpu: SUCCESS (1.879s)
[106.695913] [030/129] (926s left) sw_sync (sync_expired_merge)
[106.732947] Starting subtest: sync_expired_merge
[107.809648] Subtest sync_expired_merge: SUCCESS (1.074s)
[107.871798] [031/129] (925s left) kms_scaling_modes (scaling-mode-none)
[107.966005] Starting subtest: scaling-mode-none
[107.968542] Starting dynamic subtest: pipe-A-eDP-1
[108.079837] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[108.087719] Starting dynamic subtest: pipe-B-eDP-1
[108.130881] Dynamic subtest pipe-B-eDP-1: SKIP (0.051s)
[108.139090] Starting dynamic subtest: pipe-C-eDP-1
[108.182264] Dynamic subtest pipe-C-eDP-1: SKIP (0.050s)
[108.190678] Starting dynamic subtest: pipe-D-eDP-1
[108.232691] Dynamic subtest pipe-D-eDP-1: SKIP (0.050s)
[108.237222] Subtest scaling-mode-none: SKIP (0.264s)
[108.369713] [032/129] (924s left) gem_ctx_persistence (engines-queued)
[108.430852] Starting subtest: engines-queued
[108.433512] Starting dynamic subtest: rcs0
[108.501429] Dynamic subtest rcs0: SUCCESS (0.071s)
[108.513211] Starting dynamic subtest: bcs0
[108.525807] Dynamic subtest bcs0: SUCCESS (0.024s)
[108.536509] Starting dynamic subtest: vcs0
[110.510330] Dynamic subtest vcs0: SUCCESS (1.981s)
[110.521530] Starting dynamic subtest: vcs1
[112.493590] Dynamic subtest vcs1: SUCCESS (1.981s)
[112.505310] Starting dynamic subtest: vecs0
[114.476639] Dynamic subtest vecs0: SUCCESS (1.982s)
[114.488490] Starting dynamic subtest: ccs0
[114.630350] Dynamic subtest ccs0: SUCCESS (0.154s)
[114.633362] Subtest engines-queued: SUCCESS (6.196s)
[114.752645] [033/129] (918s left) api_intel_bb (blit-noreloc-purge-cache)
[114.816510] Starting subtest: blit-noreloc-purge-cache
[114.834135] Subtest blit-noreloc-purge-cache: SUCCESS (0.021s)
[114.959949] [034/129] (918s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[115.072161] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[115.077255] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[115.154865] [035/129] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[115.255222] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[117.868675] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.618s)
[117.989682] [036/129] (915s left) gen7_exec_parse (basic-allowed)
[118.056295] Subtest basic-allowed: SKIP (0.000s)
[118.117137] [037/129] (915s left) gem_ctx_shared (exec-shared-gtt)
[118.179219] Starting subtest: exec-shared-gtt
[118.181658] Starting dynamic subtest: rcs0
[118.188759] Dynamic subtest rcs0: SUCCESS (0.009s)
[118.198675] Starting dynamic subtest: bcs0
[118.201243] Dynamic subtest bcs0: SUCCESS (0.007s)
[118.211425] Starting dynamic subtest: vcs0
[118.213877] Dynamic subtest vcs0: SUCCESS (0.006s)
[118.221986] Starting dynamic subtest: vcs1
[118.224891] Dynamic subtest vcs1: SUCCESS (0.008s)
[118.233978] Starting dynamic subtest: vecs0
[118.236023] Dynamic subtest vecs0: SUCCESS (0.008s)
[118.243536] Starting dynamic subtest: ccs0
[118.245573] Dynamic subtest ccs0: SUCCESS (0.006s)
[118.247581] Subtest exec-shared-gtt: SUCCESS (0.045s)
[118.403028] [038/129] (914s left) gem_mmap_wc (write-cpu-read-wc)
[118.457171] Subtest write-cpu-read-wc: SKIP (0.000s)
[118.509652] [039/129] (914s left) syncobj_timeline (host-signal-ordered)
[118.565440] Starting subtest: host-signal-ordered
[118.568045] Subtest host-signal-ordered: SUCCESS (0.000s)
[118.652607] [040/129] (914s left) kms_flip (2x-flip-vs-fences)
[118.753274] Starting subtest: 2x-flip-vs-fences
[118.757082] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[118.867744] [041/129] (914s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[118.968554] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[118.970965] Starting dynamic subtest: pipe-A-eDP-1
[119.742734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[119.752240] Starting dynamic subtest: pipe-B-eDP-1
[121.537026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[121.544995] Starting dynamic subtest: pipe-C-eDP-1
[123.379354] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.840s)
[123.388900] Starting dynamic subtest: pipe-D-eDP-1
[125.193369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.814s)
[125.195861] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.214s)
[126.296134] [042/129] (907s left) gem_exec_reloc (basic-wc-read-noreloc)
[126.369394] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[126.449171] [043/129] (907s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[126.551775] Starting subtest: primary-yf-tiled-reflect-x-90
[126.557119] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[126.618717] [044/129] (906s left) kms_flip (plain-flip-fb-recreate-interruptible)
[126.726520] Starting subtest: plain-flip-fb-recreate-interruptible
[126.728862] Starting dynamic subtest: A-eDP1
[135.598195] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[135.609963] Starting dynamic subtest: B-eDP1
[144.419115] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[144.431025] Starting dynamic subtest: C-eDP1
[153.237339] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[153.245848] Starting dynamic subtest: D-eDP1
[162.062538] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[162.067849] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.350s)
[163.212410] [045/129] (870s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[163.328497] Starting subtest: yf-tiled-32bpp-rotate-270
[163.334355] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[163.437641] [046/129] (870s left) kms_psr (fbc-psr-cursor-blt)
[163.534112] Starting subtest: fbc-psr-cursor-blt
[163.536536] Starting dynamic subtest: eDP-1
[163.541299] Dynamic subtest eDP-1: SKIP (0.000s)
[163.546458] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[163.601180] [047/129] (870s left) gem_mmap_gtt (close-race)
[163.672127] Subtest close-race: SKIP (0.000s)
[163.740732] [048/129] (869s left) gem_flink_race (flink_close)
[163.773634] Starting subtest: flink_close
[168.867842] Subtest flink_close: SUCCESS (5.094s)
[168.937188] [049/129] (864s left) kms_vblank (wait-forked-busy-hang)
[169.046920] Starting subtest: wait-forked-busy-hang
[169.049333] Starting dynamic subtest: pipe-A-eDP-1
[195.274629] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.219s)
[195.289007] Starting dynamic subtest: pipe-D-eDP-1
[220.295306] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[220.298089] Subtest wait-forked-busy-hang: SUCCESS (51.239s)
[221.158939] [050/129] (812s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[221.258124] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[221.260563] Starting dynamic subtest: pipe-A-eDP-1
[221.283847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[221.293363] Starting dynamic subtest: pipe-B-eDP-1
[221.316503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[221.324850] Starting dynamic subtest: pipe-C-eDP-1
[221.348014] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[221.356112] Starting dynamic subtest: pipe-D-eDP-1
[221.379085] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[221.381272] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[223.413706] [051/129] (810s left) gem_busy (extended)
[223.601828] Starting subtest: extended
[223.604323] Starting dynamic subtest: rcs0
[223.710227] Dynamic subtest rcs0: SUCCESS (0.112s)
[223.721416] Starting dynamic subtest: bcs0
[223.752420] Dynamic subtest bcs0: SUCCESS (0.041s)
[223.762003] Starting dynamic subtest: vcs0
[225.488541] Dynamic subtest vcs0: SUCCESS (1.733s)
[225.503848] Starting dynamic subtest: vcs1
[227.534285] Dynamic subtest vcs1: SUCCESS (2.045s)
[227.546511] Starting dynamic subtest: vecs0
[229.518885] Dynamic subtest vecs0: SUCCESS (1.983s)
[229.529573] Starting dynamic subtest: ccs0
[229.564531] Dynamic subtest ccs0: SUCCESS (0.046s)
[229.567487] Subtest extended: SUCCESS (5.967s)
[229.875135] [052/129] (804s left) perf_pmu (render-node-busy-idle)
[229.987631] Starting subtest: render-node-busy-idle
[229.990812] Starting dynamic subtest: rcs0
[230.663945] Dynamic subtest rcs0: SUCCESS (0.676s)
[230.673538] Starting dynamic subtest: bcs0
[231.338366] Dynamic subtest bcs0: SUCCESS (0.674s)
[231.348532] Starting dynamic subtest: vcs0
[232.526845] Dynamic subtest vcs0: SUCCESS (1.185s)
[232.538828] Starting dynamic subtest: vcs1
[234.510649] Dynamic subtest vcs1: SUCCESS (1.983s)
[234.523114] Starting dynamic subtest: vecs0
[236.494732] Dynamic subtest vecs0: SUCCESS (1.983s)
[236.506818] Starting dynamic subtest: ccs0
[237.164807] Dynamic subtest ccs0: SUCCESS (0.670s)
[237.167532] Subtest render-node-busy-idle: SUCCESS (7.179s)
[237.237328] [053/129] (796s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[237.332924] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[237.335556] Starting dynamic subtest: pipe-A-eDP-1
[237.360281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[237.369473] Starting dynamic subtest: pipe-B-eDP-1
[237.393521] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[237.402143] Starting dynamic subtest: pipe-C-eDP-1
[237.424367] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[237.432264] Starting dynamic subtest: pipe-D-eDP-1
[237.455792] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[237.460278] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[239.460797] [054/129] (794s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[239.527962] Starting subtest: etime-multi-wait-all-for-submit-submitted
[239.634896] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[239.706381] [055/129] (794s left) kms_cursor_legacy (single-bo)
[239.838088] Starting subtest: single-bo
[239.840526] Starting dynamic subtest: pipe-A
[245.219520] Dynamic subtest pipe-A: SUCCESS (5.380s)
[245.231775] Starting dynamic subtest: pipe-B
[250.603880] Dynamic subtest pipe-B: SUCCESS (5.384s)
[250.614440] Starting dynamic subtest: pipe-C
[255.986539] Dynamic subtest pipe-C: SUCCESS (5.382s)
[255.997886] Starting dynamic subtest: pipe-D
[261.368557] Dynamic subtest pipe-D: SUCCESS (5.382s)
[261.378541] Starting dynamic subtest: all-pipes
[266.758162] Dynamic subtest all-pipes: SUCCESS (5.389s)
[266.760756] Subtest single-bo: SUCCESS (26.925s)
[266.884358] [056/129] (767s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[266.986549] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[272.318345] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.336s)
[272.425828] [057/129] (761s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[272.538539] Starting subtest: x-tiled-32bpp-rotate-180
[274.191250] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.655s)
[274.378532] [058/129] (759s left) gen9_exec_parse (secure-batches)
[274.438685] Subtest secure-batches: SKIP (0.000s)
[274.508006] [059/129] (759s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[274.616542] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[275.779989] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.166s)
[276.021494] [060/129] (758s left) gem_exec_capture (pi)
[276.082649] Starting subtest: pi
[276.085458] Starting dynamic subtest: rcs0
[281.166881] Dynamic subtest rcs0: SUCCESS (5.085s)
[281.179914] Starting dynamic subtest: bcs0
[286.153031] Dynamic subtest bcs0: SUCCESS (4.985s)
[286.165145] Starting dynamic subtest: vcs0
[291.162660] Dynamic subtest vcs0: SUCCESS (5.010s)
[291.172307] Starting dynamic subtest: vcs1
[296.110409] Dynamic subtest vcs1: SUCCESS (4.948s)
[296.120218] Starting dynamic subtest: vecs0
[300.885901] Dynamic subtest vecs0: SUCCESS (4.775s)
[300.897364] Starting dynamic subtest: ccs0
[305.691931] Dynamic subtest ccs0: SUCCESS (4.802s)
[305.694799] Subtest pi: SUCCESS (29.612s)
[305.770331] [061/129] (728s left) gem_basic (bad-close)
[305.881542] Starting subtest: bad-close
[305.886316] Subtest bad-close: SUCCESS (0.000s)
[305.970695] [062/129] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[306.096245] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[311.195915] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.100s)
[311.346212] [063/129] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[311.454975] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[311.460414] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[311.559734] [064/129] (722s left) prime_mmap (test_correct_cpu_write)
[311.629141] Starting subtest: test_correct_cpu_write
[311.631984] Starting dynamic subtest: test_correct_cpu_write-smem
[311.634551] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[311.637453] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[311.733801] [065/129] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[311.837530] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[314.637526] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.805s)
[314.781208] [066/129] (719s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[319.828795] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[319.833616] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[320.672447] [067/129] (713s left) gem_lmem_swapping (heavy-verify-random-ccs)
[320.727658] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[320.765402] [068/129] (713s left) gem_userptr_blits (dmabuf-sync)
[320.839533] Starting subtest: dmabuf-sync
[320.845092] Subtest dmabuf-sync: SKIP (0.002s)
[320.976582] [069/129] (713s left) gem_exec_reloc (basic-wc-active)
[321.033778] Subtest basic-wc-active: SKIP (0.000s)
[321.112782] [070/129] (713s left) kms_lease (lease-invalid-plane)
[321.203537] Starting subtest: lease-invalid-plane
[321.206323] Starting dynamic subtest: pipe-A-eDP-1
[321.209044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[321.218415] Starting dynamic subtest: pipe-B-eDP-1
[321.221358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.230900] Starting dynamic subtest: pipe-C-eDP-1
[321.233438] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[321.243534] Starting dynamic subtest: pipe-D-eDP-1
[321.246353] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[321.249152] Subtest lease-invalid-plane: SUCCESS (0.003s)
[321.281883] [071/129] (713s left) perf (short-reads)
[321.409462] Starting subtest: short-reads
[321.430926] Subtest short-reads: SUCCESS (0.022s)
[321.477717] [072/129] (713s left) gem_exec_whisper (basic-normal)
[321.540269] Starting subtest: basic-normal
[326.546559] Subtest basic-normal: SUCCESS (5.002s)
[326.723641] [073/129] (707s left) kms_pm_rpm (basic-pci-d3-state)
[328.701091] Starting subtest: basic-pci-d3-state
[330.153757] Subtest basic-pci-d3-state: SUCCESS (1.451s)
[330.248909] [074/129] (704s left) kms_content_protection (type1)
[330.439149] Starting subtest: type1
[333.738184] Subtest type1: SKIP (3.296s)
[334.907881] [075/129] (699s left) kms_big_fb (linear-16bpp-rotate-90)
[335.021195] Starting subtest: linear-16bpp-rotate-90
[335.041420] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[335.175060] [076/129] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[335.289431] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[340.171892] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.885s)
[340.326654] [077/129] (694s left) syncobj_timeline (multi-wait-available-submitted)
[340.387799] Starting subtest: multi-wait-available-submitted
[340.390510] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[340.483178] [078/129] (694s left) kms_psr (pr-cursor-mmap-gtt)
[340.583740] Starting subtest: pr-cursor-mmap-gtt
[340.588885] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[340.649705] [079/129] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[340.756126] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[340.761076] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[340.843413] [080/129] (694s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[340.971730] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[349.253533] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.281s)
[350.095975] [081/129] (684s left) kms_getfb (getfb2-handle-zero)
[350.150080] Starting subtest: getfb2-handle-zero
[350.152828] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[350.231629] [082/129] (684s left) gem_ctx_exec (basic-nohangcheck)
[350.293909] Starting subtest: basic-nohangcheck
[350.551069] Subtest basic-nohangcheck: SUCCESS (0.259s)
[350.676954] [083/129] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[350.778372] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[350.783227] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[350.896444] [084/129] (684s left) gem_render_copy (linear-to-vebox-y-tiled)
[350.966517] Starting subtest: linear-to-vebox-y-tiled
[350.972373] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[351.147586] [085/129] (683s left) kms_atomic (plane-cursor-legacy)
[351.240323] Starting subtest: plane-cursor-legacy
[351.243107] Starting dynamic subtest: pipe-A-eDP-1
[351.601079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[351.603357] Subtest plane-cursor-legacy: SUCCESS (0.360s)
[352.412740] [086/129] (682s left) gem_exec_async (forked-writes)
[352.489823] Starting subtest: forked-writes
[352.492605] Starting dynamic subtest: rcs0
[352.520954] Dynamic subtest rcs0: SUCCESS (0.031s)
[352.531056] Starting dynamic subtest: bcs0
[352.548192] Dynamic subtest bcs0: SUCCESS (0.026s)
[352.564649] Starting dynamic subtest: vcs0
[352.575229] Dynamic subtest vcs0: SUCCESS (0.027s)
[352.587198] Starting dynamic subtest: vcs1
[352.603417] Dynamic subtest vcs1: SUCCESS (0.027s)
[352.613142] Starting dynamic subtest: vecs0
[352.630718] Dynamic subtest vecs0: SUCCESS (0.027s)
[352.641708] Starting dynamic subtest: ccs0
[352.660541] Dynamic subtest ccs0: SUCCESS (0.029s)
[352.663230] Subtest forked-writes: SUCCESS (0.170s)
[352.882384] [087/129] (682s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[353.270820] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[354.033264] [088/129] (681s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[354.141564] Starting subtest: y-tiled-16bpp-rotate-270
[354.146438] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[354.246967] [089/129] (681s left) gem_userptr_blits (stress-mm-invalidate-close)
[354.322402] Starting subtest: stress-mm-invalidate-close
[356.470062] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[356.608335] [090/129] (678s left) kms_psr (fbc-pr-no-drrs)
[356.718382] Starting subtest: fbc-pr-no-drrs
[356.723815] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[356.786999] [091/129] (678s left) gem_exec_schedule (out-order)
[356.861363] Starting subtest: out-order
[356.863957] Starting dynamic subtest: rcs0
[356.953253] Dynamic subtest rcs0: SUCCESS (0.103s)
[356.963211] Starting dynamic subtest: vcs0
[357.036423] Dynamic subtest vcs0: SUCCESS (0.082s)
[357.045625] Starting dynamic subtest: vcs1
[357.120315] Dynamic subtest vcs1: SUCCESS (0.083s)
[357.131412] Starting dynamic subtest: vecs0
[357.194352] Dynamic subtest vecs0: SUCCESS (0.073s)
[357.206149] Starting dynamic subtest: ccs0
[357.290887] Dynamic subtest ccs0: SUCCESS (0.095s)
[357.293974] Subtest out-order: SUCCESS (0.441s)
[358.584431] [092/129] (676s left) gem_mmap_offset (clear-via-pagefault)
[358.641694] Starting subtest: clear-via-pagefault
[358.644203] Starting dynamic subtest: smem0
[423.068882] Dynamic subtest smem0: SUCCESS (64.426s)
[423.071556] Subtest clear-via-pagefault: SUCCESS (64.428s)
[423.425006] [093/129] (611s left) prime_mmap (test_errors)
[423.497530] Starting subtest: test_errors
[423.500523] Starting dynamic subtest: test_errors-smem
[423.602666] Dynamic subtest test_errors-smem: SUCCESS (0.107s)
[423.605545] Subtest test_errors: SUCCESS (0.107s)
[423.713019] [094/129] (611s left) kms_joiner (basic-ultra-joiner)
[423.833282] Starting subtest: basic-ultra-joiner
[423.838462] Subtest basic-ultra-joiner: SKIP (0.000s)
[423.891374] [095/129] (611s left) kms_cursor_crc (cursor-onscreen-64x64)
[424.065499] Starting subtest: cursor-onscreen-64x64
[424.068496] Starting dynamic subtest: pipe-A-eDP-1
[426.342821] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.273s)
[426.371201] Starting dynamic subtest: pipe-D-eDP-1
[429.374524] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.011s)
[429.377119] Subtest cursor-onscreen-64x64: SUCCESS (5.309s)
[430.195982] [096/129] (605s left) core_getversion (basic)
[430.240336] Starting subtest: basic
[430.245435] Subtest basic: SUCCESS (0.000s)
[430.295866] [097/129] (605s left) kms_plane_scaling (planes-upscale-20x20)
[430.390045] Starting subtest: planes-upscale-20x20
[430.392711] Starting dynamic subtest: pipe-A
[430.453241] Dynamic subtest pipe-A: SUCCESS (0.063s)
[430.469184] Starting dynamic subtest: pipe-B
[431.623070] Dynamic subtest pipe-B: SUCCESS (1.168s)
[431.633395] Starting dynamic subtest: pipe-C
[432.730316] Dynamic subtest pipe-C: SUCCESS (1.106s)
[432.739771] Starting dynamic subtest: pipe-D
[433.848373] Dynamic subtest pipe-D: SUCCESS (1.117s)
[433.850810] Subtest planes-upscale-20x20: SUCCESS (3.460s)
[434.995298] [098/129] (600s left) gem_exec_schedule (implicit-write-read)
[435.081242] Starting subtest: implicit-write-read
[435.083512] Starting dynamic subtest: rcs0
[435.167798] Dynamic subtest rcs0: SUCCESS (0.097s)
[435.178335] Starting dynamic subtest: vcs0
[435.258360] Dynamic subtest vcs0: SUCCESS (0.091s)
[435.269317] Starting dynamic subtest: vcs1
[435.332964] Dynamic subtest vcs1: SUCCESS (0.074s)
[435.344515] Starting dynamic subtest: vecs0
[435.406070] Dynamic subtest vecs0: SUCCESS (0.072s)
[435.416413] Starting dynamic subtest: ccs0
[435.490837] Dynamic subtest ccs0: SUCCESS (0.084s)
[435.493914] Subtest implicit-write-read: SUCCESS (0.422s)
[436.591765] [099/129] (599s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[436.980619] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[437.799894] [100/129] (597s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[437.887128] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[437.889490] Starting dynamic subtest: pipe-A-eDP-1
[437.925295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[437.934660] Starting dynamic subtest: pipe-B-eDP-1
[437.960788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[437.970100] Starting dynamic subtest: pipe-C-eDP-1
[437.996165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.005290] Starting dynamic subtest: pipe-D-eDP-1
[438.031461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.036310] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[440.070236] [101/129] (595s left) gem_pwrite (basic-self)
[440.134410] Subtest basic-self: SKIP (0.000s)
[440.191917] [102/129] (595s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[440.296522] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[440.301558] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[440.387573] [103/129] (595s left) gem_exec_params (cliprects_ptr-dirt)
[440.448421] Starting subtest: cliprects_ptr-dirt
[440.451410] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[440.549245] [104/129] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[440.648680] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[440.653340] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[440.749513] [105/129] (595s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[440.868769] Starting subtest: cursorB-vs-flipA-legacy
[440.873781] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[440.962903] [106/129] (594s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[446.026185] Starting subtest: psr2-overlay-plane-move-continuous-sf
[446.028743] Starting dynamic subtest: pipe-A-eDP-1
[452.722644] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.697s)
[452.732136] Starting dynamic subtest: pipe-B-eDP-1
[459.435390] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.712s)
[459.438301] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.413s)
[460.308542] [107/129] (575s left) gem_partial_pwrite_pread (reads-snoop)
[460.375363] Subtest reads-snoop: SKIP (0.000s)
[460.441068] [108/129] (575s left) kms_pm_backlight (brightness-with-dpms)
[460.543136] Starting subtest: brightness-with-dpms
[460.603149] Starting dynamic subtest: eDP-1
[463.299796] Dynamic subtest eDP-1: SUCCESS (2.695s)
[463.302026] Subtest brightness-with-dpms: SUCCESS (2.758s)
[464.163846] [109/129] (571s left) kms_psr (psr-primary-blt)
[464.272033] Starting subtest: psr-primary-blt
[464.274478] Starting dynamic subtest: eDP-1
[466.058377] Dynamic subtest eDP-1: SUCCESS (1.782s)
[466.061057] Subtest psr-primary-blt: SUCCESS (1.783s)
[466.912821] [110/129] (569s left) kms_vblank (wait-busy)
[467.014741] Starting subtest: wait-busy
[467.017275] Starting dynamic subtest: pipe-A-eDP-1
[468.900438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[468.915500] Starting dynamic subtest: pipe-D-eDP-1
[471.467773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[471.470541] Subtest wait-busy: SUCCESS (4.450s)
[472.262938] [111/129] (563s left) perf (gen12-invalid-class-instance)
[472.352096] Starting subtest: gen12-invalid-class-instance
[472.368323] Subtest gen12-invalid-class-instance: SUCCESS (0.013s)
[472.404442] [112/129] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[472.522431] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[477.663332] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.147s)
[477.819729] [113/129] (558s left) gem_ringfill (basic-all)
[483.538547] Starting subtest: basic-all
[484.697664] Subtest basic-all: SUCCESS (1.159s)
[484.794921] [114/129] (551s left) gem_sync (basic-store-all)
[484.884338] Starting subtest: basic-store-all
[487.949529] Subtest basic-store-all: SUCCESS (3.076s)
[488.134282] [115/129] (548s left) prime_mmap_kms (buffer-sharing)
[488.229949] Starting subtest: buffer-sharing
[488.693541] Subtest buffer-sharing: SUCCESS (0.462s)
[489.520997] [116/129] (546s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[489.634010] Starting subtest: psr-rgb101010-draw-render
[494.782519] Subtest psr-rgb101010-draw-render: SUCCESS (5.154s)
[494.914300] [117/129] (541s left) gem_exec_gttfill (all-engines)
[494.991595] Starting subtest: all-engines
[519.821326] Subtest all-engines: SUCCESS (24.832s)
[520.031383] [118/129] (516s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[520.206901] Starting subtest: cursorA-vs-flipB-toggle
[520.211797] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[520.337386] [119/129] (516s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[520.452215] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[520.464161] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[520.534517] [120/129] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[520.639401] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[520.644517] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[520.736238] [121/129] (515s left) gem_exec_reloc (basic-cpu-gtt-active)
[520.807397] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[520.862800] [122/129] (515s left) kms_chamelium_color (ctm-negative)
[520.967414] Subtest ctm-negative: SKIP (0.000s)
[521.008696] [123/129] (515s left) dumb_buffer (create-valid-dumb)
[521.077711] Starting subtest: create-valid-dumb
[521.079903] Subtest create-valid-dumb: SUCCESS (0.000s)
[521.176285] [124/129] (515s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[521.274779] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[521.276947] Starting dynamic subtest: pipe-A-default-mode
[523.968498] Dynamic subtest pipe-A-default-mode: SUCCESS (2.692s)
[523.971378] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.694s)
[524.840641] [125/129] (511s left) kms_pipe_crc_basic (suspend-read-crc)
[524.949102] Starting subtest: suspend-read-crc
[524.951540] Starting dynamic subtest: pipe-A-eDP-1
[542.685519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.558s)
[542.694805] Starting dynamic subtest: pipe-B-eDP-1
[560.370868] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.791s)
[560.380758] Starting dynamic subtest: pipe-C-eDP-1
[578.348239] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.690s)
[578.357509] Starting dynamic subtest: pipe-D-eDP-1
[596.332896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[596.335667] Subtest suspend-read-crc: SUCCESS (10.827s)
[597.160769] [126/129] (500s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[602.250597] Starting subtest: fbc-psr2-cursor-plane-update-sf
[602.253251] Starting dynamic subtest: pipe-A-eDP-1
[603.038483] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[603.048263] Starting dynamic subtest: pipe-B-eDP-1
[604.155443] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[604.160885] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.919s)
[605.320410] [127/129] (491s left) gem_userptr_blits (nohangcheck)
[605.397908] Starting subtest: nohangcheck
[605.638057] Subtest nohangcheck: SUCCESS (0.238s)
[605.764472] [128/129] (491s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[605.862722] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[605.865049] Starting dynamic subtest: pipe-A-eDP-1
[622.020874] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.449s)
[622.030589] Starting dynamic subtest: pipe-B-eDP-1
[638.895863] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.340s)
[638.905380] Starting dynamic subtest: pipe-C-eDP-1
[655.860091] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.291s)
[655.876218] Starting dynamic subtest: pipe-D-eDP-1
[672.863480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.222s)
[672.866176] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.310s)
[674.045429] [129/129] (481s left) gem_render_copy_redux (normal)
[674.103435] Starting subtest: normal
[674.438698] Subtest normal: SUCCESS (0.342s)
[674.575761] Closing watchdogs
Done.