[57.431117] Initializing watchdogs
[57.431159]   /dev/watchdog0
[57.445596] [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.450048] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.452362] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.455924] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop)
[57.581899] Starting subtest: flip-vs-dpms-on-nop
[57.584077] Starting dynamic subtest: A-eDP1
[59.512060] Dynamic subtest A-eDP1: SUCCESS (1.917s)
[59.522612] Starting dynamic subtest: B-eDP1
[61.353671] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[61.367255] Starting dynamic subtest: C-eDP1
[63.182098] Dynamic subtest C-eDP1: SUCCESS (1.819s)
[63.191097] Starting dynamic subtest: D-eDP1
[65.026149] Dynamic subtest D-eDP1: SUCCESS (1.836s)
[65.030960] Subtest flip-vs-dpms-on-nop: SUCCESS (7.413s)
[66.439526] [002/133] (951s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[66.535138] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[66.540271] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[66.606683] [003/133] (951s left) kms_psr (psr2-cursor-mmap-cpu)
[66.695104] Starting subtest: psr2-cursor-mmap-cpu
[66.697497] Starting dynamic subtest: eDP-1
[68.397090] Dynamic subtest eDP-1: SUCCESS (1.697s)
[68.399332] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.698s)
[69.174985] [004/133] (948s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[69.285398] Starting subtest: psr-rgb565-draw-mmap-cpu
[76.053412] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.764s)
[76.164305] [005/133] (941s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[76.258101] Starting subtest: fb-8bpc-vs-panel-6bpc
[76.260268] Starting dynamic subtest: pipe-A-eDP-1
[77.633667] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[77.636020] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.374s)
[78.511023] [006/133] (939s left) gem_spin_batch (resubmit)
[78.574856] Starting subtest: resubmit
[78.577324] Starting dynamic subtest: rcs0
[78.582109] Dynamic subtest rcs0: SUCCESS (0.006s)
[78.589883] Starting dynamic subtest: bcs0
[78.592269] Dynamic subtest bcs0: SUCCESS (0.002s)
[78.599847] Starting dynamic subtest: vcs0
[78.601851] Dynamic subtest vcs0: SUCCESS (0.002s)
[78.608688] Starting dynamic subtest: vcs1
[78.610663] Dynamic subtest vcs1: SUCCESS (0.004s)
[78.617316] Starting dynamic subtest: vecs0
[78.619304] Dynamic subtest vecs0: SUCCESS (0.004s)
[78.625878] Starting dynamic subtest: ccs0
[78.627885] Dynamic subtest ccs0: SUCCESS (0.003s)
[78.629902] Subtest resubmit: SUCCESS (0.024s)
[78.835724] [007/133] (939s left) kms_vblank (accuracy-idle)
[78.927520] Starting subtest: accuracy-idle
[78.929762] Starting dynamic subtest: pipe-A-eDP-1
[80.693364] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[80.706378] Starting dynamic subtest: pipe-D-eDP-1
[83.132229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[83.134591] Subtest accuracy-idle: SUCCESS (4.204s)
[83.965704] [008/133] (934s left) syncobj_timeline (etime-single-wait-submitted)
[84.034769] Starting subtest: etime-single-wait-submitted
[84.137531] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[84.214196] [009/133] (934s left) kms_content_protection (dp-mst-lic-type-1)
[84.351522] Starting subtest: dp-mst-lic-type-1
[84.356188] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[84.487231] [010/133] (933s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[84.608902] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[85.580498] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.972s)
[85.729233] [011/133] (932s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[85.831472] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[85.833809] Starting dynamic subtest: A-eDP1
[89.389090] Dynamic subtest A-eDP1: SUCCESS (3.553s)
[89.399914] Starting dynamic subtest: B-eDP1
[92.615066] Dynamic subtest B-eDP1: SUCCESS (3.222s)
[92.623672] Starting dynamic subtest: C-eDP1
[95.733114] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[95.742065] Starting dynamic subtest: D-eDP1
[98.841589] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[98.843996] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.006s)
[99.642902] [012/133] (918s left) gem_ccs (large-ctrl-surf-copy)
[99.727915] Starting subtest: large-ctrl-surf-copy
[99.732722] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[99.848069] [013/133] (918s left) syncobj_timeline (signal-point-0)
[99.915128] Starting subtest: signal-point-0
[99.917471] Subtest signal-point-0: SUCCESS (0.000s)
[100.016302] [014/133] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[100.109614] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[100.113740] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[100.203184] [015/133] (918s left) gem_render_copy (yf-tiled-to-vebox-linear)
[100.261654] Starting subtest: yf-tiled-to-vebox-linear
[100.266230] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[100.437716] [016/133] (918s left) kms_cursor_crc (cursor-offscreen-64x64)
[100.600891] Starting subtest: cursor-offscreen-64x64
[100.606173] Starting dynamic subtest: pipe-A-eDP-1
[102.549814] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[102.576576] Starting dynamic subtest: pipe-D-eDP-1
[105.146096] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[105.148551] Subtest cursor-offscreen-64x64: SUCCESS (4.544s)
[106.022108] [017/133] (912s left) gem_exec_reloc (basic-wc-gtt)
[106.079994] Subtest basic-wc-gtt: SKIP (0.000s)
[106.139107] [018/133] (912s left) i915_suspend (fence-restore-untiled)
[106.191080] Starting subtest: fence-restore-untiled
[106.195412] Subtest fence-restore-untiled: SKIP (0.000s)
[106.304385] [019/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[106.404315] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[106.408578] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[106.503015] [020/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[106.592810] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[113.190042] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.599s)
[113.318304] [021/133] (905s left) kms_getfb (getfb2-handle-protection)
[113.420748] Starting subtest: getfb2-handle-protection
[113.434812] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[113.540252] [022/133] (905s left) gem_exec_balancer (parallel-balancer)
[113.792800] Starting subtest: parallel-balancer
[114.662247] Subtest parallel-balancer: SUCCESS (0.869s)
[114.757932] [023/133] (904s left) kms_plane_lowres (tiling-yf)
[114.850405] Starting subtest: tiling-yf
[114.855031] Subtest tiling-yf: SKIP (0.000s)
[114.920457] [024/133] (903s left) gen9_exec_parse (valid-registers)
[114.975290] Subtest valid-registers: SKIP (0.000s)
[115.038976] [025/133] (903s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[115.138412] Starting subtest: sprite-rotation-90-pos-100-0
[115.142542] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[115.219192] [026/133] (903s left) kms_getfb (getfb-handle-closed)
[115.318829] Starting subtest: getfb-handle-closed
[115.321092] Subtest getfb-handle-closed: SUCCESS (0.000s)
[115.411806] [027/133] (903s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[115.555841] Starting subtest: multiplane-atomic-fence-wait
[115.851268] Subtest multiplane-atomic-fence-wait: SUCCESS (0.294s)
[116.984037] [028/133] (902s left) syncobj_timeline (wait-for-submit-complex)
[117.039252] Starting subtest: wait-for-submit-complex
[117.099993] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[117.170700] [029/133] (901s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[117.273639] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[117.277863] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[117.338345] [030/133] (901s left) gem_ccs (ctrl-surf-copy)
[117.391939] Starting subtest: ctrl-surf-copy
[117.396350] Subtest ctrl-surf-copy: SKIP (0.000s)
[117.519595] [031/133] (901s left) i915_pm_rps (reset)
[117.580423] Starting subtest: reset
[126.021884] Subtest reset: SUCCESS (8.440s)
[126.140184] [032/133] (893s left) kms_addfb_basic (bad-pitch-0)
[126.190302] Starting subtest: bad-pitch-0
[126.192685] Subtest bad-pitch-0: SUCCESS (0.000s)
[126.308710] [033/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[126.411548] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[126.415773] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[126.526980] [034/133] (892s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[126.617314] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[126.619714] Starting dynamic subtest: pipe-A
[127.001974] Dynamic subtest pipe-A: SUCCESS (0.385s)
[127.012609] Starting dynamic subtest: pipe-B
[128.397553] Dynamic subtest pipe-B: SUCCESS (1.394s)
[128.405905] Starting dynamic subtest: pipe-C
[129.815152] Dynamic subtest pipe-C: SUCCESS (1.417s)
[129.824225] Starting dynamic subtest: pipe-D
[131.242266] Dynamic subtest pipe-D: SUCCESS (1.426s)
[131.244569] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.625s)
[132.411491] [035/133] (886s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[132.504646] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[132.506935] Starting dynamic subtest: pipe-A-eDP-1
[132.532702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.028s)
[132.541501] Starting dynamic subtest: pipe-B-eDP-1
[132.561827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[132.570090] Starting dynamic subtest: pipe-C-eDP-1
[132.593403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.033s)
[132.601821] Starting dynamic subtest: pipe-D-eDP-1
[132.622047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[132.624475] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.117s)
[134.794243] [036/133] (884s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[134.880264] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[134.884891] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[136.035600] [037/133] (883s left) perf (enable-disable)
[136.181394] Starting subtest: enable-disable
[136.183537] Starting dynamic subtest: 0-rcs0
[138.439355] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[138.447962] Starting dynamic subtest: 1-vcs0
[142.903170] Dynamic subtest 1-vcs0: SUCCESS (4.463s)
[142.906143] Subtest enable-disable: SUCCESS (6.721s)
[142.950251] [038/133] (876s left) kms_flip (2x-wf_vblank-ts-check)
[143.045542] Starting subtest: 2x-wf_vblank-ts-check
[143.053349] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[143.127938] [039/133] (876s left) gem_exec_endless (dispatch)
[143.200846] Starting subtest: dispatch
[143.203192] Starting dynamic subtest: rcs0
[143.207684] Dynamic subtest rcs0: SUCCESS (0.005s)
[143.218738] Starting dynamic subtest: bcs0
[143.223265] Dynamic subtest bcs0: SUCCESS (0.008s)
[143.232328] Starting dynamic subtest: vcs0
[143.236864] Dynamic subtest vcs0: SUCCESS (0.005s)
[143.244849] Starting dynamic subtest: vcs1
[143.249224] Dynamic subtest vcs1: SUCCESS (0.005s)
[143.257172] Starting dynamic subtest: vecs0
[143.261313] Dynamic subtest vecs0: SUCCESS (0.005s)
[143.269174] Starting dynamic subtest: ccs0
[143.273492] Dynamic subtest ccs0: SUCCESS (0.004s)
[143.275701] Subtest dispatch: SUCCESS (0.036s)
[144.957681] [040/133] (874s left) gem_readwrite (read-write)
[145.006253] Subtest read-write: SKIP (0.000s)
[145.070080] [041/133] (874s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[145.179946] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[145.184516] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[145.273602] [042/133] (874s left) gem_busy (close-race)
[145.334610] Starting subtest: close-race
[168.917206] Subtest close-race: SUCCESS (23.583s)
[169.274321] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[169.278527] [043/133] (850s left) kms_color (ctm-green-to-red)
[169.409908] Starting subtest: ctm-green-to-red
[169.412113] Starting dynamic subtest: pipe-A-eDP-1
[170.098290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[170.106554] Starting dynamic subtest: pipe-B-eDP-1
[171.521256] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[171.530441] Starting dynamic subtest: pipe-C-eDP-1
[172.877530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[172.887100] Starting dynamic subtest: pipe-D-eDP-1
[174.202529] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[174.204920] Subtest ctm-green-to-red: SUCCESS (4.794s)
[175.069115] [044/133] (844s left) perf_pmu (busy-accuracy-2)
[175.111804] Starting subtest: busy-accuracy-2
[175.114546] Starting dynamic subtest: rcs0
[178.154839] Dynamic subtest rcs0: SUCCESS (3.041s)
[178.167215] Starting dynamic subtest: bcs0
[181.240758] Dynamic subtest bcs0: SUCCESS (3.050s)
[181.252717] Starting dynamic subtest: vcs0
[184.251083] Dynamic subtest vcs0: SUCCESS (3.042s)
[184.262917] Starting dynamic subtest: vcs1
[187.305084] Dynamic subtest vcs1: SUCCESS (3.051s)
[187.316414] Starting dynamic subtest: vecs0
[190.347514] Dynamic subtest vecs0: SUCCESS (3.041s)
[190.358765] Starting dynamic subtest: ccs0
[193.405941] Dynamic subtest ccs0: SUCCESS (3.056s)
[193.408535] Subtest busy-accuracy-2: SUCCESS (18.293s)
[193.522765] [045/133] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[193.623484] Starting subtest: psr-1p-primscrn-cur-indfb-move
[201.000402] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.380s)
[201.158617] [046/133] (818s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[201.266035] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[201.268401] Starting dynamic subtest: pipe-A-eDP-1
[201.365165] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[201.374918] Starting dynamic subtest: pipe-B-eDP-1
[202.542711] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[202.547354] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.278s)
[203.770873] [047/133] (816s left) dumb_buffer (create-clear)
[203.836761] Starting subtest: create-clear
[237.588656] Subtest create-clear: SUCCESS (33.748s)
[237.687950] [048/133] (782s left) syncobj_basic (bad-handle-to-fd)
[237.746499] Starting subtest: bad-handle-to-fd
[237.748696] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[237.853194] [049/133] (782s left) gem_exec_schedule (submit-golden-slice)
[237.929359] Starting subtest: submit-golden-slice
[237.931658] Starting dynamic subtest: rcs0
[237.985896] Dynamic subtest rcs0: SUCCESS (0.063s)
[237.998602] Starting dynamic subtest: bcs0
[238.043408] Dynamic subtest bcs0: SUCCESS (0.056s)
[238.055579] Starting dynamic subtest: vcs0
[238.094398] Dynamic subtest vcs0: SUCCESS (0.051s)
[238.104508] Starting dynamic subtest: vcs1
[238.155654] Dynamic subtest vcs1: SUCCESS (0.059s)
[238.166367] Starting dynamic subtest: vecs0
[238.208243] Dynamic subtest vecs0: SUCCESS (0.051s)
[238.221176] Starting dynamic subtest: ccs0
[238.271042] Dynamic subtest ccs0: SUCCESS (0.062s)
[238.273520] Subtest submit-golden-slice: SUCCESS (0.349s)
[239.986035] [050/133] (779s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[240.104634] Starting subtest: cursorA-vs-flipB-atomic
[240.109265] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[240.247066] [051/133] (779s left) kms_psr (psr2-basic)
[240.346413] Starting subtest: psr2-basic
[240.348665] Starting dynamic subtest: eDP-1
[241.926359] Dynamic subtest eDP-1: SUCCESS (1.579s)
[241.928281] Subtest psr2-basic: SUCCESS (1.580s)
[242.719993] [052/133] (777s left) gem_exec_schedule (wide)
[242.913270] Starting subtest: wide
[242.915832] Starting dynamic subtest: rcs0
[253.314388] Dynamic subtest rcs0: SUCCESS (10.397s)
[253.326302] Starting dynamic subtest: vcs0
[264.560956] Dynamic subtest vcs0: SUCCESS (11.246s)
[264.572514] Starting dynamic subtest: vcs1
[276.202052] Dynamic subtest vcs1: SUCCESS (11.640s)
[276.213989] Starting dynamic subtest: vecs0
[288.757141] Dynamic subtest vecs0: SUCCESS (12.553s)
[288.778465] Starting dynamic subtest: ccs0
[301.172493] Dynamic subtest ccs0: SUCCESS (12.414s)
[301.174720] Subtest wide: SUCCESS (58.259s)
[303.583757] [053/133] (716s left) syncobj_wait (invalid-wait-illegal-handle)
[303.642016] Starting subtest: invalid-wait-illegal-handle
[303.644309] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[303.732543] [054/133] (716s left) api_intel_bb (render)
[303.795813] Starting subtest: render
[303.798132] Starting dynamic subtest: render-none-512
[303.903424] Dynamic subtest render-none-512: SUCCESS (0.108s)
[303.915089] Starting dynamic subtest: render-none-1024
[304.285379] Dynamic subtest render-none-1024: SUCCESS (0.381s)
[304.297248] Starting dynamic subtest: render-x-512
[304.373474] Dynamic subtest render-x-512: SUCCESS (0.088s)
[304.385233] Starting dynamic subtest: render-x-1024
[304.718358] Dynamic subtest render-x-1024: SUCCESS (0.343s)
[304.730058] Starting dynamic subtest: render-y-512
[304.811290] Dynamic subtest render-y-512: SUCCESS (0.093s)
[304.822542] Starting dynamic subtest: render-y-1024
[305.184594] Dynamic subtest render-y-1024: SUCCESS (0.371s)
[305.187530] Subtest render: SUCCESS (1.390s)
[305.267807] [055/133] (714s left) kms_psr (fbc-psr2-suspend)
[305.367983] Starting subtest: fbc-psr2-suspend
[305.370580] Starting dynamic subtest: eDP-1
[305.375306] Dynamic subtest eDP-1: SKIP (0.000s)
[305.379977] Subtest fbc-psr2-suspend: SKIP (0.002s)
[305.457875] [056/133] (714s left) gem_eio (in-flight-10ms)
[305.677067] Starting subtest: in-flight-10ms
[313.827051] Subtest in-flight-10ms: SUCCESS (8.148s)
[313.961114] [057/133] (706s left) kms_psr (fbc-psr2-cursor-plane-move)
[314.058073] Starting subtest: fbc-psr2-cursor-plane-move
[314.060316] Starting dynamic subtest: eDP-1
[314.064303] Dynamic subtest eDP-1: SKIP (0.000s)
[314.068640] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[314.131826] [058/133] (706s left) perf_pmu (init-wait)
[314.171312] Starting subtest: init-wait
[314.173548] Starting dynamic subtest: rcs0
[314.175907] Dynamic subtest rcs0: SUCCESS (0.001s)
[314.185333] Starting dynamic subtest: bcs0
[314.187305] Dynamic subtest bcs0: SUCCESS (0.000s)
[314.195712] Starting dynamic subtest: vcs0
[314.197611] Dynamic subtest vcs0: SUCCESS (0.000s)
[314.205775] Starting dynamic subtest: vcs1
[314.207672] Dynamic subtest vcs1: SUCCESS (0.000s)
[314.216192] Starting dynamic subtest: vecs0
[314.218314] Dynamic subtest vecs0: SUCCESS (0.000s)
[314.226808] Starting dynamic subtest: ccs0
[314.228733] Dynamic subtest ccs0: SUCCESS (0.000s)
[314.230609] Subtest init-wait: SUCCESS (0.006s)
[314.285168] [059/133] (705s left) prime_self_import (basic-with_two_bos)
[314.323943] Starting subtest: basic-with_two_bos
[314.336165] Subtest basic-with_two_bos: SUCCESS (0.017s)
[314.431730] [060/133] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[314.528087] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[314.532480] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[314.622719] [061/133] (705s left) kms_psr (fbc-pr-cursor-render)
[314.714645] Starting subtest: fbc-pr-cursor-render
[314.718359] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[314.788310] [062/133] (705s left) kms_getfb (getfb-handle-valid)
[314.885692] Starting subtest: getfb-handle-valid
[314.887708] Subtest getfb-handle-valid: SUCCESS (0.000s)
[314.984907] [063/133] (705s left) gem_pxp (create-regular-buffer)
[315.101814] Starting subtest: create-regular-buffer
[315.103986] Subtest create-regular-buffer: SUCCESS (0.000s)
[315.209323] [064/133] (705s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[315.588506] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[316.422887] [065/133] (704s left) gem_exec_reloc (basic-gtt)
[316.494283] Subtest basic-gtt: SKIP (0.000s)
[316.571889] [066/133] (703s left) gem_sync (basic-each)
[316.644196] Starting subtest: basic-each
[319.120661] Subtest basic-each: SUCCESS (2.486s)
[319.322936] [067/133] (701s left) gem_exec_reloc (basic-wc-read-active)
[319.373469] Subtest basic-wc-read-active: SKIP (0.000s)
[319.443966] [068/133] (701s left) prime_vgem (shrink)
[319.510626] Starting subtest: shrink
[319.528183] Subtest shrink: SUCCESS (0.015s)
[319.618723] [069/133] (701s left) kms_cursor_crc (cursor-suspend)
[319.760155] Starting subtest: cursor-suspend
[319.762291] Starting dynamic subtest: pipe-A-eDP-1
[352.804500] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[352.817283] Starting dynamic subtest: pipe-D-eDP-1
[385.789762] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.721s)
[385.792146] Subtest cursor-suspend: SUCCESS (7.187s)
[386.658687] [070/133] (634s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[386.826061] Starting subtest: cursorB-vs-flipA-atomic-transitions
[386.830356] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.003s)
[386.981841] [071/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[387.082610] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[387.087088] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[387.178153] [072/133] (633s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[387.284052] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[388.278895] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.967s)
[388.380445] [073/133] (632s left) gem_exec_parallel (fds)
[388.446840] Starting subtest: fds
[388.449380] Starting dynamic subtest: rcs0
[391.207355] Dynamic subtest rcs0: SUCCESS (2.699s)
[391.219590] Starting dynamic subtest: bcs0
[394.558693] Dynamic subtest bcs0: SUCCESS (3.301s)
[394.573038] Starting dynamic subtest: vcs0
[398.832284] Dynamic subtest vcs0: SUCCESS (4.230s)
[398.843204] Starting dynamic subtest: vcs1
[402.865068] Dynamic subtest vcs1: SUCCESS (4.009s)
[402.879916] Starting dynamic subtest: vecs0
[406.830380] Dynamic subtest vecs0: SUCCESS (3.949s)
[406.840248] Starting dynamic subtest: ccs0
[410.230480] Dynamic subtest ccs0: SUCCESS (3.390s)
[410.233435] Subtest fds: SUCCESS (21.592s)
[410.443098] [074/133] (610s left) gem_eio (kms)
[410.740070] Starting subtest: kms
[431.362453] Subtest kms: SUCCESS (20.624s)
[432.538382] [075/133] (588s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[432.683552] Starting subtest: short-flip-after-cursor-atomic-transitions
[433.619023] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.936s)
[434.464389] [076/133] (586s left) perf (sysctl-defaults)
[434.551721] Starting subtest: sysctl-defaults
[434.554328] Subtest sysctl-defaults: SUCCESS (0.000s)
[434.625224] [077/133] (586s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[434.714641] Starting subtest: 4-tiled-8bpp-rotate-270
[434.735397] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[434.862174] [078/133] (586s left) kms_atomic (plane-cursor-legacy)
[434.949221] Starting subtest: plane-cursor-legacy
[434.951562] Starting dynamic subtest: pipe-A-eDP-1
[435.323817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[435.326112] Subtest plane-cursor-legacy: SUCCESS (0.374s)
[436.201116] [079/133] (584s left) kms_hdmi_inject (inject-4k)
[436.559842] Starting subtest: inject-4k
[436.879283] Subtest inject-4k: SUCCESS (0.321s)
[437.453842] [080/133] (583s left) kms_big_fb (linear-8bpp-rotate-270)
[437.555389] Starting subtest: linear-8bpp-rotate-270
[437.578260] Subtest linear-8bpp-rotate-270: SKIP (0.019s)
[437.694045] [081/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[437.790518] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[437.794551] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[437.894538] [082/133] (583s left) gem_ctx_persistence (engines-hostile-preempt)
[437.947340] Starting subtest: engines-hostile-preempt
[437.949619] Starting dynamic subtest: rcs0
[438.007388] Dynamic subtest rcs0: SUCCESS (0.060s)
[438.020664] Starting dynamic subtest: bcs0
[438.049857] Dynamic subtest bcs0: SUCCESS (0.041s)
[438.061027] Starting dynamic subtest: vcs0
[439.549018] Dynamic subtest vcs0: SUCCESS (1.497s)
[439.563799] Starting dynamic subtest: vcs1
[441.597094] Dynamic subtest vcs1: SUCCESS (2.045s)
[441.609880] Starting dynamic subtest: vecs0
[443.583795] Dynamic subtest vecs0: SUCCESS (1.985s)
[443.596286] Starting dynamic subtest: ccs0
[443.639612] Dynamic subtest ccs0: SUCCESS (0.055s)
[443.641943] Subtest engines-hostile-preempt: SUCCESS (5.693s)
[443.724901] [083/133] (577s left) gem_gpgpu_fill (offset-16x16)
[443.797265] Starting subtest: offset-16x16
[443.807979] Subtest offset-16x16: SUCCESS (0.010s)
[443.956498] [084/133] (577s left) gem_exec_params (readonly)
[444.021611] Starting subtest: readonly
[444.024037] Subtest readonly: SUCCESS (0.003s)
[444.148937] [085/133] (577s left) gem_ppgtt (blt-vs-render-ctxn)
[444.204710] Starting subtest: blt-vs-render-ctxN
[477.030217] Subtest blt-vs-render-ctxN: SUCCESS (32.815s)
[477.158996] [086/133] (544s left) syncobj_wait (multi-wait-submitted)
[477.268755] Starting subtest: multi-wait-submitted
[477.375851] Subtest multi-wait-submitted: SUCCESS (0.105s)
[477.473544] [087/133] (544s left) gem_vm_create (invalid-create)
[477.540937] Starting subtest: invalid-create
[477.543171] Subtest invalid-create: SUCCESS (0.002s)
[477.648755] [088/133] (543s left) kms_tv_load_detect (load-detect)
[477.710357] Subtest load-detect: SKIP (0.000s)
[477.779391] [089/133] (543s left) kms_plane_scaling (planes-upscale-factor-0-25)
[477.876948] Starting subtest: planes-upscale-factor-0-25
[477.879306] Starting dynamic subtest: pipe-A
[477.938053] Dynamic subtest pipe-A: SUCCESS (0.063s)
[477.950015] Starting dynamic subtest: pipe-B
[479.116230] Dynamic subtest pipe-B: SUCCESS (1.177s)
[479.132291] Starting dynamic subtest: pipe-C
[480.203629] Dynamic subtest pipe-C: SUCCESS (1.086s)
[480.214645] Starting dynamic subtest: pipe-D
[481.301684] Dynamic subtest pipe-D: SUCCESS (1.097s)
[481.303879] Subtest planes-upscale-factor-0-25: SUCCESS (3.427s)
[482.451284] [090/133] (539s left) syncobj_timeline (multi-wait-all-available-submitted)
[482.501478] Starting subtest: multi-wait-all-available-submitted
[482.503454] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[482.608290] [091/133] (539s left) perf (per-context-mode-unprivileged)
[482.719669] Starting subtest: per-context-mode-unprivileged
[482.724317] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[482.764522] [092/133] (538s left) kms_flip (2x-flip-vs-expired-vblank)
[482.855180] Starting subtest: 2x-flip-vs-expired-vblank
[482.863476] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[482.945090] [093/133] (538s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[483.056774] Starting subtest: flip-vs-cursor-crc-atomic
[483.755707] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.698s)
[484.633684] [094/133] (537s left) kms_plane_alpha_blend (constant-alpha-max)
[484.727224] Starting subtest: constant-alpha-max
[485.015904] Starting dynamic subtest: pipe-A-eDP-1
[486.031183] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.015s)
[486.045072] Starting dynamic subtest: pipe-D-eDP-1
[487.638519] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.605s)
[487.640727] Subtest constant-alpha-max: SUCCESS (2.914s)
[488.432201] [095/133] (533s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[488.523820] Starting subtest: fbcpsr-tiling-y
[488.528195] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[488.624647] [096/133] (533s left) i915_hangman (engine-engine-error)
[488.684238] Starting subtest: engine-engine-error
[488.686456] Starting dynamic subtest: rcs0
[490.529469] Dynamic subtest rcs0: SUCCESS (1.846s)
[490.543804] Starting dynamic subtest: bcs0
[492.513797] Dynamic subtest bcs0: SUCCESS (1.982s)
[492.530437] Starting dynamic subtest: vcs0
[494.498478] Dynamic subtest vcs0: SUCCESS (1.981s)
[494.513026] Starting dynamic subtest: vcs1
[496.544922] Dynamic subtest vcs1: SUCCESS (2.044s)
[496.558409] Starting dynamic subtest: vecs0
[498.530584] Dynamic subtest vecs0: SUCCESS (1.983s)
[498.544494] Starting dynamic subtest: ccs0
[500.514357] Dynamic subtest ccs0: SUCCESS (1.981s)
[500.517011] Subtest engine-engine-error: SUCCESS (11.834s)
[500.595709] [097/133] (521s left) gem_lmem_swapping (random)
[500.639063] Subtest random: SKIP (0.000s)
[500.684374] [098/133] (521s left) kms_invalid_mode (clock-too-high)
[500.781244] Starting subtest: clock-too-high
[500.783583] Starting dynamic subtest: pipe-A-eDP-1
[500.787913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.798911] Starting dynamic subtest: pipe-B-eDP-1
[500.803396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.813512] Starting dynamic subtest: pipe-C-eDP-1
[500.817876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.827309] Starting dynamic subtest: pipe-D-eDP-1
[500.831676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.836040] Subtest clock-too-high: SKIP (0.004s)
[500.873961] [099/133] (521s left) gem_exec_schedule (preempt-engines)
[500.958794] Starting subtest: preempt-engines
[500.960764] Starting dynamic subtest: rcs0
[503.197476] Dynamic subtest rcs0: SUCCESS (2.245s)
[503.209977] Starting dynamic subtest: bcs0
[505.515909] Dynamic subtest bcs0: SUCCESS (2.316s)
[505.530020] Starting dynamic subtest: vcs0
[507.803436] Dynamic subtest vcs0: SUCCESS (2.285s)
[507.817106] Starting dynamic subtest: vcs1
[510.098328] Dynamic subtest vcs1: SUCCESS (2.293s)
[510.116735] Starting dynamic subtest: vecs0
[512.439739] Dynamic subtest vecs0: SUCCESS (2.339s)
[512.450067] Starting dynamic subtest: ccs0
[514.763855] Dynamic subtest ccs0: SUCCESS (2.321s)
[514.766761] Subtest preempt-engines: SUCCESS (13.812s)
[515.071112] [100/133] (506s left) gem_exec_fence (syncobj-invalid-flags)
[515.563114] Starting subtest: syncobj-invalid-flags
[515.565629] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[516.633006] [101/133] (505s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[516.696479] Starting subtest: etime-multi-wait-all-for-submit-submitted
[516.800046] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[516.883167] [102/133] (505s left) gem_ctx_create (basic-files)
[516.951160] Starting subtest: basic-files
[518.962468] Subtest basic-files: SUCCESS (2.011s)
[520.627792] [103/133] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[520.734220] Starting subtest: fbcpsr-1p-rte
[527.634276] Subtest fbcpsr-1p-rte: SUCCESS (6.904s)
[527.770695] [104/133] (494s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[527.866047] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[527.870393] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[527.954925] [105/133] (494s left) kms_pm_dc (dc5-retention-flops)
[529.056033] Starting subtest: dc5-retention-flops
[529.060292] Subtest dc5-retention-flops: SKIP (0.000s)
[529.135793] [106/133] (493s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[529.193738] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[529.195652] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[529.320019] [107/133] (493s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[530.847365] Starting subtest: modeset-lpsp-stress-no-wait
[541.657158] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.810s)
[541.748830] [108/133] (480s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[541.848318] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[541.850611] Starting dynamic subtest: pipe-A-eDP-1
[541.870933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[541.884308] Starting dynamic subtest: pipe-B-eDP-1
[541.903174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[541.912918] Starting dynamic subtest: pipe-C-eDP-1
[541.931550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[541.941414] Starting dynamic subtest: pipe-D-eDP-1
[541.960583] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[541.962500] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[544.125249] [109/133] (478s left) kms_cursor_crc (cursor-random-32x32)
[544.318180] Starting subtest: cursor-random-32x32
[544.358964] Subtest cursor-random-32x32: SKIP (0.041s)
[544.651780] [110/133] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[544.753649] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[544.757603] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[544.858734] [111/133] (477s left) kms_chamelium_edid (dp-edid-resolution-list)
[545.238206] Subtest dp-edid-resolution-list: SKIP (0.000s)
[546.010590] [112/133] (476s left) gem_ctx_param (basic)
[546.069868] Starting subtest: basic
[546.072223] Subtest basic: SUCCESS (0.002s)
[546.170154] [113/133] (476s left) kms_psr (psr-sprite-render)
[546.266053] Starting subtest: psr-sprite-render
[546.268387] Starting dynamic subtest: eDP-1
[548.014691] Dynamic subtest eDP-1: SUCCESS (1.747s)
[548.016615] Subtest psr-sprite-render: SUCCESS (1.748s)
[548.826875] [114/133] (473s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[548.920587] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[548.924774] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[549.045137] [115/133] (473s left) kms_lease (page-flip-implicit-plane)
[549.141371] Starting subtest: page-flip-implicit-plane
[549.143322] Starting dynamic subtest: pipe-A-eDP-1
[549.635540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[549.646037] Starting dynamic subtest: pipe-B-eDP-1
[550.754720] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.115s)
[550.765910] Starting dynamic subtest: pipe-C-eDP-1
[551.913691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.159s)
[551.924876] Starting dynamic subtest: pipe-D-eDP-1
[553.019095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.103s)
[553.021458] Subtest page-flip-implicit-plane: SUCCESS (3.879s)
[553.830785] [116/133] (468s left) api_intel_allocator (reloc-allocator)
[553.889479] Starting subtest: reloc-allocator
[553.891504] Starting dynamic subtest: basic
[553.893864] Dynamic subtest basic: SUCCESS (0.003s)
[553.906332] Starting dynamic subtest: parallel-one
[553.908223] Dynamic subtest parallel-one: SUCCESS (0.009s)
[553.919622] Starting dynamic subtest: print
[553.921829] Dynamic subtest print: SUCCESS (0.000s)
[553.931939] Starting dynamic subtest: reuse
[553.934283] Dynamic subtest reuse: SUCCESS (0.000s)
[553.944114] Starting dynamic subtest: fork-reopen-allocator
[553.946249] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[553.948395] Subtest reloc-allocator: SUCCESS (0.027s)
[554.036235] [117/133] (468s left) gem_ctx_persistence (heartbeat-hostile)
[554.091285] Starting subtest: heartbeat-hostile
[554.096043] Subtest heartbeat-hostile: SKIP (0.000s)
[554.235174] [118/133] (468s left) kms_flip (flip-vs-blocking-wf-vblank)
[554.325058] Starting subtest: flip-vs-blocking-wf-vblank
[554.326953] Starting dynamic subtest: A-eDP1
[563.241747] Dynamic subtest A-eDP1: SUCCESS (8.917s)
[563.254065] Starting dynamic subtest: B-eDP1
[572.144588] Dynamic subtest B-eDP1: SUCCESS (8.897s)
[572.175016] Starting dynamic subtest: C-eDP1
[581.132696] Dynamic subtest C-eDP1: SUCCESS (8.982s)
[581.145086] Starting dynamic subtest: D-eDP1
[590.041684] Dynamic subtest D-eDP1: SUCCESS (8.905s)
[590.046790] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.715s)
[591.229330] [119/133] (431s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[591.325964] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[595.504629] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.182s)
[596.634009] [120/133] (426s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[596.737640] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[596.742057] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[596.837839] [121/133] (426s left) gem_mmap_wc (close)
[596.889397] Subtest close: SKIP (0.000s)
[596.978658] [122/133] (426s left) gem_pxp (reject-modify-context-protection-off-1)
[597.072587] Starting subtest: reject-modify-context-protection-off-1
[597.074778] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[597.190461] [123/133] (425s left) gen7_exec_parse (basic-offset)
[597.248953] Subtest basic-offset: SKIP (0.000s)
[597.308937] [124/133] (425s left) kms_chamelium_color (ctm-0-75)
[597.404631] Subtest ctm-0-75: SKIP (0.000s)
[597.454381] [125/133] (425s left) gem_mmap_gtt (hang-user)
[597.502042] Subtest hang-user: SKIP (0.000s)
[597.558443] [126/133] (425s left) kms_vblank (wait-forked-busy-hang)
[597.649455] Starting subtest: wait-forked-busy-hang
[597.651177] Starting dynamic subtest: pipe-A-eDP-1
[624.323774] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.675s)
[624.340050] Starting dynamic subtest: pipe-D-eDP-1
[648.387473] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.062s)
[648.389704] Subtest wait-forked-busy-hang: SUCCESS (50.741s)
[649.216493] [127/133] (374s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[649.312337] Starting subtest: async-flip-with-page-flip-events-linear
[649.684012] Starting dynamic subtest: pipe-A-eDP-1
[652.458031] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.773s)
[652.831436] Starting dynamic subtest: pipe-B-eDP-1
[655.558791] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s)
[655.923636] Starting dynamic subtest: pipe-C-eDP-1
[658.661468] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.745s)
[659.028828] Starting dynamic subtest: pipe-D-eDP-1
[661.757760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.736s)
[661.760124] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.448s)
[662.924223] [128/133] (360s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[663.024673] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[663.029052] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[663.138086] [129/133] (360s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[663.243253] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[663.247349] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[663.337510] [130/133] (360s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[663.435232] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[663.437499] Starting dynamic subtest: pipe-A-eDP-1
[695.581157] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.890s)
[695.592769] Starting dynamic subtest: pipe-B-eDP-1
[728.499679] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.678s)
[728.510725] Starting dynamic subtest: pipe-C-eDP-1
[761.515803] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.621s)
[761.527355] Starting dynamic subtest: pipe-D-eDP-1
[794.480692] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.630s)
[794.483315] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.824s)
[795.675786] [131/133] (227s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[795.768915] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[795.771344] Starting dynamic subtest: pipe-A-default-mode
[798.507099] Dynamic subtest pipe-A-default-mode: SUCCESS (2.673s)
[798.509868] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.674s)
[799.361619] [132/133] (224s left) gem_workarounds (reset-context)
[799.424454] Starting subtest: reset-context
[799.581755] Subtest reset-context: SUCCESS (0.154s)
[799.699770] [133/133] (223s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[799.806709] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[799.811795] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[799.899294] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_dither
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: i915_suspend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_getfb
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_plane_lowres
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_explicit_fence
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: i915_pm_rps
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_exec_endless
results: parsing output: 39/ for test: gem_readwrite
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: prime_self_import
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_sync
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_gpgpu_fill
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_ppgtt
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_tv_load_detect
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_invalid_mode
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_ctx_create
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_chamelium_edid
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: gem_workarounds
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.